builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0189 starttime: 1468991154.47 results: success (0) buildid: 20160719210919 builduid: 5c6e1c3c593642fda69a422b3bb0c487 revision: 2d1ef80b6820e79ee63799e895503ee291245ea1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:54.474146) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:54.474612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:54.474920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:54.550103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-19 22:05:54.550493) ========= 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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-19 22:05:54-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.1M=0.001s 2016-07-19 22:05:55 (18.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.489875 ========= master_lag: 1.89 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-19 22:05:56.931644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:56.931964) ========= 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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.028863 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:57.007852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 22:05:57.008231) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2d1ef80b6820e79ee63799e895503ee291245ea1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 2d1ef80b6820e79ee63799e895503ee291245ea1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vKI8x3cod7/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.Mpy2yHzC5K/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-19 22:05:57,083 truncating revision to first 12 chars 2016-07-19 22:05:57,083 Setting DEBUG logging. 2016-07-19 22:05:57,083 attempt 1/10 2016-07-19 22:05:57,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2d1ef80b6820?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 22:05:57,786 unpacking tar archive at: autoland-2d1ef80b6820/testing/mozharness/ program finished with exit code 0 elapsedTime=0.985378 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 22:05:58.016273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:58.016616) ========= script_repo_revision: 2d1ef80b6820e79ee63799e895503ee291245ea1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:58.017061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:58.017343) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 22:05:58.035845) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2016-07-19 22:05:58.036202) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vKI8x3cod7/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.Mpy2yHzC5K/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:05:58 INFO - MultiFileLogger online at 20160719 22:05:58 in /builds/slave/test 22:05:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 22:05:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:05:58 INFO - {'append_to_log': False, 22:05:58 INFO - 'base_work_dir': '/builds/slave/test', 22:05:58 INFO - 'blob_upload_branch': 'Autoland', 22:05:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:05:58 INFO - 'branch': 'Autoland', 22:05:58 INFO - 'buildbot_json_path': 'buildprops.json', 22:05:58 INFO - 'config_files': ('talos/mac_config.py',), 22:05:58 INFO - 'default_actions': ('clobber', 22:05:58 INFO - 'read-buildbot-config', 22:05:58 INFO - 'download-and-extract', 22:05:58 INFO - 'populate-webroot', 22:05:58 INFO - 'create-virtualenv', 22:05:58 INFO - 'install', 22:05:58 INFO - 'run-tests'), 22:05:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:05:58 INFO - 'download_minidump_stackwalk': True, 22:05:58 INFO - 'download_symbols': 'ondemand', 22:05:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:05:58 INFO - 'tooltool.py': '/tools/tooltool.py', 22:05:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:05:58 INFO - '/tools/misc-python/virtualenv.py')}, 22:05:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:05:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:05:58 INFO - 'installer_path': 'installer.exe', 22:05:58 INFO - 'log_level': 'info', 22:05:58 INFO - 'log_name': 'talos', 22:05:58 INFO - 'log_to_console': True, 22:05:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:05:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:05:58 INFO - 'opt_config_files': (), 22:05:58 INFO - 'pip_index': False, 22:05:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:05:58 INFO - 'cmd': ('bash', 22:05:58 INFO - '-c', 22:05:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:05:58 INFO - 'enabled': True, 22:05:58 INFO - 'halt_on_failure': False, 22:05:58 INFO - 'name': 'check_screen_resolution'},), 22:05:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:05:58 INFO - 'cmd': ('bash', 22:05:58 INFO - '-c', 22:05:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:05:58 INFO - 'enabled': True, 22:05:58 INFO - 'halt_on_failure': False, 22:05:58 INFO - 'name': 'check_screen_resolution'},), 22:05:58 INFO - 'run_cmd_checks_enabled': True, 22:05:58 INFO - 'sps_profile': False, 22:05:58 INFO - 'sps_profile_interval': 0, 22:05:58 INFO - 'suite': 'dromaeojs-e10s', 22:05:58 INFO - 'system_bits': '32', 22:05:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:05:58 INFO - 'title': 't-yosemite-r7-0189', 22:05:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:05:58 INFO - 'use_talos_json': True, 22:05:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:05:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:05:58 INFO - 'work_dir': 'build'} 22:05:58 INFO - [mozharness: 2016-07-20 05:05:58.241385Z] Running clobber step. 22:05:58 INFO - Running pre-action listener: _resource_record_pre_action 22:05:58 INFO - Running main action method: clobber 22:05:58 INFO - rmtree: /builds/slave/test/build 22:05:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:06:00 INFO - Running post-action listener: _resource_record_post_action 22:06:00 INFO - [mozharness: 2016-07-20 05:06:00.403064Z] Finished clobber step (success) 22:06:00 INFO - [mozharness: 2016-07-20 05:06:00.403195Z] Running read-buildbot-config step. 22:06:00 INFO - Running pre-action listener: _resource_record_pre_action 22:06:00 INFO - Running main action method: read_buildbot_config 22:06:00 INFO - Using buildbot properties: 22:06:00 INFO - { 22:06:00 INFO - "project": "", 22:06:00 INFO - "product": "firefox", 22:06:00 INFO - "script_repo_revision": "production", 22:06:00 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 22:06:00 INFO - "repository": "", 22:06:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 22:06:00 INFO - "buildid": "20160719210919", 22:06:00 INFO - "pgo_build": "False", 22:06:00 INFO - "basedir": "/builds/slave/test", 22:06:00 INFO - "buildnumber": 41, 22:06:00 INFO - "slavename": "t-yosemite-r7-0189", 22:06:00 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:06:00 INFO - "platform": "yosemite_r7", 22:06:00 INFO - "scheduler": "tests-autoland-macosx64-talos", 22:06:00 INFO - "branch": "autoland", 22:06:00 INFO - "repo_path": "integration/autoland", 22:06:00 INFO - "revision": "2d1ef80b6820e79ee63799e895503ee291245ea1", 22:06:00 INFO - "stage_platform": "macosx64", 22:06:00 INFO - "builduid": "5c6e1c3c593642fda69a422b3bb0c487", 22:06:00 INFO - "slavebuilddir": "test" 22:06:00 INFO - } 22:06:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 22:06:00 INFO - Running post-action listener: _resource_record_post_action 22:06:00 INFO - [mozharness: 2016-07-20 05:06:00.406641Z] Finished read-buildbot-config step (success) 22:06:00 INFO - [mozharness: 2016-07-20 05:06:00.406779Z] Running download-and-extract step. 22:06:00 INFO - Running pre-action listener: _resource_record_pre_action 22:06:00 INFO - Running main action method: download_and_extract 22:06:00 INFO - mkdir: /builds/slave/test/build/tests 22:06:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:00 INFO - https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:06:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 22:06:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 22:06:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 22:06:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 22:06:20 INFO - Downloaded 1199 bytes. 22:06:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 22:06:20 INFO - Using the following test package requirements: 22:06:20 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 22:06:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 22:06:20 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 22:06:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 22:06:20 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 22:06:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 22:06:20 INFO - u'jsshell-mac.zip'], 22:06:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 22:06:20 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 22:06:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 22:06:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 22:06:20 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 22:06:20 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 22:06:20 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 22:06:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 22:06:20 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 22:06:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 22:06:20 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 22:06:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:20 INFO - https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:06:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 22:06:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 22:06:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 22:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:06:24 INFO - Downloaded 18835981 bytes. 22:06:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:06:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:06:27 INFO - Return code: 0 22:06:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:06:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:27 INFO - https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 22:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 22:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 22:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:06:44 INFO - Downloaded 18835981 bytes. 22:06:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:06:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:06:48 INFO - Return code: 0 22:06:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:48 INFO - https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 22:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 22:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 22:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:06:49 INFO - Downloaded 14403317 bytes. 22:06:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:06:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 22:06:49 INFO - Return code: 0 22:06: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:49 INFO - https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:06:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 22:06:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 22:06:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 22:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 22:06:53 INFO - Downloaded 112931971 bytes. 22:06:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 22:06:53 INFO - mkdir: /builds/slave/test/properties 22:06:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:06:53 INFO - Writing to file /builds/slave/test/properties/build_url 22:06:53 INFO - Contents: 22:06:53 INFO - build_url:https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 22:06:54 INFO - Running post-action listener: _resource_record_post_action 22:06:54 INFO - Running post-action listener: set_extra_try_arguments 22:06:54 INFO - [mozharness: 2016-07-20 05:06:54.287344Z] Finished download-and-extract step (success) 22:06:54 INFO - [mozharness: 2016-07-20 05:06:54.287515Z] Running populate-webroot step. 22:06:54 INFO - Running pre-action listener: _resource_record_pre_action 22:06:54 INFO - Running main action method: populate_webroot 22:06:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:06:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:06:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:06:54 INFO - '--tppagecycles', 22:06:54 INFO - '7'], 22:06:54 INFO - 'tests': ['tsvgm']}}, 22:06:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:06:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:06:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:06:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:06:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:54 INFO - 'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:54 INFO - 'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['damp', 'tps']}, 22:06:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:54 INFO - 'tests': ['damp', 'tps']}, 22:06:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['dromaeo_dom']}, 22:06:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:06:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['basic_compositor_video']}, 22:06:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:06:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['a11yr', 22:06:54 INFO - 'ts_paint', 22:06:54 INFO - 'tpaint', 22:06:54 INFO - 'sessionrestore', 22:06:54 INFO - 'sessionrestore_no_auto_restore', 22:06:54 INFO - 'tabpaint']}, 22:06:54 INFO - 'other-e10s': {'tests': ['a11yr', 22:06:54 INFO - 'ts_paint', 22:06:54 INFO - 'tpaint', 22:06:54 INFO - 'sessionrestore', 22:06:54 INFO - 'sessionrestore_no_auto_restore', 22:06:54 INFO - 'tabpaint']}, 22:06:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:06:54 INFO - 'ts_paint', 22:06:54 INFO - 'tpaint', 22:06:54 INFO - 'sessionrestore', 22:06:54 INFO - 'sessionrestore_no_auto_restore', 22:06:54 INFO - 'tabpaint']}, 22:06:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:06:54 INFO - 'ts_paint', 22:06:54 INFO - 'tpaint', 22:06:54 INFO - 'sessionrestore', 22:06:54 INFO - 'sessionrestore_no_auto_restore', 22:06:54 INFO - 'tabpaint']}, 22:06:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['a11yr', 22:06:54 INFO - 'ts_paint', 22:06:54 INFO - 'tpaint', 22:06:54 INFO - 'sessionrestore', 22:06:54 INFO - 'sessionrestore_no_auto_restore', 22:06:54 INFO - 'tabpaint']}, 22:06:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['a11yr', 22:06:54 INFO - 'ts_paint', 22:06:54 INFO - 'tpaint', 22:06:54 INFO - 'sessionrestore', 22:06:54 INFO - 'sessionrestore_no_auto_restore', 22:06:54 INFO - 'tabpaint']}, 22:06:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['tsvgx', 22:06:54 INFO - 'tsvgr_opacity', 22:06:54 INFO - 'tart', 22:06:54 INFO - 'tscrollx', 22:06:54 INFO - 'cart']}, 22:06:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:06:54 INFO - 'tsvgr_opacity', 22:06:54 INFO - 'tart', 22:06:54 INFO - 'tscrollx', 22:06:54 INFO - 'cart']}, 22:06:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:54 INFO - 'talos_options': ['--disable-e10s'], 22:06:54 INFO - 'tests': ['tp5o']}, 22:06:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:54 INFO - 'tests': ['tp5o']}, 22:06:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:54 INFO - 'talos_options': ['--disable-e10s', 22:06:54 INFO - '--xperf_path', 22:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:54 INFO - 'tests': ['tp5n']}, 22:06:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:54 INFO - 'talos_options': ['--xperf_path', 22:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:54 INFO - 'tests': ['tp5n']}}, 22:06:54 INFO - 'talos.zip': {'path': '', 22:06:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:06:54 INFO - Running post-action listener: _resource_record_post_action 22:06:54 INFO - [mozharness: 2016-07-20 05:06:54.306659Z] Finished populate-webroot step (success) 22:06:54 INFO - [mozharness: 2016-07-20 05:06:54.306789Z] Running create-virtualenv step. 22:06:54 INFO - Running pre-action listener: _resource_record_pre_action 22:06:54 INFO - Running main action method: create_virtualenv 22:06:54 INFO - Creating virtualenv /builds/slave/test/build/venv 22:06:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:06:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:06:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:06:54 INFO - Using real prefix '/tools/python27' 22:06:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:06:55 INFO - Installing distribute.............................................................................................................................................................................................done. 22:06:57 INFO - Installing pip.................done. 22:06:57 INFO - Return code: 0 22:06:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:57 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 0x1033b6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d8c93cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, '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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:06:57 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 22:06:57 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 22:06:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:06:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:06:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:06:57 INFO - 'HOME': '/Users/cltbld', 22:06:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:06:57 INFO - 'LOGNAME': 'cltbld', 22:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:57 INFO - 'MOZ_NO_REMOTE': '1', 22:06:57 INFO - 'NO_EM_RESTART': '1', 22:06:57 INFO - 'PAGER': '/bin/cat', 22:06:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:57 INFO - 'PWD': '/builds/slave/test', 22:06:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:06:57 INFO - 'SHELL': '/bin/bash', 22:06:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:06:57 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:06:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:06:57 INFO - 'USER': 'cltbld', 22:06:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:06:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:57 INFO - 'XPC_FLAGS': '0x0', 22:06:57 INFO - 'XPC_SERVICE_NAME': '0', 22:06:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:06:58 INFO - Cleaning up... 22:06:58 INFO - Return code: 0 22:06:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d8c93cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, '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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:06:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:06:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:06:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:06:58 INFO - 'HOME': '/Users/cltbld', 22:06:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:06:58 INFO - 'LOGNAME': 'cltbld', 22:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:58 INFO - 'MOZ_NO_REMOTE': '1', 22:06:58 INFO - 'NO_EM_RESTART': '1', 22:06:58 INFO - 'PAGER': '/bin/cat', 22:06:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:58 INFO - 'PWD': '/builds/slave/test', 22:06:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:06:58 INFO - 'SHELL': '/bin/bash', 22:06:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:06:58 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:06:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:06:58 INFO - 'USER': 'cltbld', 22:06:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:06:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:58 INFO - 'XPC_FLAGS': '0x0', 22:06:58 INFO - 'XPC_SERVICE_NAME': '0', 22:06:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:58 INFO - Downloading/unpacking psutil>=3.1.1 22:06:58 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 22:06:58 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 22:06:58 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 22:06:58 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 22:06:58 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 22:06:58 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 22:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:02 INFO - Installing collected packages: psutil 22:07:02 INFO - Running setup.py install for psutil 22:07:02 INFO - building 'psutil._psutil_osx' extension 22:07:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 22:07:03 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 22:07:03 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 22:07:03 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 22:07:03 INFO - building 'psutil._psutil_posix' extension 22:07:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 22:07:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:07:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:07:03 INFO - ^ 22:07:03 INFO - 1 warning generated. 22:07:03 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 22:07:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:03 INFO - Successfully installed psutil 22:07:03 INFO - Cleaning up... 22:07:03 INFO - Return code: 0 22:07:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d8c93cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, '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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:07: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:07: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 mozsystemmonitor==0.3 22:07:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:07:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:07:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:07:04 INFO - 'HOME': '/Users/cltbld', 22:07:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:07:04 INFO - 'LOGNAME': 'cltbld', 22:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:04 INFO - 'MOZ_NO_REMOTE': '1', 22:07:04 INFO - 'NO_EM_RESTART': '1', 22:07:04 INFO - 'PAGER': '/bin/cat', 22:07:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:04 INFO - 'PWD': '/builds/slave/test', 22:07:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:07:04 INFO - 'SHELL': '/bin/bash', 22:07:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:07:04 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:07:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:07:04 INFO - 'USER': 'cltbld', 22:07:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:07:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:04 INFO - 'XPC_FLAGS': '0x0', 22:07:04 INFO - 'XPC_SERVICE_NAME': '0', 22:07:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:07:07 INFO - Installing collected packages: mozsystemmonitor 22:07:07 INFO - Running setup.py install for mozsystemmonitor 22:07:07 INFO - Successfully installed mozsystemmonitor 22:07:07 INFO - Cleaning up... 22:07:07 INFO - Return code: 0 22:07:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:07:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:07 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 0x1033b6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d8c93cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, '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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:07:07 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 22:07:07 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 22:07:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:07:07 INFO - 'HOME': '/Users/cltbld', 22:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:07:07 INFO - 'LOGNAME': 'cltbld', 22:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:07 INFO - 'MOZ_NO_REMOTE': '1', 22:07:07 INFO - 'NO_EM_RESTART': '1', 22:07:07 INFO - 'PAGER': '/bin/cat', 22:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:07 INFO - 'PWD': '/builds/slave/test', 22:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:07:07 INFO - 'SHELL': '/bin/bash', 22:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:07:07 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:07:07 INFO - 'USER': 'cltbld', 22:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:07 INFO - 'XPC_FLAGS': '0x0', 22:07:07 INFO - 'XPC_SERVICE_NAME': '0', 22:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:07 INFO - Downloading/unpacking jsonschema==2.5.1 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:07:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:10 INFO - Downloading functools32-3.2.3-2.tar.gz 22:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:07:10 INFO - warning: no files found matching '*.txt' 22:07:10 INFO - no previously-included directories found matching 'build' 22:07:10 INFO - no previously-included directories found matching 'dist' 22:07:10 INFO - no previously-included directories found matching '.git*' 22:07:10 INFO - Installing collected packages: jsonschema, functools32 22:07:10 INFO - Running setup.py install for functools32 22:07:10 INFO - warning: no files found matching '*.txt' 22:07:10 INFO - no previously-included directories found matching 'build' 22:07:10 INFO - no previously-included directories found matching 'dist' 22:07:10 INFO - no previously-included directories found matching '.git*' 22:07:10 INFO - Successfully installed jsonschema functools32 22:07:10 INFO - Cleaning up... 22:07:10 INFO - Return code: 0 22:07:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d8c93cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, '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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:07:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:07:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:07:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:07:10 INFO - 'HOME': '/Users/cltbld', 22:07:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:07:10 INFO - 'LOGNAME': 'cltbld', 22:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:10 INFO - 'MOZ_NO_REMOTE': '1', 22:07:10 INFO - 'NO_EM_RESTART': '1', 22:07:10 INFO - 'PAGER': '/bin/cat', 22:07:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:10 INFO - 'PWD': '/builds/slave/test', 22:07:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:07:10 INFO - 'SHELL': '/bin/bash', 22:07:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:07:10 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:07:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:07:10 INFO - 'USER': 'cltbld', 22:07:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:07:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:10 INFO - 'XPC_FLAGS': '0x0', 22:07:10 INFO - 'XPC_SERVICE_NAME': '0', 22:07:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:11 INFO - Downloading/unpacking blobuploader==1.2.4 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07: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 22:07:13 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:07:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:14 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 22:07:14 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 22:07:14 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 22:07:14 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 22:07:14 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 22:07:14 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 22:07:14 INFO - Downloading docopt-0.6.1.tar.gz 22:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:14 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:14 INFO - Running setup.py install for blobuploader 22:07:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:07:14 INFO - Running setup.py install for requests 22:07:15 INFO - Running setup.py install for docopt 22:07:15 INFO - Successfully installed blobuploader requests docopt 22:07:15 INFO - Cleaning up... 22:07:15 INFO - Return code: 0 22:07:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d8c93cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, '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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:07:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:07:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:07:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:07:15 INFO - 'HOME': '/Users/cltbld', 22:07:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:07:15 INFO - 'LOGNAME': 'cltbld', 22:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:15 INFO - 'MOZ_NO_REMOTE': '1', 22:07:15 INFO - 'NO_EM_RESTART': '1', 22:07:15 INFO - 'PAGER': '/bin/cat', 22:07:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:15 INFO - 'PWD': '/builds/slave/test', 22:07:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:07:15 INFO - 'SHELL': '/bin/bash', 22:07:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:07:15 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:07:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:07:15 INFO - 'USER': 'cltbld', 22:07:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:07:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:15 INFO - 'XPC_FLAGS': '0x0', 22:07:15 INFO - 'XPC_SERVICE_NAME': '0', 22:07:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-cv3MhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Gu5c1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-UBfsyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-3Tgcng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-62_cm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-7UyxvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-iRlbvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-zGO8Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-vxYjmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-FiklCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-EKx9ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:17 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-FS2bdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:17 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-iqSF8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:17 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-CiJYGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:17 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-AQkL5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:17 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-sXakiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:17 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-B_65rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:17 INFO - Running setup.py install for manifestparser 22:07:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:07:17 INFO - Running setup.py install for mozcrash 22:07:17 INFO - Running setup.py install for mozdebug 22:07:18 INFO - Running setup.py install for mozdevice 22:07:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:07:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:07:18 INFO - Running setup.py install for mozfile 22:07:18 INFO - Running setup.py install for mozhttpd 22:07:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:07:18 INFO - Running setup.py install for mozinfo 22:07:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:07:18 INFO - Running setup.py install for mozInstall 22:07:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:07:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:07:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:07:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:07:18 INFO - Running setup.py install for mozleak 22:07:18 INFO - Running setup.py install for mozlog 22:07:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:07:19 INFO - Running setup.py install for moznetwork 22:07:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:07:19 INFO - Running setup.py install for mozprocess 22:07:19 INFO - Running setup.py install for mozprofile 22:07:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:07:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:07:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:07:19 INFO - Running setup.py install for mozrunner 22:07:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:07:19 INFO - Running setup.py install for mozscreenshot 22:07:19 INFO - Running setup.py install for moztest 22:07:20 INFO - Running setup.py install for mozversion 22:07:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:07:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:20 INFO - Cleaning up... 22:07:20 INFO - Return code: 0 22:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d8c93cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, '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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:07:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:07:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:07:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:07:20 INFO - 'HOME': '/Users/cltbld', 22:07:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:07:20 INFO - 'LOGNAME': 'cltbld', 22:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:20 INFO - 'MOZ_NO_REMOTE': '1', 22:07:20 INFO - 'NO_EM_RESTART': '1', 22:07:20 INFO - 'PAGER': '/bin/cat', 22:07:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:20 INFO - 'PWD': '/builds/slave/test', 22:07:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:07:20 INFO - 'SHELL': '/bin/bash', 22:07:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:07:20 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:07:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:07:20 INFO - 'USER': 'cltbld', 22:07:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:07:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:20 INFO - 'XPC_FLAGS': '0x0', 22:07:20 INFO - 'XPC_SERVICE_NAME': '0', 22:07:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:20 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-ezTtPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:20 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-7B0xEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:20 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Px28Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:20 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-HMeJEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:20 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Fe19a8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-BblJaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-kVgFvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-x99Fhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-dSzqGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-_eJv6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-6FDC4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-p4TDGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-LPtyAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-N59mfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:21 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-hexEOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:22 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-53Y_Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:22 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-kIzYxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:07:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:24 INFO - Downloading blessings-1.6.tar.gz 22:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:24 INFO - Installing collected packages: blessings 22:07:24 INFO - Running setup.py install for blessings 22:07:24 INFO - Successfully installed blessings 22:07:24 INFO - Cleaning up... 22:07:25 INFO - Return code: 0 22:07:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:07:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:25 INFO - Reading from file tmpfile_stdout 22:07:25 INFO - Current package versions: 22:07:25 INFO - blessings == 1.6 22:07:25 INFO - blobuploader == 1.2.4 22:07:25 INFO - docopt == 0.6.1 22:07:25 INFO - functools32 == 3.2.3-2 22:07:25 INFO - jsonschema == 2.5.1 22:07:25 INFO - manifestparser == 1.1 22:07:25 INFO - mozInstall == 1.12 22:07:25 INFO - mozcrash == 0.17 22:07:25 INFO - mozdebug == 0.1 22:07:25 INFO - mozdevice == 0.48 22:07:25 INFO - mozfile == 1.2 22:07:25 INFO - mozhttpd == 0.7 22:07:25 INFO - mozinfo == 0.9 22:07:25 INFO - mozleak == 0.1 22:07:25 INFO - mozlog == 3.3 22:07:25 INFO - moznetwork == 0.27 22:07:25 INFO - mozprocess == 0.23 22:07:25 INFO - mozprofile == 0.28 22:07:25 INFO - mozrunner == 6.12 22:07:25 INFO - mozscreenshot == 0.1 22:07:25 INFO - mozsystemmonitor == 0.3 22:07:25 INFO - moztest == 0.7 22:07:25 INFO - mozversion == 1.4 22:07:25 INFO - psutil == 3.1.1 22:07:25 INFO - requests == 1.2.3 22:07:25 INFO - wsgiref == 0.1.2 22:07:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d8c93cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, '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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:07:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:07:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:07:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:07:25 INFO - 'HOME': '/Users/cltbld', 22:07:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:07:25 INFO - 'LOGNAME': 'cltbld', 22:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:25 INFO - 'MOZ_NO_REMOTE': '1', 22:07:25 INFO - 'NO_EM_RESTART': '1', 22:07:25 INFO - 'PAGER': '/bin/cat', 22:07:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:25 INFO - 'PWD': '/builds/slave/test', 22:07:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:07:25 INFO - 'SHELL': '/bin/bash', 22:07:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:07:25 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:07:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:07:25 INFO - 'USER': 'cltbld', 22:07:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:07:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:25 INFO - 'XPC_FLAGS': '0x0', 22:07:25 INFO - 'XPC_SERVICE_NAME': '0', 22:07:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:25 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)) 22:07:25 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)) 22:07:25 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)) 22:07:25 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)) 22:07:25 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)) 22:07:25 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)) 22:07:25 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)) 22:07:25 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)) 22:07:25 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)) 22:07:25 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)) 22:07:25 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)) 22:07:25 INFO - Cleaning up... 22:07:25 INFO - Return code: 0 22:07:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10344b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9d8c93cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, '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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 22:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:07:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:07:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:07:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:07:25 INFO - 'HOME': '/Users/cltbld', 22:07:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:07:25 INFO - 'LOGNAME': 'cltbld', 22:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:25 INFO - 'MOZ_NO_REMOTE': '1', 22:07:25 INFO - 'NO_EM_RESTART': '1', 22:07:25 INFO - 'PAGER': '/bin/cat', 22:07:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:25 INFO - 'PWD': '/builds/slave/test', 22:07:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:07:25 INFO - 'SHELL': '/bin/bash', 22:07:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:07:25 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:07:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:07:25 INFO - 'USER': 'cltbld', 22:07:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:07:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:25 INFO - 'XPC_FLAGS': '0x0', 22:07:25 INFO - 'XPC_SERVICE_NAME': '0', 22:07:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:07:25 INFO - Cleaning up... 22:07:25 INFO - Return code: 0 22:07:25 INFO - Running post-action listener: _resource_record_post_action 22:07:25 INFO - Running post-action listener: _start_resource_monitoring 22:07:25 INFO - Starting resource monitoring. 22:07:25 INFO - [mozharness: 2016-07-20 05:07:25.901891Z] Finished create-virtualenv step (success) 22:07:25 INFO - [mozharness: 2016-07-20 05:07:25.902856Z] Running install step. 22:07:25 INFO - Running pre-action listener: _resource_record_pre_action 22:07:25 INFO - Running main action method: install 22:07:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:26 INFO - Reading from file tmpfile_stdout 22:07:26 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:07:26 INFO - Reading from file tmpfile_stdout 22:07:26 INFO - Output received: 22:07:26 INFO - Usage: mozinstall [options] installer 22:07:26 INFO - Options: 22:07:26 INFO - -h, --help show this help message and exit 22:07:26 INFO - -d DEST, --destination=DEST 22:07:26 INFO - Directory to install application into. [default: 22:07:26 INFO - "/builds/slave/test"] 22:07:26 INFO - --app=APP Application being installed. [default: firefox] 22:07:26 INFO - mkdir: /builds/slave/test/build/application 22:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:08:01 INFO - Reading from file tmpfile_stdout 22:08:01 INFO - Output received: 22:08:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:08:01 INFO - Running post-action listener: _resource_record_post_action 22:08:01 INFO - [mozharness: 2016-07-20 05:08:01.019525Z] Finished install step (success) 22:08:01 INFO - [mozharness: 2016-07-20 05:08:01.019697Z] Running run-tests step. 22:08:01 INFO - Running pre-action listener: _resource_record_pre_action 22:08:01 INFO - Running main action method: run_tests 22:08:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:08:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:08:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:08:01 INFO - 2016-07-19 22:08:01.032 screenresolution[1649:9075] starting screenresolution argv=screenresolution get 22:08:01 INFO - 2016-07-19 22:08:01.034 screenresolution[1649:9075] Display 0: 1600x1200x32@60 22:08:01 INFO - 2016-07-19 22:08:01.039 screenresolution[1650:9077] starting screenresolution argv=screenresolution list 22:08:01 INFO - Available Modes on Display 0 22:08:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:08:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:08:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:08:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:08:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:08:01 INFO - Intel Iris: 22:08:01 INFO - Chipset Model: Intel Iris 22:08:01 INFO - Type: GPU 22:08:01 INFO - Bus: Built-In 22:08:01 INFO - VRAM (Dynamic, Max): 1536 MB 22:08:01 INFO - Vendor: Intel (0x8086) 22:08:01 INFO - Device ID: 0x0a2e 22:08:01 INFO - Revision ID: 0x0009 22:08:01 INFO - Displays: 22:08:01 INFO - Display: 22:08:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:08:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:08:01 INFO - Display Serial Number: 1600x1200 60 22:08:01 INFO - Main Display: Yes 22:08:01 INFO - Mirror: Off 22:08:01 INFO - Online: Yes 22:08:01 INFO - Rotation: Supported 22:08:01 INFO - Return code: 0 22:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:01 INFO - Python 2.7.3 22:08:01 INFO - Return code: 0 22:08:01 INFO - grabbing minidump binary from tooltool 22:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:01 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 0x10331ad30>, '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 0x10307fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103312b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:01 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 22:08:01 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 22:08:01 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 22:08:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:01 INFO - Return code: 0 22:08:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:08:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:08:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0189 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:08:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vKI8x3cod7/Render', 22:08:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:08:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:08:01 INFO - 'HOME': '/Users/cltbld', 22:08:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:08:01 INFO - 'LOGNAME': 'cltbld', 22:08:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:01 INFO - 'MOZ_NO_REMOTE': '1', 22:08:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:01 INFO - 'NO_EM_RESTART': '1', 22:08:01 INFO - 'PAGER': '/bin/cat', 22:08:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:01 INFO - 'PWD': '/builds/slave/test', 22:08:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:08:01 INFO - 'SHELL': '/bin/bash', 22:08:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mpy2yHzC5K/Listeners', 22:08:01 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 22:08:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:08:01 INFO - 'USER': 'cltbld', 22:08:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:08:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:01 INFO - 'XPC_FLAGS': '0x0', 22:08:01 INFO - 'XPC_SERVICE_NAME': '0', 22:08:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:08:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:08:01 INFO - mozversion application_buildid: 20160719210919 22:08:01 INFO - mozversion application_changeset: 2d1ef80b6820e79ee63799e895503ee291245ea1 22:08:01 INFO - mozversion application_display_name: Nightly 22:08:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:01 INFO - mozversion application_name: Firefox 22:08:01 INFO - mozversion application_remotingname: firefox 22:08:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:08:01 INFO - mozversion application_vendor: Mozilla 22:08:01 INFO - mozversion application_version: 50.0a1 22:08:01 INFO - mozversion platform_buildid: 20160719210919 22:08:01 INFO - mozversion platform_changeset: 2d1ef80b6820e79ee63799e895503ee291245ea1 22:08:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:08:01 INFO - mozversion platform_version: 50.0a1 22:08:01 INFO - using testdate: 1468991281 22:08:01 INFO - actual date: 1468991281 22:08:01 INFO - starting webserver on 'localhost:49271' 22:08:01 INFO - SUITE-START | Running 2 tests 22:08:01 INFO - TEST-START | dromaeo_css 22:08:01 INFO - operating with platform_type : mac_ 22:08:01 INFO - Initialising browser for dromaeo_css test... 22:08:01 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpeu2OpO/profile http://localhost:49271/getInfo.html) 22:08:04 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 22:08:04 INFO - PROCESS | 1660 | colorDepth:24 22:08:04 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 22:08:04 INFO - PROCESS | 1660 | __metrics 22:08:04 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:08:05 INFO - TEST-INFO | 1660: exit 0 22:08:05 INFO - Browser initialized. 22:08:05 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:05 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpeu2OpO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:17 INFO - PROCESS | 1664 | RSS: Main: 254783488 22:08:17 INFO - PROCESS | 1664 | 22:09:07 INFO - PROCESS | 1664 | 1468991347051 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:11:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 22:11:18 INFO - PROCESS | 1664 | RSS: Main: 267177984 22:11:18 INFO - PROCESS | 1664 | 22:14:21 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 22:14:21 INFO - PROCESS | 1664 | RSS: Main: 275767296 22:14:21 INFO - PROCESS | 1664 | 22:17:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 22:17:24 INFO - PROCESS | 1664 | RSS: Main: 280326144 22:17:24 INFO - PROCESS | 1664 | 22:20:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 22:20:26 INFO - PROCESS | 1664 | RSS: Main: 279769088 22:20:26 INFO - PROCESS | 1664 | 22:23:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 22:23:30 INFO - PROCESS | 1664 | RSS: Main: 282968064 22:23:30 INFO - PROCESS | 1664 | 22:26:32 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 22:26:32 INFO - PROCESS | 1664 | RSS: Main: 283111424 22:26:32 INFO - PROCESS | 1664 | 22:26:32 INFO - PROCESS | 1664 | __start_tp_report 22:26:32 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 22:26:32 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 22:26:32 INFO - PROCESS | 1664 | |i|pagename|runs| 22:26:32 INFO - PROCESS | 1664 | |0;dojo.html;2811.5220412529866;3365.1587103224188;3383.5263063171174;3404.3021180657965;3413.7098346640532;5798.56510761693;5897.705114744267;5917.142014407914;5924.140999555062;5937.317208521022;5705.714714264281;5790.10253410721;5806.158107074471;5829.533637309016;5897.085951677486;5212.635115541904;5257.579393648499;5382.2195781611645;5384.757685904124;5404.189371594272;233.85325531957398;5256.08018596744;5309.761060752276;5346.144616861303;5357.08929481989;5324.733763311839;5337.119375303089;5345.358556973188;5366.114591092465;5375.516203541661;5350;5374.543163831079;5390.622656414013;5392.73036348181;5398.379186393537;5237.502437268454;5242.947570524322;5272.446393128705;5320.015797077514;5327;4614.630829533629;5829.154772557998;5911.970440147815;5941.762329506814;5986.401359864022;6138.633639632414;6229.750809967596;6274.435300822902;6288.056791481269;6301.180846489973;6224.906626400608;6241.157443745127;6267.1539342189135;6323.557350985433;6346.714397852108;5896.410358964112;5956.285245770535;5963.791267305667;5969.015112506475;6002.3697511761075;6229.937700622936;6273.905891411632;6384.7126879290545;6387.425131738166;6436.903446448307;6189.164462797555;6226.346233645492;6245.500359971192;6259.843503912348;6262.624242545462;5286.629935904527;5371.274877891513;5866.914620795166;6265;6355.904661430082;6268.561200715997;6283.8114856554375;6303.180586523723;6336.17629708135;6355.951268040814;6274.341194174637;6315.052742088724;6319.304876463585;6325.8734825304155;6328.46208072319;5014.89970200594;5059.139946209153;5061.746912654353;5064.46823083571;5070.873228169252;4446.933296000562;4485.529019452975;4520.4575450946095;4560.475545312332;4574.085182963354;5347.465253474699;5455.372632147354;5852.678102704307;5911.822645320647;5916.23088998436;5196.68819870809;6203.131561581382;6288.5598008138995;6292.2134733158355;6304.6847657617855;5042.949570504321;5191.792328306901;5590.804321848797;5871.823845284648;6032.6983650818165;4589.58693717567;4922.261660750916;5497.340319161726;5527.115661494142;5581.776728930879;6519.7392104315295;6532.183477065367;6533.281339052701;6537.052127441494;6547.574407663486;6280.623162610258;6301.275353334242;6304.810855674337;6313.3686631336495;6366.96816515933;5305.628605997543;6309.526785491198;6410.134631824644;6568.9014664781025;6580.934190658032;6270.6551139685935;6292.874142517033;6304.211973503312;6306.810795676137;6310.873782524415;6280.026595877646;6296.33888441707;6310.652914089769;6320.462760665211;6352.36476352361;5092.516210959953;6050.364711705208;6187.443130118311;6193.566450348432;6230.6884655767935;6268.655223962726;6272.153259309935;6272.498200143887;6299.874002520016;6304.527160463075;5263.763015691233;5529.529989950899;5721.884232574608;6030.819075427744;6181.474574661204;6097.494431795148;6185.938140618537;6243.438090571689;6263.217097862767;6304.3380445054445;6130.356312587114;6178.474829639531;6196.411340922605;6199.1011303359855;6201.81394558164 22:26:32 INFO - PROCESS | 1664 | |1;ext.html;487.376158517098;499.8125702861427;519.8388499565133;542.6608369768893;570.3327107284476;38203.617963820354;40645.59354406455;40696.79651601738;40746.79626601867;40792.59207407925;41447;42145.946351341154;42155.367669484905;42227.78886105573;42239.577604223945;9553.522323883795;9681.51592420376;9700.805983880318;9708.951455242714;9744.561494732754;9662.90337096627;9782.755431114208;9787.314887957846;9791.804163916717;9823.410595364265;9753.268504862164;9795.559199836025;9804.509774511282;9840.803183936318;9870.45712485813;8336.666533338659;9719.95140024299;9789.412635241873;9792.118709316124;9794.118529332358;9029.735836982827;9039.638414463414;9565.617375304979;9648.951755241249;9659.178969787576;39593.40609890854;39934.60065399367;40106.59893401058;40175.19649606991;40348.99127521835;3433.1588760753775;3505.1237190702323;3507.824608769551;3558.6085530591613;3672.6143754905615;25724;31766.205844853834;32309;32489.187770305933;32616.673833261837;3301.983490082534;3315.784474009182;3332.7167190788814;3387.2548039431285;3430;491466.96931668743;492899.53550232376;493909;497880;499046;33289;34125.14687132841;55021.724891375285;55333;55744;34734.826325868715;34846;35187;35213.47179792305;35228.295434091684;14876.404943802127;15014.924925375522;15037.699246015238;15059.623509412353;15072.397104115713;12608.684782880502;12776.169548979287;12804.679883003;12861.678458038437;12907.354632268349;7697.384209263246;7746.767596972099;7754.542508910478;7803.492772969739;7814.179511151361;3220.62962759281;3223.129754966193;3227.7579181561478;3244.6106467224085;3266.4810862948366;957.4111921168432;966.1063516247443;1023.7133602591286;1048.4967215736337;1086.413336798136;30441.847790760905;30562.235944101132;30900.0729978101;31011.379772404427;31020.68979310178;985.261054209343;1079.2930630437077;1108.3349990005931;1137.181229514748;1199.974022210997;15022.323995420233;16016.279267432994;16172.353105875633;16345;16650.000999940043;637102;640688;643222;652216;652896.4710352931;57639.711801440724;57699;57792.422075778704;58271.70864145652;58332.41667583355;1392.234271150863;1418.5177039806515;1425.3942074618246;1437.3388241409068;1445.169027809035;30360.84819575888;30524.542131868486;30564.388712225187;31245.687543124277;31420;49550.76123096807;50855.49144508508;50879;50887.98224035424;51254;553639;560937;565916;567777;571558;26150.86924565365;26963;27278.181654550393;27321.72678273192;27347.31631709223;48031.519684802704;48840.02319953652;49119;49263.75368123136;49289.767755806395;40649.21133139936;40686;40873.97815054647;41145.58854411417;41490.792546037075;40176.39735403913;40233;40831;41271.1745765089;41568.16863662649;38624;39051.609483904795;39471.605283947945;39543.2091358177;41030.58969410387;32430.351392971537;34810.65189348176;35009.29981400409;35235.64764352324;35413.645863542064;25676.229713108638;25985.090521831644;26280.817363219085;26319.736802632495;26628.467430651664 22:26:32 INFO - PROCESS | 1664 | |2;jquery.html;384.267969518068;384.4771111288647;388.61721204613457;396.83333000139936;410.0834634591687;20237;21429.785702143014;21760.89119554402;22440;22685.432864178405;19239.42281731547;20220.483463740242;20605.763654180722;21008.89495552524;21628.134874605035;4702.341672165891;5139.665921715076;5600.747966341524;6081.726322315484;6090.390960903918;4130.339145736668;5273.76268067936;5923.940760592382;6253.8123856284155;6556.672166391685;6489.707963141646;6566.5075119366;6576.375244351779;6579.736810527573;6596.076549283104;6434.9678251608675;6562.835929101763;6568.835779105513;6580.80257592273;6589.17635295588;5013.197888337849;5339.866503337447;5355.919661205085;5694.715264236772;5764.135379693038;12391.566295179715;12590.307533085677;13497.460101595925;13712.862871371359;13750.449982000708;2177.5862586108747;2255.92843399384;2272.2955883676113;2286.5998450271136;2352.6706261123454;10053.447060411674;10125.848112278321;10231.539580718885;10285.382877027403;10451.216158788046;1654.2555849867488;1869.719542068687;1908.1031914999928;1930.3436831477225;1953.3504487830073;123310.53378932372;126816.0977585337;130155;135594;135857.3207133968;9320.580573874056;11652.009579185695;11810.350430726392;11837.704057398461;11926.761464770829;14675.77986330206;14711.632209194642;14738.410463581551;14741.705165896621;14842.628934276729;8557.058723540405;8602.096779838026;8674.95900491945;8675.39272250949;8751.737447876574;8499.490030598185;8556.358273129541;8666.78333041679;8717.607707653171;8736.563171841382;4130.946608614844;4496.774096822029;4510.909781804346;4586.334981427674;4625.791839367236;1682.2177687375429;1847.5104097414196;1976.5256338478948;1980.3563042674546;2023.453667509764;777.8016605765607;920.5949382271779;924.2790623313826;940.4075432477632;1047.5652604169336;21164.47088822792;21706;21708.674369884466;21925.671114933288;21997.780022199895;941.4868896451451;949.3734135470694;954.627695198873;968.8546717992217;1066.7119877633152;8701.216890479887;11214.271072380432;11543.422828858524;11562.76874462506;11616.593419230287;577757;589188;590216;610060;610362;128010.35994819966;129201.70798292085;135597;135838.32080839534;138365.6163438373;962.7352478068448;976.8730065091635;977.0961860279214;983.8622592837008;1008.5159123620704;17485.300587976337;19026.619467610846;19395.418137455898;19436.805631943498;19546.804531955066;56011.43988560062;57226.42773572211;57312;57747.71126144342;58635;81753.18246817456;82503;82695;82777.58611206905;83458;6398.552101353047;8335.458195217292;8338.791530211793;8491.558813994712;8498.575071246289;12375.443105060114;13307.80038299407;13333.599992000256;13532.864671353555;13602.727945440838;9360.485173315534;11380.772384552098;11489.885101148882;11584.47869845842;11619.76760464769;9624;11410.828837567276;11452.312861228353;11541.711457213636;11618.88381116178;9718.465484398426;11758.70603234926;11828.585999489977;11962.76074478523;11973.16187866841;6634.137562116894;6735.461163106842;7631.236876312324;7664.80837979055;8452.577371131541;8391.951006124234;9397.624095036395;10867.347959122479;11596.768064638829;11793.29240245588 22:26:32 INFO - PROCESS | 1664 | |3;mootools.html;1568.4196847166547;1615.030981411153;1863.608642185141;1940.5633732410201;1947.51312171957;7994.080680721719;8638.26574741147;8663.87004194936;9145.451272923621;9145.862812057816;8673.829033080532;8780.736577902673;8893.777655558615;8906.599203035863;8919.286457083434;2004.9699254511195;2375.0618505690327;2386.7851893329553;2411.4574220800355;2421.7457166997474;2380.4881950380664;2403.399150212447;2429.3683642252963;2431.3435372449426;2432.902683892651;2394.2936833634035;2416.178499310234;2421.455172586163;2425.2724182745196;2439;2398.0887262840183;2408.915687950922;2414.5653782319177;2418;2430.2952143878256;2385.045981607371;2394.185976767907;2400.2559206645997;2400.8439451435775;2407.386116540271;8889;8975.012748597648;9049.683261085831;9053.59258833354;9063.365564410495;5297.867553311159;5385.78456861729;5453.23654688344;5461.836144915659;5464.6994415307145;3553.4136867417105;3655.7075433965483;3695.224002959382;3702.222533268017;3737.4580685800406;1086.5436516662942;1087.5649740103943;1099.9780004399947;1105.220819322384;1119.7872404243249;9877.802443951081;11711.53153873844;11898.940505297505;11901;11948.283103013848;4459.955400446019;4518.1415531049;4666.590072381635;4701.4358277006295;4704.95295047052;9309.860352094724;9324.766880827898;9352;9358.532073396304;9365.157135857806;5256.185291279858;5264.657797243167;5322.962022405671;5323.680579165262;5326.201069839478;4414.183376075436;4825;4970.65205435616;4974.353334066548;4975.776090075955;3729.9627003729615;3774.7923864187733;3796.9430458543143;3840.7695538267794;3845.134844659929;1143.3768596115137;1155.722626569634;1159.878212787662;1166.3351889423118;1175.6531823112202;860.2472836268265;900.6982660808702;963.4893506441457;976.8326849414881;995.328153496387;5946.554008449383;6059.212302400748;6150.200473938449;6164.167837341991;6246.812595622138;435.61012893460173;443.8158164361818;444.74581679663686;448.9887752806206;471.3565982434021;4030.3954406839207;4144.79276036203;4163.042500224965;4192.601702838226;4225.661947044229;10274.691759247235;10533.894661053444;10715.24993250465;10760.300580462244;10906.563737450571;9140.862887056699;10634.521446534924;10835.620753273755;10900.836487452694;10910.345379277269;6733.528652994341;6876.484263680144;7317.890231646529;7393.445491588152;8076.313513351313;6012.699365031818;6111.144439778345;6177.938220617736;6245.500359971101;6269.561130720988;9916.405015699082;10233.692989210336;10295.588176472857;10313.1233845121;10353;10431.739206519898;10505.527251273865;10537.63118290856;10599.523021463898;10607.734806629896;7115;7553.622318884144;7767.495112817649;7798.181190974866;7799.5320280783335;8657.95671021666;8678.956605216934;8731.083236260101;8742.781430464289;8758.868616970878;7600.923990760021;7812.726554570563;7831.17772633888;7842.843143137219;7868.881966770388;7512.361449276654;7590;7604.5437273763755;7696.807579810549;7758.68965241384;7126.572405655677;7152.821179470555;7201.3518783309755;7206;7208.207097219407;4454.821807127679;4993.375828021497;5120.71836049006;5186.533212010937;5196.610254230872;5079.212722028092;5099.464556221692;5131.538161565477;5318.654287471302;5334.493223143795 22:26:32 INFO - PROCESS | 1664 | |4;prototype.html;310.1378168691039;314.60831265074984;321.8583823117828;325.34930139720575;329.5452275859317;4488.394066800981;5611.438856114387;5646.548276137909;5662;5745.971270143644;5072;5450.754716037778;5594.692291923942;5606.467385598362;5625.634333768302;3659.8719044833438;3978.7413818101804;4047.251258517169;4216.515100763406;4220.936685949713;4030.9798451007705;4183.477065366829;4231.259529582326;4251.256030194703;4260.211860805761;3856.8979905951323;4226.978865105671;4230.873073807791;4239.2581298272835;4258.680598955075;4098.200850834073;4212.199682060429;4224.345226489899;4241.978790106045;4261.296886013804;3620.348337299285;3635.836387362575;3664.175560498893;3677.2277821657485;3681.7606855554304;5392.950678742092;5397.379301380352;5411.215373770781;5424.5660347172525;5476.315460567429;4432.168935859928;4647.581717645428;4874.8537543873745;4921.917178220786;4933.28467372229;5044.848654540369;5283.788648454057;5541.806036788734;5874.882502349972;5899.351071382144;3524.647535246455;4039.8788036358956;4057.2494088593703;4068.471098757172;4079.306517891936;5827.3007239131575;5895.823125306248;6210.689465526751;6238.5009199264405;6275.686215689243;4016.357382818735;4034.636882680573;4053.3717273822604;4061.3298805696727;4061.735987160825;4117.2588933992165;4120.608542188487;4125.834966601303;4137.131202447459;4146.274401979642;4675.649326300541;4872.6589138760655;4881.487443818419;4884.875079340498;5025;5044.755083987664;5963.479312775215;5969.373215812364;5976.282846058414;5997.850053748692;1348.595421373584;1374.9656258593616;1457.8104846369904;1462.9707405851823;1474.4913005013252;799.9001373111971;829.7178959153796;912.5346073502561;925.9536723502399;985.5367977050774;4829;4938.777755001033;5435.097715799518;5553.1670249462095;5608.775648974077;5157.793688252428;5559.8888022239325;5976.8804623908145;6034.6982650867285;6082.878342433215;4648.651351148677;5247.317848679723;5517.889642207133;5541.251930989265;5550.888982220333;2878.625778648762;2944.954541137908;3136.2786559091537;3160.288934989655;3161.762867784925;5960.956832554286;6292.577357717312;6337.461315788118;6339;6355.586886852339;5068.16375298079;5982.384756115911;6273.749050038039;6301.991681330965;6318.325643704422;5029.723365214948;5059.241113832881;5568.888622227614;5930.250576080067;5936.90353655976;5422.566194704493;5946.048632218824;6023.66869822164;6049.546284028627;6065.150878877049;5142.382914050338;5422.891542169214;6127.3259941407305;6199.659018754011;6244.313125556276;5692.612895327274;6003.3996600339615;6028.884656338591;6502.674866256573;6545.901811472737;4042.6159514846045;4046.1907618475834;4058.939115913323;4075;4083.5099788025627;5111.616628752784;5895.94104058954;6228.28374736893;6229.159063526366;6243.313235543996;5837.620554663933;6025.367336429612;6041.456268935817;6076.240469941257;6081.840946463942;5240.816571419982;5355.928814237091;5477.835664930059;5988.311344195473;5996.580239383376;4684.601808846286;4833.4441539223435;5305.522502974751;5821.621594596338;5877.882442351214;5958.821235362946;5974.462298393166;5988.910166347596;5994.220751302303;6009.248843894513;4658.440987081572;5842.737076831468;5878;5907.1308293068105;5925.40745925404 22:26:32 INFO - PROCESS | 1664 | |5;yui.html;730.7734602273296;762.7864198024554;788.4953629677008;858.8840506531624;879.5690111845198;16121.193940302983;16195;16408;16416.015039097663;16444.75332870008;14817.18505482198;14912.030718003349;14923.17922514264;14927.104373737584;14929.104253744756;701.7087908517972;873.7728190670408;879.4986857491233;912.7991841794794;927.6289484206304;874.9518776467291;902.3322741171519;913.7030465098836;915.5971372596036;919.1773362840254;813.9796505087361;918.6509126531942;918.7749001494643;946.820104180207;963.8698775665266;959.2805395953035;961.8268711631904;963.8361478548663;963.9469829159393;966.9661561845337;701.1411021498674;718.6442710858106;719.061624579923;721.156247190788;721.6644260418931;15036.699266014728;15267.923660381739;15268.770968435483;15278.770818437732;15390.769138462932;9850.359726617748;10535.84196237057;13450.327483625877;14195.716085678228;15200.695986080216;11768.764624707457;13251;13265.933670331684;13373.933130334286;13616.114952528054;3596.604373518911;4686.437627484724;4708;4766.38037055184;4898.951010489885;101877;104606;105196;105603.41594876083;105690.99999999923;11110.888891110986;11240.269382490113;11246.606368777053;11620.418979051183;11630.709232269091;21549.060584547467;21609.891950540146;21723.913804310036;21929.780702193093;21935.451613709465;8105.473144245723;8156;8164.020317561931;8276.29651479619;8309.293710034715;4558.475775285885;4604.88487787808;4605.585497305258;4609.93085103717;4626.907461850744;3432.262063656326;3516.894493165209;3546.8295462497313;3562.946555801665;3563.679268865763;654.5385503220218;657.756839573207;662.0565693886193;662.29134825736;667.6061123936901;574.7643466178847;599.6012651586645;634.3276127305071;639.3446717114902;643.5366536094004;9233.036585608854;9288.164065234161;9369.906300936904;9377.812443751087;9407.952960235156;620.1472974659843;634.9777757778455;639.8496353356958;640.215735723744;654.3554598720257;4412.602865742098;4450.488193857748;4540.296254080623;4564.210275431568;4587.564181402761;150560;152836;155375.4462455361;155413.89172216493;156538;105530;115591.42204288924;116775.6644867098;129129;129425.70574294325;98804;100636;100743;109876.35185472065;111007;10014.227864726061;10077.949610251902;10078.8488172676;10244.795104098026;10419.218558608287;48943.26585101298;56551.151732724866;58245.417545824;58913;65896;58964.410355897606;64620;74375.25624743683;83577;94599.58100628633;13557.457701691821;13594.660133496742;13816.378262978391;14356.641083972985;14379.712405752036;15211.239438027833;15280.465183718516;15304.846951530342;15310.004849684736;16032.919835401215;13868.445262189804;13974.930125349309;13986.44054237819;14042.859571404155;14369.9281503596;14038.929805350908;14268.785968210694;14478.203698796668;14550.417983280973;14751.704965900837;13765.655858603615;13771.967102467555;13952.790708139182;14293.785593216318;14426.06230595008;11366;11476.713082173012;11896.345700986183;12052.089708948586;12059.75880482403;10330.690079297634;10518.842217366899;10748;11796.528138874692;11818.763624727286 22:26:32 INFO - PROCESS | 1664 | __end_tp_report 22:26:32 INFO - PROCESS | 1664 | __start_cc_report 22:26:32 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,437 22:26:32 INFO - PROCESS | 1664 | __end_cc_report 22:26:32 INFO - PROCESS | 1664 | __startTimestamp1468992392886__endTimestamp 22:26:32 INFO - PROCESS | 1664 | 22:26:32 INFO - PROCESS | 1664 | ------- Summary: start ------- 22:26:32 INFO - PROCESS | 1664 | Number of tests: 6 22:26:32 INFO - PROCESS | 1664 | 22:26:32 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5756.21 Median:6002.37 stddev:808.65 (13.5%) stddev-sans-first:777.44 22:26:32 INFO - PROCESS | 1664 | Values: 2811.5 3365.2 3383.5 3404.3 3413.7 5798.6 5897.7 5917.1 5924.1 5937.3 5705.7 5790.1 5806.2 5829.5 5897.1 5212.6 5257.6 5382.2 5384.8 5404.2 233.9 5256.1 5309.8 5346.1 5357.1 5324.7 5337.1 5345.4 5366.1 5375.5 5350.0 5374.5 5390.6 5392.7 5398.4 5237.5 5242.9 5272.4 5320.0 5327.0 4614.6 5829.2 5912.0 5941.8 5986.4 6138.6 6229.8 6274.4 6288.1 6301.2 6224.9 6241.2 6267.2 6323.6 6346.7 5896.4 5956.3 5963.8 5969.0 6002.4 6229.9 6273.9 6384.7 6387.4 6436.9 6189.2 6226.3 6245.5 6259.8 6262.6 5286.6 5371.3 5866.9 6265.0 6355.9 6268.6 6283.8 6303.2 6336.2 6356.0 6274.3 6315.1 6319.3 6325.9 6328.5 5014.9 5059.1 5061.7 5064.5 5070.9 4446.9 4485.5 4520.5 4560.5 4574.1 5347.5 5455.4 5852.7 5911.8 5916.2 5196.7 6203.1 6288.6 6292.2 6304.7 5042.9 5191.8 5590.8 5871.8 6032.7 4589.6 4922.3 5497.3 5527.1 5581.8 6519.7 6532.2 6533.3 6537.1 6547.6 6280.6 6301.3 6304.8 6313.4 6367.0 5305.6 6309.5 6410.1 6568.9 6580.9 6270.7 6292.9 6304.2 6306.8 6310.9 6280.0 6296.3 6310.7 6320.5 6352.4 5092.5 6050.4 6187.4 6193.6 6230.7 6268.7 6272.2 6272.5 6299.9 6304.5 5263.8 5529.5 5721.9 6030.8 6181.5 6097.5 6185.9 6243.4 6263.2 6304.3 6130.4 6178.5 6196.4 6199.1 6201.8 22:26:32 INFO - PROCESS | 1664 | 22:26:32 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:68928.74 Median:40497.29 stddev:152896.40 (377.5%) stddev-sans-first:153238.96 22:26:32 INFO - PROCESS | 1664 | Values: 487.4 499.8 519.8 542.7 570.3 38203.6 40645.6 40696.8 40746.8 40792.6 41447.0 42145.9 42155.4 42227.8 42239.6 9553.5 9681.5 9700.8 9709.0 9744.6 9662.9 9782.8 9787.3 9791.8 9823.4 9753.3 9795.6 9804.5 9840.8 9870.5 8336.7 9720.0 9789.4 9792.1 9794.1 9029.7 9039.6 9565.6 9649.0 9659.2 39593.4 39934.6 40106.6 40175.2 40349.0 3433.2 3505.1 3507.8 3558.6 3672.6 25724.0 31766.2 32309.0 32489.2 32616.7 3302.0 3315.8 3332.7 3387.3 3430.0 491467.0 492899.5 493909.0 497880.0 499046.0 33289.0 34125.1 55021.7 55333.0 55744.0 34734.8 34846.0 35187.0 35213.5 35228.3 14876.4 15014.9 15037.7 15059.6 15072.4 12608.7 12776.2 12804.7 12861.7 12907.4 7697.4 7746.8 7754.5 7803.5 7814.2 3220.6 3223.1 3227.8 3244.6 3266.5 957.4 966.1 1023.7 1048.5 1086.4 30441.8 30562.2 30900.1 31011.4 31020.7 985.3 1079.3 1108.3 1137.2 1200.0 15022.3 16016.3 16172.4 16345.0 16650.0 637102.0 640688.0 643222.0 652216.0 652896.5 57639.7 57699.0 57792.4 58271.7 58332.4 1392.2 1418.5 1425.4 1437.3 1445.2 30360.8 30524.5 30564.4 31245.7 31420.0 49550.8 50855.5 50879.0 50888.0 51254.0 553639.0 560937.0 565916.0 567777.0 571558.0 26150.9 26963.0 27278.2 27321.7 27347.3 48031.5 48840.0 49119.0 49263.8 49289.8 40649.2 40686.0 40874.0 41145.6 41490.8 40176.4 40233.0 40831.0 41271.2 41568.2 38624.0 39051.6 39471.6 39543.2 41030.6 32430.4 34810.7 35009.3 35235.6 35413.6 25676.2 25985.1 26280.8 26319.7 26628.5 22:26:32 INFO - PROCESS | 1664 | 22:26:32 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35447.67 Median:1368.47 stddev:100019.43 (7308.9%) stddev-sans-first:100265.36 22:26:32 INFO - PROCESS | 1664 | Values: 384.3 384.5 388.6 396.8 410.1 20237.0 21429.8 21760.9 22440.0 22685.4 19239.4 20220.5 20605.8 21008.9 21628.1 4702.3 5139.7 5600.7 6081.7 6090.4 4130.3 5273.8 5923.9 6253.8 6556.7 6489.7 6566.5 6576.4 6579.7 6596.1 6435.0 6562.8 6568.8 6580.8 6589.2 5013.2 5339.9 5355.9 5694.7 5764.1 12391.6 12590.3 13497.5 13712.9 13750.4 2177.6 2255.9 2272.3 2286.6 2352.7 10053.4 10125.8 10231.5 10285.4 10451.2 1654.3 1869.7 1908.1 1930.3 1953.4 123310.5 126816.1 130155.0 135594.0 135857.3 9320.6 11652.0 11810.4 11837.7 11926.8 14675.8 14711.6 14738.4 14741.7 14842.6 8557.1 8602.1 8675.0 8675.4 8751.7 8499.5 8556.4 8666.8 8717.6 8736.6 4130.9 4496.8 4510.9 4586.3 4625.8 1682.2 1847.5 1976.5 1980.4 2023.5 777.8 920.6 924.3 940.4 1047.6 21164.5 21706.0 21708.7 21925.7 21997.8 941.5 949.4 954.6 968.9 1066.7 8701.2 11214.3 11543.4 11562.8 11616.6 577757.0 589188.0 590216.0 610060.0 610362.0 128010.4 129201.7 135597.0 135838.3 138365.6 962.7 976.9 977.1 983.9 1008.5 17485.3 19026.6 19395.4 19436.8 19546.8 56011.4 57226.4 57312.0 57747.7 58635.0 81753.2 82503.0 82695.0 82777.6 83458.0 6398.6 8335.5 8338.8 8491.6 8498.6 12375.4 13307.8 13333.6 13532.9 13602.7 9360.5 11380.8 11489.9 11584.5 11619.8 9624.0 11410.8 11452.3 11541.7 11618.9 9718.5 11758.7 11828.6 11962.8 11973.2 6634.1 6735.5 7631.2 7664.8 8452.6 8392.0 9397.6 10867.3 11596.8 11793.3 22:26:32 INFO - PROCESS | 1664 | 22:26:32 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5752.36 Median:4972.50 stddev:3216.20 (64.7%) stddev-sans-first:3209.86 22:26:32 INFO - PROCESS | 1664 | Values: 1568.4 1615.0 1863.6 1940.6 1947.5 7994.1 8638.3 8663.9 9145.5 9145.9 8673.8 8780.7 8893.8 8906.6 8919.3 2005.0 2375.1 2386.8 2411.5 2421.7 2380.5 2403.4 2429.4 2431.3 2432.9 2394.3 2416.2 2421.5 2425.3 2439.0 2398.1 2408.9 2414.6 2418.0 2430.3 2385.0 2394.2 2400.3 2400.8 2407.4 8889.0 8975.0 9049.7 9053.6 9063.4 5297.9 5385.8 5453.2 5461.8 5464.7 3553.4 3655.7 3695.2 3702.2 3737.5 1086.5 1087.6 1100.0 1105.2 1119.8 9877.8 11711.5 11898.9 11901.0 11948.3 4460.0 4518.1 4666.6 4701.4 4705.0 9309.9 9324.8 9352.0 9358.5 9365.2 5256.2 5264.7 5323.0 5323.7 5326.2 4414.2 4825.0 4970.7 4974.4 4975.8 3730.0 3774.8 3796.9 3840.8 3845.1 1143.4 1155.7 1159.9 1166.3 1175.7 860.2 900.7 963.5 976.8 995.3 5946.6 6059.2 6150.2 6164.2 6246.8 435.6 443.8 444.7 449.0 471.4 4030.4 4144.8 4163.0 4192.6 4225.7 10274.7 10533.9 10715.2 10760.3 10906.6 9140.9 10634.5 10835.6 10900.8 10910.3 6733.5 6876.5 7317.9 7393.4 8076.3 6012.7 6111.1 6177.9 6245.5 6269.6 9916.4 10233.7 10295.6 10313.1 10353.0 10431.7 10505.5 10537.6 10599.5 10607.7 7115.0 7553.6 7767.5 7798.2 7799.5 8658.0 8679.0 8731.1 8742.8 8758.9 7600.9 7812.7 7831.2 7842.8 7868.9 7512.4 7590.0 7604.5 7696.8 7758.7 7126.6 7152.8 7201.4 7206.0 7208.2 4454.8 4993.4 5120.7 5186.5 5196.6 5079.2 5099.5 5131.5 5318.7 5334.5 22:26:32 INFO - PROCESS | 1664 | 22:26:32 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4776.46 Median:5374.44 stddev:1471.36 (27.4%) stddev-sans-first:1436.79 22:26:32 INFO - PROCESS | 1664 | Values: 310.1 314.6 321.9 325.3 329.5 4488.4 5611.4 5646.5 5662.0 5746.0 5072.0 5450.8 5594.7 5606.5 5625.6 3659.9 3978.7 4047.3 4216.5 4220.9 4031.0 4183.5 4231.3 4251.3 4260.2 3856.9 4227.0 4230.9 4239.3 4258.7 4098.2 4212.2 4224.3 4242.0 4261.3 3620.3 3635.8 3664.2 3677.2 3681.8 5393.0 5397.4 5411.2 5424.6 5476.3 4432.2 4647.6 4874.9 4921.9 4933.3 5044.8 5283.8 5541.8 5874.9 5899.4 3524.6 4039.9 4057.2 4068.5 4079.3 5827.3 5895.8 6210.7 6238.5 6275.7 4016.4 4034.6 4053.4 4061.3 4061.7 4117.3 4120.6 4125.8 4137.1 4146.3 4675.6 4872.7 4881.5 4884.9 5025.0 5044.8 5963.5 5969.4 5976.3 5997.9 1348.6 1375.0 1457.8 1463.0 1474.5 799.9 829.7 912.5 926.0 985.5 4829.0 4938.8 5435.1 5553.2 5608.8 5157.8 5559.9 5976.9 6034.7 6082.9 4648.7 5247.3 5517.9 5541.3 5550.9 2878.6 2945.0 3136.3 3160.3 3161.8 5961.0 6292.6 6337.5 6339.0 6355.6 5068.2 5982.4 6273.7 6302.0 6318.3 5029.7 5059.2 5568.9 5930.3 5936.9 5422.6 5946.0 6023.7 6049.5 6065.2 5142.4 5422.9 6127.3 6199.7 6244.3 5692.6 6003.4 6028.9 6502.7 6545.9 4042.6 4046.2 4058.9 4075.0 4083.5 5111.6 5895.9 6228.3 6229.2 6243.3 5837.6 6025.4 6041.5 6076.2 6081.8 5240.8 5355.9 5477.8 5988.3 5996.6 4684.6 4833.4 5305.5 5821.6 5877.9 5958.8 5974.5 5988.9 5994.2 6009.2 4658.4 5842.7 5878.0 5907.1 5925.4 22:26:32 INFO - PROCESS | 1664 | 22:26:32 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:24086.34 Median:21826.85 stddev:37927.07 (173.8%) stddev-sans-first:37992.93 22:26:32 INFO - PROCESS | 1664 | Values: 730.8 762.8 788.5 858.9 879.6 16121.2 16195.0 16408.0 16416.0 16444.8 14817.2 14912.0 14923.2 14927.1 14929.1 701.7 873.8 879.5 912.8 927.6 875.0 902.3 913.7 915.6 919.2 814.0 918.7 918.8 946.8 963.9 959.3 961.8 963.8 963.9 967.0 701.1 718.6 719.1 721.2 721.7 15036.7 15267.9 15268.8 15278.8 15390.8 9850.4 10535.8 13450.3 14195.7 15200.7 11768.8 13251.0 13265.9 13373.9 13616.1 3596.6 4686.4 4708.0 4766.4 4899.0 101877.0 104606.0 105196.0 105603.4 105691.0 11110.9 11240.3 11246.6 11620.4 11630.7 21549.1 21609.9 21723.9 21929.8 21935.5 8105.5 8156.0 8164.0 8276.3 8309.3 4558.5 4604.9 4605.6 4609.9 4626.9 3432.3 3516.9 3546.8 3562.9 3563.7 654.5 657.8 662.1 662.3 667.6 574.8 599.6 634.3 639.3 643.5 9233.0 9288.2 9369.9 9377.8 9408.0 620.1 635.0 639.8 640.2 654.4 4412.6 4450.5 4540.3 4564.2 4587.6 150560.0 152836.0 155375.4 155413.9 156538.0 105530.0 115591.4 116775.7 129129.0 129425.7 98804.0 100636.0 100743.0 109876.4 111007.0 10014.2 10077.9 10078.8 10244.8 10419.2 48943.3 56551.2 58245.4 58913.0 65896.0 58964.4 64620.0 74375.3 83577.0 94599.6 13557.5 13594.7 13816.4 14356.6 14379.7 15211.2 15280.5 15304.8 15310.0 16032.9 13868.4 13974.9 13986.4 14042.9 14369.9 14038.9 14268.8 14478.2 14550.4 14751.7 13765.7 13772.0 13952.8 14293.8 14426.1 11366.0 11476.7 11896.3 12052.1 12059.8 10330.7 10518.8 10748.0 11796.5 11818.8 22:26:32 INFO - PROCESS | 1664 | -------- Summary: end -------- 22:26:32 INFO - PROCESS | 1664 | 22:26:33 INFO - TEST-INFO | 1664: exit 0 22:26:33 INFO - TEST-OK | dromaeo_css | took 1111962ms 22:26:33 INFO - TEST-START | kraken 22:26:33 INFO - operating with platform_type : mac_ 22:26:33 INFO - Initialising browser for kraken test... 22:26:33 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpk4rhtG/profile http://localhost:49271/getInfo.html) 22:26:36 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 22:26:36 INFO - PROCESS | 1673 | colorDepth:24 22:26:36 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 22:26:36 INFO - PROCESS | 1673 | __metrics 22:26:36 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:26:37 INFO - TEST-INFO | 1673: exit 0 22:26:37 INFO - Browser initialized. 22:26:37 INFO - Running cycle 1/1 for kraken test... 22:26:37 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpk4rhtG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:49 INFO - PROCESS | 1675 | RSS: Main: 254509056 22:26:49 INFO - PROCESS | 1675 | 22:26:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:53 INFO - PROCESS | 1675 | RSS: Main: 267493376 22:26:53 INFO - PROCESS | 1675 | 22:26:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 22:26:56 INFO - PROCESS | 1675 | RSS: Main: 271515648 22:26:56 INFO - PROCESS | 1675 | 22:26:59 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 22:27:00 INFO - PROCESS | 1675 | RSS: Main: 271761408 22:27:00 INFO - PROCESS | 1675 | 22:27:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 22:27:02 INFO - PROCESS | 1675 | RSS: Main: 272736256 22:27:02 INFO - PROCESS | 1675 | 22:27:04 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:05 INFO - PROCESS | 1675 | RSS: Main: 273379328 22:27:05 INFO - PROCESS | 1675 | 22:27:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:09 INFO - PROCESS | 1675 | RSS: Main: 274055168 22:27:09 INFO - PROCESS | 1675 | 22:27:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 22:27:12 INFO - PROCESS | 1675 | RSS: Main: 274116608 22:27:12 INFO - PROCESS | 1675 | 22:27:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 22:27:16 INFO - PROCESS | 1675 | RSS: Main: 274456576 22:27:16 INFO - PROCESS | 1675 | 22:27:18 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:18 INFO - PROCESS | 1675 | RSS: Main: 274206720 22:27:18 INFO - PROCESS | 1675 | 22:27:20 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:21 INFO - PROCESS | 1675 | RSS: Main: 274198528 22:27:21 INFO - PROCESS | 1675 | 22:27:23 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:24 INFO - PROCESS | 1675 | RSS: Main: 274251776 22:27:24 INFO - PROCESS | 1675 | 22:27:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:27:27 INFO - PROCESS | 1675 | RSS: Main: 274362368 22:27:27 INFO - PROCESS | 1675 | 22:27:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:30 INFO - PROCESS | 1675 | RSS: Main: 274366464 22:27:30 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 22:27:32 INFO - PROCESS | 1675 | RSS: Main: 275378176 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | __start_tp_report 22:27:32 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 22:27:32 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 22:27:32 INFO - PROCESS | 1675 | |i|pagename|runs| 22:27:32 INFO - PROCESS | 1675 | |0;ai-astar;103;117;107;116;118;118;113;117;115;115 22:27:32 INFO - PROCESS | 1675 | |1;audio-beat-detection;142;109;130;154;108;130;129;114;205;120 22:27:32 INFO - PROCESS | 1675 | |2;audio-dft;199;185;247;221;272;216;193;198;195;199 22:27:32 INFO - PROCESS | 1675 | |3;audio-fft;74;74;70;107;51;59;83;61;126;50 22:27:32 INFO - PROCESS | 1675 | |4;audio-oscillator;70;85;144;70;79;70;140;104;104;122 22:27:32 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;89;88;76;129;93;89;137;86;89;85 22:27:32 INFO - PROCESS | 1675 | |6;imaging-darkroom;123;95;95;98;104;96;98;162;99;154 22:27:32 INFO - PROCESS | 1675 | |7;imaging-desaturate;89;93;97;121;91;92;89;90;92;93 22:27:32 INFO - PROCESS | 1675 | |8;json-parse-financial;51;74;72;75;80;86;89;85;53;54 22:27:32 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;66;69;74;71;72;75;76;69;71;70 22:27:32 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;84;82;84;81;86;81;84;86;85;87 22:27:32 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;140;134;140;141;133;135;134;137;184;158 22:27:32 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;164;176;166;165;168;164;165;169;165;168 22:27:32 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;65;68;68;66;68;65;66;66;70;90 22:27:32 INFO - PROCESS | 1675 | __end_tp_report 22:27:32 INFO - PROCESS | 1675 | __start_cc_report 22:27:32 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1122 22:27:32 INFO - PROCESS | 1675 | __end_cc_report 22:27:32 INFO - PROCESS | 1675 | __startTimestamp1468992452855__endTimestamp 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | ------- Summary: start ------- 22:27:32 INFO - PROCESS | 1675 | Number of tests: 14 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:113.90 Median:116.50 stddev:5.02 (4.3%) stddev-sans-first:3.44 22:27:32 INFO - PROCESS | 1675 | Values: 103.0 117.0 107.0 116.0 118.0 118.0 113.0 117.0 115.0 115.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:130.00 stddev:28.79 (22.1%) stddev-sans-first:30.39 22:27:32 INFO - PROCESS | 1675 | Values: 142.0 109.0 130.0 154.0 108.0 130.0 129.0 114.0 205.0 120.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:212.50 Median:207.50 stddev:27.55 (13.3%) stddev-sans-first:28.79 22:27:32 INFO - PROCESS | 1675 | Values: 199.0 185.0 247.0 221.0 272.0 216.0 193.0 198.0 195.0 199.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:75.50 Median:65.50 stddev:24.42 (37.3%) stddev-sans-first:25.89 22:27:32 INFO - PROCESS | 1675 | Values: 74.0 74.0 70.0 107.0 51.0 59.0 83.0 61.0 126.0 50.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:70.00 stddev:28.68 (41.0%) stddev-sans-first:28.46 22:27:32 INFO - PROCESS | 1675 | Values: 70.0 85.0 144.0 70.0 79.0 70.0 140.0 104.0 104.0 122.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:88.50 stddev:20.03 (22.6%) stddev-sans-first:21.08 22:27:32 INFO - PROCESS | 1675 | Values: 89.0 88.0 76.0 129.0 93.0 89.0 137.0 86.0 89.0 85.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:112.40 Median:95.50 stddev:25.48 (26.7%) stddev-sans-first:26.73 22:27:32 INFO - PROCESS | 1675 | Values: 123.0 95.0 95.0 98.0 104.0 96.0 98.0 162.0 99.0 154.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:92.00 stddev:9.53 (10.4%) stddev-sans-first:9.89 22:27:32 INFO - PROCESS | 1675 | Values: 89.0 93.0 97.0 121.0 91.0 92.0 89.0 90.0 92.0 93.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:77.50 stddev:14.36 (18.5%) stddev-sans-first:13.09 22:27:32 INFO - PROCESS | 1675 | Values: 51.0 74.0 72.0 75.0 80.0 86.0 89.0 85.0 53.0 54.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.06 (4.3%) stddev-sans-first:2.57 22:27:32 INFO - PROCESS | 1675 | Values: 66.0 69.0 74.0 71.0 72.0 75.0 76.0 69.0 71.0 70.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.50 stddev:2.11 (2.5%) stddev-sans-first:2.24 22:27:32 INFO - PROCESS | 1675 | Values: 84.0 82.0 84.0 81.0 86.0 81.0 84.0 86.0 85.0 87.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:140.00 stddev:15.94 (11.4%) stddev-sans-first:16.85 22:27:32 INFO - PROCESS | 1675 | Values: 140.0 134.0 140.0 141.0 133.0 135.0 134.0 137.0 184.0 158.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.00 stddev:3.62 (2.2%) stddev-sans-first:3.67 22:27:32 INFO - PROCESS | 1675 | Values: 164.0 176.0 166.0 165.0 168.0 164.0 165.0 169.0 165.0 168.0 22:27:32 INFO - PROCESS | 1675 | 22:27:32 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.00 stddev:7.48 (11.0%) stddev-sans-first:7.78 22:27:32 INFO - PROCESS | 1675 | Values: 65.0 68.0 68.0 66.0 68.0 65.0 66.0 66.0 70.0 90.0 22:27:32 INFO - PROCESS | 1675 | -------- Summary: end -------- 22:27:32 INFO - PROCESS | 1675 | 22:27:33 INFO - TEST-INFO | 1675: exit 0 22:27:33 INFO - TEST-OK | kraken | took 60074ms 22:27:33 INFO - SUITE-END | took 1172s 22:27:33 INFO - Completed test suite (00:19:32) 22:27:33 INFO - javascript benchmark 22:27:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7370.694620349142, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2811.5220412529866, 3365.1587103224188, 3383.5263063171174, 3404.3021180657965, 3413.7098346640532, 5798.56510761693, 5897.705114744267, 5917.142014407914, 5924.140999555062, 5937.317208521022, 5705.714714264281, 5790.10253410721, 5806.158107074471, 5829.533637309016, 5897.085951677486, 5212.635115541904, 5257.579393648499, 5382.2195781611645, 5384.757685904124, 5404.189371594272, 233.85325531957398, 5256.08018596744, 5309.761060752276, 5346.144616861303, 5357.08929481989, 5324.733763311839, 5337.119375303089, 5345.358556973188, 5366.114591092465, 5375.516203541661, 5350.0, 5374.543163831079, 5390.622656414013, 5392.73036348181, 5398.379186393537, 5237.502437268454, 5242.947570524322, 5272.446393128705, 5320.015797077514, 5327.0, 4614.630829533629, 5829.154772557998, 5911.970440147815, 5941.762329506814, 5986.401359864022, 6138.633639632414, 6229.750809967596, 6274.435300822902, 6288.056791481269, 6301.180846489973, 6224.906626400608, 6241.157443745127, 6267.1539342189135, 6323.557350985433, 6346.714397852108, 5896.410358964112, 5956.285245770535, 5963.791267305667, 5969.015112506475, 6002.3697511761075, 6229.937700622936, 6273.905891411632, 6384.7126879290545, 6387.425131738166, 6436.903446448307, 6189.164462797555, 6226.346233645492, 6245.500359971192, 6259.843503912348, 6262.624242545462, 5286.629935904527, 5371.274877891513, 5866.914620795166, 6265.0, 6355.904661430082, 6268.561200715997, 6283.8114856554375, 6303.180586523723, 6336.17629708135, 6355.951268040814, 6274.341194174637, 6315.052742088724, 6319.304876463585, 6325.8734825304155, 6328.46208072319, 5014.89970200594, 5059.139946209153, 5061.746912654353, 5064.46823083571, 5070.873228169252, 4446.933296000562, 4485.529019452975, 4520.4575450946095, 4560.475545312332, 4574.085182963354, 5347.465253474699, 5455.372632147354, 5852.678102704307, 5911.822645320647, 5916.23088998436, 5196.68819870809, 6203.131561581382, 6288.5598008138995, 6292.2134733158355, 6304.6847657617855, 5042.949570504321, 5191.792328306901, 5590.804321848797, 5871.823845284648, 6032.6983650818165, 4589.58693717567, 4922.261660750916, 5497.340319161726, 5527.115661494142, 5581.776728930879, 6519.7392104315295, 6532.183477065367, 6533.281339052701, 6537.052127441494, 6547.574407663486, 6280.623162610258, 6301.275353334242, 6304.810855674337, 6313.3686631336495, 6366.96816515933, 5305.628605997543, 6309.526785491198, 6410.134631824644, 6568.9014664781025, 6580.934190658032, 6270.6551139685935, 6292.874142517033, 6304.211973503312, 6306.810795676137, 6310.873782524415, 6280.026595877646, 6296.33888441707, 6310.652914089769, 6320.462760665211, 6352.36476352361, 5092.516210959953, 6050.364711705208, 6187.443130118311, 6193.566450348432, 6230.6884655767935, 6268.655223962726, 6272.153259309935, 6272.498200143887, 6299.874002520016, 6304.527160463075, 5263.763015691233, 5529.529989950899, 5721.884232574608, 6030.819075427744, 6181.474574661204, 6097.494431795148, 6185.938140618537, 6243.438090571689, 6263.217097862767, 6304.3380445054445, 6130.356312587114, 6178.474829639531, 6196.411340922605, 6199.1011303359855, 6201.81394558164], "value": 5706.742424215943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.376158517098, 499.8125702861427, 519.8388499565133, 542.6608369768893, 570.3327107284476, 38203.617963820354, 40645.59354406455, 40696.79651601738, 40746.79626601867, 40792.59207407925, 41447.0, 42145.946351341154, 42155.367669484905, 42227.78886105573, 42239.577604223945, 9553.522323883795, 9681.51592420376, 9700.805983880318, 9708.951455242714, 9744.561494732754, 9662.90337096627, 9782.755431114208, 9787.314887957846, 9791.804163916717, 9823.410595364265, 9753.268504862164, 9795.559199836025, 9804.509774511282, 9840.803183936318, 9870.45712485813, 8336.666533338659, 9719.95140024299, 9789.412635241873, 9792.118709316124, 9794.118529332358, 9029.735836982827, 9039.638414463414, 9565.617375304979, 9648.951755241249, 9659.178969787576, 39593.40609890854, 39934.60065399367, 40106.59893401058, 40175.19649606991, 40348.99127521835, 3433.1588760753775, 3505.1237190702323, 3507.824608769551, 3558.6085530591613, 3672.6143754905615, 25724.0, 31766.205844853834, 32309.0, 32489.187770305933, 32616.673833261837, 3301.983490082534, 3315.784474009182, 3332.7167190788814, 3387.2548039431285, 3430.0, 491466.96931668743, 492899.53550232376, 493909.0, 497880.0, 499046.0, 33289.0, 34125.14687132841, 55021.724891375285, 55333.0, 55744.0, 34734.826325868715, 34846.0, 35187.0, 35213.47179792305, 35228.295434091684, 14876.404943802127, 15014.924925375522, 15037.699246015238, 15059.623509412353, 15072.397104115713, 12608.684782880502, 12776.169548979287, 12804.679883003, 12861.678458038437, 12907.354632268349, 7697.384209263246, 7746.767596972099, 7754.542508910478, 7803.492772969739, 7814.179511151361, 3220.62962759281, 3223.129754966193, 3227.7579181561478, 3244.6106467224085, 3266.4810862948366, 957.4111921168432, 966.1063516247443, 1023.7133602591286, 1048.4967215736337, 1086.413336798136, 30441.847790760905, 30562.235944101132, 30900.0729978101, 31011.379772404427, 31020.68979310178, 985.261054209343, 1079.2930630437077, 1108.3349990005931, 1137.181229514748, 1199.974022210997, 15022.323995420233, 16016.279267432994, 16172.353105875633, 16345.0, 16650.000999940043, 637102.0, 640688.0, 643222.0, 652216.0, 652896.4710352931, 57639.711801440724, 57699.0, 57792.422075778704, 58271.70864145652, 58332.41667583355, 1392.234271150863, 1418.5177039806515, 1425.3942074618246, 1437.3388241409068, 1445.169027809035, 30360.84819575888, 30524.542131868486, 30564.388712225187, 31245.687543124277, 31420.0, 49550.76123096807, 50855.49144508508, 50879.0, 50887.98224035424, 51254.0, 553639.0, 560937.0, 565916.0, 567777.0, 571558.0, 26150.86924565365, 26963.0, 27278.181654550393, 27321.72678273192, 27347.31631709223, 48031.519684802704, 48840.02319953652, 49119.0, 49263.75368123136, 49289.767755806395, 40649.21133139936, 40686.0, 40873.97815054647, 41145.58854411417, 41490.792546037075, 40176.39735403913, 40233.0, 40831.0, 41271.1745765089, 41568.16863662649, 38624.0, 39051.609483904795, 39471.605283947945, 39543.2091358177, 41030.58969410387, 32430.351392971537, 34810.65189348176, 35009.29981400409, 35235.64764352324, 35413.645863542064, 25676.229713108638, 25985.090521831644, 26280.817363219085, 26319.736802632495, 26628.467430651664], "value": 18882.73293920579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.267969518068, 384.4771111288647, 388.61721204613457, 396.83333000139936, 410.0834634591687, 20237.0, 21429.785702143014, 21760.89119554402, 22440.0, 22685.432864178405, 19239.42281731547, 20220.483463740242, 20605.763654180722, 21008.89495552524, 21628.134874605035, 4702.341672165891, 5139.665921715076, 5600.747966341524, 6081.726322315484, 6090.390960903918, 4130.339145736668, 5273.76268067936, 5923.940760592382, 6253.8123856284155, 6556.672166391685, 6489.707963141646, 6566.5075119366, 6576.375244351779, 6579.736810527573, 6596.076549283104, 6434.9678251608675, 6562.835929101763, 6568.835779105513, 6580.80257592273, 6589.17635295588, 5013.197888337849, 5339.866503337447, 5355.919661205085, 5694.715264236772, 5764.135379693038, 12391.566295179715, 12590.307533085677, 13497.460101595925, 13712.862871371359, 13750.449982000708, 2177.5862586108747, 2255.92843399384, 2272.2955883676113, 2286.5998450271136, 2352.6706261123454, 10053.447060411674, 10125.848112278321, 10231.539580718885, 10285.382877027403, 10451.216158788046, 1654.2555849867488, 1869.719542068687, 1908.1031914999928, 1930.3436831477225, 1953.3504487830073, 123310.53378932372, 126816.0977585337, 130155.0, 135594.0, 135857.3207133968, 9320.580573874056, 11652.009579185695, 11810.350430726392, 11837.704057398461, 11926.761464770829, 14675.77986330206, 14711.632209194642, 14738.410463581551, 14741.705165896621, 14842.628934276729, 8557.058723540405, 8602.096779838026, 8674.95900491945, 8675.39272250949, 8751.737447876574, 8499.490030598185, 8556.358273129541, 8666.78333041679, 8717.607707653171, 8736.563171841382, 4130.946608614844, 4496.774096822029, 4510.909781804346, 4586.334981427674, 4625.791839367236, 1682.2177687375429, 1847.5104097414196, 1976.5256338478948, 1980.3563042674546, 2023.453667509764, 777.8016605765607, 920.5949382271779, 924.2790623313826, 940.4075432477632, 1047.5652604169336, 21164.47088822792, 21706.0, 21708.674369884466, 21925.671114933288, 21997.780022199895, 941.4868896451451, 949.3734135470694, 954.627695198873, 968.8546717992217, 1066.7119877633152, 8701.216890479887, 11214.271072380432, 11543.422828858524, 11562.76874462506, 11616.593419230287, 577757.0, 589188.0, 590216.0, 610060.0, 610362.0, 128010.35994819966, 129201.70798292085, 135597.0, 135838.32080839534, 138365.6163438373, 962.7352478068448, 976.8730065091635, 977.0961860279214, 983.8622592837008, 1008.5159123620704, 17485.300587976337, 19026.619467610846, 19395.418137455898, 19436.805631943498, 19546.804531955066, 56011.43988560062, 57226.42773572211, 57312.0, 57747.71126144342, 58635.0, 81753.18246817456, 82503.0, 82695.0, 82777.58611206905, 83458.0, 6398.552101353047, 8335.458195217292, 8338.791530211793, 8491.558813994712, 8498.575071246289, 12375.443105060114, 13307.80038299407, 13333.599992000256, 13532.864671353555, 13602.727945440838, 9360.485173315534, 11380.772384552098, 11489.885101148882, 11584.47869845842, 11619.76760464769, 9624.0, 11410.828837567276, 11452.312861228353, 11541.711457213636, 11618.88381116178, 9718.465484398426, 11758.70603234926, 11828.585999489977, 11962.76074478523, 11973.16187866841, 6634.137562116894, 6735.461163106842, 7631.236876312324, 7664.80837979055, 8452.577371131541, 8391.951006124234, 9397.624095036395, 10867.347959122479, 11596.768064638829, 11793.29240245588], "value": 9526.796077827259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1568.4196847166547, 1615.030981411153, 1863.608642185141, 1940.5633732410201, 1947.51312171957, 7994.080680721719, 8638.26574741147, 8663.87004194936, 9145.451272923621, 9145.862812057816, 8673.829033080532, 8780.736577902673, 8893.777655558615, 8906.599203035863, 8919.286457083434, 2004.9699254511195, 2375.0618505690327, 2386.7851893329553, 2411.4574220800355, 2421.7457166997474, 2380.4881950380664, 2403.399150212447, 2429.3683642252963, 2431.3435372449426, 2432.902683892651, 2394.2936833634035, 2416.178499310234, 2421.455172586163, 2425.2724182745196, 2439.0, 2398.0887262840183, 2408.915687950922, 2414.5653782319177, 2418.0, 2430.2952143878256, 2385.045981607371, 2394.185976767907, 2400.2559206645997, 2400.8439451435775, 2407.386116540271, 8889.0, 8975.012748597648, 9049.683261085831, 9053.59258833354, 9063.365564410495, 5297.867553311159, 5385.78456861729, 5453.23654688344, 5461.836144915659, 5464.6994415307145, 3553.4136867417105, 3655.7075433965483, 3695.224002959382, 3702.222533268017, 3737.4580685800406, 1086.5436516662942, 1087.5649740103943, 1099.9780004399947, 1105.220819322384, 1119.7872404243249, 9877.802443951081, 11711.53153873844, 11898.940505297505, 11901.0, 11948.283103013848, 4459.955400446019, 4518.1415531049, 4666.590072381635, 4701.4358277006295, 4704.95295047052, 9309.860352094724, 9324.766880827898, 9352.0, 9358.532073396304, 9365.157135857806, 5256.185291279858, 5264.657797243167, 5322.962022405671, 5323.680579165262, 5326.201069839478, 4414.183376075436, 4825.0, 4970.65205435616, 4974.353334066548, 4975.776090075955, 3729.9627003729615, 3774.7923864187733, 3796.9430458543143, 3840.7695538267794, 3845.134844659929, 1143.3768596115137, 1155.722626569634, 1159.878212787662, 1166.3351889423118, 1175.6531823112202, 860.2472836268265, 900.6982660808702, 963.4893506441457, 976.8326849414881, 995.328153496387, 5946.554008449383, 6059.212302400748, 6150.200473938449, 6164.167837341991, 6246.812595622138, 435.61012893460173, 443.8158164361818, 444.74581679663686, 448.9887752806206, 471.3565982434021, 4030.3954406839207, 4144.79276036203, 4163.042500224965, 4192.601702838226, 4225.661947044229, 10274.691759247235, 10533.894661053444, 10715.24993250465, 10760.300580462244, 10906.563737450571, 9140.862887056699, 10634.521446534924, 10835.620753273755, 10900.836487452694, 10910.345379277269, 6733.528652994341, 6876.484263680144, 7317.890231646529, 7393.445491588152, 8076.313513351313, 6012.699365031818, 6111.144439778345, 6177.938220617736, 6245.500359971101, 6269.561130720988, 9916.405015699082, 10233.692989210336, 10295.588176472857, 10313.1233845121, 10353.0, 10431.739206519898, 10505.527251273865, 10537.63118290856, 10599.523021463898, 10607.734806629896, 7115.0, 7553.622318884144, 7767.495112817649, 7798.181190974866, 7799.5320280783335, 8657.95671021666, 8678.956605216934, 8731.083236260101, 8742.781430464289, 8758.868616970878, 7600.923990760021, 7812.726554570563, 7831.17772633888, 7842.843143137219, 7868.881966770388, 7512.361449276654, 7590.0, 7604.5437273763755, 7696.807579810549, 7758.68965241384, 7126.572405655677, 7152.821179470555, 7201.3518783309755, 7206.0, 7208.207097219407, 4454.821807127679, 4993.375828021497, 5120.71836049006, 5186.533212010937, 5196.610254230872, 5079.212722028092, 5099.464556221692, 5131.538161565477, 5318.654287471302, 5334.493223143795], "value": 4553.692512878092, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.1378168691039, 314.60831265074984, 321.8583823117828, 325.34930139720575, 329.5452275859317, 4488.394066800981, 5611.438856114387, 5646.548276137909, 5662.0, 5745.971270143644, 5072.0, 5450.754716037778, 5594.692291923942, 5606.467385598362, 5625.634333768302, 3659.8719044833438, 3978.7413818101804, 4047.251258517169, 4216.515100763406, 4220.936685949713, 4030.9798451007705, 4183.477065366829, 4231.259529582326, 4251.256030194703, 4260.211860805761, 3856.8979905951323, 4226.978865105671, 4230.873073807791, 4239.2581298272835, 4258.680598955075, 4098.200850834073, 4212.199682060429, 4224.345226489899, 4241.978790106045, 4261.296886013804, 3620.348337299285, 3635.836387362575, 3664.175560498893, 3677.2277821657485, 3681.7606855554304, 5392.950678742092, 5397.379301380352, 5411.215373770781, 5424.5660347172525, 5476.315460567429, 4432.168935859928, 4647.581717645428, 4874.8537543873745, 4921.917178220786, 4933.28467372229, 5044.848654540369, 5283.788648454057, 5541.806036788734, 5874.882502349972, 5899.351071382144, 3524.647535246455, 4039.8788036358956, 4057.2494088593703, 4068.471098757172, 4079.306517891936, 5827.3007239131575, 5895.823125306248, 6210.689465526751, 6238.5009199264405, 6275.686215689243, 4016.357382818735, 4034.636882680573, 4053.3717273822604, 4061.3298805696727, 4061.735987160825, 4117.2588933992165, 4120.608542188487, 4125.834966601303, 4137.131202447459, 4146.274401979642, 4675.649326300541, 4872.6589138760655, 4881.487443818419, 4884.875079340498, 5025.0, 5044.755083987664, 5963.479312775215, 5969.373215812364, 5976.282846058414, 5997.850053748692, 1348.595421373584, 1374.9656258593616, 1457.8104846369904, 1462.9707405851823, 1474.4913005013252, 799.9001373111971, 829.7178959153796, 912.5346073502561, 925.9536723502399, 985.5367977050774, 4829.0, 4938.777755001033, 5435.097715799518, 5553.1670249462095, 5608.775648974077, 5157.793688252428, 5559.8888022239325, 5976.8804623908145, 6034.6982650867285, 6082.878342433215, 4648.651351148677, 5247.317848679723, 5517.889642207133, 5541.251930989265, 5550.888982220333, 2878.625778648762, 2944.954541137908, 3136.2786559091537, 3160.288934989655, 3161.762867784925, 5960.956832554286, 6292.577357717312, 6337.461315788118, 6339.0, 6355.586886852339, 5068.16375298079, 5982.384756115911, 6273.749050038039, 6301.991681330965, 6318.325643704422, 5029.723365214948, 5059.241113832881, 5568.888622227614, 5930.250576080067, 5936.90353655976, 5422.566194704493, 5946.048632218824, 6023.66869822164, 6049.546284028627, 6065.150878877049, 5142.382914050338, 5422.891542169214, 6127.3259941407305, 6199.659018754011, 6244.313125556276, 5692.612895327274, 6003.3996600339615, 6028.884656338591, 6502.674866256573, 6545.901811472737, 4042.6159514846045, 4046.1907618475834, 4058.939115913323, 4075.0, 4083.5099788025627, 5111.616628752784, 5895.94104058954, 6228.28374736893, 6229.159063526366, 6243.313235543996, 5837.620554663933, 6025.367336429612, 6041.456268935817, 6076.240469941257, 6081.840946463942, 5240.816571419982, 5355.928814237091, 5477.835664930059, 5988.311344195473, 5996.580239383376, 4684.601808846286, 4833.4441539223435, 5305.522502974751, 5821.621594596338, 5877.882442351214, 5958.821235362946, 5974.462298393166, 5988.910166347596, 5994.220751302303, 6009.248843894513, 4658.440987081572, 5842.737076831468, 5878.0, 5907.1308293068105, 5925.40745925404], "value": 4304.641311633012, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.7734602273296, 762.7864198024554, 788.4953629677008, 858.8840506531624, 879.5690111845198, 16121.193940302983, 16195.0, 16408.0, 16416.015039097663, 16444.75332870008, 14817.18505482198, 14912.030718003349, 14923.17922514264, 14927.104373737584, 14929.104253744756, 701.7087908517972, 873.7728190670408, 879.4986857491233, 912.7991841794794, 927.6289484206304, 874.9518776467291, 902.3322741171519, 913.7030465098836, 915.5971372596036, 919.1773362840254, 813.9796505087361, 918.6509126531942, 918.7749001494643, 946.820104180207, 963.8698775665266, 959.2805395953035, 961.8268711631904, 963.8361478548663, 963.9469829159393, 966.9661561845337, 701.1411021498674, 718.6442710858106, 719.061624579923, 721.156247190788, 721.6644260418931, 15036.699266014728, 15267.923660381739, 15268.770968435483, 15278.770818437732, 15390.769138462932, 9850.359726617748, 10535.84196237057, 13450.327483625877, 14195.716085678228, 15200.695986080216, 11768.764624707457, 13251.0, 13265.933670331684, 13373.933130334286, 13616.114952528054, 3596.604373518911, 4686.437627484724, 4708.0, 4766.38037055184, 4898.951010489885, 101877.0, 104606.0, 105196.0, 105603.41594876083, 105690.99999999923, 11110.888891110986, 11240.269382490113, 11246.606368777053, 11620.418979051183, 11630.709232269091, 21549.060584547467, 21609.891950540146, 21723.913804310036, 21929.780702193093, 21935.451613709465, 8105.473144245723, 8156.0, 8164.020317561931, 8276.29651479619, 8309.293710034715, 4558.475775285885, 4604.88487787808, 4605.585497305258, 4609.93085103717, 4626.907461850744, 3432.262063656326, 3516.894493165209, 3546.8295462497313, 3562.946555801665, 3563.679268865763, 654.5385503220218, 657.756839573207, 662.0565693886193, 662.29134825736, 667.6061123936901, 574.7643466178847, 599.6012651586645, 634.3276127305071, 639.3446717114902, 643.5366536094004, 9233.036585608854, 9288.164065234161, 9369.906300936904, 9377.812443751087, 9407.952960235156, 620.1472974659843, 634.9777757778455, 639.8496353356958, 640.215735723744, 654.3554598720257, 4412.602865742098, 4450.488193857748, 4540.296254080623, 4564.210275431568, 4587.564181402761, 150560.0, 152836.0, 155375.4462455361, 155413.89172216493, 156538.0, 105530.0, 115591.42204288924, 116775.6644867098, 129129.0, 129425.70574294325, 98804.0, 100636.0, 100743.0, 109876.35185472065, 111007.0, 10014.227864726061, 10077.949610251902, 10078.8488172676, 10244.795104098026, 10419.218558608287, 48943.26585101298, 56551.151732724866, 58245.417545824, 58913.0, 65896.0, 58964.410355897606, 64620.0, 74375.25624743683, 83577.0, 94599.58100628633, 13557.457701691821, 13594.660133496742, 13816.378262978391, 14356.641083972985, 14379.712405752036, 15211.239438027833, 15280.465183718516, 15304.846951530342, 15310.004849684736, 16032.919835401215, 13868.445262189804, 13974.930125349309, 13986.44054237819, 14042.859571404155, 14369.9281503596, 14038.929805350908, 14268.785968210694, 14478.203698796668, 14550.417983280973, 14751.704965900837, 13765.655858603615, 13771.967102467555, 13952.790708139182, 14293.785593216318, 14426.06230595008, 11366.0, 11476.713082173012, 11896.345700986183, 12052.089708948586, 12059.75880482403, 10330.690079297634, 10518.842217366899, 10748.0, 11796.528138874692, 11818.763624727286], "value": 7967.240525651755, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 107.0, 116.0, 118.0, 118.0, 113.0, 117.0, 115.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 130.0, 154.0, 108.0, 130.0, 129.0, 114.0, 205.0, 120.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 185.0, 247.0, 221.0, 272.0, 216.0, 193.0, 198.0, 195.0, 199.0], "value": 212.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 70.0, 107.0, 51.0, 59.0, 83.0, 61.0, 126.0, 50.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 85.0, 144.0, 70.0, 79.0, 70.0, 140.0, 104.0, 104.0, 122.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 76.0, 129.0, 93.0, 89.0, 137.0, 86.0, 89.0, 85.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 95.0, 95.0, 98.0, 104.0, 96.0, 98.0, 162.0, 99.0, 154.0], "value": 112.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 97.0, 121.0, 91.0, 92.0, 89.0, 90.0, 92.0, 93.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 74.0, 72.0, 75.0, 80.0, 86.0, 89.0, 85.0, 53.0, 54.0], "value": 71.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 74.0, 71.0, 72.0, 75.0, 76.0, 69.0, 71.0, 70.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 81.0, 86.0, 81.0, 84.0, 86.0, 85.0, 87.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 140.0, 141.0, 133.0, 135.0, 134.0, 137.0, 184.0, 158.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 176.0, 166.0, 165.0, 168.0, 164.0, 165.0, 169.0, 165.0, 168.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 68.0, 66.0, 68.0, 65.0, 66.0, 66.0, 70.0, 90.0], "value": 69.2, "unit": "score"}]}]} 22:27:34 INFO - Return code: 0 22:27:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:27:34 ERROR - # TBPL SUCCESS # 22:27:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:27:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:27:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:27:34 INFO - 2016-07-19 22:27:34.149 screenresolution[1680:11819] starting screenresolution argv=screenresolution get 22:27:34 INFO - 2016-07-19 22:27:34.151 screenresolution[1680:11819] Display 0: 1600x1200x32@60 22:27:34 INFO - 2016-07-19 22:27:34.157 screenresolution[1681:11822] starting screenresolution argv=screenresolution list 22:27:34 INFO - Available Modes on Display 0 22:27:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:27:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:27:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:27:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:27:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:27:34 INFO - Intel Iris: 22:27:34 INFO - Chipset Model: Intel Iris 22:27:34 INFO - Type: GPU 22:27:34 INFO - Bus: Built-In 22:27:34 INFO - VRAM (Dynamic, Max): 1536 MB 22:27:34 INFO - Vendor: Intel (0x8086) 22:27:34 INFO - Device ID: 0x0a2e 22:27:34 INFO - Revision ID: 0x0009 22:27:34 INFO - Displays: 22:27:34 INFO - Display: 22:27:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:27:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:27:34 INFO - Display Serial Number: 1600x1200 60 22:27:34 INFO - Main Display: Yes 22:27:34 INFO - Mirror: Off 22:27:34 INFO - Online: Yes 22:27:34 INFO - Rotation: Supported 22:27:34 INFO - Return code: 0 22:27:34 INFO - Running post-action listener: _resource_record_post_action 22:27:34 INFO - [mozharness: 2016-07-20 05:27:34.390701Z] Finished run-tests step (success) 22:27:34 INFO - Running post-run listener: _resource_record_post_run 22:27:34 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31480832; Write bytes: 710643712; Read time: 318; Write time: 2126 22:27:34 INFO - TinderboxPrint: CPU usage
54.2% 22:27:34 INFO - TinderboxPrint: I/O read bytes / time
31,480,832 / 318 22:27:34 INFO - TinderboxPrint: I/O write bytes / time
710,643,712 / 2,126 22:27:34 INFO - TinderboxPrint: CPU idle
2,211.4 (45.8%) 22:27:34 INFO - TinderboxPrint: CPU system
972.3 (20.1%) 22:27:34 INFO - TinderboxPrint: CPU user
1,650.0 (34.1%) 22:27:34 INFO - TinderboxPrint: Swap in / out
435,654,656 / 0 22:27:34 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408750592; Write bytes: 411731968; Read time: 30362; Write time: 999 22:27:34 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 29215744; Write bytes: 297355264; Read time: 292; Write time: 1122 22:27:34 INFO - Running post-run listener: _upload_blobber_files 22:27:34 INFO - Blob upload gear active. 22:27:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:27:34 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 22:27:34 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:27:34 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:27:35 INFO - (blobuploader) - INFO - Open directory for files ... 22:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:27:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:36 INFO - (blobuploader) - INFO - Done attempting. 22:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:27:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:37 INFO - (blobuploader) - INFO - Done attempting. 22:27:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:27:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:27:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:40 INFO - (blobuploader) - INFO - Done attempting. 22:27:40 INFO - (blobuploader) - INFO - Iteration through files over. 22:27:40 INFO - Return code: 0 22:27:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:27:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:27:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a1295b657d84c52ba9e774d272b378733df8957db5ceb62ce73fccbded4fbfa5fbb6384d15dbafc95efadedfdac3d099d72253e53469a787bfd529bea28e54e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ecc90962c4212b2a755ff69d85dc89bbb14db019f37453a5d67f8313c61fc9a55022daf60de1e23551f7950724a4759328e4e4d34307bef3aa8c3b46508669e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/86bc2ac69e1143746ac5adb832073bbdbc4e929eb8fab56b3d4466bc3e7aa9d8553bd920d2f2890c46b6604c146c09923ef86ce57cafe4fc28648cd6a84667d1"} 22:27:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:27:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:27:40 INFO - Contents: 22:27:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a1295b657d84c52ba9e774d272b378733df8957db5ceb62ce73fccbded4fbfa5fbb6384d15dbafc95efadedfdac3d099d72253e53469a787bfd529bea28e54e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ecc90962c4212b2a755ff69d85dc89bbb14db019f37453a5d67f8313c61fc9a55022daf60de1e23551f7950724a4759328e4e4d34307bef3aa8c3b46508669e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/86bc2ac69e1143746ac5adb832073bbdbc4e929eb8fab56b3d4466bc3e7aa9d8553bd920d2f2890c46b6604c146c09923ef86ce57cafe4fc28648cd6a84667d1"} 22:27:40 INFO - Running post-run listener: copy_logs_to_upload_dir 22:27:40 INFO - Copying logs to upload dir... 22:27:40 INFO - mkdir: /builds/slave/test/build/upload/logs 22:27:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1302.701675 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2016-07-19 22:27:40.777562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 22:27:40.781397) ========= 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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a1295b657d84c52ba9e774d272b378733df8957db5ceb62ce73fccbded4fbfa5fbb6384d15dbafc95efadedfdac3d099d72253e53469a787bfd529bea28e54e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ecc90962c4212b2a755ff69d85dc89bbb14db019f37453a5d67f8313c61fc9a55022daf60de1e23551f7950724a4759328e4e4d34307bef3aa8c3b46508669e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/86bc2ac69e1143746ac5adb832073bbdbc4e929eb8fab56b3d4466bc3e7aa9d8553bd920d2f2890c46b6604c146c09923ef86ce57cafe4fc28648cd6a84667d1"} build_url:https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/eASJS7L3QCumvkQbClgxYg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a1295b657d84c52ba9e774d272b378733df8957db5ceb62ce73fccbded4fbfa5fbb6384d15dbafc95efadedfdac3d099d72253e53469a787bfd529bea28e54e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ecc90962c4212b2a755ff69d85dc89bbb14db019f37453a5d67f8313c61fc9a55022daf60de1e23551f7950724a4759328e4e4d34307bef3aa8c3b46508669e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/86bc2ac69e1143746ac5adb832073bbdbc4e929eb8fab56b3d4466bc3e7aa9d8553bd920d2f2890c46b6604c146c09923ef86ce57cafe4fc28648cd6a84667d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 22:27:40.814166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 22:27:40.814493) ========= 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.vKI8x3cod7/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.Mpy2yHzC5K/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.005101 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 22:27:40.862770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 22:27:40.863120) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 22:27:40.863443) ========= ========= Total master_lag: 2.07 =========