builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0029 starttime: 1468968991.27 results: success (0) buildid: 20160719145619 builduid: a5bccaf2c2124cf3ac17a6fd442b5915 revision: 8a26f6b014e67c5829f2c2a28b82f9b28fc0737d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:31.265513) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:31.265961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:31.266253) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:31.289116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:31.289502) ========= 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.B05Oaf35QD/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.rk4pm77nrT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-19 15:56:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.85M=0.001s 2016-07-19 15:56:31 (7.85 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109151 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:31.420296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:31.420603) ========= 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.B05Oaf35QD/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.rk4pm77nrT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020817 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:31.682656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 15:56:31.682996) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8a26f6b014e67c5829f2c2a28b82f9b28fc0737d --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 8a26f6b014e67c5829f2c2a28b82f9b28fc0737d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B05Oaf35QD/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.rk4pm77nrT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-19 15:56:31,755 truncating revision to first 12 chars 2016-07-19 15:56:31,755 Setting DEBUG logging. 2016-07-19 15:56:31,755 attempt 1/10 2016-07-19 15:56:31,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8a26f6b014e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 15:56:32,557 unpacking tar archive at: autoland-8a26f6b014e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.067338 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 15:56:32.772279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:32.772599) ========= script_repo_revision: 8a26f6b014e67c5829f2c2a28b82f9b28fc0737d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:32.772983) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:32.773315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 15:56:32.792397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-19 15:56:32.792782) ========= /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.B05Oaf35QD/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.rk4pm77nrT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:56:32 INFO - MultiFileLogger online at 20160719 15:56:32 in /builds/slave/test 15:56:32 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 15:56:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:56:32 INFO - {'append_to_log': False, 15:56:32 INFO - 'base_work_dir': '/builds/slave/test', 15:56:32 INFO - 'blob_upload_branch': 'Autoland', 15:56:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:56:32 INFO - 'branch': 'Autoland', 15:56:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:56:32 INFO - 'config_files': ('talos/mac_config.py',), 15:56:32 INFO - 'default_actions': ('clobber', 15:56:32 INFO - 'read-buildbot-config', 15:56:32 INFO - 'download-and-extract', 15:56:32 INFO - 'populate-webroot', 15:56:32 INFO - 'create-virtualenv', 15:56:32 INFO - 'install', 15:56:32 INFO - 'run-tests'), 15:56:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:56:32 INFO - 'download_minidump_stackwalk': True, 15:56:32 INFO - 'download_symbols': 'ondemand', 15:56:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:56:32 INFO - 'tooltool.py': '/tools/tooltool.py', 15:56:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:56:32 INFO - '/tools/misc-python/virtualenv.py')}, 15:56:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:56:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:56:32 INFO - 'installer_path': 'installer.exe', 15:56:32 INFO - 'log_level': 'info', 15:56:32 INFO - 'log_name': 'talos', 15:56:32 INFO - 'log_to_console': True, 15:56:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:56:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:56:32 INFO - 'opt_config_files': (), 15:56:32 INFO - 'pip_index': False, 15:56:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:56:32 INFO - 'cmd': ('bash', 15:56:32 INFO - '-c', 15:56:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:56:32 INFO - 'enabled': True, 15:56:32 INFO - 'halt_on_failure': False, 15:56:32 INFO - 'name': 'check_screen_resolution'},), 15:56:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:56:32 INFO - 'cmd': ('bash', 15:56:32 INFO - '-c', 15:56:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:56:32 INFO - 'enabled': True, 15:56:32 INFO - 'halt_on_failure': False, 15:56:32 INFO - 'name': 'check_screen_resolution'},), 15:56:32 INFO - 'run_cmd_checks_enabled': True, 15:56:32 INFO - 'sps_profile': False, 15:56:32 INFO - 'sps_profile_interval': 0, 15:56:32 INFO - 'suite': 'dromaeojs-e10s', 15:56:32 INFO - 'system_bits': '32', 15:56:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:56:32 INFO - 'title': 't-yosemite-r7-0029', 15:56:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:56:32 INFO - 'use_talos_json': True, 15:56:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:56:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:56:32 INFO - 'work_dir': 'build'} 15:56:32 INFO - [mozharness: 2016-07-19 22:56:32.997452Z] Running clobber step. 15:56:32 INFO - Running pre-action listener: _resource_record_pre_action 15:56:32 INFO - Running main action method: clobber 15:56:32 INFO - rmtree: /builds/slave/test/build 15:56:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:56:34 INFO - Running post-action listener: _resource_record_post_action 15:56:34 INFO - [mozharness: 2016-07-19 22:56:34.500885Z] Finished clobber step (success) 15:56:34 INFO - [mozharness: 2016-07-19 22:56:34.501009Z] Running read-buildbot-config step. 15:56:34 INFO - Running pre-action listener: _resource_record_pre_action 15:56:34 INFO - Running main action method: read_buildbot_config 15:56:34 INFO - Using buildbot properties: 15:56:34 INFO - { 15:56:34 INFO - "project": "", 15:56:34 INFO - "product": "firefox", 15:56:34 INFO - "script_repo_revision": "production", 15:56:34 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 15:56:34 INFO - "repository": "", 15:56:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 15:56:34 INFO - "buildid": "20160719145619", 15:56:34 INFO - "pgo_build": "False", 15:56:34 INFO - "basedir": "/builds/slave/test", 15:56:34 INFO - "buildnumber": 56, 15:56:34 INFO - "slavename": "t-yosemite-r7-0029", 15:56:34 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 15:56:34 INFO - "platform": "yosemite_r7", 15:56:34 INFO - "scheduler": "tests-autoland-macosx64-talos", 15:56:34 INFO - "branch": "autoland", 15:56:34 INFO - "repo_path": "integration/autoland", 15:56:34 INFO - "revision": "8a26f6b014e67c5829f2c2a28b82f9b28fc0737d", 15:56:34 INFO - "stage_platform": "macosx64", 15:56:34 INFO - "builduid": "a5bccaf2c2124cf3ac17a6fd442b5915", 15:56:34 INFO - "slavebuilddir": "test" 15:56:34 INFO - } 15:56:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 15:56:34 INFO - Running post-action listener: _resource_record_post_action 15:56:34 INFO - [mozharness: 2016-07-19 22:56:34.504356Z] Finished read-buildbot-config step (success) 15:56:34 INFO - [mozharness: 2016-07-19 22:56:34.504490Z] Running download-and-extract step. 15:56:34 INFO - Running pre-action listener: _resource_record_pre_action 15:56:34 INFO - Running main action method: download_and_extract 15:56:34 INFO - mkdir: /builds/slave/test/build/tests 15:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:56:34 INFO - https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 15:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 15:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/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 15:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/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 15:56:35 INFO - Downloaded 1199 bytes. 15:56:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 15:56:35 INFO - Using the following test package requirements: 15:56:35 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 15:56:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:56:35 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 15:56:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:56:35 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 15:56:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:56:35 INFO - u'jsshell-mac.zip'], 15:56:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:56:35 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 15:56:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 15:56:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:56:35 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 15:56:35 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:56:35 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 15:56:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:56:35 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 15:56:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:56:35 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 15:56:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:56:35 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')]} 15:56:35 INFO - https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/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 15:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/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 15:56:37 INFO - Downloaded 18835974 bytes. 15:56:37 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'] 15:56:37 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 15:56:40 INFO - Return code: 0 15:56:40 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 15:56:40 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')]} 15:56:40 INFO - https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/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 15:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/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 15:56:41 INFO - Downloaded 18835974 bytes. 15:56:41 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'] 15:56:41 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 15:56:45 INFO - Return code: 0 15:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:56:45 INFO - https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:56:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 15:56:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 15:56:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/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 15:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/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 15:56:46 INFO - Downloaded 14403317 bytes. 15:56:46 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'] 15:56:46 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 15:56:46 INFO - Return code: 0 15:56:46 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')]} 15:56:46 INFO - https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:56:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:56:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:56:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 15:56:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eMouewSA2nENgOKu-4aQ/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 15:56:50 INFO - Downloaded 112930000 bytes. 15:56:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:56:50 INFO - mkdir: /builds/slave/test/properties 15:56:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:56:50 INFO - Writing to file /builds/slave/test/properties/build_url 15:56:50 INFO - Contents: 15:56:50 INFO - build_url:https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:56:51 INFO - Running post-action listener: _resource_record_post_action 15:56:51 INFO - Running post-action listener: set_extra_try_arguments 15:56:51 INFO - [mozharness: 2016-07-19 22:56:51.457379Z] Finished download-and-extract step (success) 15:56:51 INFO - [mozharness: 2016-07-19 22:56:51.457506Z] Running populate-webroot step. 15:56:51 INFO - Running pre-action listener: _resource_record_pre_action 15:56:51 INFO - Running main action method: populate_webroot 15:56:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:56:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:56:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:56:51 INFO - '--tppagecycles', 15:56:51 INFO - '7'], 15:56:51 INFO - 'tests': ['tsvgm']}}, 15:56:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:56:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:56:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:56:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:56:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:51 INFO - 'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:51 INFO - 'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['damp', 'tps']}, 15:56:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:51 INFO - 'tests': ['damp', 'tps']}, 15:56:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['dromaeo_dom']}, 15:56:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:56:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['basic_compositor_video']}, 15:56:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:56:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['a11yr', 15:56:51 INFO - 'ts_paint', 15:56:51 INFO - 'tpaint', 15:56:51 INFO - 'sessionrestore', 15:56:51 INFO - 'sessionrestore_no_auto_restore', 15:56:51 INFO - 'tabpaint']}, 15:56:51 INFO - 'other-e10s': {'tests': ['a11yr', 15:56:51 INFO - 'ts_paint', 15:56:51 INFO - 'tpaint', 15:56:51 INFO - 'sessionrestore', 15:56:51 INFO - 'sessionrestore_no_auto_restore', 15:56:51 INFO - 'tabpaint']}, 15:56:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:56:51 INFO - 'ts_paint', 15:56:51 INFO - 'tpaint', 15:56:51 INFO - 'sessionrestore', 15:56:51 INFO - 'sessionrestore_no_auto_restore', 15:56:51 INFO - 'tabpaint']}, 15:56:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:56:51 INFO - 'ts_paint', 15:56:51 INFO - 'tpaint', 15:56:51 INFO - 'sessionrestore', 15:56:51 INFO - 'sessionrestore_no_auto_restore', 15:56:51 INFO - 'tabpaint']}, 15:56:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['a11yr', 15:56:51 INFO - 'ts_paint', 15:56:51 INFO - 'tpaint', 15:56:51 INFO - 'sessionrestore', 15:56:51 INFO - 'sessionrestore_no_auto_restore', 15:56:51 INFO - 'tabpaint']}, 15:56:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['a11yr', 15:56:51 INFO - 'ts_paint', 15:56:51 INFO - 'tpaint', 15:56:51 INFO - 'sessionrestore', 15:56:51 INFO - 'sessionrestore_no_auto_restore', 15:56:51 INFO - 'tabpaint']}, 15:56:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['tsvgx', 15:56:51 INFO - 'tsvgr_opacity', 15:56:51 INFO - 'tart', 15:56:51 INFO - 'tscrollx', 15:56:51 INFO - 'cart']}, 15:56:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:56:51 INFO - 'tsvgr_opacity', 15:56:51 INFO - 'tart', 15:56:51 INFO - 'tscrollx', 15:56:51 INFO - 'cart']}, 15:56:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:51 INFO - 'talos_options': ['--disable-e10s'], 15:56:51 INFO - 'tests': ['tp5o']}, 15:56:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:51 INFO - 'tests': ['tp5o']}, 15:56:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:51 INFO - 'talos_options': ['--disable-e10s', 15:56:51 INFO - '--xperf_path', 15:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:51 INFO - 'tests': ['tp5n']}, 15:56:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:51 INFO - 'talos_options': ['--xperf_path', 15:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:51 INFO - 'tests': ['tp5n']}}, 15:56:51 INFO - 'talos.zip': {'path': '', 15:56:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:56:51 INFO - Running post-action listener: _resource_record_post_action 15:56:51 INFO - [mozharness: 2016-07-19 22:56:51.476654Z] Finished populate-webroot step (success) 15:56:51 INFO - [mozharness: 2016-07-19 22:56:51.476785Z] Running create-virtualenv step. 15:56:51 INFO - Running pre-action listener: _resource_record_pre_action 15:56:51 INFO - Running main action method: create_virtualenv 15:56:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:56:51 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 15:56:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:56:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:56:51 INFO - Using real prefix '/tools/python27' 15:56:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:56:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:56:55 INFO - Installing pip.................done. 15:56:55 INFO - Return code: 0 15:56:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:56:55 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')]} 15:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:55 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')]} 15:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:55 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 0x10d961a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989859fe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, '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.B05Oaf35QD/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.rk4pm77nrT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:55 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 15:56:55 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 15:56:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:56:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:55 INFO - 'HOME': '/Users/cltbld', 15:56:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:55 INFO - 'LOGNAME': 'cltbld', 15:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:55 INFO - 'MOZ_NO_REMOTE': '1', 15:56:55 INFO - 'NO_EM_RESTART': '1', 15:56:55 INFO - 'PAGER': '/bin/cat', 15:56:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:55 INFO - 'PWD': '/builds/slave/test', 15:56:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:55 INFO - 'SHELL': '/bin/bash', 15:56:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:56:55 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:56:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:55 INFO - 'USER': 'cltbld', 15:56:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:55 INFO - 'XPC_FLAGS': '0x0', 15:56:55 INFO - 'XPC_SERVICE_NAME': '0', 15:56:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:55 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 15:56:55 INFO - Cleaning up... 15:56:55 INFO - Return code: 0 15:56:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:56:55 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')]} 15:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:55 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')]} 15:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:55 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 0x10d961a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989859fe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, '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.B05Oaf35QD/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.rk4pm77nrT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:55 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 15:56:55 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 15:56:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:56:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:55 INFO - 'HOME': '/Users/cltbld', 15:56:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:55 INFO - 'LOGNAME': 'cltbld', 15:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:55 INFO - 'MOZ_NO_REMOTE': '1', 15:56:55 INFO - 'NO_EM_RESTART': '1', 15:56:55 INFO - 'PAGER': '/bin/cat', 15:56:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:55 INFO - 'PWD': '/builds/slave/test', 15:56:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:55 INFO - 'SHELL': '/bin/bash', 15:56:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:56:55 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:56:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:55 INFO - 'USER': 'cltbld', 15:56:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:55 INFO - 'XPC_FLAGS': '0x0', 15:56:55 INFO - 'XPC_SERVICE_NAME': '0', 15:56:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:55 INFO - Downloading/unpacking psutil>=3.1.1 15:56:55 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 15:56:55 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 15:56:55 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 15:56:55 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 15:56:55 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 15:56:55 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 15:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:58 INFO - Installing collected packages: psutil 15:56:58 INFO - Running setup.py install for psutil 15:56:58 INFO - building 'psutil._psutil_osx' extension 15:56:58 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 15:56:59 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 15:56:59 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 15:56:59 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 15:56:59 INFO - building 'psutil._psutil_posix' extension 15:56:59 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 15:56:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:56:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:56:59 INFO - ^ 15:56:59 INFO - 1 warning generated. 15:56:59 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 15:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:59 INFO - Successfully installed psutil 15:56:59 INFO - Cleaning up... 15:56:59 INFO - Return code: 0 15:56:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:56:59 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')]} 15:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:59 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')]} 15:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:59 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 0x10d961a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989859fe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, '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.B05Oaf35QD/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.rk4pm77nrT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:59 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 15:56:59 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 15:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:59 INFO - 'HOME': '/Users/cltbld', 15:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:59 INFO - 'LOGNAME': 'cltbld', 15:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:59 INFO - 'MOZ_NO_REMOTE': '1', 15:56:59 INFO - 'NO_EM_RESTART': '1', 15:56:59 INFO - 'PAGER': '/bin/cat', 15:56:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:59 INFO - 'PWD': '/builds/slave/test', 15:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:59 INFO - 'SHELL': '/bin/bash', 15:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:56:59 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:59 INFO - 'USER': 'cltbld', 15:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:59 INFO - 'XPC_FLAGS': '0x0', 15:56:59 INFO - 'XPC_SERVICE_NAME': '0', 15:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:57:02 INFO - Installing collected packages: mozsystemmonitor 15:57:02 INFO - Running setup.py install for mozsystemmonitor 15:57:02 INFO - Successfully installed mozsystemmonitor 15:57:02 INFO - Cleaning up... 15:57:02 INFO - Return code: 0 15:57:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:57:02 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')]} 15:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:02 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')]} 15:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:02 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 0x10d961a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989859fe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, '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.B05Oaf35QD/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.rk4pm77nrT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:57:02 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 15:57:02 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 15:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:02 INFO - 'HOME': '/Users/cltbld', 15:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:02 INFO - 'LOGNAME': 'cltbld', 15:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:02 INFO - 'MOZ_NO_REMOTE': '1', 15:57:02 INFO - 'NO_EM_RESTART': '1', 15:57:02 INFO - 'PAGER': '/bin/cat', 15:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:02 INFO - 'PWD': '/builds/slave/test', 15:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:02 INFO - 'SHELL': '/bin/bash', 15:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:57:02 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:02 INFO - 'USER': 'cltbld', 15:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:02 INFO - 'XPC_FLAGS': '0x0', 15:57:02 INFO - 'XPC_SERVICE_NAME': '0', 15:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:02 INFO - Downloading/unpacking jsonschema==2.5.1 15:57:02 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 15:57:02 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 15:57:02 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 15:57:02 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 15:57:02 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 15:57:02 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 15:57:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:57:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:05 INFO - Downloading functools32-3.2.3-2.tar.gz 15:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:57:05 INFO - warning: no files found matching '*.txt' 15:57:05 INFO - no previously-included directories found matching 'build' 15:57:05 INFO - no previously-included directories found matching 'dist' 15:57:05 INFO - no previously-included directories found matching '.git*' 15:57:05 INFO - Installing collected packages: jsonschema, functools32 15:57:06 INFO - Running setup.py install for functools32 15:57:06 INFO - warning: no files found matching '*.txt' 15:57:06 INFO - no previously-included directories found matching 'build' 15:57:06 INFO - no previously-included directories found matching 'dist' 15:57:06 INFO - no previously-included directories found matching '.git*' 15:57:06 INFO - Successfully installed jsonschema functools32 15:57:06 INFO - Cleaning up... 15:57:06 INFO - Return code: 0 15:57:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d961a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989859fe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, '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.B05Oaf35QD/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.rk4pm77nrT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:57:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:57:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:06 INFO - 'HOME': '/Users/cltbld', 15:57:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:06 INFO - 'LOGNAME': 'cltbld', 15:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:06 INFO - 'MOZ_NO_REMOTE': '1', 15:57:06 INFO - 'NO_EM_RESTART': '1', 15:57:06 INFO - 'PAGER': '/bin/cat', 15:57:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:06 INFO - 'PWD': '/builds/slave/test', 15:57:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:06 INFO - 'SHELL': '/bin/bash', 15:57:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:57:06 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:57:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:06 INFO - 'USER': 'cltbld', 15:57:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:06 INFO - 'XPC_FLAGS': '0x0', 15:57:06 INFO - 'XPC_SERVICE_NAME': '0', 15:57:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:06 INFO - Downloading/unpacking blobuploader==1.2.4 15:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:08 INFO - Downloading blobuploader-1.2.4.tar.gz 15:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:57:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:57:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:10 INFO - Downloading docopt-0.6.1.tar.gz 15:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:57:10 INFO - Installing collected packages: blobuploader, requests, docopt 15:57:10 INFO - Running setup.py install for blobuploader 15:57:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:57:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:57:10 INFO - Running setup.py install for requests 15:57:10 INFO - Running setup.py install for docopt 15:57:11 INFO - Successfully installed blobuploader requests docopt 15:57:11 INFO - Cleaning up... 15:57:11 INFO - Return code: 0 15:57:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57:11 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')]} 15:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:11 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')]} 15:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:11 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 0x10d961a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989859fe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, '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.B05Oaf35QD/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.rk4pm77nrT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:57:11 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 15:57:11 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 15:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:11 INFO - 'HOME': '/Users/cltbld', 15:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:11 INFO - 'LOGNAME': 'cltbld', 15:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:11 INFO - 'MOZ_NO_REMOTE': '1', 15:57:11 INFO - 'NO_EM_RESTART': '1', 15:57:11 INFO - 'PAGER': '/bin/cat', 15:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:11 INFO - 'PWD': '/builds/slave/test', 15:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:11 INFO - 'SHELL': '/bin/bash', 15:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:57:11 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:11 INFO - 'USER': 'cltbld', 15:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:11 INFO - 'XPC_FLAGS': '0x0', 15:57:11 INFO - 'XPC_SERVICE_NAME': '0', 15:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:57:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ryNBr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:57:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XRf7yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:57:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_2TKaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:57:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_lijAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:57:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-6V5B5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:57:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hcdhb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-DBKO3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-zEpq87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_e5JwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-4wtKJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-uLH7g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-9FfAXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-JwQiYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-qfWVrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-oGOmH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:57:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-iMNQaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:57:13 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-SbDwbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:57:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:57:13 INFO - Running setup.py install for manifestparser 15:57:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:57:13 INFO - Running setup.py install for mozcrash 15:57:13 INFO - Running setup.py install for mozdebug 15:57:13 INFO - Running setup.py install for mozdevice 15:57:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:57:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:57:13 INFO - Running setup.py install for mozfile 15:57:13 INFO - Running setup.py install for mozhttpd 15:57:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:57:14 INFO - Running setup.py install for mozinfo 15:57:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:57:14 INFO - Running setup.py install for mozInstall 15:57:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:57:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:57:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:57:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:57:14 INFO - Running setup.py install for mozleak 15:57:14 INFO - Running setup.py install for mozlog 15:57:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:57:14 INFO - Running setup.py install for moznetwork 15:57:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:57:14 INFO - Running setup.py install for mozprocess 15:57:14 INFO - Running setup.py install for mozprofile 15:57:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:57:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:57:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:57:15 INFO - Running setup.py install for mozrunner 15:57:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:57:15 INFO - Running setup.py install for mozscreenshot 15:57:15 INFO - Running setup.py install for moztest 15:57:15 INFO - Running setup.py install for mozversion 15:57:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:57:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:57:15 INFO - Cleaning up... 15:57:15 INFO - Return code: 0 15:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57: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')]} 15:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57: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')]} 15:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:15 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 0x10d961a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989859fe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, '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.B05Oaf35QD/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.rk4pm77nrT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:57:15 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 15:57:15 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 15:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:15 INFO - 'HOME': '/Users/cltbld', 15:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:15 INFO - 'LOGNAME': 'cltbld', 15:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:15 INFO - 'MOZ_NO_REMOTE': '1', 15:57:15 INFO - 'NO_EM_RESTART': '1', 15:57:15 INFO - 'PAGER': '/bin/cat', 15:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:15 INFO - 'PWD': '/builds/slave/test', 15:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:15 INFO - 'SHELL': '/bin/bash', 15:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:57:15 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:15 INFO - 'USER': 'cltbld', 15:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:15 INFO - 'XPC_FLAGS': '0x0', 15:57:15 INFO - 'XPC_SERVICE_NAME': '0', 15:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-nDdAsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:57:16 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)) 15:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Az35Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:57:16 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)) 15:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dAUptc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:57:16 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)) 15:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-3fXvfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:57:16 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)) 15:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-2rXYiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:57:16 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)) 15:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-diuXUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:57:16 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)) 15:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-E1sIO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:57:16 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)) 15:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-F_9G7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:57:16 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)) 15:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-3s7sSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:57:16 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)) 15:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:57:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Gcb5no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:57:17 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)) 15:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:57:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-MJ5PwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:57:17 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)) 15:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:57:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dYt7bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:57:17 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)) 15:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:57:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-wjShJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:57:17 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)) 15:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:57:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-OVhVXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:57:17 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)) 15:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-T90e9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:17 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)) 15:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:57:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-YL18T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:57:17 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)) 15:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:57:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-nUp3eM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:57:17 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)) 15:57:17 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)) 15:57:17 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)) 15:57:17 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)) 15:57:17 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)) 15:57:17 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)) 15:57:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:20 INFO - Downloading blessings-1.6.tar.gz 15:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:57:20 INFO - Installing collected packages: blessings 15:57:20 INFO - Running setup.py install for blessings 15:57:20 INFO - Successfully installed blessings 15:57:20 INFO - Cleaning up... 15:57:21 INFO - Return code: 0 15:57:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:57:21 INFO - Reading from file tmpfile_stdout 15:57:21 INFO - Current package versions: 15:57:21 INFO - blessings == 1.6 15:57:21 INFO - blobuploader == 1.2.4 15:57:21 INFO - docopt == 0.6.1 15:57:21 INFO - functools32 == 3.2.3-2 15:57:21 INFO - jsonschema == 2.5.1 15:57:21 INFO - manifestparser == 1.1 15:57:21 INFO - mozInstall == 1.12 15:57:21 INFO - mozcrash == 0.17 15:57:21 INFO - mozdebug == 0.1 15:57:21 INFO - mozdevice == 0.48 15:57:21 INFO - mozfile == 1.2 15:57:21 INFO - mozhttpd == 0.7 15:57:21 INFO - mozinfo == 0.9 15:57:21 INFO - mozleak == 0.1 15:57:21 INFO - mozlog == 3.3 15:57:21 INFO - moznetwork == 0.27 15:57:21 INFO - mozprocess == 0.23 15:57:21 INFO - mozprofile == 0.28 15:57:21 INFO - mozrunner == 6.12 15:57:21 INFO - mozscreenshot == 0.1 15:57:21 INFO - mozsystemmonitor == 0.3 15:57:21 INFO - moztest == 0.7 15:57:21 INFO - mozversion == 1.4 15:57:21 INFO - psutil == 3.1.1 15:57:21 INFO - requests == 1.2.3 15:57:21 INFO - wsgiref == 0.1.2 15:57:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:21 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 0x10d961a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989859fe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, '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.B05Oaf35QD/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.rk4pm77nrT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:57:21 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 15:57:21 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 15:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:21 INFO - 'HOME': '/Users/cltbld', 15:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:21 INFO - 'LOGNAME': 'cltbld', 15:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:21 INFO - 'MOZ_NO_REMOTE': '1', 15:57:21 INFO - 'NO_EM_RESTART': '1', 15:57:21 INFO - 'PAGER': '/bin/cat', 15:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:21 INFO - 'PWD': '/builds/slave/test', 15:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:21 INFO - 'SHELL': '/bin/bash', 15:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:57:21 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:21 INFO - 'USER': 'cltbld', 15:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:21 INFO - 'XPC_FLAGS': '0x0', 15:57:21 INFO - 'XPC_SERVICE_NAME': '0', 15:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:21 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)) 15:57:21 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)) 15:57:21 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)) 15:57:21 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)) 15:57:21 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)) 15:57:21 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)) 15:57:21 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)) 15:57:21 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)) 15:57:21 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)) 15:57:21 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)) 15:57:21 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)) 15:57:21 INFO - Cleaning up... 15:57:21 INFO - Return code: 0 15:57:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:57:21 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 0x10d961a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989859fe10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, '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.B05Oaf35QD/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.rk4pm77nrT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:57:21 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 15:57:21 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 15:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:21 INFO - 'HOME': '/Users/cltbld', 15:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:21 INFO - 'LOGNAME': 'cltbld', 15:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:21 INFO - 'MOZ_NO_REMOTE': '1', 15:57:21 INFO - 'NO_EM_RESTART': '1', 15:57:21 INFO - 'PAGER': '/bin/cat', 15:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:21 INFO - 'PWD': '/builds/slave/test', 15:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:21 INFO - 'SHELL': '/bin/bash', 15:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:57:21 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:21 INFO - 'USER': 'cltbld', 15:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:21 INFO - 'XPC_FLAGS': '0x0', 15:57:21 INFO - 'XPC_SERVICE_NAME': '0', 15:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:57:21 INFO - Cleaning up... 15:57:21 INFO - Return code: 0 15:57:21 INFO - Running post-action listener: _resource_record_post_action 15:57:21 INFO - Running post-action listener: _start_resource_monitoring 15:57:21 INFO - Starting resource monitoring. 15:57:21 INFO - [mozharness: 2016-07-19 22:57:21.955038Z] Finished create-virtualenv step (success) 15:57:21 INFO - [mozharness: 2016-07-19 22:57:21.956024Z] Running install step. 15:57:21 INFO - Running pre-action listener: _resource_record_pre_action 15:57:21 INFO - Running main action method: install 15:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:57:22 INFO - Reading from file tmpfile_stdout 15:57:22 INFO - Detecting whether we're running mozinstall >=1.0... 15:57:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:57:22 INFO - Reading from file tmpfile_stdout 15:57:22 INFO - Output received: 15:57:22 INFO - Usage: mozinstall [options] installer 15:57:22 INFO - Options: 15:57:22 INFO - -h, --help show this help message and exit 15:57:22 INFO - -d DEST, --destination=DEST 15:57:22 INFO - Directory to install application into. [default: 15:57:22 INFO - "/builds/slave/test"] 15:57:22 INFO - --app=APP Application being installed. [default: firefox] 15:57:22 INFO - mkdir: /builds/slave/test/build/application 15:57:22 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'] 15:57:22 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 15:57:57 INFO - Reading from file tmpfile_stdout 15:57:57 INFO - Output received: 15:57:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:57:57 INFO - Running post-action listener: _resource_record_post_action 15:57:57 INFO - [mozharness: 2016-07-19 22:57:57.037393Z] Finished install step (success) 15:57:57 INFO - [mozharness: 2016-07-19 22:57:57.037516Z] Running run-tests step. 15:57:57 INFO - Running pre-action listener: _resource_record_pre_action 15:57:57 INFO - Running main action method: run_tests 15:57:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:57:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:57:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:57:57 INFO - 2016-07-19 15:57:57.052 screenresolution[1920:15042] starting screenresolution argv=screenresolution get 15:57:57 INFO - 2016-07-19 15:57:57.054 screenresolution[1920:15042] Display 0: 1600x1200x32@60 15:57:57 INFO - 2016-07-19 15:57:57.060 screenresolution[1921:15044] starting screenresolution argv=screenresolution list 15:57:57 INFO - Available Modes on Display 0 15:57:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:57:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:57:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:57:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:57:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:57:57 INFO - Intel Iris: 15:57:57 INFO - Chipset Model: Intel Iris 15:57:57 INFO - Type: GPU 15:57:57 INFO - Bus: Built-In 15:57:57 INFO - VRAM (Dynamic, Max): 1536 MB 15:57:57 INFO - Vendor: Intel (0x8086) 15:57:57 INFO - Device ID: 0x0a2e 15:57:57 INFO - Revision ID: 0x0009 15:57:57 INFO - Displays: 15:57:57 INFO - Display: 15:57:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:57:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:57:57 INFO - Display Serial Number: 1600x1200 60 15:57:57 INFO - Main Display: Yes 15:57:57 INFO - Mirror: Off 15:57:57 INFO - Online: Yes 15:57:57 INFO - Rotation: Supported 15:57:57 INFO - Return code: 0 15:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:57:57 INFO - Python 2.7.3 15:57:57 INFO - Return code: 0 15:57:57 INFO - grabbing minidump binary from tooltool 15:57: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')]} 15:57:57 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 0x10d8c5d30>, '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 0x10d62adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8bdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:57:57 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 15:57:57 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 15:57:57 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 15:57:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:57:57 INFO - Return code: 0 15:57:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:57:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:57:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:57:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:57:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:57:57 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/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:57:57 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/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B05Oaf35QD/Render', 15:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:57 INFO - 'HOME': '/Users/cltbld', 15:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:57 INFO - 'LOGNAME': 'cltbld', 15:57:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:57:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:57 INFO - 'MOZ_NO_REMOTE': '1', 15:57:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:57:57 INFO - 'NO_EM_RESTART': '1', 15:57:57 INFO - 'PAGER': '/bin/cat', 15:57:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:57 INFO - 'PWD': '/builds/slave/test', 15:57:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:57 INFO - 'SHELL': '/bin/bash', 15:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rk4pm77nrT/Listeners', 15:57:57 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:57 INFO - 'USER': 'cltbld', 15:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:57 INFO - 'XPC_FLAGS': '0x0', 15:57:57 INFO - 'XPC_SERVICE_NAME': '0', 15:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:57:57 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/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:57:57 INFO - mozversion application_buildid: 20160719145619 15:57:57 INFO - mozversion application_changeset: 8a26f6b014e67c5829f2c2a28b82f9b28fc0737d 15:57:57 INFO - mozversion application_display_name: Nightly 15:57:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:57:57 INFO - mozversion application_name: Firefox 15:57:57 INFO - mozversion application_remotingname: firefox 15:57:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:57:57 INFO - mozversion application_vendor: Mozilla 15:57:57 INFO - mozversion application_version: 50.0a1 15:57:57 INFO - mozversion platform_buildid: 20160719145619 15:57:57 INFO - mozversion platform_changeset: 8a26f6b014e67c5829f2c2a28b82f9b28fc0737d 15:57:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:57:57 INFO - mozversion platform_version: 50.0a1 15:57:57 INFO - using testdate: 1468969077 15:57:57 INFO - actual date: 1468969077 15:57:57 INFO - starting webserver on 'localhost:51840' 15:57:57 INFO - SUITE-START | Running 2 tests 15:57:57 INFO - TEST-START | dromaeo_css 15:57:57 INFO - operating with platform_type : mac_ 15:57:57 INFO - Initialising browser for dromaeo_css test... 15:57:57 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpf1FlZS/profile http://localhost:51840/getInfo.html) 15:58:00 INFO - PROCESS | 1931 | __metrics Screen width/height:1600/1200 15:58:00 INFO - PROCESS | 1931 | colorDepth:24 15:58:00 INFO - PROCESS | 1931 | Browser inner width/height: 1024/689 15:58:00 INFO - PROCESS | 1931 | __metrics 15:58:00 ERROR - PROCESS | 1931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:58:01 INFO - TEST-INFO | 1931: exit 0 15:58:01 INFO - Browser initialized. 15:58:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:58:01 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpf1FlZS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:58:13 INFO - PROCESS | 1934 | RSS: Main: 254525440 15:58:13 INFO - PROCESS | 1934 | 15:59:03 INFO - PROCESS | 1934 | 1468969143444 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] 16:01:14 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:51840/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51840/tests/dromaeo/cssquery-ext.html) 16:01:15 INFO - PROCESS | 1934 | RSS: Main: 266960896 16:01:15 INFO - PROCESS | 1934 | 16:04:18 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:51840/tests/dromaeo/cssquery-ext.html (next: http://localhost:51840/tests/dromaeo/cssquery-jquery.html) 16:04:18 INFO - PROCESS | 1934 | RSS: Main: 275587072 16:04:18 INFO - PROCESS | 1934 | 16:07:20 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:51840/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51840/tests/dromaeo/cssquery-mootools.html) 16:07:21 INFO - PROCESS | 1934 | RSS: Main: 279986176 16:07:21 INFO - PROCESS | 1934 | 16:10:23 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:51840/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51840/tests/dromaeo/cssquery-prototype.html) 16:10:23 INFO - PROCESS | 1934 | RSS: Main: 278913024 16:10:23 INFO - PROCESS | 1934 | 16:13:26 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:51840/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51840/tests/dromaeo/cssquery-yui.html) 16:13:27 INFO - PROCESS | 1934 | RSS: Main: 282509312 16:13:27 INFO - PROCESS | 1934 | 16:16:29 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:51840/tests/dromaeo/cssquery-yui.html (next: http://localhost:51840/tests/dromaeo/cssquery-dojo.html) 16:16:29 INFO - PROCESS | 1934 | RSS: Main: 282611712 16:16:29 INFO - PROCESS | 1934 | 16:16:29 INFO - PROCESS | 1934 | __start_tp_report 16:16:29 INFO - PROCESS | 1934 | _x_x_mozilla_page_load 16:16:29 INFO - PROCESS | 1934 | _x_x_mozilla_page_load_details 16:16:29 INFO - PROCESS | 1934 | |i|pagename|runs| 16:16:29 INFO - PROCESS | 1934 | |0;dojo.html;2717.6331195288635;2881.452524020436;3356.9593426037914;3422.9828850855743;3437.8281085945705;5730.169125476803;5737.512311453526;5784.768609255625;5841.912371314434;5854.853628659285;5637.3235211774545;5801.332846722628;5814.854628634286;5815.651060936347;5875.647461152324;4221.873343799691;4258.765767882765;5293.57651387888;5351.438098999607;5365.865853353658;5198.766055527511;5369.704666243355;5423.29497165368;5436.510714035736;5439.075357189287;5189.870253243699;5192.480751924815;5254.816081437131;5275.736213189363;5284.603654725892;5219.686818790847;5220.686758794484;5234.162533994542;5239.21411788231;5266.92099618506;5228.712420816853;5252.422233554306;5263.815766448156;5319.654222475527;5350.30446042016;5425.810096646638;5770.567207459458;5782.248307720011;5786.189933409326;5835;6185.87628247437;6260.436560709512;6275.183957787829;6328.430441260262;6341.936580634181;6190.3190649028575;6275.466585340251;6293.905591416133;6298.1812364392335;6307.905381419282;5846.824595262106;5866.032104702719;5910.73401696929;5916.26046744157;5923.822285331361;6274.717637706314;6328;6330.778422755181;6334.366563343721;6357.809265722036;6109.404666050326;6128.3258841527395;6225;6235.064740288993;6239.937600623935;6257.061440783918;6305.243370795534;6307.180066591405;6317.6209427434505;6323.652199129;6050.606710563799;6166.475849552839;6229.781957631461;6242.687865606701;6280.214973128359;6125.235451818339;6125.47964319526;6208.782692605737;6297.338779428185;6306.527010474141;4961.875953101129;4996.275540046746;5008.17365134756;5012.8496145115705;5069.163588008011;4473.753943533072;4483.449298961556;4499.662525310615;4537.3647689323525;4560.863174104782;5578.219049333096;5900;5944.346121926585;5951.583389162717;5977.67122808241;6267.717952692049;6270.996640537492;6276.278228003838;6297.527685423612;6328.493720502441;5901.380355062743;5969.970150149222;5979.641221526722;5998.171471965023;6047.12316714074;5370.62405631602;5444.020076386289;5461.972690136524;5495.835124946258;5513;6354.078658594478;6376.585521941059;6401.231852177675;6402.48780097591;6410.326915673973;6283.497320214463;6285.685715714288;6289.182406287337;6292.496600271876;6297.96851015742;5257.395399529103;6233.438990490878;6260.186175797117;6282.057691346152;6356.3325850785;6220.626762394271;6227.439530442282;6258.812235632939;6278.4035516625845;6281.371862813682;6186.381361863778;6228.003519436868;6268.905966410416;6269.0909818075215;6286.654234017173;6081.6655083969035;6106.572539922163;6143.849652621547;6155.292141403616;6195.256569211723;4870.975645121894;6141.293751218667;6163.907541386972;6176.66028368444;6180.196574445294;5939.970300148471;6018.458338749533;6038.5772995889865;6083.726232319645;6087.66517841523;6071.666058366833;6126.578745377254;6160.13758073861;6182.629042257479;6204.100405441095;6069.635821850703;6079.240094988127;6083.878322433615;6098.928203058511;6130.50955923534 16:16:29 INFO - PROCESS | 1934 | |1;ext.html;521.2936471081682;522.3731522173392;536.1930294906166;559.0049711513508;559.9104143337065;38313.616863831354;40595.59404405955;40654.59345406545;40795.77612671625;40857;41541.169176616524;41787.79106104465;41833.79083104588;41877.16245675085;41946.58053419465;9471.952640236823;9523.28575356851;9608;9651.5174241288;9669.178119859786;9532.71401857942;9559;9592.712218633453;9613.182879455255;9616.182624476927;7300.963495182516;8219;9566.378185417925;9625.951870240639;9668.854967175497;9523.714288571355;9531.666391676328;9558.187554057879;9622.422654640744;9637.036296370306;8025.398095142829;9521.523923803783;9603.90396096044;9608.903910960871;9631.90368096317;39797.60202397968;40179.59820401788;40279.59720402788;40303.59696403028;40387.7980610098;2862.2415060009116;3470.9826450867836;3512.1570823002294;3534.6288639692975;3642.21692336149;26381.868090659424;31089.53365699516;32786.836065819516;32858;32859.01422957315;2536.6195070739536;3189.7129258366626;3269.7057264846276;3296.1924328539662;3300.422426075427;493784;497618;502144;502742;503490;54388.184177237374;64035.67982160152;64220;64340.67829660822;64563.67718161379;65778;66061.66969165123;66973.66513167403;67007.32992670011;67011.66494167596;16471.094089824936;16662.00027998324;16788.412405565745;16798.32806687743;16831.242594083295;11483.483243254073;11655;12683.302418367079;12919.935400323126;12944.352782361033;16801.937959568633;19267.614647706967;19424.12591433389;19509.804901951084;19544.804551954297;8033.598320083973;8079.1516890725625;8130.30892374143;8150.592470376576;8214;871.2507243770352;959.6209497248548;974.6637410093506;983.8130755156498;1102.6416414665266;28704.13887583376;29626.963056292927;30483;30614.84692576523;30722.078337649906;1061.4109169411051;1130.5929865248504;1170.4381896689467;1195.3425615911215;1243.4590952935503;15872.603184920239;15927.920360398355;15995.280212390471;16227.513174604781;16424.1787910604;590659;693221;694159;696642;706366;59481;60035.399646003854;60337.69831150904;60340.396596034356;60344.39655603476;1337.6923307639104;1352.648311439033;1382.4884792626792;1387.098386049056;1395.762720337545;30019.699803002564;30035;30281.862317069157;30453.086407407813;30508.542371863994;50695.49304506907;50976.49023509866;50992.49007509877;51221.48778512167;51268;561864;565755;571412;573537.396939038;573949;21557.89221053885;25779.355516112246;25937.48125037451;27438;28248.15255542337;49054.75472622614;49161.508384915694;49642.751786240835;50052.499475004784;50100.74949625228;40778.59221407748;41107.383389249786;41126;41596.1680766389;41607.37588936229;40843;41152;41272.380914285706;41685.79157104316;42262.366064508446;38979.805100974314;39254.4111838317;39572.802135989135;39623.80188099041;39769.80115099406;30108.24729381783;34825.47761783525;35572.822135890194;36347.27305453929;36573.817130914176;25660.61509077328;26074;26121;26509.734902651497;26536.336591585365 16:16:29 INFO - PROCESS | 1934 | |2;jquery.html;384.3657964358808;387.4420833999041;389.11282276409776;390.923007115397;412.6904821383962;14657.853421465783;19769.505762355948;20649.174033038697;21130.04914778833;21136.365909022734;20737.377878663665;21169.68245476315;21523;21832;21893;5331.147016477365;5512.669239845602;5551.056320425517;5567.916481252784;5571.860703482425;5394.7842086316505;5467.535259502927;5483.698396588186;5523.392426833066;5549.084401073818;5665.12190610456;5893.322267939177;5955.255593050869;6030.547708921827;6039.3960603939695;5921.792737254197;6055.636661800306;6060.575759696823;6118.541109416767;6216.813495595139;6002.759889604411;6054.697265136726;6068.939310606882;6073.1497590337385;6079.452849243589;13530.93234533821;13715.657108572266;21108.5778284435;22310.54981426202;26832.463350733073;2262.7510973793032;2337.053493335202;2359.5634807560655;2424.9936276445255;2944.7055294470597;10311.484425778755;10312.690619281433;10444.425556594384;10503.632372866912;10505.737356566071;1843.732658764485;1854.1563588567305;1864.9347272845384;1908.236705317884;1950.3271371376852;117045;119903;120219.3989030058;121508.39245803803;121511.78488215093;11638.70903227426;11697.445933461098;11704.70738231551;11832.88167118335;11850.348230847214;14834.73904718111;14876.479323223635;14941.551753447415;14948.775768363483;14960.625984350261;8527.573621318908;8620.482771033758;8638.222559969632;8703.43427677199;8730.825383492294;6937.3062693731235;8529.616167272488;8530.274926631306;8649;8672.262857657044;4526.864194074183;4582.839600613963;4620.259127218299;4635.23518619424;4692.225782745809;1698.8980661160122;1939.21461807968;1983.305842954983;2034.745656792901;2036.5926814637132;351.89267273481323;381.5859792125575;416.1946633264582;808.1635507249968;913.1051569461964;11972.820407693891;11992.160548761678;12045.036397088212;12184.51261949512;12283.955863751502;436.6899501354074;439.70320033976935;440.28673548851066;448.42153621827475;457.3756821938031;6065.423784740443;6168.889599872066;6172.382761723792;6266.154069200691;6274.309825919146;595246;596043;602161;602873;607873;129465.70534294537;142373;145133;145999;147823.26088369705;949.886013678363;961.8461046232569;998.9500524973722;1001.7044971733357;1005.4168582222294;18882.622347552697;19162;19229.326973555857;19326.03369831531;19421.611567768283;54015;54608;54728;56196.43803561912;56721.14918276312;69632;80836;81213;81685.77471338054;82644.17355826365;7965.840683186188;8007.712981187092;8033.272846338065;8218.849361089333;8322.126176751353;9038.186563209343;11889.286642801113;12597.622071337875;12859.614211573667;12945.935270323587;10002.399856008662;10720.177569812995;11072.224944253825;11108.944650258212;11379.943100284445;9395.577199025924;11319;11448.313101213955;11465.14011449128;11575.536978520764;11626.069914406997;11750.23623464472;11814.232074915102;11922.582709605122;12046.939765301116;7093.32613401726;7441.10706715176;7481.251874812475;7722.691092356243;8331.333493320399;10258.53836577341;10935.56257749681;11379.886201137882;11536.480858361227;11702.2978621283 16:16:29 INFO - PROCESS | 1934 | |3;mootools.html;1563.5543869997045;1593.0441734959022;1687.9028631389604;1834.6055598046416;1846.9261229550818;7888.605569721505;8583.313334933206;8646.91353086469;9080.72757817265;9085.772855678602;8724.825503489943;8780;8925.553722313874;8930.330225233118;8946.060663630307;2369;2392.473655795722;2400.5078958813488;2404.2426635609813;2407.8194135439826;2386.642003699442;2398.640203969401;2402.1832576923844;2427.2354208424376;2435.305937807725;2408.650745641881;2409.2410890569413;2424.733279339271;2425.1148330859196;2427.2718184544565;2381.4403615150427;2384.7257565379855;2393.9760602393926;2404.5791986402396;2414.0947144820693;2375.5486457573006;2387.0332515331147;2393.5571919195004;2398.892049857743;2409.638554216864;8889;8921.55392230386;8969.506677132755;8981.506017169053;9045.638174473013;4457.48738895028;5308.9469105308835;5310.3362079739645;5368.91946620801;5449.01917654822;3507.9649203507893;3604.315180115796;3644.526211592476;3654.4701018352457;3663.5420572428447;1033.8500917367014;1049.7638031442941;1060.0936199549428;1074.409075008742;1077.8975997280245;11713.590024349107;11863.703407414798;11865.762684746256;11879.049676025983;11880.465379057963;4613.700109492872;4671.299305104261;4847.466778654416;4871.537203965618;4874.171390863562;10139.695809125738;10164.542595583216;10164.644237451654;10181.389116653025;10207.030332118586;5288.497592728761;5425.186222066722;5432.483914028161;5446.863828404322;5459.50864422196;4419.204543182193;4786.1863483207935;4923.113839508923;4954.9752251238515;4968.30443737877;4056.7556655948856;4057.4928133983253;4070.1249231414795;4109.404136400205;4126.339785634284;1294.695746499572;1300.486307908371;1309.4500309869877;1319.0239222975122;1319.0766463475607;773.5242825662177;804.5655346113033;851.5444237332997;893.0533634347612;930.2465003347311;6026.427489388501;6188.535859810532;6274.6548939807835;6274.874502509924;6307.779227727007;920.185635712386;948.4309414351334;949.2595775295142;997.6258902911409;1017.3590637898077;4160.563140870165;4251.128518653669;4269.082147338275;4328;4338.956610433918;10523.631672891564;10561.102306303897;10805.459727013775;10934.07060399859;10949.343039417661;10784.352938823695;10798.946005269923;10803.189760767973;10816.351018938889;10817.18871084656;7261.128664560287;7864.72473463426;8288.751337459886;8368.539730314891;8432;6199.690015499297;6212;6289.993601023814;6327.082573026977;6332.778352757631;8653.17794809492;9968.202543796624;10251.974802519688;10270.33242839213;10288.691339259834;10116.988301169824;10309.22680798958;10369.533370998171;10438;10503.737406564896;7039;7564.886526701994;7694.499857509244;7748.7675369739;7848.529088254723;8611.65553377858;8619.353548484014;8668;8674.479531228146;8731.126887311219;7596.734114305973;7747.612619369122;7783.494072885244;7839.098503671923;7866.213378662317;7558.3953283738265;7569.3566046886635;7624.466287359832;7737.883931741141;7769.223077692185;7173;7225.602591857499;7240.710371585288;7305.853882922418;7311;5101.51535604117;5205.869853253699;5236.528712415901;5250.89498210026;5278;5195.688258704338;5229.947700522946;5232.377962831534;5284.603654725988;5316.308879845596 16:16:29 INFO - PROCESS | 1934 | |4;prototype.html;280.1720914697069;309.5248793102588;315.25442328892177;318.63993687133535;319.3421551603695;5274.630775845692;5365.409804921455;5470.8085217017415;5530.723463826813;5590.804321848731;4432.7118737282135;5389.892202155955;5412.052890744114;5457.426970168135;5457.645253058548;3609.3142302962483;3951.348027575461;4192.895177620561;4200.51694055183;4215.367694845782;3286.457734473809;4137.710360274767;4189.748615083089;4189.97905010476;4223.450951376317;3186.3467989062187;3326.6507016763253;3454.6027206871154;3930.528336599612;4075;4068.921735740031;4069.2268468990796;4079.469668943048;4093.5292441369324;4111.8972025699595;3557.62644922282;3568.8572457101686;3569.7322700797545;3573.5175751273505;3576.749627526074;5017.738469994532;5128.897422051538;5214.487798538419;5222.321098257202;5318;3876;3942.448057271984;4634.490206077328;4680.4149481314835;4684.718916864965;4597.4484161290475;4957.033378491195;5139;5284.837335786121;5710.600257981943;3571.8035508047046;3860.575336712959;3866.574676785551;3870.5872356589925;3908.2965066288057;5250.18622113573;5284.207368894658;5558.777648894039;5932.584719069667;6027.714895381983;3950.7827069511454;3963.009247688078;3964.484616999772;3981.8606348777653;3987.5613682494904;3867.4530187925056;4030.496187976503;4040.717149799486;4046.1503084352025;4047.8988025299604;3914.1212218135456;4651.767411629405;4672.789724462407;4722.598579120745;4738.73936933465;4530.365748795171;4568.748718820497;5575.330960284792;5850;5853.536615846038;1206.9155159138952;1330.2151730479063;1369.4932874836175;1375.5529452927838;1377.4903285784324;722.9060222171084;799.4324029938692;817.840521098392;827.7103013945191;834.2700137379793;3619.2218672985437;3874.8837534874;4478.216312145361;4602.332661764025;4651.465081515601;4424.6239069678795;4503.279475283939;4809.22475856458;4932.630052745986;5064.088464076428;3932.2528719543197;4511.187986162522;4520.16933142078;4546.749359067217;4561.24739417999;2422.212780846197;2437.987810060974;2605.7231956341634;2619;2626.724193959645;4560.88597785058;5153.201253805666;5192.740362981911;5200.853483642342;5236.476352364733;4460.442444694413;5052.216906379517;5163.915577728644;5176.5858731301405;5257.973710131425;4425.026494171278;4856.902861942742;4963.975180124076;5063.164577844688;5085.288059671723;3924.8822535323984;4079.8776036718946;4413.7351758894565;4808.374911261513;5023.623228257822;4913.680610760289;4933.777979990838;4975;5000.549950504472;5006.097682880482;4865.324071760589;5689.97580435509;5896.7936122235515;6265.96867015662;6275.937240627535;3300.422426075379;3910.374340105683;3972.245273398045;3978.5822488638278;3991.7604943703473;4874.2444921037295;5228.843134705965;5411.296531451044;5668.728082882958;5999.640021598718;4809.567138957371;5002.449730529566;5389.7603551182665;5720.3707592165665;5751.798687045934;5134.922976155286;5141.511556402136;5333.959877823942;5786.450287222707;5797.739101740516;4415.646748260067;5028.321176641107;5466.043442397644;5617.494425501724;5662.433756624305;5171.043356978971;5687.767254126131;5699.204750503578;5705.4579814917515;5710.628809127394;4799.400074990626;4934.62990275738;5264.605154613496;5538.944610553843;5675.928286175599 16:16:29 INFO - PROCESS | 1934 | |5;yui.html;735.57704320016;784.6312233250372;793.5754371411292;848.5460278750869;854.7051267312777;15359;15603.84396156038;15814.4464943727;15848.68302633948;15956.920215398935;11793.941030294858;12775.488980440794;13295.468181272738;13361.599152025456;13433.529826456075;704.4505285877024;873.2751815992742;905.8777065096226;910.403685585939;914.2640174659397;890.9153630405101;902.6479672927563;905.6105874473974;906.5739102621757;910.4264313482497;966.2897770138942;969.6363863551169;970.0541971577726;970.7718686108794;975.3903810118676;926.1201858234704;927.2952556057378;953.5041778275328;954.8329042417583;965.034965034965;711.903892974447;713.8536599996988;716.8243780273866;718.3965469006008;721.1238345410352;15026.098434093989;15279.61800954985;15330.923345383313;15460.768088478682;15493;13493.797593036112;13548.254845983467;13614.727705445835;13667.863321366758;13671.453141874314;13150.671233219151;13247.403866826016;13255.005874559447;13454.529091481849;13513.391897364641;4648.721076735406;4661.650376221797;4679.532046795327;4706.5293470653005;4877.195262781637;108838;108963;109215.45392273067;109628;110125.89874101237;10807.459627018618;10998.632284085596;11074.976877405394;11222.046126079375;11483.540658373571;21088.472788180112;21100.894495527424;21118.155273788878;21119.894400528206;21139.471513211985;7914.129445760962;7922.603869806487;8048.476849004796;8130.186981301823;8242.793930151794;4375.190589740908;4407.867763967086;4483.21543729846;4487.5961163494785;4595.816167353269;3493.982530087333;3582.6238244984424;3588.1567831559564;3592.4072528033103;3593.2813437312643;649.7595889520813;654.5745265577413;657.7237560224717;673.1854456108066;675.2234929830734;518.6836030021684;573.2719446303255;630.8391360203119;667.0694381338103;671.4292851076643;9638.614455421844;9673;9709.223262139012;9723.805523889625;9901.257405694458;586.5247665769938;607.9118527813442;647.239493595024;670.5239280111078;693.3240090911321;4594.5864872161665;4756.667033307635;4772.236442169236;4776.928346074812;4779.091972525209;154345;156167;157934;158928;159356.4064359365;110571;122132;133724;134707;139863;86482;108161.45919270354;108185;109233;110053;6948.374646281859;9049.366544342096;9073.546322683971;9129.634814607607;9333.626654933998;48918.26622600593;63707.362926370144;63756.36243637504;63935;65063.67468162629;94790.57814132655;100215.49892250492;100781;101467.98532014585;101831;11937.701557461132;12041;12058;12423.751524969632;12556.87443125557;13074.411651475897;13086.607401777961;13206.933965330112;13394.995375347084;13567.728645427234;12401.751964960831;12565.120441569003;12667.93666031664;12830.935845320713;12973.805392919303;12386.504539818667;12426.62720118398;12431.129820912449;12563.497460101493;12847.93576032114;10846.403447810446;12659.683507912376;12798.296093714935;13449.663758406117;13602.115862468909;11478.947289734504;11554.480048397674;11652.708682283012;11712.238704484182;11826;10385.532651030873;10406.531706073094;11503.76992460163;11681.474333654836;11758.94120529426 16:16:29 INFO - PROCESS | 1934 | __end_tp_report 16:16:29 INFO - PROCESS | 1934 | __start_cc_report 16:16:29 INFO - PROCESS | 1934 | _x_x_mozilla_cycle_collect,439 16:16:29 INFO - PROCESS | 1934 | __end_cc_report 16:16:29 INFO - PROCESS | 1934 | __startTimestamp1468970189821__endTimestamp 16:16:29 INFO - PROCESS | 1934 | 16:16:29 INFO - PROCESS | 1934 | ------- Summary: start ------- 16:16:29 INFO - PROCESS | 1934 | Number of tests: 6 16:16:29 INFO - PROCESS | 1934 | 16:16:29 INFO - PROCESS | 1934 | [#0] dojo.html Cycles:165 Average:5783.33 Median:6071.67 stddev:684.52 (11.3%) stddev-sans-first:642.98 16:16:29 INFO - PROCESS | 1934 | Values: 2717.6 2881.5 3357.0 3423.0 3437.8 5730.2 5737.5 5784.8 5841.9 5854.9 5637.3 5801.3 5814.9 5815.7 5875.6 4221.9 4258.8 5293.6 5351.4 5365.9 5198.8 5369.7 5423.3 5436.5 5439.1 5189.9 5192.5 5254.8 5275.7 5284.6 5219.7 5220.7 5234.2 5239.2 5266.9 5228.7 5252.4 5263.8 5319.7 5350.3 5425.8 5770.6 5782.2 5786.2 5835.0 6185.9 6260.4 6275.2 6328.4 6341.9 6190.3 6275.5 6293.9 6298.2 6307.9 5846.8 5866.0 5910.7 5916.3 5923.8 6274.7 6328.0 6330.8 6334.4 6357.8 6109.4 6128.3 6225.0 6235.1 6239.9 6257.1 6305.2 6307.2 6317.6 6323.7 6050.6 6166.5 6229.8 6242.7 6280.2 6125.2 6125.5 6208.8 6297.3 6306.5 4961.9 4996.3 5008.2 5012.8 5069.2 4473.8 4483.4 4499.7 4537.4 4560.9 5578.2 5900.0 5944.3 5951.6 5977.7 6267.7 6271.0 6276.3 6297.5 6328.5 5901.4 5970.0 5979.6 5998.2 6047.1 5370.6 5444.0 5462.0 5495.8 5513.0 6354.1 6376.6 6401.2 6402.5 6410.3 6283.5 6285.7 6289.2 6292.5 6298.0 5257.4 6233.4 6260.2 6282.1 6356.3 6220.6 6227.4 6258.8 6278.4 6281.4 6186.4 6228.0 6268.9 6269.1 6286.7 6081.7 6106.6 6143.8 6155.3 6195.3 4871.0 6141.3 6163.9 6176.7 6180.2 5940.0 6018.5 6038.6 6083.7 6087.7 6071.7 6126.6 6160.1 6182.6 6204.1 6069.6 6079.2 6083.9 6098.9 6130.5 16:16:29 INFO - PROCESS | 1934 | 16:16:29 INFO - PROCESS | 1934 | [#1] ext.html Cycles:180 Average:71867.29 Median:41212.19 stddev:156888.56 (380.7%) stddev-sans-first:157237.23 16:16:29 INFO - PROCESS | 1934 | Values: 521.3 522.4 536.2 559.0 559.9 38313.6 40595.6 40654.6 40795.8 40857.0 41541.2 41787.8 41833.8 41877.2 41946.6 9472.0 9523.3 9608.0 9651.5 9669.2 9532.7 9559.0 9592.7 9613.2 9616.2 7301.0 8219.0 9566.4 9626.0 9668.9 9523.7 9531.7 9558.2 9622.4 9637.0 8025.4 9521.5 9603.9 9608.9 9631.9 39797.6 40179.6 40279.6 40303.6 40387.8 2862.2 3471.0 3512.2 3534.6 3642.2 26381.9 31089.5 32786.8 32858.0 32859.0 2536.6 3189.7 3269.7 3296.2 3300.4 493784.0 497618.0 502144.0 502742.0 503490.0 54388.2 64035.7 64220.0 64340.7 64563.7 65778.0 66061.7 66973.7 67007.3 67011.7 16471.1 16662.0 16788.4 16798.3 16831.2 11483.5 11655.0 12683.3 12919.9 12944.4 16801.9 19267.6 19424.1 19509.8 19544.8 8033.6 8079.2 8130.3 8150.6 8214.0 871.3 959.6 974.7 983.8 1102.6 28704.1 29627.0 30483.0 30614.8 30722.1 1061.4 1130.6 1170.4 1195.3 1243.5 15872.6 15927.9 15995.3 16227.5 16424.2 590659.0 693221.0 694159.0 696642.0 706366.0 59481.0 60035.4 60337.7 60340.4 60344.4 1337.7 1352.6 1382.5 1387.1 1395.8 30019.7 30035.0 30281.9 30453.1 30508.5 50695.5 50976.5 50992.5 51221.5 51268.0 561864.0 565755.0 571412.0 573537.4 573949.0 21557.9 25779.4 25937.5 27438.0 28248.2 49054.8 49161.5 49642.8 50052.5 50100.7 40778.6 41107.4 41126.0 41596.2 41607.4 40843.0 41152.0 41272.4 41685.8 42262.4 38979.8 39254.4 39572.8 39623.8 39769.8 30108.2 34825.5 35572.8 36347.3 36573.8 25660.6 26074.0 26121.0 26509.7 26536.3 16:16:29 INFO - PROCESS | 1934 | 16:16:29 INFO - PROCESS | 1934 | [#2] jquery.html Cycles:180 Average:35115.99 Median:366.74 stddev:100840.94 (27496.6%) stddev-sans-first:101090.10 16:16:29 INFO - PROCESS | 1934 | Values: 384.4 387.4 389.1 390.9 412.7 14657.9 19769.5 20649.2 21130.0 21136.4 20737.4 21169.7 21523.0 21832.0 21893.0 5331.1 5512.7 5551.1 5567.9 5571.9 5394.8 5467.5 5483.7 5523.4 5549.1 5665.1 5893.3 5955.3 6030.5 6039.4 5921.8 6055.6 6060.6 6118.5 6216.8 6002.8 6054.7 6068.9 6073.1 6079.5 13530.9 13715.7 21108.6 22310.5 26832.5 2262.8 2337.1 2359.6 2425.0 2944.7 10311.5 10312.7 10444.4 10503.6 10505.7 1843.7 1854.2 1864.9 1908.2 1950.3 117045.0 119903.0 120219.4 121508.4 121511.8 11638.7 11697.4 11704.7 11832.9 11850.3 14834.7 14876.5 14941.6 14948.8 14960.6 8527.6 8620.5 8638.2 8703.4 8730.8 6937.3 8529.6 8530.3 8649.0 8672.3 4526.9 4582.8 4620.3 4635.2 4692.2 1698.9 1939.2 1983.3 2034.7 2036.6 351.9 381.6 416.2 808.2 913.1 11972.8 11992.2 12045.0 12184.5 12284.0 436.7 439.7 440.3 448.4 457.4 6065.4 6168.9 6172.4 6266.2 6274.3 595246.0 596043.0 602161.0 602873.0 607873.0 129465.7 142373.0 145133.0 145999.0 147823.3 949.9 961.8 999.0 1001.7 1005.4 18882.6 19162.0 19229.3 19326.0 19421.6 54015.0 54608.0 54728.0 56196.4 56721.1 69632.0 80836.0 81213.0 81685.8 82644.2 7965.8 8007.7 8033.3 8218.8 8322.1 9038.2 11889.3 12597.6 12859.6 12945.9 10002.4 10720.2 11072.2 11108.9 11379.9 9395.6 11319.0 11448.3 11465.1 11575.5 11626.1 11750.2 11814.2 11922.6 12046.9 7093.3 7441.1 7481.3 7722.7 8331.3 10258.5 10935.6 11379.9 11536.5 11702.3 16:16:29 INFO - PROCESS | 1934 | 16:16:29 INFO - PROCESS | 1934 | [#3] mootools.html Cycles:180 Average:5839.92 Median:4872.85 stddev:3239.35 (66.5%) stddev-sans-first:3232.49 16:16:29 INFO - PROCESS | 1934 | Values: 1563.6 1593.0 1687.9 1834.6 1846.9 7888.6 8583.3 8646.9 9080.7 9085.8 8724.8 8780.0 8925.6 8930.3 8946.1 2369.0 2392.5 2400.5 2404.2 2407.8 2386.6 2398.6 2402.2 2427.2 2435.3 2408.7 2409.2 2424.7 2425.1 2427.3 2381.4 2384.7 2394.0 2404.6 2414.1 2375.5 2387.0 2393.6 2398.9 2409.6 8889.0 8921.6 8969.5 8981.5 9045.6 4457.5 5308.9 5310.3 5368.9 5449.0 3508.0 3604.3 3644.5 3654.5 3663.5 1033.9 1049.8 1060.1 1074.4 1077.9 11713.6 11863.7 11865.8 11879.0 11880.5 4613.7 4671.3 4847.5 4871.5 4874.2 10139.7 10164.5 10164.6 10181.4 10207.0 5288.5 5425.2 5432.5 5446.9 5459.5 4419.2 4786.2 4923.1 4955.0 4968.3 4056.8 4057.5 4070.1 4109.4 4126.3 1294.7 1300.5 1309.5 1319.0 1319.1 773.5 804.6 851.5 893.1 930.2 6026.4 6188.5 6274.7 6274.9 6307.8 920.2 948.4 949.3 997.6 1017.4 4160.6 4251.1 4269.1 4328.0 4339.0 10523.6 10561.1 10805.5 10934.1 10949.3 10784.4 10798.9 10803.2 10816.4 10817.2 7261.1 7864.7 8288.8 8368.5 8432.0 6199.7 6212.0 6290.0 6327.1 6332.8 8653.2 9968.2 10252.0 10270.3 10288.7 10117.0 10309.2 10369.5 10438.0 10503.7 7039.0 7564.9 7694.5 7748.8 7848.5 8611.7 8619.4 8668.0 8674.5 8731.1 7596.7 7747.6 7783.5 7839.1 7866.2 7558.4 7569.4 7624.5 7737.9 7769.2 7173.0 7225.6 7240.7 7305.9 7311.0 5101.5 5205.9 5236.5 5250.9 5278.0 5195.7 5229.9 5232.4 5284.6 5316.3 16:16:29 INFO - PROCESS | 1934 | 16:16:29 INFO - PROCESS | 1934 | [#4] prototype.html Cycles:180 Average:4348.74 Median:4703.66 stddev:1325.25 (28.2%) stddev-sans-first:1293.30 16:16:29 INFO - PROCESS | 1934 | Values: 280.2 309.5 315.3 318.6 319.3 5274.6 5365.4 5470.8 5530.7 5590.8 4432.7 5389.9 5412.1 5457.4 5457.6 3609.3 3951.3 4192.9 4200.5 4215.4 3286.5 4137.7 4189.7 4190.0 4223.5 3186.3 3326.7 3454.6 3930.5 4075.0 4068.9 4069.2 4079.5 4093.5 4111.9 3557.6 3568.9 3569.7 3573.5 3576.7 5017.7 5128.9 5214.5 5222.3 5318.0 3876.0 3942.4 4634.5 4680.4 4684.7 4597.4 4957.0 5139.0 5284.8 5710.6 3571.8 3860.6 3866.6 3870.6 3908.3 5250.2 5284.2 5558.8 5932.6 6027.7 3950.8 3963.0 3964.5 3981.9 3987.6 3867.5 4030.5 4040.7 4046.2 4047.9 3914.1 4651.8 4672.8 4722.6 4738.7 4530.4 4568.7 5575.3 5850.0 5853.5 1206.9 1330.2 1369.5 1375.6 1377.5 722.9 799.4 817.8 827.7 834.3 3619.2 3874.9 4478.2 4602.3 4651.5 4424.6 4503.3 4809.2 4932.6 5064.1 3932.3 4511.2 4520.2 4546.7 4561.2 2422.2 2438.0 2605.7 2619.0 2626.7 4560.9 5153.2 5192.7 5200.9 5236.5 4460.4 5052.2 5163.9 5176.6 5258.0 4425.0 4856.9 4964.0 5063.2 5085.3 3924.9 4079.9 4413.7 4808.4 5023.6 4913.7 4933.8 4975.0 5000.5 5006.1 4865.3 5690.0 5896.8 6266.0 6275.9 3300.4 3910.4 3972.2 3978.6 3991.8 4874.2 5228.8 5411.3 5668.7 5999.6 4809.6 5002.4 5389.8 5720.4 5751.8 5134.9 5141.5 5334.0 5786.5 5797.7 4415.6 5028.3 5466.0 5617.5 5662.4 5171.0 5687.8 5699.2 5705.5 5710.6 4799.4 4934.6 5264.6 5538.9 5675.9 16:16:29 INFO - PROCESS | 1934 | 16:16:29 INFO - PROCESS | 1934 | [#5] yui.html Cycles:180 Average:25016.19 Median:21119.02 stddev:40397.86 (191.3%) stddev-sans-first:40470.05 16:16:29 INFO - PROCESS | 1934 | Values: 735.6 784.6 793.6 848.5 854.7 15359.0 15603.8 15814.4 15848.7 15956.9 11793.9 12775.5 13295.5 13361.6 13433.5 704.5 873.3 905.9 910.4 914.3 890.9 902.6 905.6 906.6 910.4 966.3 969.6 970.1 970.8 975.4 926.1 927.3 953.5 954.8 965.0 711.9 713.9 716.8 718.4 721.1 15026.1 15279.6 15330.9 15460.8 15493.0 13493.8 13548.3 13614.7 13667.9 13671.5 13150.7 13247.4 13255.0 13454.5 13513.4 4648.7 4661.7 4679.5 4706.5 4877.2 108838.0 108963.0 109215.5 109628.0 110125.9 10807.5 10998.6 11075.0 11222.0 11483.5 21088.5 21100.9 21118.2 21119.9 21139.5 7914.1 7922.6 8048.5 8130.2 8242.8 4375.2 4407.9 4483.2 4487.6 4595.8 3494.0 3582.6 3588.2 3592.4 3593.3 649.8 654.6 657.7 673.2 675.2 518.7 573.3 630.8 667.1 671.4 9638.6 9673.0 9709.2 9723.8 9901.3 586.5 607.9 647.2 670.5 693.3 4594.6 4756.7 4772.2 4776.9 4779.1 154345.0 156167.0 157934.0 158928.0 159356.4 110571.0 122132.0 133724.0 134707.0 139863.0 86482.0 108161.5 108185.0 109233.0 110053.0 6948.4 9049.4 9073.5 9129.6 9333.6 48918.3 63707.4 63756.4 63935.0 65063.7 94790.6 100215.5 100781.0 101468.0 101831.0 11937.7 12041.0 12058.0 12423.8 12556.9 13074.4 13086.6 13206.9 13395.0 13567.7 12401.8 12565.1 12667.9 12830.9 12973.8 12386.5 12426.6 12431.1 12563.5 12847.9 10846.4 12659.7 12798.3 13449.7 13602.1 11478.9 11554.5 11652.7 11712.2 11826.0 10385.5 10406.5 11503.8 11681.5 11758.9 16:16:29 INFO - PROCESS | 1934 | -------- Summary: end -------- 16:16:29 INFO - PROCESS | 1934 | 16:16:30 INFO - TEST-INFO | 1934: exit 0 16:16:30 INFO - TEST-OK | dromaeo_css | took 1112789ms 16:16:30 INFO - TEST-START | kraken 16:16:30 INFO - operating with platform_type : mac_ 16:16:30 INFO - Initialising browser for kraken test... 16:16:30 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpNVLFTb/profile http://localhost:51840/getInfo.html) 16:16:33 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 16:16:33 INFO - PROCESS | 1939 | colorDepth:24 16:16:33 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 16:16:33 INFO - PROCESS | 1939 | __metrics 16:16:33 ERROR - PROCESS | 1939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:16:34 INFO - TEST-INFO | 1939: exit 0 16:16:34 INFO - Browser initialized. 16:16:34 INFO - Running cycle 1/1 for kraken test... 16:16:34 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpNVLFTb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:16:46 INFO - PROCESS | 1941 | RSS: Main: 254337024 16:16:46 INFO - PROCESS | 1941 | 16:16:48 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51840/tests/kraken/driver.html?testName=audio-beat-detection) 16:16:49 INFO - PROCESS | 1941 | RSS: Main: 267542528 16:16:49 INFO - PROCESS | 1941 | 16:16:52 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51840/tests/kraken/driver.html?testName=audio-dft) 16:16:53 INFO - PROCESS | 1941 | RSS: Main: 271572992 16:16:53 INFO - PROCESS | 1941 | 16:16:56 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51840/tests/kraken/driver.html?testName=audio-fft) 16:16:57 INFO - PROCESS | 1941 | RSS: Main: 272113664 16:16:57 INFO - PROCESS | 1941 | 16:16:59 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51840/tests/kraken/driver.html?testName=audio-oscillator) 16:16:59 INFO - PROCESS | 1941 | RSS: Main: 273022976 16:16:59 INFO - PROCESS | 1941 | 16:17:01 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51840/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:17:02 INFO - PROCESS | 1941 | RSS: Main: 273657856 16:17:02 INFO - PROCESS | 1941 | 16:17:05 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51840/tests/kraken/driver.html?testName=imaging-darkroom) 16:17:05 INFO - PROCESS | 1941 | RSS: Main: 274575360 16:17:05 INFO - PROCESS | 1941 | 16:17:08 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51840/tests/kraken/driver.html?testName=imaging-desaturate) 16:17:09 INFO - PROCESS | 1941 | RSS: Main: 274735104 16:17:09 INFO - PROCESS | 1941 | 16:17:12 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51840/tests/kraken/driver.html?testName=json-parse-financial) 16:17:13 INFO - PROCESS | 1941 | RSS: Main: 274821120 16:17:13 INFO - PROCESS | 1941 | 16:17:14 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51840/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:17:15 INFO - PROCESS | 1941 | RSS: Main: 274698240 16:17:15 INFO - PROCESS | 1941 | 16:17:17 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51840/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:17:18 INFO - PROCESS | 1941 | RSS: Main: 274092032 16:17:18 INFO - PROCESS | 1941 | 16:17:20 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51840/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:17:20 INFO - PROCESS | 1941 | RSS: Main: 274132992 16:17:20 INFO - PROCESS | 1941 | 16:17:23 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:17:24 INFO - PROCESS | 1941 | RSS: Main: 274268160 16:17:24 INFO - PROCESS | 1941 | 16:17:27 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:17:28 INFO - PROCESS | 1941 | RSS: Main: 274186240 16:17:28 INFO - PROCESS | 1941 | 16:17:29 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:51840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51840/tests/kraken/driver.html?testName=ai-astar) 16:17:30 INFO - PROCESS | 1941 | RSS: Main: 275288064 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | __start_tp_report 16:17:30 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 16:17:30 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 16:17:30 INFO - PROCESS | 1941 | |i|pagename|runs| 16:17:30 INFO - PROCESS | 1941 | |0;ai-astar;104;114;106;116;116;135;167;160;117;116 16:17:30 INFO - PROCESS | 1941 | |1;audio-beat-detection;187;143;121;192;142;140;131;111;148;105 16:17:30 INFO - PROCESS | 1941 | |2;audio-dft;203;203;210;234;268;245;203;197;198;196 16:17:30 INFO - PROCESS | 1941 | |3;audio-fft;67;86;77;148;60;59;60;61;135;58 16:17:30 INFO - PROCESS | 1941 | |4;audio-oscillator;71;72;129;71;71;79;121;71;73;116 16:17:30 INFO - PROCESS | 1941 | |5;imaging-gaussian-blur;90;89;136;88;92;88;92;90;90;89 16:17:30 INFO - PROCESS | 1941 | |6;imaging-darkroom;98;96;118;157;108;98;96;120;116;96 16:17:30 INFO - PROCESS | 1941 | |7;imaging-desaturate;89;100;98;99;143;116;93;96;109;119 16:17:30 INFO - PROCESS | 1941 | |8;json-parse-financial;56;56;56;54;58;78;81;88;71;57 16:17:30 INFO - PROCESS | 1941 | |9;json-stringify-tinderbox;69;70;69;72;88;79;79;72;72;75 16:17:30 INFO - PROCESS | 1941 | |10;stanford-crypto-aes;92;108;86;83;88;84;82;96;95;86 16:17:30 INFO - PROCESS | 1941 | |11;stanford-crypto-ccm;149;137;132;156;149;145;152;153;190;155 16:17:30 INFO - PROCESS | 1941 | |12;stanford-crypto-pbkdf2;184;215;224;167;167;174;167;231;225;177 16:17:30 INFO - PROCESS | 1941 | |13;stanford-crypto-sha256-iterative;64;71;61;65;70;58;70;84;86;81 16:17:30 INFO - PROCESS | 1941 | __end_tp_report 16:17:30 INFO - PROCESS | 1941 | __start_cc_report 16:17:30 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,1121 16:17:30 INFO - PROCESS | 1941 | __end_cc_report 16:17:30 INFO - PROCESS | 1941 | __startTimestamp1468970250217__endTimestamp 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | ------- Summary: start ------- 16:17:30 INFO - PROCESS | 1941 | Number of tests: 14 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#0] ai-astar Cycles:10 Average:125.10 Median:116.50 stddev:21.91 (18.8%) stddev-sans-first:21.86 16:17:30 INFO - PROCESS | 1941 | Values: 104.0 114.0 106.0 116.0 116.0 135.0 167.0 160.0 117.0 116.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:142.50 stddev:28.79 (20.2%) stddev-sans-first:25.51 16:17:30 INFO - PROCESS | 1941 | Values: 187.0 143.0 121.0 192.0 142.0 140.0 131.0 111.0 148.0 105.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#2] audio-dft Cycles:10 Average:215.70 Median:206.50 stddev:24.71 (12.0%) stddev-sans-first:25.78 16:17:30 INFO - PROCESS | 1941 | Values: 203.0 203.0 210.0 234.0 268.0 245.0 203.0 197.0 198.0 196.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#3] audio-fft Cycles:10 Average:81.10 Median:60.50 stddev:33.23 (54.9%) stddev-sans-first:34.85 16:17:30 INFO - PROCESS | 1941 | Values: 67.0 86.0 77.0 148.0 60.0 59.0 60.0 61.0 135.0 58.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:71.00 stddev:24.19 (34.1%) stddev-sans-first:24.92 16:17:30 INFO - PROCESS | 1941 | Values: 71.0 72.0 129.0 71.0 71.0 79.0 121.0 71.0 73.0 116.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#5] imaging-gaussian-blur Cycles:10 Average:94.40 Median:90.00 stddev:14.68 (16.3%) stddev-sans-first:15.49 16:17:30 INFO - PROCESS | 1941 | Values: 90.0 89.0 136.0 88.0 92.0 88.0 92.0 90.0 90.0 89.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:96.00 stddev:19.11 (19.9%) stddev-sans-first:19.75 16:17:30 INFO - PROCESS | 1941 | Values: 98.0 96.0 118.0 157.0 108.0 98.0 96.0 120.0 116.0 96.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#7] imaging-desaturate Cycles:10 Average:106.20 Median:91.00 stddev:16.17 (17.8%) stddev-sans-first:15.91 16:17:30 INFO - PROCESS | 1941 | Values: 89.0 100.0 98.0 99.0 143.0 116.0 93.0 96.0 109.0 119.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:64.50 stddev:12.76 (19.8%) stddev-sans-first:13.06 16:17:30 INFO - PROCESS | 1941 | Values: 56.0 56.0 56.0 54.0 58.0 78.0 81.0 88.0 71.0 57.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#9] json-stringify-tinderbox Cycles:10 Average:74.50 Median:73.50 stddev:5.99 (8.1%) stddev-sans-first:6.01 16:17:30 INFO - PROCESS | 1941 | Values: 69.0 70.0 69.0 72.0 88.0 79.0 79.0 72.0 72.0 75.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:87.00 stddev:7.99 (9.2%) stddev-sans-first:8.44 16:17:30 INFO - PROCESS | 1941 | Values: 92.0 108.0 86.0 83.0 88.0 84.0 82.0 96.0 95.0 86.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:152.50 stddev:15.50 (10.2%) stddev-sans-first:16.40 16:17:30 INFO - PROCESS | 1941 | Values: 149.0 137.0 132.0 156.0 149.0 145.0 152.0 153.0 190.0 155.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.10 Median:199.50 stddev:27.16 (13.6%) stddev-sans-first:28.61 16:17:30 INFO - PROCESS | 1941 | Values: 184.0 215.0 224.0 167.0 167.0 174.0 167.0 231.0 225.0 177.0 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - PROCESS | 1941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.50 stddev:9.72 (13.8%) stddev-sans-first:9.97 16:17:30 INFO - PROCESS | 1941 | Values: 64.0 71.0 61.0 65.0 70.0 58.0 70.0 84.0 86.0 81.0 16:17:30 INFO - PROCESS | 1941 | -------- Summary: end -------- 16:17:30 INFO - PROCESS | 1941 | 16:17:30 INFO - TEST-INFO | 1941: exit 0 16:17:31 INFO - TEST-OK | kraken | took 60573ms 16:17:31 INFO - SUITE-END | took 1173s 16:17:31 INFO - Completed test suite (00:19:33) 16:17:31 INFO - javascript benchmark 16:17:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7311.551138383008, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2717.6331195288635, 2881.452524020436, 3356.9593426037914, 3422.9828850855743, 3437.8281085945705, 5730.169125476803, 5737.512311453526, 5784.768609255625, 5841.912371314434, 5854.853628659285, 5637.3235211774545, 5801.332846722628, 5814.854628634286, 5815.651060936347, 5875.647461152324, 4221.873343799691, 4258.765767882765, 5293.57651387888, 5351.438098999607, 5365.865853353658, 5198.766055527511, 5369.704666243355, 5423.29497165368, 5436.510714035736, 5439.075357189287, 5189.870253243699, 5192.480751924815, 5254.816081437131, 5275.736213189363, 5284.603654725892, 5219.686818790847, 5220.686758794484, 5234.162533994542, 5239.21411788231, 5266.92099618506, 5228.712420816853, 5252.422233554306, 5263.815766448156, 5319.654222475527, 5350.30446042016, 5425.810096646638, 5770.567207459458, 5782.248307720011, 5786.189933409326, 5835.0, 6185.87628247437, 6260.436560709512, 6275.183957787829, 6328.430441260262, 6341.936580634181, 6190.3190649028575, 6275.466585340251, 6293.905591416133, 6298.1812364392335, 6307.905381419282, 5846.824595262106, 5866.032104702719, 5910.73401696929, 5916.26046744157, 5923.822285331361, 6274.717637706314, 6328.0, 6330.778422755181, 6334.366563343721, 6357.809265722036, 6109.404666050326, 6128.3258841527395, 6225.0, 6235.064740288993, 6239.937600623935, 6257.061440783918, 6305.243370795534, 6307.180066591405, 6317.6209427434505, 6323.652199129, 6050.606710563799, 6166.475849552839, 6229.781957631461, 6242.687865606701, 6280.214973128359, 6125.235451818339, 6125.47964319526, 6208.782692605737, 6297.338779428185, 6306.527010474141, 4961.875953101129, 4996.275540046746, 5008.17365134756, 5012.8496145115705, 5069.163588008011, 4473.753943533072, 4483.449298961556, 4499.662525310615, 4537.3647689323525, 4560.863174104782, 5578.219049333096, 5900.0, 5944.346121926585, 5951.583389162717, 5977.67122808241, 6267.717952692049, 6270.996640537492, 6276.278228003838, 6297.527685423612, 6328.493720502441, 5901.380355062743, 5969.970150149222, 5979.641221526722, 5998.171471965023, 6047.12316714074, 5370.62405631602, 5444.020076386289, 5461.972690136524, 5495.835124946258, 5513.0, 6354.078658594478, 6376.585521941059, 6401.231852177675, 6402.48780097591, 6410.326915673973, 6283.497320214463, 6285.685715714288, 6289.182406287337, 6292.496600271876, 6297.96851015742, 5257.395399529103, 6233.438990490878, 6260.186175797117, 6282.057691346152, 6356.3325850785, 6220.626762394271, 6227.439530442282, 6258.812235632939, 6278.4035516625845, 6281.371862813682, 6186.381361863778, 6228.003519436868, 6268.905966410416, 6269.0909818075215, 6286.654234017173, 6081.6655083969035, 6106.572539922163, 6143.849652621547, 6155.292141403616, 6195.256569211723, 4870.975645121894, 6141.293751218667, 6163.907541386972, 6176.66028368444, 6180.196574445294, 5939.970300148471, 6018.458338749533, 6038.5772995889865, 6083.726232319645, 6087.66517841523, 6071.666058366833, 6126.578745377254, 6160.13758073861, 6182.629042257479, 6204.100405441095, 6069.635821850703, 6079.240094988127, 6083.878322433615, 6098.928203058511, 6130.50955923534], "value": 5736.467382359525, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.2936471081682, 522.3731522173392, 536.1930294906166, 559.0049711513508, 559.9104143337065, 38313.616863831354, 40595.59404405955, 40654.59345406545, 40795.77612671625, 40857.0, 41541.169176616524, 41787.79106104465, 41833.79083104588, 41877.16245675085, 41946.58053419465, 9471.952640236823, 9523.28575356851, 9608.0, 9651.5174241288, 9669.178119859786, 9532.71401857942, 9559.0, 9592.712218633453, 9613.182879455255, 9616.182624476927, 7300.963495182516, 8219.0, 9566.378185417925, 9625.951870240639, 9668.854967175497, 9523.714288571355, 9531.666391676328, 9558.187554057879, 9622.422654640744, 9637.036296370306, 8025.398095142829, 9521.523923803783, 9603.90396096044, 9608.903910960871, 9631.90368096317, 39797.60202397968, 40179.59820401788, 40279.59720402788, 40303.59696403028, 40387.7980610098, 2862.2415060009116, 3470.9826450867836, 3512.1570823002294, 3534.6288639692975, 3642.21692336149, 26381.868090659424, 31089.53365699516, 32786.836065819516, 32858.0, 32859.01422957315, 2536.6195070739536, 3189.7129258366626, 3269.7057264846276, 3296.1924328539662, 3300.422426075427, 493784.0, 497618.0, 502144.0, 502742.0, 503490.0, 54388.184177237374, 64035.67982160152, 64220.0, 64340.67829660822, 64563.67718161379, 65778.0, 66061.66969165123, 66973.66513167403, 67007.32992670011, 67011.66494167596, 16471.094089824936, 16662.00027998324, 16788.412405565745, 16798.32806687743, 16831.242594083295, 11483.483243254073, 11655.0, 12683.302418367079, 12919.935400323126, 12944.352782361033, 16801.937959568633, 19267.614647706967, 19424.12591433389, 19509.804901951084, 19544.804551954297, 8033.598320083973, 8079.1516890725625, 8130.30892374143, 8150.592470376576, 8214.0, 871.2507243770352, 959.6209497248548, 974.6637410093506, 983.8130755156498, 1102.6416414665266, 28704.13887583376, 29626.963056292927, 30483.0, 30614.84692576523, 30722.078337649906, 1061.4109169411051, 1130.5929865248504, 1170.4381896689467, 1195.3425615911215, 1243.4590952935503, 15872.603184920239, 15927.920360398355, 15995.280212390471, 16227.513174604781, 16424.1787910604, 590659.0, 693221.0, 694159.0, 696642.0, 706366.0, 59481.0, 60035.399646003854, 60337.69831150904, 60340.396596034356, 60344.39655603476, 1337.6923307639104, 1352.648311439033, 1382.4884792626792, 1387.098386049056, 1395.762720337545, 30019.699803002564, 30035.0, 30281.862317069157, 30453.086407407813, 30508.542371863994, 50695.49304506907, 50976.49023509866, 50992.49007509877, 51221.48778512167, 51268.0, 561864.0, 565755.0, 571412.0, 573537.396939038, 573949.0, 21557.89221053885, 25779.355516112246, 25937.48125037451, 27438.0, 28248.15255542337, 49054.75472622614, 49161.508384915694, 49642.751786240835, 50052.499475004784, 50100.74949625228, 40778.59221407748, 41107.383389249786, 41126.0, 41596.1680766389, 41607.37588936229, 40843.0, 41152.0, 41272.380914285706, 41685.79157104316, 42262.366064508446, 38979.805100974314, 39254.4111838317, 39572.802135989135, 39623.80188099041, 39769.80115099406, 30108.24729381783, 34825.47761783525, 35572.822135890194, 36347.27305453929, 36573.817130914176, 25660.61509077328, 26074.0, 26121.0, 26509.734902651497, 26536.336591585365], "value": 20319.114305043295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3657964358808, 387.4420833999041, 389.11282276409776, 390.923007115397, 412.6904821383962, 14657.853421465783, 19769.505762355948, 20649.174033038697, 21130.04914778833, 21136.365909022734, 20737.377878663665, 21169.68245476315, 21523.0, 21832.0, 21893.0, 5331.147016477365, 5512.669239845602, 5551.056320425517, 5567.916481252784, 5571.860703482425, 5394.7842086316505, 5467.535259502927, 5483.698396588186, 5523.392426833066, 5549.084401073818, 5665.12190610456, 5893.322267939177, 5955.255593050869, 6030.547708921827, 6039.3960603939695, 5921.792737254197, 6055.636661800306, 6060.575759696823, 6118.541109416767, 6216.813495595139, 6002.759889604411, 6054.697265136726, 6068.939310606882, 6073.1497590337385, 6079.452849243589, 13530.93234533821, 13715.657108572266, 21108.5778284435, 22310.54981426202, 26832.463350733073, 2262.7510973793032, 2337.053493335202, 2359.5634807560655, 2424.9936276445255, 2944.7055294470597, 10311.484425778755, 10312.690619281433, 10444.425556594384, 10503.632372866912, 10505.737356566071, 1843.732658764485, 1854.1563588567305, 1864.9347272845384, 1908.236705317884, 1950.3271371376852, 117045.0, 119903.0, 120219.3989030058, 121508.39245803803, 121511.78488215093, 11638.70903227426, 11697.445933461098, 11704.70738231551, 11832.88167118335, 11850.348230847214, 14834.73904718111, 14876.479323223635, 14941.551753447415, 14948.775768363483, 14960.625984350261, 8527.573621318908, 8620.482771033758, 8638.222559969632, 8703.43427677199, 8730.825383492294, 6937.3062693731235, 8529.616167272488, 8530.274926631306, 8649.0, 8672.262857657044, 4526.864194074183, 4582.839600613963, 4620.259127218299, 4635.23518619424, 4692.225782745809, 1698.8980661160122, 1939.21461807968, 1983.305842954983, 2034.745656792901, 2036.5926814637132, 351.89267273481323, 381.5859792125575, 416.1946633264582, 808.1635507249968, 913.1051569461964, 11972.820407693891, 11992.160548761678, 12045.036397088212, 12184.51261949512, 12283.955863751502, 436.6899501354074, 439.70320033976935, 440.28673548851066, 448.42153621827475, 457.3756821938031, 6065.423784740443, 6168.889599872066, 6172.382761723792, 6266.154069200691, 6274.309825919146, 595246.0, 596043.0, 602161.0, 602873.0, 607873.0, 129465.70534294537, 142373.0, 145133.0, 145999.0, 147823.26088369705, 949.886013678363, 961.8461046232569, 998.9500524973722, 1001.7044971733357, 1005.4168582222294, 18882.622347552697, 19162.0, 19229.326973555857, 19326.03369831531, 19421.611567768283, 54015.0, 54608.0, 54728.0, 56196.43803561912, 56721.14918276312, 69632.0, 80836.0, 81213.0, 81685.77471338054, 82644.17355826365, 7965.840683186188, 8007.712981187092, 8033.272846338065, 8218.849361089333, 8322.126176751353, 9038.186563209343, 11889.286642801113, 12597.622071337875, 12859.614211573667, 12945.935270323587, 10002.399856008662, 10720.177569812995, 11072.224944253825, 11108.944650258212, 11379.943100284445, 9395.577199025924, 11319.0, 11448.313101213955, 11465.14011449128, 11575.536978520764, 11626.069914406997, 11750.23623464472, 11814.232074915102, 11922.582709605122, 12046.939765301116, 7093.32613401726, 7441.10706715176, 7481.251874812475, 7722.691092356243, 8331.333493320399, 10258.53836577341, 10935.56257749681, 11379.886201137882, 11536.480858361227, 11702.2978621283], "value": 8988.648569935911, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.5543869997045, 1593.0441734959022, 1687.9028631389604, 1834.6055598046416, 1846.9261229550818, 7888.605569721505, 8583.313334933206, 8646.91353086469, 9080.72757817265, 9085.772855678602, 8724.825503489943, 8780.0, 8925.553722313874, 8930.330225233118, 8946.060663630307, 2369.0, 2392.473655795722, 2400.5078958813488, 2404.2426635609813, 2407.8194135439826, 2386.642003699442, 2398.640203969401, 2402.1832576923844, 2427.2354208424376, 2435.305937807725, 2408.650745641881, 2409.2410890569413, 2424.733279339271, 2425.1148330859196, 2427.2718184544565, 2381.4403615150427, 2384.7257565379855, 2393.9760602393926, 2404.5791986402396, 2414.0947144820693, 2375.5486457573006, 2387.0332515331147, 2393.5571919195004, 2398.892049857743, 2409.638554216864, 8889.0, 8921.55392230386, 8969.506677132755, 8981.506017169053, 9045.638174473013, 4457.48738895028, 5308.9469105308835, 5310.3362079739645, 5368.91946620801, 5449.01917654822, 3507.9649203507893, 3604.315180115796, 3644.526211592476, 3654.4701018352457, 3663.5420572428447, 1033.8500917367014, 1049.7638031442941, 1060.0936199549428, 1074.409075008742, 1077.8975997280245, 11713.590024349107, 11863.703407414798, 11865.762684746256, 11879.049676025983, 11880.465379057963, 4613.700109492872, 4671.299305104261, 4847.466778654416, 4871.537203965618, 4874.171390863562, 10139.695809125738, 10164.542595583216, 10164.644237451654, 10181.389116653025, 10207.030332118586, 5288.497592728761, 5425.186222066722, 5432.483914028161, 5446.863828404322, 5459.50864422196, 4419.204543182193, 4786.1863483207935, 4923.113839508923, 4954.9752251238515, 4968.30443737877, 4056.7556655948856, 4057.4928133983253, 4070.1249231414795, 4109.404136400205, 4126.339785634284, 1294.695746499572, 1300.486307908371, 1309.4500309869877, 1319.0239222975122, 1319.0766463475607, 773.5242825662177, 804.5655346113033, 851.5444237332997, 893.0533634347612, 930.2465003347311, 6026.427489388501, 6188.535859810532, 6274.6548939807835, 6274.874502509924, 6307.779227727007, 920.185635712386, 948.4309414351334, 949.2595775295142, 997.6258902911409, 1017.3590637898077, 4160.563140870165, 4251.128518653669, 4269.082147338275, 4328.0, 4338.956610433918, 10523.631672891564, 10561.102306303897, 10805.459727013775, 10934.07060399859, 10949.343039417661, 10784.352938823695, 10798.946005269923, 10803.189760767973, 10816.351018938889, 10817.18871084656, 7261.128664560287, 7864.72473463426, 8288.751337459886, 8368.539730314891, 8432.0, 6199.690015499297, 6212.0, 6289.993601023814, 6327.082573026977, 6332.778352757631, 8653.17794809492, 9968.202543796624, 10251.974802519688, 10270.33242839213, 10288.691339259834, 10116.988301169824, 10309.22680798958, 10369.533370998171, 10438.0, 10503.737406564896, 7039.0, 7564.886526701994, 7694.499857509244, 7748.7675369739, 7848.529088254723, 8611.65553377858, 8619.353548484014, 8668.0, 8674.479531228146, 8731.126887311219, 7596.734114305973, 7747.612619369122, 7783.494072885244, 7839.098503671923, 7866.213378662317, 7558.3953283738265, 7569.3566046886635, 7624.466287359832, 7737.883931741141, 7769.223077692185, 7173.0, 7225.602591857499, 7240.710371585288, 7305.853882922418, 7311.0, 5101.51535604117, 5205.869853253699, 5236.528712415901, 5250.89498210026, 5278.0, 5195.688258704338, 5229.947700522946, 5232.377962831534, 5284.603654725988, 5316.308879845596], "value": 4695.254319961935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.1720914697069, 309.5248793102588, 315.25442328892177, 318.63993687133535, 319.3421551603695, 5274.630775845692, 5365.409804921455, 5470.8085217017415, 5530.723463826813, 5590.804321848731, 4432.7118737282135, 5389.892202155955, 5412.052890744114, 5457.426970168135, 5457.645253058548, 3609.3142302962483, 3951.348027575461, 4192.895177620561, 4200.51694055183, 4215.367694845782, 3286.457734473809, 4137.710360274767, 4189.748615083089, 4189.97905010476, 4223.450951376317, 3186.3467989062187, 3326.6507016763253, 3454.6027206871154, 3930.528336599612, 4075.0, 4068.921735740031, 4069.2268468990796, 4079.469668943048, 4093.5292441369324, 4111.8972025699595, 3557.62644922282, 3568.8572457101686, 3569.7322700797545, 3573.5175751273505, 3576.749627526074, 5017.738469994532, 5128.897422051538, 5214.487798538419, 5222.321098257202, 5318.0, 3876.0, 3942.448057271984, 4634.490206077328, 4680.4149481314835, 4684.718916864965, 4597.4484161290475, 4957.033378491195, 5139.0, 5284.837335786121, 5710.600257981943, 3571.8035508047046, 3860.575336712959, 3866.574676785551, 3870.5872356589925, 3908.2965066288057, 5250.18622113573, 5284.207368894658, 5558.777648894039, 5932.584719069667, 6027.714895381983, 3950.7827069511454, 3963.009247688078, 3964.484616999772, 3981.8606348777653, 3987.5613682494904, 3867.4530187925056, 4030.496187976503, 4040.717149799486, 4046.1503084352025, 4047.8988025299604, 3914.1212218135456, 4651.767411629405, 4672.789724462407, 4722.598579120745, 4738.73936933465, 4530.365748795171, 4568.748718820497, 5575.330960284792, 5850.0, 5853.536615846038, 1206.9155159138952, 1330.2151730479063, 1369.4932874836175, 1375.5529452927838, 1377.4903285784324, 722.9060222171084, 799.4324029938692, 817.840521098392, 827.7103013945191, 834.2700137379793, 3619.2218672985437, 3874.8837534874, 4478.216312145361, 4602.332661764025, 4651.465081515601, 4424.6239069678795, 4503.279475283939, 4809.22475856458, 4932.630052745986, 5064.088464076428, 3932.2528719543197, 4511.187986162522, 4520.16933142078, 4546.749359067217, 4561.24739417999, 2422.212780846197, 2437.987810060974, 2605.7231956341634, 2619.0, 2626.724193959645, 4560.88597785058, 5153.201253805666, 5192.740362981911, 5200.853483642342, 5236.476352364733, 4460.442444694413, 5052.216906379517, 5163.915577728644, 5176.5858731301405, 5257.973710131425, 4425.026494171278, 4856.902861942742, 4963.975180124076, 5063.164577844688, 5085.288059671723, 3924.8822535323984, 4079.8776036718946, 4413.7351758894565, 4808.374911261513, 5023.623228257822, 4913.680610760289, 4933.777979990838, 4975.0, 5000.549950504472, 5006.097682880482, 4865.324071760589, 5689.97580435509, 5896.7936122235515, 6265.96867015662, 6275.937240627535, 3300.422426075379, 3910.374340105683, 3972.245273398045, 3978.5822488638278, 3991.7604943703473, 4874.2444921037295, 5228.843134705965, 5411.296531451044, 5668.728082882958, 5999.640021598718, 4809.567138957371, 5002.449730529566, 5389.7603551182665, 5720.3707592165665, 5751.798687045934, 5134.922976155286, 5141.511556402136, 5333.959877823942, 5786.450287222707, 5797.739101740516, 4415.646748260067, 5028.321176641107, 5466.043442397644, 5617.494425501724, 5662.433756624305, 5171.043356978971, 5687.767254126131, 5699.204750503578, 5705.4579814917515, 5710.628809127394, 4799.400074990626, 4934.62990275738, 5264.605154613496, 5538.944610553843, 5675.928286175599], "value": 3930.812153015802, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.57704320016, 784.6312233250372, 793.5754371411292, 848.5460278750869, 854.7051267312777, 15359.0, 15603.84396156038, 15814.4464943727, 15848.68302633948, 15956.920215398935, 11793.941030294858, 12775.488980440794, 13295.468181272738, 13361.599152025456, 13433.529826456075, 704.4505285877024, 873.2751815992742, 905.8777065096226, 910.403685585939, 914.2640174659397, 890.9153630405101, 902.6479672927563, 905.6105874473974, 906.5739102621757, 910.4264313482497, 966.2897770138942, 969.6363863551169, 970.0541971577726, 970.7718686108794, 975.3903810118676, 926.1201858234704, 927.2952556057378, 953.5041778275328, 954.8329042417583, 965.034965034965, 711.903892974447, 713.8536599996988, 716.8243780273866, 718.3965469006008, 721.1238345410352, 15026.098434093989, 15279.61800954985, 15330.923345383313, 15460.768088478682, 15493.0, 13493.797593036112, 13548.254845983467, 13614.727705445835, 13667.863321366758, 13671.453141874314, 13150.671233219151, 13247.403866826016, 13255.005874559447, 13454.529091481849, 13513.391897364641, 4648.721076735406, 4661.650376221797, 4679.532046795327, 4706.5293470653005, 4877.195262781637, 108838.0, 108963.0, 109215.45392273067, 109628.0, 110125.89874101237, 10807.459627018618, 10998.632284085596, 11074.976877405394, 11222.046126079375, 11483.540658373571, 21088.472788180112, 21100.894495527424, 21118.155273788878, 21119.894400528206, 21139.471513211985, 7914.129445760962, 7922.603869806487, 8048.476849004796, 8130.186981301823, 8242.793930151794, 4375.190589740908, 4407.867763967086, 4483.21543729846, 4487.5961163494785, 4595.816167353269, 3493.982530087333, 3582.6238244984424, 3588.1567831559564, 3592.4072528033103, 3593.2813437312643, 649.7595889520813, 654.5745265577413, 657.7237560224717, 673.1854456108066, 675.2234929830734, 518.6836030021684, 573.2719446303255, 630.8391360203119, 667.0694381338103, 671.4292851076643, 9638.614455421844, 9673.0, 9709.223262139012, 9723.805523889625, 9901.257405694458, 586.5247665769938, 607.9118527813442, 647.239493595024, 670.5239280111078, 693.3240090911321, 4594.5864872161665, 4756.667033307635, 4772.236442169236, 4776.928346074812, 4779.091972525209, 154345.0, 156167.0, 157934.0, 158928.0, 159356.4064359365, 110571.0, 122132.0, 133724.0, 134707.0, 139863.0, 86482.0, 108161.45919270354, 108185.0, 109233.0, 110053.0, 6948.374646281859, 9049.366544342096, 9073.546322683971, 9129.634814607607, 9333.626654933998, 48918.26622600593, 63707.362926370144, 63756.36243637504, 63935.0, 65063.67468162629, 94790.57814132655, 100215.49892250492, 100781.0, 101467.98532014585, 101831.0, 11937.701557461132, 12041.0, 12058.0, 12423.751524969632, 12556.87443125557, 13074.411651475897, 13086.607401777961, 13206.933965330112, 13394.995375347084, 13567.728645427234, 12401.751964960831, 12565.120441569003, 12667.93666031664, 12830.935845320713, 12973.805392919303, 12386.504539818667, 12426.62720118398, 12431.129820912449, 12563.497460101493, 12847.93576032114, 10846.403447810446, 12659.683507912376, 12798.296093714935, 13449.663758406117, 13602.115862468909, 11478.947289734504, 11554.480048397674, 11652.708682283012, 11712.238704484182, 11826.0, 10385.532651030873, 10406.531706073094, 11503.76992460163, 11681.474333654836, 11758.94120529426], "value": 7899.963191827263, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1608.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 106.0, 116.0, 116.0, 135.0, 167.0, 160.0, 117.0, 116.0], "value": 125.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 143.0, 121.0, 192.0, 142.0, 140.0, 131.0, 111.0, 148.0, 105.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 203.0, 210.0, 234.0, 268.0, 245.0, 203.0, 197.0, 198.0, 196.0], "value": 215.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 86.0, 77.0, 148.0, 60.0, 59.0, 60.0, 61.0, 135.0, 58.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 129.0, 71.0, 71.0, 79.0, 121.0, 71.0, 73.0, 116.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 136.0, 88.0, 92.0, 88.0, 92.0, 90.0, 90.0, 89.0], "value": 94.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 118.0, 157.0, 108.0, 98.0, 96.0, 120.0, 116.0, 96.0], "value": 110.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 100.0, 98.0, 99.0, 143.0, 116.0, 93.0, 96.0, 109.0, 119.0], "value": 106.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 54.0, 58.0, 78.0, 81.0, 88.0, 71.0, 57.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 72.0, 88.0, 79.0, 79.0, 72.0, 72.0, 75.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 108.0, 86.0, 83.0, 88.0, 84.0, 82.0, 96.0, 95.0, 86.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 137.0, 132.0, 156.0, 149.0, 145.0, 152.0, 153.0, 190.0, 155.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 215.0, 224.0, 167.0, 167.0, 174.0, 167.0, 231.0, 225.0, 177.0], "value": 193.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 61.0, 65.0, 70.0, 58.0, 70.0, 84.0, 86.0, 81.0], "value": 71.0, "unit": "score"}]}]} 16:17:31 INFO - Return code: 0 16:17:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:17:31 ERROR - # TBPL SUCCESS # 16:17:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:31 INFO - 2016-07-19 16:17:31.496 screenresolution[1946:17480] starting screenresolution argv=screenresolution get 16:17:31 INFO - 2016-07-19 16:17:31.498 screenresolution[1946:17480] Display 0: 1600x1200x32@60 16:17:31 INFO - 2016-07-19 16:17:31.504 screenresolution[1947:17483] starting screenresolution argv=screenresolution list 16:17:31 INFO - Available Modes on Display 0 16:17:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:31 INFO - Intel Iris: 16:17:31 INFO - Chipset Model: Intel Iris 16:17:31 INFO - Type: GPU 16:17:31 INFO - Bus: Built-In 16:17:31 INFO - VRAM (Dynamic, Max): 1536 MB 16:17:31 INFO - Vendor: Intel (0x8086) 16:17:31 INFO - Device ID: 0x0a2e 16:17:31 INFO - Revision ID: 0x0009 16:17:31 INFO - Displays: 16:17:31 INFO - Display: 16:17:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:31 INFO - Display Serial Number: 1600x1200 60 16:17:31 INFO - Main Display: Yes 16:17:31 INFO - Mirror: Off 16:17:31 INFO - Online: Yes 16:17:31 INFO - Rotation: Supported 16:17:31 INFO - Return code: 0 16:17:31 INFO - Running post-action listener: _resource_record_post_action 16:17:31 INFO - [mozharness: 2016-07-19 23:17:31.741340Z] Finished run-tests step (success) 16:17:31 INFO - Running post-run listener: _resource_record_post_run 16:17:31 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 843776; Write bytes: 709727744; Read time: 9; Write time: 2116 16:17:31 INFO - TinderboxPrint: CPU usage
54.2% 16:17:31 INFO - TinderboxPrint: I/O read bytes / time
843,776 / 9 16:17:31 INFO - TinderboxPrint: I/O write bytes / time
709,727,744 / 2,116 16:17:31 INFO - TinderboxPrint: CPU idle
2,213.5 (45.8%) 16:17:31 INFO - TinderboxPrint: CPU system
977.7 (20.2%) 16:17:31 INFO - TinderboxPrint: CPU user
1,646.5 (34.0%) 16:17:31 INFO - TinderboxPrint: Swap in / out
408,117,248 / 0 16:17:31 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408576512; Write bytes: 414092800; Read time: 30704; Write time: 820 16:17:31 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 770048; Write bytes: 294139904; Read time: 7; Write time: 1289 16:17:32 INFO - Running post-run listener: _upload_blobber_files 16:17:32 INFO - Blob upload gear active. 16:17:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:17:32 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 16:17:32 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'] 16:17:32 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 16:17:32 INFO - (blobuploader) - INFO - Open directory for files ... 16:17:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:17:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:17:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:33 INFO - (blobuploader) - INFO - Done attempting. 16:17:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:17:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:17:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:34 INFO - (blobuploader) - INFO - Done attempting. 16:17:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:17:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:17:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:37 INFO - (blobuploader) - INFO - Done attempting. 16:17:37 INFO - (blobuploader) - INFO - Iteration through files over. 16:17:37 INFO - Return code: 0 16:17:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:17:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:17:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/095297009f5e8d8951925dd03e373fd3ac3a8e6f69675a046a7339a84569378bbcd8d628915b74d17c9883ffda57e2b494c64a1d09cfd0e12c09e16470c5b37a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d6f5d13901ef7b9744aa543b78cd0ec2de1e42dd8b05105cef602b4019c3bbd3d61c89f85efc270a271203940ff2af8998ba22457c840180a657450f1baf391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/315277e046b73623a3b7aae79137e87d75840ff807a53271cbfdd5b779071ec65d6c165535f3f31c6c1dade653ca6fbc5b307ef13217720e064d81d1c7d97b0b"} 16:17:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:17:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:17:37 INFO - Contents: 16:17:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/095297009f5e8d8951925dd03e373fd3ac3a8e6f69675a046a7339a84569378bbcd8d628915b74d17c9883ffda57e2b494c64a1d09cfd0e12c09e16470c5b37a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d6f5d13901ef7b9744aa543b78cd0ec2de1e42dd8b05105cef602b4019c3bbd3d61c89f85efc270a271203940ff2af8998ba22457c840180a657450f1baf391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/315277e046b73623a3b7aae79137e87d75840ff807a53271cbfdd5b779071ec65d6c165535f3f31c6c1dade653ca6fbc5b307ef13217720e064d81d1c7d97b0b"} 16:17:37 INFO - Running post-run listener: copy_logs_to_upload_dir 16:17:37 INFO - Copying logs to upload dir... 16:17:37 INFO - mkdir: /builds/slave/test/build/upload/logs 16:17:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.938883 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-19 16:17:37.775207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 16:17:37.778490) ========= 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.B05Oaf35QD/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.rk4pm77nrT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/095297009f5e8d8951925dd03e373fd3ac3a8e6f69675a046a7339a84569378bbcd8d628915b74d17c9883ffda57e2b494c64a1d09cfd0e12c09e16470c5b37a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d6f5d13901ef7b9744aa543b78cd0ec2de1e42dd8b05105cef602b4019c3bbd3d61c89f85efc270a271203940ff2af8998ba22457c840180a657450f1baf391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/315277e046b73623a3b7aae79137e87d75840ff807a53271cbfdd5b779071ec65d6c165535f3f31c6c1dade653ca6fbc5b307ef13217720e064d81d1c7d97b0b"} build_url:https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011053 build_url: 'https://queue.taskcluster.net/v1/task/d2eMouewSA2nENgOKu-4aQ/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/095297009f5e8d8951925dd03e373fd3ac3a8e6f69675a046a7339a84569378bbcd8d628915b74d17c9883ffda57e2b494c64a1d09cfd0e12c09e16470c5b37a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d6f5d13901ef7b9744aa543b78cd0ec2de1e42dd8b05105cef602b4019c3bbd3d61c89f85efc270a271203940ff2af8998ba22457c840180a657450f1baf391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/315277e046b73623a3b7aae79137e87d75840ff807a53271cbfdd5b779071ec65d6c165535f3f31c6c1dade653ca6fbc5b307ef13217720e064d81d1c7d97b0b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 16:17:37.810497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 16:17:37.810837) ========= 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.B05Oaf35QD/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.rk4pm77nrT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005232 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 16:17:37.860110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 16:17:37.860440) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 16:17:37.860786) ========= ========= Total master_lag: 0.39 =========