builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0127 starttime: 1468341362.54 results: success (0) buildid: 20160712072641 builduid: f1671b1e731d494fbcad432be7cc2726 revision: fcfa26398425779f0dc87fc4658f2ebcc6f6f8cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:02.540951) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:02.541670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:02.542176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:02.567796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:02.568647) ========= 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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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-12 09:36:02-- 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% 36.3M=0s 2016-07-12 09:36:02 (36.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142901 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:02.738805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:02.739506) ========= 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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.028065 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:02.792618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 09:36:02.793391) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fcfa26398425779f0dc87fc4658f2ebcc6f6f8cb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fcfa26398425779f0dc87fc4658f2ebcc6f6f8cb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1oqDyryKJQ/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.XJ75SyyvQp/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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-12 09:36:02,868 truncating revision to first 12 chars 2016-07-12 09:36:02,868 Setting DEBUG logging. 2016-07-12 09:36:02,868 attempt 1/10 2016-07-12 09:36:02,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fcfa26398425?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 09:36:04,390 unpacking tar archive at: mozilla-central-fcfa26398425/testing/mozharness/ program finished with exit code 0 elapsedTime=1.793322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 09:36:04.610884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:04.611272) ========= script_repo_revision: fcfa26398425779f0dc87fc4658f2ebcc6f6f8cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:04.611713) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:04.612033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 09:36:04.631479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-12 09:36:04.631817) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1oqDyryKJQ/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.XJ75SyyvQp/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:36:04 INFO - MultiFileLogger online at 20160712 09:36:04 in /builds/slave/test 09:36:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:36:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:36:04 INFO - {'append_to_log': False, 09:36:04 INFO - 'base_work_dir': '/builds/slave/test', 09:36:04 INFO - 'blob_upload_branch': 'Firefox', 09:36:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:36:04 INFO - 'branch': 'Firefox', 09:36:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:36:04 INFO - 'config_files': ('talos/mac_config.py',), 09:36:04 INFO - 'default_actions': ('clobber', 09:36:04 INFO - 'read-buildbot-config', 09:36:04 INFO - 'download-and-extract', 09:36:04 INFO - 'populate-webroot', 09:36:04 INFO - 'create-virtualenv', 09:36:04 INFO - 'install', 09:36:04 INFO - 'run-tests'), 09:36:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:36:04 INFO - 'download_minidump_stackwalk': True, 09:36:04 INFO - 'download_symbols': 'ondemand', 09:36:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:36:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:36:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:36:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:36:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:36:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:36:04 INFO - 'installer_path': 'installer.exe', 09:36:04 INFO - 'log_level': 'info', 09:36:04 INFO - 'log_name': 'talos', 09:36:04 INFO - 'log_to_console': True, 09:36:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:36:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:36:04 INFO - 'opt_config_files': (), 09:36:04 INFO - 'pip_index': False, 09:36:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:36:04 INFO - 'cmd': ('bash', 09:36:04 INFO - '-c', 09:36:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:36:04 INFO - 'enabled': True, 09:36:04 INFO - 'halt_on_failure': False, 09:36:04 INFO - 'name': 'check_screen_resolution'},), 09:36:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:36:04 INFO - 'cmd': ('bash', 09:36:04 INFO - '-c', 09:36:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:36:04 INFO - 'enabled': True, 09:36:04 INFO - 'halt_on_failure': False, 09:36:04 INFO - 'name': 'check_screen_resolution'},), 09:36:04 INFO - 'run_cmd_checks_enabled': True, 09:36:04 INFO - 'sps_profile': False, 09:36:04 INFO - 'sps_profile_interval': 0, 09:36:04 INFO - 'suite': 'dromaeojs-e10s', 09:36:04 INFO - 'system_bits': '32', 09:36:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:36:04 INFO - 'title': 't-yosemite-r7-0127', 09:36:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:36:04 INFO - 'use_talos_json': True, 09:36:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:36:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:36:04 INFO - 'work_dir': 'build'} 09:36:04 INFO - ##### 09:36:04 INFO - ##### Running clobber step. 09:36:04 INFO - ##### 09:36:04 INFO - Running pre-action listener: _resource_record_pre_action 09:36:04 INFO - Running main action method: clobber 09:36:04 INFO - rmtree: /builds/slave/test/build 09:36:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:36:06 INFO - Running post-action listener: _resource_record_post_action 09:36:06 INFO - ##### 09:36:06 INFO - ##### Finished clobber step (success) 09:36:06 INFO - ##### 09:36:06 INFO - ##### 09:36:06 INFO - ##### Running read-buildbot-config step. 09:36:06 INFO - ##### 09:36:06 INFO - Running pre-action listener: _resource_record_pre_action 09:36:06 INFO - Running main action method: read_buildbot_config 09:36:06 INFO - Using buildbot properties: 09:36:06 INFO - { 09:36:06 INFO - "project": "", 09:36:06 INFO - "product": "firefox", 09:36:06 INFO - "script_repo_revision": "production", 09:36:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:36:06 INFO - "repository": "", 09:36:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:36:06 INFO - "buildid": "20160712072641", 09:36:06 INFO - "pgo_build": "False", 09:36:06 INFO - "basedir": "/builds/slave/test", 09:36:06 INFO - "buildnumber": 329, 09:36:06 INFO - "slavename": "t-yosemite-r7-0127", 09:36:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:36:06 INFO - "platform": "yosemite_r7", 09:36:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:36:06 INFO - "branch": "mozilla-central", 09:36:06 INFO - "repo_path": "mozilla-central", 09:36:06 INFO - "revision": "fcfa26398425779f0dc87fc4658f2ebcc6f6f8cb", 09:36:06 INFO - "stage_platform": "macosx64", 09:36:06 INFO - "builduid": "f1671b1e731d494fbcad432be7cc2726", 09:36:06 INFO - "slavebuilddir": "test" 09:36:06 INFO - } 09:36:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 09:36:06 INFO - Running post-action listener: _resource_record_post_action 09:36:06 INFO - ##### 09:36:06 INFO - ##### Finished read-buildbot-config step (success) 09:36:06 INFO - ##### 09:36:06 INFO - ##### 09:36:06 INFO - ##### Running download-and-extract step. 09:36:06 INFO - ##### 09:36:06 INFO - Running pre-action listener: _resource_record_pre_action 09:36:06 INFO - Running main action method: download_and_extract 09:36:06 INFO - mkdir: /builds/slave/test/build/tests 09:36: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')]} 09:36:06 INFO - https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:36:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:36:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:36:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/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 09:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/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 09:36:08 INFO - Downloaded 1199 bytes. 09:36:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:36:08 INFO - Using the following test package requirements: 09:36:08 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:36:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:36:08 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 09:36:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:36:08 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 09:36:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:36:08 INFO - u'jsshell-mac.zip'], 09:36:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:36:08 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 09:36:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:36:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:36:08 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 09:36:08 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:36:08 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 09:36:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:36:08 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 09:36:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:36:08 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 09:36:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:36:08 INFO - https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:36:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:36:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:36:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/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 09:36:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/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 09:36:10 INFO - Downloaded 18772483 bytes. 09:36:10 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'] 09:36:10 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 09:36:13 INFO - Return code: 0 09:36:13 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 09:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:36:13 INFO - https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/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 09:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/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 09:36:15 INFO - Downloaded 18772483 bytes. 09:36:15 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'] 09:36:15 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 09:36:19 INFO - Return code: 0 09:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:36:19 INFO - https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:36:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:36:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:36:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/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 09:36:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/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 09:36:20 INFO - Downloaded 14403317 bytes. 09:36:20 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'] 09:36:20 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 09:36:20 INFO - Return code: 0 09:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:20 INFO - https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:36:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:36:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:36:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 09:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/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 09:36:23 INFO - Downloaded 112444357 bytes. 09:36:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:36:23 INFO - mkdir: /builds/slave/test/properties 09:36:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:36:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:36:23 INFO - Contents: 09:36:23 INFO - build_url:https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:36:24 INFO - Running post-action listener: _resource_record_post_action 09:36:24 INFO - Running post-action listener: set_extra_try_arguments 09:36:24 INFO - ##### 09:36:24 INFO - ##### Finished download-and-extract step (success) 09:36:24 INFO - ##### 09:36:24 INFO - ##### 09:36:24 INFO - ##### Running populate-webroot step. 09:36:24 INFO - ##### 09:36:24 INFO - Running pre-action listener: _resource_record_pre_action 09:36:24 INFO - Running main action method: populate_webroot 09:36:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:24 INFO - '--tppagecycles', 09:36:24 INFO - '7'], 09:36:24 INFO - 'tests': ['tsvgm']}}, 09:36:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:36:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:36:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:36:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:24 INFO - 'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:24 INFO - 'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['damp', 'tps']}, 09:36:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:24 INFO - 'tests': ['damp', 'tps']}, 09:36:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['dromaeo_dom']}, 09:36:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['basic_compositor_video']}, 09:36:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:36:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['a11yr', 09:36:24 INFO - 'ts_paint', 09:36:24 INFO - 'tpaint', 09:36:24 INFO - 'sessionrestore', 09:36:24 INFO - 'sessionrestore_no_auto_restore', 09:36:24 INFO - 'tabpaint']}, 09:36:24 INFO - 'other-e10s': {'tests': ['a11yr', 09:36:24 INFO - 'ts_paint', 09:36:24 INFO - 'tpaint', 09:36:24 INFO - 'sessionrestore', 09:36:24 INFO - 'sessionrestore_no_auto_restore', 09:36:24 INFO - 'tabpaint']}, 09:36:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:36:24 INFO - 'ts_paint', 09:36:24 INFO - 'tpaint', 09:36:24 INFO - 'sessionrestore', 09:36:24 INFO - 'sessionrestore_no_auto_restore', 09:36:24 INFO - 'tabpaint']}, 09:36:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:36:24 INFO - 'ts_paint', 09:36:24 INFO - 'tpaint', 09:36:24 INFO - 'sessionrestore', 09:36:24 INFO - 'sessionrestore_no_auto_restore', 09:36:24 INFO - 'tabpaint']}, 09:36:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['a11yr', 09:36:24 INFO - 'ts_paint', 09:36:24 INFO - 'tpaint', 09:36:24 INFO - 'sessionrestore', 09:36:24 INFO - 'sessionrestore_no_auto_restore', 09:36:24 INFO - 'tabpaint']}, 09:36:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['a11yr', 09:36:24 INFO - 'ts_paint', 09:36:24 INFO - 'tpaint', 09:36:24 INFO - 'sessionrestore', 09:36:24 INFO - 'sessionrestore_no_auto_restore', 09:36:24 INFO - 'tabpaint']}, 09:36:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['tsvgx', 09:36:24 INFO - 'tsvgr_opacity', 09:36:24 INFO - 'tart', 09:36:24 INFO - 'tscrollx', 09:36:24 INFO - 'cart']}, 09:36:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:36:24 INFO - 'tsvgr_opacity', 09:36:24 INFO - 'tart', 09:36:24 INFO - 'tscrollx', 09:36:24 INFO - 'cart']}, 09:36:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:24 INFO - 'talos_options': ['--disable-e10s'], 09:36:24 INFO - 'tests': ['tp5o']}, 09:36:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:24 INFO - 'tests': ['tp5o']}, 09:36:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:24 INFO - 'talos_options': ['--disable-e10s', 09:36:24 INFO - '--xperf_path', 09:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:24 INFO - 'tests': ['tp5n']}, 09:36:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:24 INFO - 'talos_options': ['--xperf_path', 09:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:24 INFO - 'tests': ['tp5n']}}, 09:36:24 INFO - 'talos.zip': {'path': '', 09:36:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:24 INFO - Running post-action listener: _resource_record_post_action 09:36:24 INFO - ##### 09:36:24 INFO - ##### Finished populate-webroot step (success) 09:36:24 INFO - ##### 09:36:24 INFO - ##### 09:36:24 INFO - ##### Running create-virtualenv step. 09:36:24 INFO - ##### 09:36:24 INFO - Running pre-action listener: _resource_record_pre_action 09:36:24 INFO - Running main action method: create_virtualenv 09:36:24 INFO - Creating virtualenv /builds/slave/test/build/venv 09:36:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:36:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:36:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:25 INFO - Using real prefix '/tools/python27' 09:36:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:36:25 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:28 INFO - Installing pip.................done. 09:36:28 INFO - Return code: 0 09:36:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:36:28 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')]} 09:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:28 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')]} 09:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:28 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 0x108a84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b19618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd0592050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, '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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:28 INFO - 'HOME': '/Users/cltbld', 09:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:28 INFO - 'LOGNAME': 'cltbld', 09:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:28 INFO - 'MOZ_NO_REMOTE': '1', 09:36:28 INFO - 'NO_EM_RESTART': '1', 09:36:28 INFO - 'PAGER': '/bin/cat', 09:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:28 INFO - 'PWD': '/builds/slave/test', 09:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:28 INFO - 'SHELL': '/bin/bash', 09:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:36:28 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:28 INFO - 'USER': 'cltbld', 09:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:28 INFO - 'XPC_FLAGS': '0x0', 09:36:28 INFO - 'XPC_SERVICE_NAME': '0', 09:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:36:28 INFO - Cleaning up... 09:36:28 INFO - Return code: 0 09:36:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:36:28 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')]} 09:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:28 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')]} 09:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:28 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 0x108a84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b19618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd0592050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, '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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:28 INFO - 'HOME': '/Users/cltbld', 09:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:28 INFO - 'LOGNAME': 'cltbld', 09:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:28 INFO - 'MOZ_NO_REMOTE': '1', 09:36:28 INFO - 'NO_EM_RESTART': '1', 09:36:28 INFO - 'PAGER': '/bin/cat', 09:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:28 INFO - 'PWD': '/builds/slave/test', 09:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:28 INFO - 'SHELL': '/bin/bash', 09:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:36:28 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:28 INFO - 'USER': 'cltbld', 09:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:28 INFO - 'XPC_FLAGS': '0x0', 09:36:28 INFO - 'XPC_SERVICE_NAME': '0', 09:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:29 INFO - Downloading/unpacking psutil>=3.1.1 09:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:32 INFO - Installing collected packages: psutil 09:36:32 INFO - Running setup.py install for psutil 09:36:32 INFO - building 'psutil._psutil_osx' extension 09:36:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:36:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:36:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:36:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:36:33 INFO - building 'psutil._psutil_posix' extension 09:36:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:36:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:36:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:36:33 INFO - ^ 09:36:33 INFO - 1 warning generated. 09:36:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:36:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:33 INFO - Successfully installed psutil 09:36:33 INFO - Cleaning up... 09:36:33 INFO - Return code: 0 09:36:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:36:33 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')]} 09:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:33 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')]} 09:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:33 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 0x108a84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b19618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd0592050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, '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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:36:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:36:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:33 INFO - 'HOME': '/Users/cltbld', 09:36:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:33 INFO - 'LOGNAME': 'cltbld', 09:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:33 INFO - 'MOZ_NO_REMOTE': '1', 09:36:33 INFO - 'NO_EM_RESTART': '1', 09:36:33 INFO - 'PAGER': '/bin/cat', 09:36:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:33 INFO - 'PWD': '/builds/slave/test', 09:36:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:33 INFO - 'SHELL': '/bin/bash', 09:36:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:36:33 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:36:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:33 INFO - 'USER': 'cltbld', 09:36:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:33 INFO - 'XPC_FLAGS': '0x0', 09:36:33 INFO - 'XPC_SERVICE_NAME': '0', 09:36:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:36:36 INFO - Installing collected packages: mozsystemmonitor 09:36:36 INFO - Running setup.py install for mozsystemmonitor 09:36:36 INFO - Successfully installed mozsystemmonitor 09:36:36 INFO - Cleaning up... 09:36:36 INFO - Return code: 0 09:36:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:36 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 0x108a84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b19618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd0592050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, '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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:36:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:36:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:36 INFO - 'HOME': '/Users/cltbld', 09:36:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:36 INFO - 'LOGNAME': 'cltbld', 09:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:36 INFO - 'MOZ_NO_REMOTE': '1', 09:36:36 INFO - 'NO_EM_RESTART': '1', 09:36:36 INFO - 'PAGER': '/bin/cat', 09:36:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:36 INFO - 'PWD': '/builds/slave/test', 09:36:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:36 INFO - 'SHELL': '/bin/bash', 09:36:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:36:36 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:36:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:36 INFO - 'USER': 'cltbld', 09:36:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:36 INFO - 'XPC_FLAGS': '0x0', 09:36:36 INFO - 'XPC_SERVICE_NAME': '0', 09:36:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:36 INFO - Downloading/unpacking jsonschema==2.5.1 09:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:36:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:39 INFO - Downloading functools32-3.2.3-2.tar.gz 09:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:36:39 INFO - warning: no files found matching '*.txt' 09:36:39 INFO - no previously-included directories found matching 'build' 09:36:39 INFO - no previously-included directories found matching 'dist' 09:36:39 INFO - no previously-included directories found matching '.git*' 09:36:39 INFO - Installing collected packages: jsonschema, functools32 09:36:39 INFO - Running setup.py install for functools32 09:36:39 INFO - warning: no files found matching '*.txt' 09:36:39 INFO - no previously-included directories found matching 'build' 09:36:39 INFO - no previously-included directories found matching 'dist' 09:36:39 INFO - no previously-included directories found matching '.git*' 09:36:39 INFO - Successfully installed jsonschema functools32 09:36:39 INFO - Cleaning up... 09:36:39 INFO - Return code: 0 09:36:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:36:39 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')]} 09:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:39 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')]} 09:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:39 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 0x108a84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b19618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd0592050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, '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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:36:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:36:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:39 INFO - 'HOME': '/Users/cltbld', 09:36:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:39 INFO - 'LOGNAME': 'cltbld', 09:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:39 INFO - 'MOZ_NO_REMOTE': '1', 09:36:39 INFO - 'NO_EM_RESTART': '1', 09:36:39 INFO - 'PAGER': '/bin/cat', 09:36:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:39 INFO - 'PWD': '/builds/slave/test', 09:36:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:39 INFO - 'SHELL': '/bin/bash', 09:36:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:36:39 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:36:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:39 INFO - 'USER': 'cltbld', 09:36:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:39 INFO - 'XPC_FLAGS': '0x0', 09:36:39 INFO - 'XPC_SERVICE_NAME': '0', 09:36:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:36:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:43 INFO - Downloading docopt-0.6.1.tar.gz 09:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:43 INFO - Running setup.py install for blobuploader 09:36:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:36:44 INFO - Running setup.py install for requests 09:36:44 INFO - Running setup.py install for docopt 09:36:44 INFO - Successfully installed blobuploader requests docopt 09:36:44 INFO - Cleaning up... 09:36:44 INFO - Return code: 0 09:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:44 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')]} 09:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:44 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')]} 09:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:44 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 0x108a84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b19618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd0592050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, '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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:44 INFO - 'HOME': '/Users/cltbld', 09:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:44 INFO - 'LOGNAME': 'cltbld', 09:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:44 INFO - 'MOZ_NO_REMOTE': '1', 09:36:44 INFO - 'NO_EM_RESTART': '1', 09:36:44 INFO - 'PAGER': '/bin/cat', 09:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:44 INFO - 'PWD': '/builds/slave/test', 09:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:44 INFO - 'SHELL': '/bin/bash', 09:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:36:44 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:44 INFO - 'USER': 'cltbld', 09:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:44 INFO - 'XPC_FLAGS': '0x0', 09:36:44 INFO - 'XPC_SERVICE_NAME': '0', 09:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ZBN8Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-zpgyst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-kpme3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-wVOdJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-8WHeVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-APXrTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-Fq1SIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-tnwgM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-GJI7gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:45 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-g6IssI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:46 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-EwaaZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:46 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-MWaoi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:46 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-QCJmvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:46 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ITM3ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:46 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ELp4Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:46 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-nNOTe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:46 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-U2xAGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:46 INFO - Running setup.py install for manifestparser 09:36:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:36:46 INFO - Running setup.py install for mozcrash 09:36:47 INFO - Running setup.py install for mozdebug 09:36:47 INFO - Running setup.py install for mozdevice 09:36:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:36:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:36:47 INFO - Running setup.py install for mozfile 09:36:47 INFO - Running setup.py install for mozhttpd 09:36:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:36:47 INFO - Running setup.py install for mozinfo 09:36:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:36:47 INFO - Running setup.py install for mozInstall 09:36:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:36:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:36:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:36:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:36:47 INFO - Running setup.py install for mozleak 09:36:48 INFO - Running setup.py install for mozlog 09:36:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:36:48 INFO - Running setup.py install for moznetwork 09:36:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:36:48 INFO - Running setup.py install for mozprocess 09:36:48 INFO - Running setup.py install for mozprofile 09:36:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:36:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:36:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:36:48 INFO - Running setup.py install for mozrunner 09:36:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:36:48 INFO - Running setup.py install for mozscreenshot 09:36:49 INFO - Running setup.py install for moztest 09:36:49 INFO - Running setup.py install for mozversion 09:36:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:36:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:49 INFO - Cleaning up... 09:36:49 INFO - Return code: 0 09:36:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:49 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 0x108a84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b19618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd0592050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, '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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:49 INFO - 'HOME': '/Users/cltbld', 09:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:49 INFO - 'LOGNAME': 'cltbld', 09:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:49 INFO - 'MOZ_NO_REMOTE': '1', 09:36:49 INFO - 'NO_EM_RESTART': '1', 09:36:49 INFO - 'PAGER': '/bin/cat', 09:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:49 INFO - 'PWD': '/builds/slave/test', 09:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:49 INFO - 'SHELL': '/bin/bash', 09:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:36:49 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:49 INFO - 'USER': 'cltbld', 09:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:49 INFO - 'XPC_FLAGS': '0x0', 09:36:49 INFO - 'XPC_SERVICE_NAME': '0', 09:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:49 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-zuc54_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:49 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-SfbF1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:49 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)) 09:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:49 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-wLouT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:49 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-y1UD5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:50 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)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-D5VOIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-haBheK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-uPac_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-C_TD_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-GrScMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-b9ScvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-S2nVpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-vZk1O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:50 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)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-TPXEnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-azf8J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:51 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)) 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-lUCiOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ggtXGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:51 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)) 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-z2KB6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:36:51 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)) 09:36:51 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)) 09:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:36:51 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)) 09:36:51 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)) 09:36:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:53 INFO - Downloading blessings-1.6.tar.gz 09:36:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:53 INFO - Installing collected packages: blessings 09:36:53 INFO - Running setup.py install for blessings 09:36:54 INFO - Successfully installed blessings 09:36:54 INFO - Cleaning up... 09:36:54 INFO - Return code: 0 09:36:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:36:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:54 INFO - Reading from file tmpfile_stdout 09:36:54 INFO - Current package versions: 09:36:54 INFO - blessings == 1.6 09:36:54 INFO - blobuploader == 1.2.4 09:36:54 INFO - docopt == 0.6.1 09:36:54 INFO - functools32 == 3.2.3-2 09:36:54 INFO - jsonschema == 2.5.1 09:36:54 INFO - manifestparser == 1.1 09:36:54 INFO - mozInstall == 1.12 09:36:54 INFO - mozcrash == 0.17 09:36:54 INFO - mozdebug == 0.1 09:36:54 INFO - mozdevice == 0.48 09:36:54 INFO - mozfile == 1.2 09:36:54 INFO - mozhttpd == 0.7 09:36:54 INFO - mozinfo == 0.9 09:36:54 INFO - mozleak == 0.1 09:36:54 INFO - mozlog == 3.2 09:36:54 INFO - moznetwork == 0.27 09:36:54 INFO - mozprocess == 0.23 09:36:54 INFO - mozprofile == 0.28 09:36:54 INFO - mozrunner == 6.12 09:36:54 INFO - mozscreenshot == 0.1 09:36:54 INFO - mozsystemmonitor == 0.3 09:36:54 INFO - moztest == 0.7 09:36:54 INFO - mozversion == 1.4 09:36:54 INFO - psutil == 3.1.1 09:36:54 INFO - requests == 1.2.3 09:36:54 INFO - wsgiref == 0.1.2 09:36:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:54 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 0x108a84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b19618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd0592050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, '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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:54 INFO - 'HOME': '/Users/cltbld', 09:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:54 INFO - 'LOGNAME': 'cltbld', 09:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:54 INFO - 'MOZ_NO_REMOTE': '1', 09:36:54 INFO - 'NO_EM_RESTART': '1', 09:36:54 INFO - 'PAGER': '/bin/cat', 09:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:54 INFO - 'PWD': '/builds/slave/test', 09:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:54 INFO - 'SHELL': '/bin/bash', 09:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:36:54 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:54 INFO - 'USER': 'cltbld', 09:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:54 INFO - 'XPC_FLAGS': '0x0', 09:36:54 INFO - 'XPC_SERVICE_NAME': '0', 09:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:36:54 INFO - Cleaning up... 09:36:54 INFO - Return code: 0 09:36:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:54 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 0x108a84a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b19618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd0592050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, '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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:54 INFO - 'HOME': '/Users/cltbld', 09:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:54 INFO - 'LOGNAME': 'cltbld', 09:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:54 INFO - 'MOZ_NO_REMOTE': '1', 09:36:54 INFO - 'NO_EM_RESTART': '1', 09:36:54 INFO - 'PAGER': '/bin/cat', 09:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:54 INFO - 'PWD': '/builds/slave/test', 09:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:54 INFO - 'SHELL': '/bin/bash', 09:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:36:54 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:54 INFO - 'USER': 'cltbld', 09:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:54 INFO - 'XPC_FLAGS': '0x0', 09:36:54 INFO - 'XPC_SERVICE_NAME': '0', 09:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:36:54 INFO - Cleaning up... 09:36:55 INFO - Return code: 0 09:36:55 INFO - Running post-action listener: _resource_record_post_action 09:36:55 INFO - Running post-action listener: _start_resource_monitoring 09:36:55 INFO - Starting resource monitoring. 09:36:55 INFO - ##### 09:36:55 INFO - ##### Finished create-virtualenv step (success) 09:36:55 INFO - ##### 09:36:55 INFO - ##### 09:36:55 INFO - ##### Running install step. 09:36:55 INFO - ##### 09:36:55 INFO - Running pre-action listener: _resource_record_pre_action 09:36:55 INFO - Running main action method: install 09:36:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:55 INFO - Reading from file tmpfile_stdout 09:36:55 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:36:55 INFO - Reading from file tmpfile_stdout 09:36:55 INFO - Output received: 09:36:55 INFO - Usage: mozinstall [options] installer 09:36:55 INFO - Options: 09:36:55 INFO - -h, --help show this help message and exit 09:36:55 INFO - -d DEST, --destination=DEST 09:36:55 INFO - Directory to install application into. [default: 09:36:55 INFO - "/builds/slave/test"] 09:36:55 INFO - --app=APP Application being installed. [default: firefox] 09:36:55 INFO - mkdir: /builds/slave/test/build/application 09:36:55 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'] 09:36:55 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 09:37:30 INFO - Reading from file tmpfile_stdout 09:37:30 INFO - Output received: 09:37:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:37:30 INFO - Running post-action listener: _resource_record_post_action 09:37:30 INFO - ##### 09:37:30 INFO - ##### Finished install step (success) 09:37:30 INFO - ##### 09:37:30 INFO - ##### 09:37:30 INFO - ##### Running run-tests step. 09:37:30 INFO - ##### 09:37:30 INFO - Running pre-action listener: _resource_record_pre_action 09:37:30 INFO - Running main action method: run_tests 09:37:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:37:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:37:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:37:30 INFO - 2016-07-12 09:37:30.042 screenresolution[1629:7359] starting screenresolution argv=screenresolution get 09:37:30 INFO - 2016-07-12 09:37:30.044 screenresolution[1629:7359] Display 0: 1600x1200x32@60 09:37:30 INFO - 2016-07-12 09:37:30.051 screenresolution[1630:7361] starting screenresolution argv=screenresolution list 09:37:30 INFO - Available Modes on Display 0 09:37:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:37:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:37:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:37:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:37:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:37:30 INFO - Intel Iris: 09:37:30 INFO - Chipset Model: Intel Iris 09:37:30 INFO - Type: GPU 09:37:30 INFO - Bus: Built-In 09:37:30 INFO - VRAM (Dynamic, Max): 1536 MB 09:37:30 INFO - Vendor: Intel (0x8086) 09:37:30 INFO - Device ID: 0x0a2e 09:37:30 INFO - Revision ID: 0x0009 09:37:30 INFO - Displays: 09:37:30 INFO - Display: 09:37:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:37:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:37:30 INFO - Display Serial Number: 1600x1200 60 09:37:30 INFO - Main Display: Yes 09:37:30 INFO - Mirror: Off 09:37:30 INFO - Online: Yes 09:37:30 INFO - Rotation: Supported 09:37:30 INFO - Return code: 0 09:37:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:37:30 INFO - Python 2.7.3 09:37:30 INFO - Return code: 0 09:37:30 INFO - grabbing minidump binary from tooltool 09:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:37:30 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 0x1089e8d30>, '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 0x10874ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:37:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:37:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:37:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:37:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:37:30 INFO - Return code: 0 09:37:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:37:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:37:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:37:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:37:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:37:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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 09:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0127 --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 09:37:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1oqDyryKJQ/Render', 09:37:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:30 INFO - 'HOME': '/Users/cltbld', 09:37:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:30 INFO - 'LOGNAME': 'cltbld', 09:37:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:37:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:30 INFO - 'MOZ_NO_REMOTE': '1', 09:37:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:37:30 INFO - 'NO_EM_RESTART': '1', 09:37:30 INFO - 'PAGER': '/bin/cat', 09:37:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:30 INFO - 'PWD': '/builds/slave/test', 09:37:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:37:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:30 INFO - 'SHELL': '/bin/bash', 09:37:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XJ75SyyvQp/Listeners', 09:37:30 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 09:37:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:30 INFO - 'USER': 'cltbld', 09:37:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:30 INFO - 'XPC_FLAGS': '0x0', 09:37:30 INFO - 'XPC_SERVICE_NAME': '0', 09:37:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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 09:37:30 INFO - mozversion application_buildid: 20160712072641 09:37:30 INFO - mozversion application_changeset: fcfa26398425779f0dc87fc4658f2ebcc6f6f8cb 09:37:30 INFO - mozversion application_display_name: Nightly 09:37:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:37:30 INFO - mozversion application_name: Firefox 09:37:30 INFO - mozversion application_remotingname: firefox 09:37:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:37:30 INFO - mozversion application_vendor: Mozilla 09:37:30 INFO - mozversion application_version: 50.0a1 09:37:30 INFO - mozversion platform_buildid: 20160712072641 09:37:30 INFO - mozversion platform_changeset: fcfa26398425779f0dc87fc4658f2ebcc6f6f8cb 09:37:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:37:30 INFO - mozversion platform_version: 50.0a1 09:37:30 INFO - using testdate: 1468341450 09:37:30 INFO - actual date: 1468341450 09:37:30 INFO - starting webserver on 'localhost:49265' 09:37:30 INFO - SUITE-START | Running 2 tests 09:37:30 INFO - TEST-START | dromaeo_css 09:37:30 INFO - operating with platform_type : mac_ 09:37:30 INFO - Initialising browser for dromaeo_css test... 09:37:30 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpfQSvt0/profile http://localhost:49265/getInfo.html) 09:37:34 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 09:37:34 INFO - PROCESS | 1640 | colorDepth:24 09:37:34 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 09:37:34 INFO - PROCESS | 1640 | __metrics 09:37:34 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 09:37:34 INFO - TEST-INFO | 1640: exit 0 09:37:34 INFO - Browser initialized. 09:37:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:37:34 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpfQSvt0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:46 INFO - PROCESS | 1643 | RSS: Main: 253960192 09:37:46 INFO - PROCESS | 1643 | 09:38:36 INFO - PROCESS | 1643 | 1468341516646 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] 09:40:47 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 09:40:48 INFO - PROCESS | 1643 | RSS: Main: 266485760 09:40:48 INFO - PROCESS | 1643 | 09:43:50 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 09:43:51 INFO - PROCESS | 1643 | RSS: Main: 275017728 09:43:51 INFO - PROCESS | 1643 | 09:46:53 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 09:46:53 INFO - PROCESS | 1643 | RSS: Main: 279609344 09:46:53 INFO - PROCESS | 1643 | 09:49:55 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 09:49:56 INFO - PROCESS | 1643 | RSS: Main: 278544384 09:49:56 INFO - PROCESS | 1643 | 09:52:59 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 09:52:59 INFO - PROCESS | 1643 | RSS: Main: 282382336 09:52:59 INFO - PROCESS | 1643 | 09:56:02 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 09:56:02 INFO - PROCESS | 1643 | RSS: Main: 282419200 09:56:02 INFO - PROCESS | 1643 | 09:56:02 INFO - PROCESS | 1643 | __start_tp_report 09:56:02 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 09:56:02 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 09:56:02 INFO - PROCESS | 1643 | |i|pagename|runs| 09:56:02 INFO - PROCESS | 1643 | |0;dojo.html;3396.5584474018374;3411.215420453296;3415.6072051714045;3422.264213194163;3453.8445769940354;5580.246666699994;5630.592351912027;5783.334916484606;5867.794627188049;5882.235309409776;5683.124568892266;5783.624064435809;5834.095715164146;5851.122331650244;5917.763289468427;5228.372595288562;5288.206768984644;5382.784688612471;5414.83755487336;5440.727963601824;87.10861774566594;5367.0339338918975;5414.702191379472;5423.945760542403;5473.863153421156;5305.442928492511;5308.5487733542695;5308.840734777963;5352.143657014878;5367.087595108841;5292.179712144623;5304.098303288451;5348.705821179834;5364;5395.271638328853;5216.191490319006;5237.397699264595;5278.498542638443;5303.443138470482;5308.23030660552;4545.954540454586;5830.7084645767545;5846.941530584725;5858.648481091105;5935.91096133554;4936.679115857493;5467.644603100785;5747.166660834156;6281.842953926142;6301.243850737895;5631.8028868989795;6296.181496405438;6321.87356252877;6324.968375158141;6326.68366581669;6033.034714445667;6053.636781793107;6061.302950160743;6068.757249710006;6093.512518998469;6200.286966998763;6287.151234583364;6317.842053948688;6454.225492940877;6479.7408103675325;5182.5594824439595;6145.108959200891;6150.169727086786;6159.5688301818445;6177.2587289524645;6262.467690246289;6286.591371560834;6287.056941458818;6291.905621415683;6317.6209427434505;6072.787452439144;6119.663418512025;6120.571559990758;6127.525510585588;6182;6146.907796383058;6158.476529494954;6222.315545290015;6230.532710046765;6257.530685198628;4783.425988881287;5042.773075211624;5060.443351231362;5074.492550744896;5094.955534115497;4451.710638808467;4492.438445194351;4502.549745025537;4517.322401639781;4603.95396046042;6044.395560444008;6089.117078023662;6159.106929495288;6166.506679465632;6184.845378865564;6412.583182093149;6418.486521078303;6419.069234960904;6419.90861553537;6426.325235850262;6008.639481631116;6056.3338032816355;6056.394360563909;6101.908471372933;6102.631095304529;5626.268585083994;5628.943710562924;5635.126555383922;5637;5676.801311954062;6610;6628.668566571749;6631.204255489372;6637.4690024798865;6653.268140504444;6212.502999759918;6251.062340648939;6270.435660790551;6325.399087086719;6327.430531252209;6573.276939536551;6583.506237032338;6630.90053649186;6641.33586641332;6657.034729964032;6269.4984401246875;6284.24589049317;6286.622802631857;6289.182406287337;6298.307186209605;5830.416958304136;6110.938890611037;6199.442050215503;6202.751889924533;6382.872342553216;6227.06594010902;6272.4982001440685;6295.527835412454;6301.779437719658;6323.715432805443;6083.057126145454;6279.215098112736;6285.120083188449;6294.874102518015;6301.590396624205;6100.786472473442;6111.54163437735;6123.61874666675;6129.829245452198;6138.140660307471;6213.409726076196;6224.470919971853;6282.811515654537;6297.275813281532;6303.149074874833;5932.762689492372;6120.325235636639;6124.693765311806;6192.81421557354;6213.316535181217 09:56:02 INFO - PROCESS | 1643 | |1;ext.html;470.75991244465314;475.00249476100186;519.1667373864949;541.65875498436;542.0919959068559;39970.80014599927;42098.158036839246;42177;42216.36675449867;42431.93920151994;37290.627093729054;43426;44138;44267.77866110673;44494.1101177977;8456.83086338276;9496.952515237448;9660.951695241549;9822.803543929118;9861.260405469618;8349.165083491664;9768.413895166314;9810.607575696964;9819.852702209473;9859.852102218472;9696.563654635524;9719.75700607487;9802.313838031341;9844.852327215098;9873.308868379216;9732.318737688365;9742.318037737361;9746.51267436629;9777.511124443821;9802.313838031341;9661.130498255121;9698.272629552812;9761.755956101155;9776.266779991529;9776.413415195111;41099.7945010276;41455.37816932718;41463.792681036706;41636.1672766546;41652.79173604112;3172.7303179229793;3265.232670322472;3412.0446275043028;3500.859965601373;3611.7832930024283;30122.09633710992;31641.050768476984;31833.8858139964;32509.51235731466;32580.674193258;3099.3026569022013;3147.370525894807;3164.683531646817;3235.4014507315987;3280.5407242986003;374705;438005;445295;446997.7650111761;448038;34078;34291.82854085714;34300.656993430246;34442.48336274908;34454.13864653354;35867.82066089705;36429.63570364263;36462.817685911934;36471.90584282476;36502;16898.493045208663;16910.74633880493;17040.57398565046;17078.316867325168;17114.400995965083;12947.870521294855;13010.804837927439;13036.217826930415;13045.152065115926;13142;15898.443554475538;16759.664806703797;19738.137969994557;19752.60494790096;19796.505087372643;8026.438149329608;8126.628607801353;8167.8740944291785;8171.182881711781;8229.506229626242;844.6916875340579;927.1794461901266;996.8853581838036;1047.4448542272607;1081.464674985887;29661.85169074141;31744.682553174174;31751.52372714411;31894.202644934063;32935.50596741051;1027.917766578672;1079.5034284229184;1125.1898632984403;1159.918805683611;1165.7027457998156;15035.323410446555;16272.267747951371;16442.917785410995;16545.6690866182;16837.494875153767;529791;656363;688755;695206;695723;60159;60845.695771520855;62048.68975655093;62308.376916230256;62449.37550624435;1399.3283224052511;1410.4499245294344;1425.7932599773183;1428.050346519553;1428.8571142885837;31117.22206944754;31338.373232534766;31707.22018075299;31951.041468755975;31999.36001280008;52754.20868686896;52862;52975.47024529705;53079.99999999846;53266;600996;606489;607581;610050;614851;23459.648105278095;25291.73541322963;26655.466890662465;27365.04222352208;27461.17616471509;43637;49060.75469622629;49116;49332.013359731885;49503;29924.551131732605;40885.34245274048;40962.38556421596;41032.974175645846;41949;34420.82789586036;39714;41142.177156456106;41483.96290092772;41502.58497415108;34354.48468272928;40490.39264410977;40737.59262407338;41202;41387.7930610345;35205.647943520235;36527;37141.25717485581;37197.814010929775;37302.44046339253;26360.60459093077;26602.20193394201;27231.04691335873;27285.45429091447;27530.44939101247 09:56:02 INFO - PROCESS | 1643 | |2;jquery.html;344.95343128677627;383.4554931996563;389.140000598677;398.5138131479594;409.3879649923363;20337.59324813503;22044.559108817815;22254.777452225473;22511.662325065136;22955.540889182226;21627.243046493375;21951.780482195172;21984.780152198473;22270;22331.330060098182;5906.379830117829;6192.504599632019;6217.720202590872;6241.1574437451045;6249.500039996812;4227.196832601811;6152.661603611799;6542.50931180161;6873.312668733111;6884.862302753942;5815.418458154193;6874.587524748531;6901.516893817435;6908.309169083102;6937.618430986294;6111.2055432793895;6130.5095592352955;6160.322364539919;6218.968905155491;6230.719617617218;6002.429769171922;6089;6103.847403814896;6142.570020098595;6146.969265153691;13673.453061877513;13907.860921390758;22720.43198920024;24574.50850982988;25930.611040834214;2418.238254949685;2428.90284388626;2839.488891999439;2977.374751302229;3025.803322784034;10279.79440411195;10337.173026157889;10392.480375981171;10479.371237725685;13716.971227157903;1776.1030679506766;1887.160213704902;1897.3169658922777;1909.7230851820025;1956.7847536770944;129884;130411.04383434256;133010.99999999904;135471;136458;11690.240134391237;11812.763744725058;11862.347570883512;11882.584109556125;11973.10201734856;14748.557543273719;14884.404623814926;14919.92540037293;14948.925255373653;14968.775468367983;8748.212660860552;8763.737087887373;8772.429792063496;8781;8890.955545222232;8770.062029220282;8774.034856165817;8784;8857.557122143868;8881.245094167069;4636.536346365404;4639.489656137822;4667.603253723471;4671.416072990876;4678.719276843401;1693.1987687641079;1798.6492633936257;1851.5093500222451;1975.9450171821431;1992.4122383896786;777.7044723005222;829.2578142562373;911.5123408976166;930.2418528898926;989.2284018465608;16752.748708769377;21314.254001109886;22519.392332284337;22839.657405138936;22962.42593935165;959.6976952260155;961.7499450142873;963.9759006024765;993.6671215142864;1048.6434612231878;11603.07175425964;11955.641330759918;12082.758344833053;12092.153549251469;12123.272603643809;506463;528954;614588.9270553619;631327;632817;132355;137500;138171;138490;139388;972.397113789455;991.5884907763342;1058.444316733721;1059.0574388793825;1069.3209811769427;16409.425670101966;20328.186872524933;20785.752854828155;20981.580368392242;21011.579768404852;41851.37222941719;53249.9663976812;56305;56966;57603.4793041385;84113;85410.57294713735;85781.14218857732;86598.56700716456;86824.56587717021;6788.558743681645;8369.748907532783;8513.063563008189;8531;8695.739127825922;11686.298822070703;11775.411229438323;13318.200907945555;13409.463621455032;13558.254296013814;10888.945555272174;11683.532658693897;11713.062954963412;11729.178957472895;11776.155232044775;11349.886501134883;11499.195056345976;11541.249818761753;11639;11671.183017188716;11246.987771100641;11865.940670296593;11891.524339026688;11925.34410607425;11973.521059157536;8360.372972027244;8465.95767021161;8467.66129354819;8517.44636598619;8596.150695744062;7976.800579985546;8978.371513993958;11469.713257168638;11636.650900473;11684.006859416704 09:56:02 INFO - PROCESS | 1643 | |3;mootools.html;1346.3739361197042;1516.6132636177772;1697.1938329293587;1849.2510533234035;1875.9624807503842;7099.964500177492;8008.759737207879;8590.87113693295;9110.954445227773;9129.13273239042;8620.65517379304;8700.477971321725;8842.646294148226;8846.5134417607;8864.069272726367;2348.260298006127;2372.92881213563;2376.607859703147;2377.6671266022686;2399.5440866235444;2346.085026839534;2378.678878351426;2385.6540801583847;2395.43707228802;2397.2927986244013;2349.189529612281;2363.763623637631;2368.147466911919;2369.5379401016808;2371.3834403055243;2333.3933177373833;2345.0502546468624;2355.422921384263;2355.964660530102;2361.2207971369407;2326.5114325991563;2344.1443872986238;2345.3081341004445;2349.941251468727;2356.15178535727;8924.598393072263;8966.686165984225;8967.372283940127;8970.820583588356;8971.685990990283;5187.818426355059;5254.343207099113;5301.522862942354;5324.520793128599;5327.893442131174;3580.1228698968657;3626.075350785533;3673.1735359544155;3678.2091850252054;3698.2418604186078;932.6222879733651;1003.8193125237455;1055.5408397347178;1097.7091070866147;1103.9944800276028;11486.885131148665;11532.019778318769;11575.652730418102;11665.825012624817;11684.649460516282;4615.100055489147;4708.552687494683;4795.880102997453;4844.297576851337;4848.369711937426;10029.348092373972;10029.997000300058;10032.347897386646;10040.096391324816;10045.49772511386;5305.495977882095;5358.33020872391;5382.596305277119;5386.218998245233;5390.326209223847;4381.6932814703305;4743.0988112258565;4883.853484395474;4886.413630364379;4938.358013458227;3370.1574606348413;3936.2127574485216;4001.6398524132387;4034.5561988181275;4106.815193316248;1285.7107150890974;1294.4627979388636;1301.102239454773;1304.2696090189525;1305.0407950156628;804.8752443371287;866.4021824940896;934.4159900062461;957.6169532187041;975.3562648651997;6037.698115094227;6049.667268300198;6115.84710382244;6150.7232174552255;6279.623222606659;761.7333933123363;950.4534892436876;1027.2193133218807;1076.9461526923621;1089.7330154112294;4020.43713880057;4062.695297852673;4071.8574849880706;4137.234611596804;4142.130152667974;10645.84031239532;10812.67561973142;10917.072048875934;10980.341179529254;11014.50434730439;9140.314476414296;10621.734456638645;10754.139668826476;10914.508847101899;10940.617078402376;8290.129536398712;8291.378146639026;8412.242898139197;8439.746807595782;8484.448510846774;5310.601704872072;5647.6893770843;6022.397760223943;6035.547333949883;6042.123892035718;9952.303338766507;10104.69685909424;10198.33710808795;10208.387496750218;10281.74295642585;8047.275745182962;10155.39067655943;10268.897311027093;10301.072903438726;10332.896671033193;6994.125734283215;7450.96274518624;7633.1985141559335;7710.730124445618;7806.453548251568;8519.020312664123;8579.399442039246;8607.913920860961;8642;8654.956725216334;7520.135184453858;7682.347000505019;7737.767866964;7755.069391673035;7755.379569634303;6942.576771761877;7190.209077001421;7273.3453989141235;7344.779656610311;7379.667914943733;6358.523110766619;7142.678579463833;7162;7204.675789589586;7207.747728829466;4921.50784921505;4973.502649734997;5052.621053421081;5059.544640982329;5102.719350435762;4926.876828079184;5047.2429135629945;5065.265536497261;5087.135187018142;5277.920831187612 09:56:02 INFO - PROCESS | 1643 | |4;prototype.html;309.5403326060799;315.2764405688944;321.6220940395036;324.40309829912957;325.76870422000377;4934.383202099738;5032.616030591585;5172.482751724826;5600.52395546379;5656.2929633795775;4867.586255168315;5711.828645140642;5733.885322293551;5743.856403589902;5748.885022299552;3816.0841398064404;4208.45388539932;4360.520342762302;4387.670924680646;4418.64650827933;3556.697680697144;3931.7051221158385;4025.993501624594;4397.714148580348;4432.312991486308;3382.560267165265;3782.7895073576465;4348.391225228471;4348.999730062072;4378.430803995476;3570.982145089284;3745.056525386491;4257.041356257402;4413.470383553962;4423.469183697976;3797.2215695782297;3799.2211596622624;3818.4654148419245;3818.987968188432;3819.598942111066;4842.782074806642;4936.98895620945;5219.686818790885;5616.63491873031;5616.647098498655;4460.264056430685;4901.362822833044;4936.333594964705;4945.23348880924;4966.566382472599;5909.852253693649;5995.820125396202;6076.088586711984;6097.664628445434;6113.663748493831;4032.6773858091283;4061.6750659947133;4061.97969010156;4063;4070.633642972147;5425.860569280456;6004.309504407005;6266.749330026793;6422.068800024017;6481.513886458534;3904.7266691331333;3998.5601583825755;4096.668582710631;4109.404136400265;4131.925699318199;4149.651363306937;4173.9982404222765;4180.707350485498;4193.316277582349;4194.664426845845;4503.572160644733;4718.952810471851;4920.803167873317;4974.104661160954;4984.601231901439;5038.908852826109;5418.295621569171;5804.767809287666;6064.302605200371;6137.9079313810325;1346.8787809097228;1400.8108905297859;1492.7611582146803;1502.6168327076525;1503.301269565384;792.9088154862264;902.8284625921185;915.4736026784625;933.5052422216236;935.5088578496208;4418.889527761831;4818.590419814355;4865.567216391804;4874.561289483963;4881.486034692065;4435.179491794029;4808.543188397097;4984.728894131973;5023.8492845214705;5372.811951581676;4098.8360465581045;4294.291441912112;4532.501424843264;4867.756612169377;4883.975580122076;2211.81199598036;2411.577169470021;2777.125205560242;2815.8310501369983;2852.8445979378384;5481.534069604048;5517.393086760453;5545.390007099216;5549.94551035302;5550.66783971852;5465.016297066487;5468.261784659099;5544.445555444423;5900.350961394243;6486.189226346707;6150.093471023997;6582.341765823379;6584.045313429526;6622.536422450478;6632.8673426531195;6032.849178770566;6345.748348606353;6349.777757778455;6357.745690172342;6376.9043464349;5183.248428977702;6000.699965001645;6219.657918814509;6231.470325022424;6246.219222597176;6240.625562466266;6331.715072821642;6611.652863233483;6629.867402651824;6659.034440006269;3588.8515674983755;3612.8374223159494;3972.9602703973746;4030.234255491447;4164.875053748392;5790;6224.502039836892;6279.89145373025;6298.016124920819;6322.557420980487;5857.970710146422;6039.701464185046;6108.908366374419;6120.724567394389;6136.6011209271255;5272.209168624737;5696.914546281726;6012.3085845126625;6012.963453455976;6018.916595012764;5926.140709597171;5937;5940.702964851826;5943.435373639497;5947.167396564398;4752.52474752522;5226.581873450191;5727.651662818224;6052.606580572248;6142.3550527194;4964.808445972868;5761.818827140342;5764.36591974874;5975.342712301556;6022.54830887694 09:56:02 INFO - PROCESS | 1643 | |5;yui.html;667.3560014585925;706.2443185791205;711.3313485323795;716.9641517924106;818.3453237410071;15273.389064437422;15528.53414397567;16076.196190190502;16227.513174604752;16369.918150409247;14234.003619746596;14264.358103885324;14319.355628996695;14344.71310573788;14369.497067602637;701.6842420910585;717.720089165226;876.6843936182969;888.6800751729372;897.5826240798027;879.3185281406896;894.7941973346134;901.486152892848;903.9457632542036;909.122696597783;954.3939598355025;954.7040417470606;957.7174733453647;961.3174646001347;961.8124465729186;912.8585069314267;918.7197904639082;933.3326671429926;947.5641205045687;949.188443880486;679.2867489136437;687.5221720903974;697.4699228586311;707.4481904114747;708.9078419805444;15289.311980960883;15526.301316440788;15544;15554.377824886991;15562.766558501631;11165.609203677832;14983.625409364744;14986.100833949999;15053.774193387108;15211;11561.826572601418;11737.943585077299;11983.580574679932;12052.879471205264;12155.088368372408;3857.7106716996336;3860.6718428933295;3990.5610382857863;4089.815958281855;4128.380742888561;99595.50202248943;113064;113095;114285;114422.28366574508;11199;11500.309981401142;11527.942360288313;11599.536018559163;11822.408879555987;23568;23685.407864803517;24071.879640602034;24072.87963560206;24109;8196.713115041064;8217.30152937007;8244.258016778398;8317.792055198668;8374.916250837536;4424.203643344229;4546.659000574904;4547;4551.613112885442;4594;3596.6583174598372;3664.2854643344826;3709.221063576679;3714.0714821294678;3725.0314918121485;635.5932203389834;657.3459407889085;662.066486254379;665.0622622102812;666.5267659961385;524.6275144647267;640.5868215001298;689.1902015132199;703.9436845052384;714.8320144765976;8949.955250223707;9489.335746497816;9529.330162504844;9681.951590242004;9837.508124593742;568.3435631845225;630.5806638585381;633.9746410143634;683.1221879884325;707.5719189890145;4579.839705610288;4597.218472859622;4746.857594272177;4760.238361862154;4831;83827.58086209653;146454;150839;152806.7078993816;154435;122794;123182;125751.37124314503;126285;126416;114019.85980140258;117189;119332.24340417844;120014.7998520021;122834.38582807028;9138.17756401927;9138.360314778167;9155.587998539948;9157.587908543997;9484.57319420614;46239;49317.26024109713;61334;65191.674041629485;66731.99902001377;54411;54652.726736366065;85371.57314213637;88600.5569972146;97147.51426242823;12871.871281287067;12890.742185156432;13622.38699258516;13750.931245344109;13922.09506382082;12409.565665201675;15449.304781284643;15684.137372444626;15733.44932927342;16084.195790210677;11326.886731132583;14170.00809943294;14424;14667.706645866809;14689.70620587561;13713.862861371259;13878.375473103937;14293.608399337027;14309.499167529086;14788.186649733938;13689.520866769615;13829.239391833546;13926.791098133739;14159.64600884986;14618.634534136732;11490.88509114898;11549.769004620028;11620.593279235187;11759;11891.464884080064;10439.843402349123;11115.388653624128;11185.440727963733;11845.23006004607;11845.466953987263 09:56:02 INFO - PROCESS | 1643 | __end_tp_report 09:56:02 INFO - PROCESS | 1643 | __start_cc_report 09:56:02 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,432 09:56:02 INFO - PROCESS | 1643 | __end_cc_report 09:56:02 INFO - PROCESS | 1643 | __startTimestamp1468342562606__endTimestamp 09:56:02 INFO - PROCESS | 1643 | 09:56:02 INFO - PROCESS | 1643 | ------- Summary: start ------- 09:56:02 INFO - PROCESS | 1643 | Number of tests: 6 09:56:02 INFO - PROCESS | 1643 | 09:56:02 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5815.65 Median:6111.54 stddev:797.62 (13.1%) stddev-sans-first:777.16 09:56:02 INFO - PROCESS | 1643 | Values: 3396.6 3411.2 3415.6 3422.3 3453.8 5580.2 5630.6 5783.3 5867.8 5882.2 5683.1 5783.6 5834.1 5851.1 5917.8 5228.4 5288.2 5382.8 5414.8 5440.7 87.1 5367.0 5414.7 5423.9 5473.9 5305.4 5308.5 5308.8 5352.1 5367.1 5292.2 5304.1 5348.7 5364.0 5395.3 5216.2 5237.4 5278.5 5303.4 5308.2 4546.0 5830.7 5846.9 5858.6 5935.9 4936.7 5467.6 5747.2 6281.8 6301.2 5631.8 6296.2 6321.9 6325.0 6326.7 6033.0 6053.6 6061.3 6068.8 6093.5 6200.3 6287.2 6317.8 6454.2 6479.7 5182.6 6145.1 6150.2 6159.6 6177.3 6262.5 6286.6 6287.1 6291.9 6317.6 6072.8 6119.7 6120.6 6127.5 6182.0 6146.9 6158.5 6222.3 6230.5 6257.5 4783.4 5042.8 5060.4 5074.5 5095.0 4451.7 4492.4 4502.5 4517.3 4604.0 6044.4 6089.1 6159.1 6166.5 6184.8 6412.6 6418.5 6419.1 6419.9 6426.3 6008.6 6056.3 6056.4 6101.9 6102.6 5626.3 5628.9 5635.1 5637.0 5676.8 6610.0 6628.7 6631.2 6637.5 6653.3 6212.5 6251.1 6270.4 6325.4 6327.4 6573.3 6583.5 6630.9 6641.3 6657.0 6269.5 6284.2 6286.6 6289.2 6298.3 5830.4 6110.9 6199.4 6202.8 6382.9 6227.1 6272.5 6295.5 6301.8 6323.7 6083.1 6279.2 6285.1 6294.9 6301.6 6100.8 6111.5 6123.6 6129.8 6138.1 6213.4 6224.5 6282.8 6297.3 6303.1 5932.8 6120.3 6124.7 6192.8 6213.3 09:56:02 INFO - PROCESS | 1643 | 09:56:02 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:69046.05 Median:40811.47 stddev:153516.54 (376.2%) stddev-sans-first:153860.85 09:56:02 INFO - PROCESS | 1643 | Values: 470.8 475.0 519.2 541.7 542.1 39970.8 42098.2 42177.0 42216.4 42431.9 37290.6 43426.0 44138.0 44267.8 44494.1 8456.8 9497.0 9661.0 9822.8 9861.3 8349.2 9768.4 9810.6 9819.9 9859.9 9696.6 9719.8 9802.3 9844.9 9873.3 9732.3 9742.3 9746.5 9777.5 9802.3 9661.1 9698.3 9761.8 9776.3 9776.4 41099.8 41455.4 41463.8 41636.2 41652.8 3172.7 3265.2 3412.0 3500.9 3611.8 30122.1 31641.1 31833.9 32509.5 32580.7 3099.3 3147.4 3164.7 3235.4 3280.5 374705.0 438005.0 445295.0 446997.8 448038.0 34078.0 34291.8 34300.7 34442.5 34454.1 35867.8 36429.6 36462.8 36471.9 36502.0 16898.5 16910.7 17040.6 17078.3 17114.4 12947.9 13010.8 13036.2 13045.2 13142.0 15898.4 16759.7 19738.1 19752.6 19796.5 8026.4 8126.6 8167.9 8171.2 8229.5 844.7 927.2 996.9 1047.4 1081.5 29661.9 31744.7 31751.5 31894.2 32935.5 1027.9 1079.5 1125.2 1159.9 1165.7 15035.3 16272.3 16442.9 16545.7 16837.5 529791.0 656363.0 688755.0 695206.0 695723.0 60159.0 60845.7 62048.7 62308.4 62449.4 1399.3 1410.4 1425.8 1428.1 1428.9 31117.2 31338.4 31707.2 31951.0 31999.4 52754.2 52862.0 52975.5 53080.0 53266.0 600996.0 606489.0 607581.0 610050.0 614851.0 23459.6 25291.7 26655.5 27365.0 27461.2 43637.0 49060.8 49116.0 49332.0 49503.0 29924.6 40885.3 40962.4 41033.0 41949.0 34420.8 39714.0 41142.2 41484.0 41502.6 34354.5 40490.4 40737.6 41202.0 41387.8 35205.6 36527.0 37141.3 37197.8 37302.4 26360.6 26602.2 27231.0 27285.5 27530.4 09:56:02 INFO - PROCESS | 1643 | 09:56:02 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:35696.51 Median:2423.57 stddev:98535.19 (4065.7%) stddev-sans-first:98775.86 09:56:02 INFO - PROCESS | 1643 | Values: 345.0 383.5 389.1 398.5 409.4 20337.6 22044.6 22254.8 22511.7 22955.5 21627.2 21951.8 21984.8 22270.0 22331.3 5906.4 6192.5 6217.7 6241.2 6249.5 4227.2 6152.7 6542.5 6873.3 6884.9 5815.4 6874.6 6901.5 6908.3 6937.6 6111.2 6130.5 6160.3 6219.0 6230.7 6002.4 6089.0 6103.8 6142.6 6147.0 13673.5 13907.9 22720.4 24574.5 25930.6 2418.2 2428.9 2839.5 2977.4 3025.8 10279.8 10337.2 10392.5 10479.4 13717.0 1776.1 1887.2 1897.3 1909.7 1956.8 129884.0 130411.0 133011.0 135471.0 136458.0 11690.2 11812.8 11862.3 11882.6 11973.1 14748.6 14884.4 14919.9 14948.9 14968.8 8748.2 8763.7 8772.4 8781.0 8891.0 8770.1 8774.0 8784.0 8857.6 8881.2 4636.5 4639.5 4667.6 4671.4 4678.7 1693.2 1798.6 1851.5 1975.9 1992.4 777.7 829.3 911.5 930.2 989.2 16752.7 21314.3 22519.4 22839.7 22962.4 959.7 961.7 964.0 993.7 1048.6 11603.1 11955.6 12082.8 12092.2 12123.3 506463.0 528954.0 614588.9 631327.0 632817.0 132355.0 137500.0 138171.0 138490.0 139388.0 972.4 991.6 1058.4 1059.1 1069.3 16409.4 20328.2 20785.8 20981.6 21011.6 41851.4 53250.0 56305.0 56966.0 57603.5 84113.0 85410.6 85781.1 86598.6 86824.6 6788.6 8369.7 8513.1 8531.0 8695.7 11686.3 11775.4 13318.2 13409.5 13558.3 10888.9 11683.5 11713.1 11729.2 11776.2 11349.9 11499.2 11541.2 11639.0 11671.2 11247.0 11865.9 11891.5 11925.3 11973.5 8360.4 8466.0 8467.7 8517.4 8596.2 7976.8 8978.4 11469.7 11636.7 11684.0 09:56:02 INFO - PROCESS | 1643 | 09:56:02 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5751.12 Median:4866.11 stddev:3205.73 (65.9%) stddev-sans-first:3197.63 09:56:02 INFO - PROCESS | 1643 | Values: 1346.4 1516.6 1697.2 1849.3 1876.0 7100.0 8008.8 8590.9 9111.0 9129.1 8620.7 8700.5 8842.6 8846.5 8864.1 2348.3 2372.9 2376.6 2377.7 2399.5 2346.1 2378.7 2385.7 2395.4 2397.3 2349.2 2363.8 2368.1 2369.5 2371.4 2333.4 2345.1 2355.4 2356.0 2361.2 2326.5 2344.1 2345.3 2349.9 2356.2 8924.6 8966.7 8967.4 8970.8 8971.7 5187.8 5254.3 5301.5 5324.5 5327.9 3580.1 3626.1 3673.2 3678.2 3698.2 932.6 1003.8 1055.5 1097.7 1104.0 11486.9 11532.0 11575.7 11665.8 11684.6 4615.1 4708.6 4795.9 4844.3 4848.4 10029.3 10030.0 10032.3 10040.1 10045.5 5305.5 5358.3 5382.6 5386.2 5390.3 4381.7 4743.1 4883.9 4886.4 4938.4 3370.2 3936.2 4001.6 4034.6 4106.8 1285.7 1294.5 1301.1 1304.3 1305.0 804.9 866.4 934.4 957.6 975.4 6037.7 6049.7 6115.8 6150.7 6279.6 761.7 950.5 1027.2 1076.9 1089.7 4020.4 4062.7 4071.9 4137.2 4142.1 10645.8 10812.7 10917.1 10980.3 11014.5 9140.3 10621.7 10754.1 10914.5 10940.6 8290.1 8291.4 8412.2 8439.7 8484.4 5310.6 5647.7 6022.4 6035.5 6042.1 9952.3 10104.7 10198.3 10208.4 10281.7 8047.3 10155.4 10268.9 10301.1 10332.9 6994.1 7451.0 7633.2 7710.7 7806.5 8519.0 8579.4 8607.9 8642.0 8655.0 7520.1 7682.3 7737.8 7755.1 7755.4 6942.6 7190.2 7273.3 7344.8 7379.7 6358.5 7142.7 7162.0 7204.7 7207.7 4921.5 4973.5 5052.6 5059.5 5102.7 4926.9 5047.2 5065.3 5087.1 5277.9 09:56:02 INFO - PROCESS | 1643 | 09:56:02 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4759.82 Median:5035.76 stddev:1515.90 (30.1%) stddev-sans-first:1482.89 09:56:02 INFO - PROCESS | 1643 | Values: 309.5 315.3 321.6 324.4 325.8 4934.4 5032.6 5172.5 5600.5 5656.3 4867.6 5711.8 5733.9 5743.9 5748.9 3816.1 4208.5 4360.5 4387.7 4418.6 3556.7 3931.7 4026.0 4397.7 4432.3 3382.6 3782.8 4348.4 4349.0 4378.4 3571.0 3745.1 4257.0 4413.5 4423.5 3797.2 3799.2 3818.5 3819.0 3819.6 4842.8 4937.0 5219.7 5616.6 5616.6 4460.3 4901.4 4936.3 4945.2 4966.6 5909.9 5995.8 6076.1 6097.7 6113.7 4032.7 4061.7 4062.0 4063.0 4070.6 5425.9 6004.3 6266.7 6422.1 6481.5 3904.7 3998.6 4096.7 4109.4 4131.9 4149.7 4174.0 4180.7 4193.3 4194.7 4503.6 4719.0 4920.8 4974.1 4984.6 5038.9 5418.3 5804.8 6064.3 6137.9 1346.9 1400.8 1492.8 1502.6 1503.3 792.9 902.8 915.5 933.5 935.5 4418.9 4818.6 4865.6 4874.6 4881.5 4435.2 4808.5 4984.7 5023.8 5372.8 4098.8 4294.3 4532.5 4867.8 4884.0 2211.8 2411.6 2777.1 2815.8 2852.8 5481.5 5517.4 5545.4 5549.9 5550.7 5465.0 5468.3 5544.4 5900.4 6486.2 6150.1 6582.3 6584.0 6622.5 6632.9 6032.8 6345.7 6349.8 6357.7 6376.9 5183.2 6000.7 6219.7 6231.5 6246.2 6240.6 6331.7 6611.7 6629.9 6659.0 3588.9 3612.8 3973.0 4030.2 4164.9 5790.0 6224.5 6279.9 6298.0 6322.6 5858.0 6039.7 6108.9 6120.7 6136.6 5272.2 5696.9 6012.3 6013.0 6018.9 5926.1 5937.0 5940.7 5943.4 5947.2 4752.5 5226.6 5727.7 6052.6 6142.4 4964.8 5761.8 5764.4 5975.3 6022.5 09:56:02 INFO - PROCESS | 1643 | 09:56:02 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:24378.64 Median:3711.65 stddev:38534.60 (1038.2%) stddev-sans-first:38601.58 09:56:02 INFO - PROCESS | 1643 | Values: 667.4 706.2 711.3 717.0 818.3 15273.4 15528.5 16076.2 16227.5 16369.9 14234.0 14264.4 14319.4 14344.7 14369.5 701.7 717.7 876.7 888.7 897.6 879.3 894.8 901.5 903.9 909.1 954.4 954.7 957.7 961.3 961.8 912.9 918.7 933.3 947.6 949.2 679.3 687.5 697.5 707.4 708.9 15289.3 15526.3 15544.0 15554.4 15562.8 11165.6 14983.6 14986.1 15053.8 15211.0 11561.8 11737.9 11983.6 12052.9 12155.1 3857.7 3860.7 3990.6 4089.8 4128.4 99595.5 113064.0 113095.0 114285.0 114422.3 11199.0 11500.3 11527.9 11599.5 11822.4 23568.0 23685.4 24071.9 24072.9 24109.0 8196.7 8217.3 8244.3 8317.8 8374.9 4424.2 4546.7 4547.0 4551.6 4594.0 3596.7 3664.3 3709.2 3714.1 3725.0 635.6 657.3 662.1 665.1 666.5 524.6 640.6 689.2 703.9 714.8 8950.0 9489.3 9529.3 9682.0 9837.5 568.3 630.6 634.0 683.1 707.6 4579.8 4597.2 4746.9 4760.2 4831.0 83827.6 146454.0 150839.0 152806.7 154435.0 122794.0 123182.0 125751.4 126285.0 126416.0 114019.9 117189.0 119332.2 120014.8 122834.4 9138.2 9138.4 9155.6 9157.6 9484.6 46239.0 49317.3 61334.0 65191.7 66732.0 54411.0 54652.7 85371.6 88600.6 97147.5 12871.9 12890.7 13622.4 13750.9 13922.1 12409.6 15449.3 15684.1 15733.4 16084.2 11326.9 14170.0 14424.0 14667.7 14689.7 13713.9 13878.4 14293.6 14309.5 14788.2 13689.5 13829.2 13926.8 14159.6 14618.6 11490.9 11549.8 11620.6 11759.0 11891.5 10439.8 11115.4 11185.4 11845.2 11845.5 09:56:02 INFO - PROCESS | 1643 | -------- Summary: end -------- 09:56:02 INFO - PROCESS | 1643 | 09:56:03 INFO - TEST-INFO | 1643: exit 0 09:56:03 INFO - TEST-OK | dromaeo_css | took 1112602ms 09:56:03 INFO - TEST-START | kraken 09:56:03 INFO - operating with platform_type : mac_ 09:56:03 INFO - Initialising browser for kraken test... 09:56:03 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpiMfZ02/profile http://localhost:49265/getInfo.html) 09:56:06 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 09:56:06 INFO - PROCESS | 1654 | colorDepth:24 09:56:06 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 09:56:06 INFO - PROCESS | 1654 | __metrics 09:56:06 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 09:56:06 INFO - TEST-INFO | 1654: exit 0 09:56:06 INFO - Browser initialized. 09:56:06 INFO - Running cycle 1/1 for kraken test... 09:56:06 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpiMfZ02/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:18 INFO - PROCESS | 1656 | RSS: Main: 254271488 09:56:18 INFO - PROCESS | 1656 | 09:56:21 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 09:56:22 INFO - PROCESS | 1656 | RSS: Main: 266973184 09:56:22 INFO - PROCESS | 1656 | 09:56:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 09:56:25 INFO - PROCESS | 1656 | RSS: Main: 271114240 09:56:25 INFO - PROCESS | 1656 | 09:56:28 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 09:56:29 INFO - PROCESS | 1656 | RSS: Main: 271302656 09:56:29 INFO - PROCESS | 1656 | 09:56:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 09:56:32 INFO - PROCESS | 1656 | RSS: Main: 272228352 09:56:32 INFO - PROCESS | 1656 | 09:56:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:56:34 INFO - PROCESS | 1656 | RSS: Main: 272949248 09:56:34 INFO - PROCESS | 1656 | 09:56:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 09:56:38 INFO - PROCESS | 1656 | RSS: Main: 273825792 09:56:38 INFO - PROCESS | 1656 | 09:56:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 09:56:41 INFO - PROCESS | 1656 | RSS: Main: 273879040 09:56:41 INFO - PROCESS | 1656 | 09:56:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 09:56:45 INFO - PROCESS | 1656 | RSS: Main: 273768448 09:56:45 INFO - PROCESS | 1656 | 09:56:46 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:47 INFO - PROCESS | 1656 | RSS: Main: 273616896 09:56:47 INFO - PROCESS | 1656 | 09:56:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:49 INFO - PROCESS | 1656 | RSS: Main: 273620992 09:56:49 INFO - PROCESS | 1656 | 09:56:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:52 INFO - PROCESS | 1656 | RSS: Main: 273821696 09:56:52 INFO - PROCESS | 1656 | 09:56:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:55 INFO - PROCESS | 1656 | RSS: Main: 273784832 09:56:55 INFO - PROCESS | 1656 | 09:56:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:59 INFO - PROCESS | 1656 | RSS: Main: 273780736 09:56:59 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 09:57:01 INFO - PROCESS | 1656 | RSS: Main: 274866176 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | __start_tp_report 09:57:01 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 09:57:01 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 09:57:01 INFO - PROCESS | 1656 | |i|pagename|runs| 09:57:01 INFO - PROCESS | 1656 | |0;ai-astar;106;116;104;116;116;116;112;117;115;117 09:57:01 INFO - PROCESS | 1656 | |1;audio-beat-detection;148;106;136;152;109;118;152;136;175;109 09:57:01 INFO - PROCESS | 1656 | |2;audio-dft;187;199;197;214;232;198;195;199;199;196 09:57:01 INFO - PROCESS | 1656 | |3;audio-fft;71;80;69;110;59;61;59;72;157;78 09:57:01 INFO - PROCESS | 1656 | |4;audio-oscillator;70;72;122;70;71;80;115;70;75;119 09:57:01 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;100;88;89;87;90;87;90;88;91;87 09:57:01 INFO - PROCESS | 1656 | |6;imaging-darkroom;95;96;95;98;94;96;96;124;96;95 09:57:01 INFO - PROCESS | 1656 | |7;imaging-desaturate;90;93;91;94;94;91;90;91;89;90 09:57:01 INFO - PROCESS | 1656 | |8;json-parse-financial;56;59;57;58;57;58;57;59;56;55 09:57:01 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;67;70;77;69;75;72;69;71;73;71 09:57:01 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;88;86;80;88;85;87;87;86;88;103 09:57:01 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;153;151;130;136;139;148;123;137;145;125 09:57:01 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;224;157;226;228;170;162;159;188;222;158 09:57:01 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;65;67;66;68;65;66;67;66;69;64 09:57:01 INFO - PROCESS | 1656 | __end_tp_report 09:57:01 INFO - PROCESS | 1656 | __start_cc_report 09:57:01 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1121 09:57:01 INFO - PROCESS | 1656 | __end_cc_report 09:57:01 INFO - PROCESS | 1656 | __startTimestamp1468342621642__endTimestamp 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | ------- Summary: start ------- 09:57:01 INFO - PROCESS | 1656 | Number of tests: 14 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:113.50 Median:116.00 stddev:4.72 (4.1%) stddev-sans-first:4.15 09:57:01 INFO - PROCESS | 1656 | Values: 106.0 116.0 104.0 116.0 116.0 116.0 112.0 117.0 115.0 117.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:142.00 stddev:23.15 (16.3%) stddev-sans-first:24.00 09:57:01 INFO - PROCESS | 1656 | Values: 148.0 106.0 136.0 152.0 109.0 118.0 152.0 136.0 175.0 109.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:201.60 Median:199.00 stddev:12.56 (6.3%) stddev-sans-first:12.16 09:57:01 INFO - PROCESS | 1656 | Values: 187.0 199.0 197.0 214.0 232.0 198.0 195.0 199.0 199.0 196.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:81.60 Median:70.00 stddev:30.40 (43.4%) stddev-sans-first:32.00 09:57:01 INFO - PROCESS | 1656 | Values: 71.0 80.0 69.0 110.0 59.0 61.0 59.0 72.0 157.0 78.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:70.50 stddev:22.53 (32.0%) stddev-sans-first:23.11 09:57:01 INFO - PROCESS | 1656 | Values: 70.0 72.0 122.0 70.0 71.0 80.0 115.0 70.0 75.0 119.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:88.50 stddev:3.89 (4.4%) stddev-sans-first:1.51 09:57:01 INFO - PROCESS | 1656 | Values: 100.0 88.0 89.0 87.0 90.0 87.0 90.0 88.0 91.0 87.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:98.50 Median:96.00 stddev:9.02 (9.4%) stddev-sans-first:9.48 09:57:01 INFO - PROCESS | 1656 | Values: 95.0 96.0 95.0 98.0 94.0 96.0 96.0 124.0 96.0 95.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:91.00 stddev:1.77 (1.9%) stddev-sans-first:1.81 09:57:01 INFO - PROCESS | 1656 | Values: 90.0 93.0 91.0 94.0 94.0 91.0 90.0 91.0 89.0 90.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:1.32 (2.3%) stddev-sans-first:1.32 09:57:01 INFO - PROCESS | 1656 | Values: 56.0 59.0 57.0 58.0 57.0 58.0 57.0 59.0 56.0 55.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:2.99 (4.2%) stddev-sans-first:2.71 09:57:01 INFO - PROCESS | 1656 | Values: 67.0 70.0 77.0 69.0 75.0 72.0 69.0 71.0 73.0 71.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:5.85 (6.7%) stddev-sans-first:6.20 09:57:01 INFO - PROCESS | 1656 | Values: 88.0 86.0 80.0 88.0 85.0 87.0 87.0 86.0 88.0 103.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:142.00 stddev:10.55 (7.4%) stddev-sans-first:9.84 09:57:01 INFO - PROCESS | 1656 | Values: 153.0 151.0 130.0 136.0 139.0 148.0 123.0 137.0 145.0 125.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.40 Median:205.00 stddev:31.93 (15.6%) stddev-sans-first:31.32 09:57:01 INFO - PROCESS | 1656 | Values: 224.0 157.0 226.0 228.0 170.0 162.0 159.0 188.0 222.0 158.0 09:57:01 INFO - PROCESS | 1656 | 09:57:01 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.49 (2.2%) stddev-sans-first:1.51 09:57:01 INFO - PROCESS | 1656 | Values: 65.0 67.0 66.0 68.0 65.0 66.0 67.0 66.0 69.0 64.0 09:57:01 INFO - PROCESS | 1656 | -------- Summary: end -------- 09:57:01 INFO - PROCESS | 1656 | 09:57:02 INFO - TEST-INFO | 1656: exit 0 09:57:02 INFO - TEST-OK | kraken | took 59219ms 09:57:02 INFO - SUITE-END | took 1171s 09:57:02 INFO - Completed test suite (00:19:32) 09:57:02 INFO - javascript benchmark 09:57:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7503.364037081646, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3396.5584474018374, 3411.215420453296, 3415.6072051714045, 3422.264213194163, 3453.8445769940354, 5580.246666699994, 5630.592351912027, 5783.334916484606, 5867.794627188049, 5882.235309409776, 5683.124568892266, 5783.624064435809, 5834.095715164146, 5851.122331650244, 5917.763289468427, 5228.372595288562, 5288.206768984644, 5382.784688612471, 5414.83755487336, 5440.727963601824, 87.10861774566594, 5367.0339338918975, 5414.702191379472, 5423.945760542403, 5473.863153421156, 5305.442928492511, 5308.5487733542695, 5308.840734777963, 5352.143657014878, 5367.087595108841, 5292.179712144623, 5304.098303288451, 5348.705821179834, 5364.0, 5395.271638328853, 5216.191490319006, 5237.397699264595, 5278.498542638443, 5303.443138470482, 5308.23030660552, 4545.954540454586, 5830.7084645767545, 5846.941530584725, 5858.648481091105, 5935.91096133554, 4936.679115857493, 5467.644603100785, 5747.166660834156, 6281.842953926142, 6301.243850737895, 5631.8028868989795, 6296.181496405438, 6321.87356252877, 6324.968375158141, 6326.68366581669, 6033.034714445667, 6053.636781793107, 6061.302950160743, 6068.757249710006, 6093.512518998469, 6200.286966998763, 6287.151234583364, 6317.842053948688, 6454.225492940877, 6479.7408103675325, 5182.5594824439595, 6145.108959200891, 6150.169727086786, 6159.5688301818445, 6177.2587289524645, 6262.467690246289, 6286.591371560834, 6287.056941458818, 6291.905621415683, 6317.6209427434505, 6072.787452439144, 6119.663418512025, 6120.571559990758, 6127.525510585588, 6182.0, 6146.907796383058, 6158.476529494954, 6222.315545290015, 6230.532710046765, 6257.530685198628, 4783.425988881287, 5042.773075211624, 5060.443351231362, 5074.492550744896, 5094.955534115497, 4451.710638808467, 4492.438445194351, 4502.549745025537, 4517.322401639781, 4603.95396046042, 6044.395560444008, 6089.117078023662, 6159.106929495288, 6166.506679465632, 6184.845378865564, 6412.583182093149, 6418.486521078303, 6419.069234960904, 6419.90861553537, 6426.325235850262, 6008.639481631116, 6056.3338032816355, 6056.394360563909, 6101.908471372933, 6102.631095304529, 5626.268585083994, 5628.943710562924, 5635.126555383922, 5637.0, 5676.801311954062, 6610.0, 6628.668566571749, 6631.204255489372, 6637.4690024798865, 6653.268140504444, 6212.502999759918, 6251.062340648939, 6270.435660790551, 6325.399087086719, 6327.430531252209, 6573.276939536551, 6583.506237032338, 6630.90053649186, 6641.33586641332, 6657.034729964032, 6269.4984401246875, 6284.24589049317, 6286.622802631857, 6289.182406287337, 6298.307186209605, 5830.416958304136, 6110.938890611037, 6199.442050215503, 6202.751889924533, 6382.872342553216, 6227.06594010902, 6272.4982001440685, 6295.527835412454, 6301.779437719658, 6323.715432805443, 6083.057126145454, 6279.215098112736, 6285.120083188449, 6294.874102518015, 6301.590396624205, 6100.786472473442, 6111.54163437735, 6123.61874666675, 6129.829245452198, 6138.140660307471, 6213.409726076196, 6224.470919971853, 6282.811515654537, 6297.275813281532, 6303.149074874833, 5932.762689492372, 6120.325235636639, 6124.693765311806, 6192.81421557354, 6213.316535181217], "value": 5768.025525718763, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.75991244465314, 475.00249476100186, 519.1667373864949, 541.65875498436, 542.0919959068559, 39970.80014599927, 42098.158036839246, 42177.0, 42216.36675449867, 42431.93920151994, 37290.627093729054, 43426.0, 44138.0, 44267.77866110673, 44494.1101177977, 8456.83086338276, 9496.952515237448, 9660.951695241549, 9822.803543929118, 9861.260405469618, 8349.165083491664, 9768.413895166314, 9810.607575696964, 9819.852702209473, 9859.852102218472, 9696.563654635524, 9719.75700607487, 9802.313838031341, 9844.852327215098, 9873.308868379216, 9732.318737688365, 9742.318037737361, 9746.51267436629, 9777.511124443821, 9802.313838031341, 9661.130498255121, 9698.272629552812, 9761.755956101155, 9776.266779991529, 9776.413415195111, 41099.7945010276, 41455.37816932718, 41463.792681036706, 41636.1672766546, 41652.79173604112, 3172.7303179229793, 3265.232670322472, 3412.0446275043028, 3500.859965601373, 3611.7832930024283, 30122.09633710992, 31641.050768476984, 31833.8858139964, 32509.51235731466, 32580.674193258, 3099.3026569022013, 3147.370525894807, 3164.683531646817, 3235.4014507315987, 3280.5407242986003, 374705.0, 438005.0, 445295.0, 446997.7650111761, 448038.0, 34078.0, 34291.82854085714, 34300.656993430246, 34442.48336274908, 34454.13864653354, 35867.82066089705, 36429.63570364263, 36462.817685911934, 36471.90584282476, 36502.0, 16898.493045208663, 16910.74633880493, 17040.57398565046, 17078.316867325168, 17114.400995965083, 12947.870521294855, 13010.804837927439, 13036.217826930415, 13045.152065115926, 13142.0, 15898.443554475538, 16759.664806703797, 19738.137969994557, 19752.60494790096, 19796.505087372643, 8026.438149329608, 8126.628607801353, 8167.8740944291785, 8171.182881711781, 8229.506229626242, 844.6916875340579, 927.1794461901266, 996.8853581838036, 1047.4448542272607, 1081.464674985887, 29661.85169074141, 31744.682553174174, 31751.52372714411, 31894.202644934063, 32935.50596741051, 1027.917766578672, 1079.5034284229184, 1125.1898632984403, 1159.918805683611, 1165.7027457998156, 15035.323410446555, 16272.267747951371, 16442.917785410995, 16545.6690866182, 16837.494875153767, 529791.0, 656363.0, 688755.0, 695206.0, 695723.0, 60159.0, 60845.695771520855, 62048.68975655093, 62308.376916230256, 62449.37550624435, 1399.3283224052511, 1410.4499245294344, 1425.7932599773183, 1428.050346519553, 1428.8571142885837, 31117.22206944754, 31338.373232534766, 31707.22018075299, 31951.041468755975, 31999.36001280008, 52754.20868686896, 52862.0, 52975.47024529705, 53079.99999999846, 53266.0, 600996.0, 606489.0, 607581.0, 610050.0, 614851.0, 23459.648105278095, 25291.73541322963, 26655.466890662465, 27365.04222352208, 27461.17616471509, 43637.0, 49060.75469622629, 49116.0, 49332.013359731885, 49503.0, 29924.551131732605, 40885.34245274048, 40962.38556421596, 41032.974175645846, 41949.0, 34420.82789586036, 39714.0, 41142.177156456106, 41483.96290092772, 41502.58497415108, 34354.48468272928, 40490.39264410977, 40737.59262407338, 41202.0, 41387.7930610345, 35205.647943520235, 36527.0, 37141.25717485581, 37197.814010929775, 37302.44046339253, 26360.60459093077, 26602.20193394201, 27231.04691335873, 27285.45429091447, 27530.44939101247], "value": 19800.224749684243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.95343128677627, 383.4554931996563, 389.140000598677, 398.5138131479594, 409.3879649923363, 20337.59324813503, 22044.559108817815, 22254.777452225473, 22511.662325065136, 22955.540889182226, 21627.243046493375, 21951.780482195172, 21984.780152198473, 22270.0, 22331.330060098182, 5906.379830117829, 6192.504599632019, 6217.720202590872, 6241.1574437451045, 6249.500039996812, 4227.196832601811, 6152.661603611799, 6542.50931180161, 6873.312668733111, 6884.862302753942, 5815.418458154193, 6874.587524748531, 6901.516893817435, 6908.309169083102, 6937.618430986294, 6111.2055432793895, 6130.5095592352955, 6160.322364539919, 6218.968905155491, 6230.719617617218, 6002.429769171922, 6089.0, 6103.847403814896, 6142.570020098595, 6146.969265153691, 13673.453061877513, 13907.860921390758, 22720.43198920024, 24574.50850982988, 25930.611040834214, 2418.238254949685, 2428.90284388626, 2839.488891999439, 2977.374751302229, 3025.803322784034, 10279.79440411195, 10337.173026157889, 10392.480375981171, 10479.371237725685, 13716.971227157903, 1776.1030679506766, 1887.160213704902, 1897.3169658922777, 1909.7230851820025, 1956.7847536770944, 129884.0, 130411.04383434256, 133010.99999999904, 135471.0, 136458.0, 11690.240134391237, 11812.763744725058, 11862.347570883512, 11882.584109556125, 11973.10201734856, 14748.557543273719, 14884.404623814926, 14919.92540037293, 14948.925255373653, 14968.775468367983, 8748.212660860552, 8763.737087887373, 8772.429792063496, 8781.0, 8890.955545222232, 8770.062029220282, 8774.034856165817, 8784.0, 8857.557122143868, 8881.245094167069, 4636.536346365404, 4639.489656137822, 4667.603253723471, 4671.416072990876, 4678.719276843401, 1693.1987687641079, 1798.6492633936257, 1851.5093500222451, 1975.9450171821431, 1992.4122383896786, 777.7044723005222, 829.2578142562373, 911.5123408976166, 930.2418528898926, 989.2284018465608, 16752.748708769377, 21314.254001109886, 22519.392332284337, 22839.657405138936, 22962.42593935165, 959.6976952260155, 961.7499450142873, 963.9759006024765, 993.6671215142864, 1048.6434612231878, 11603.07175425964, 11955.641330759918, 12082.758344833053, 12092.153549251469, 12123.272603643809, 506463.0, 528954.0, 614588.9270553619, 631327.0, 632817.0, 132355.0, 137500.0, 138171.0, 138490.0, 139388.0, 972.397113789455, 991.5884907763342, 1058.444316733721, 1059.0574388793825, 1069.3209811769427, 16409.425670101966, 20328.186872524933, 20785.752854828155, 20981.580368392242, 21011.579768404852, 41851.37222941719, 53249.9663976812, 56305.0, 56966.0, 57603.4793041385, 84113.0, 85410.57294713735, 85781.14218857732, 86598.56700716456, 86824.56587717021, 6788.558743681645, 8369.748907532783, 8513.063563008189, 8531.0, 8695.739127825922, 11686.298822070703, 11775.411229438323, 13318.200907945555, 13409.463621455032, 13558.254296013814, 10888.945555272174, 11683.532658693897, 11713.062954963412, 11729.178957472895, 11776.155232044775, 11349.886501134883, 11499.195056345976, 11541.249818761753, 11639.0, 11671.183017188716, 11246.987771100641, 11865.940670296593, 11891.524339026688, 11925.34410607425, 11973.521059157536, 8360.372972027244, 8465.95767021161, 8467.66129354819, 8517.44636598619, 8596.150695744062, 7976.800579985546, 8978.371513993958, 11469.713257168638, 11636.650900473, 11684.006859416704], "value": 9930.11455720998, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.3739361197042, 1516.6132636177772, 1697.1938329293587, 1849.2510533234035, 1875.9624807503842, 7099.964500177492, 8008.759737207879, 8590.87113693295, 9110.954445227773, 9129.13273239042, 8620.65517379304, 8700.477971321725, 8842.646294148226, 8846.5134417607, 8864.069272726367, 2348.260298006127, 2372.92881213563, 2376.607859703147, 2377.6671266022686, 2399.5440866235444, 2346.085026839534, 2378.678878351426, 2385.6540801583847, 2395.43707228802, 2397.2927986244013, 2349.189529612281, 2363.763623637631, 2368.147466911919, 2369.5379401016808, 2371.3834403055243, 2333.3933177373833, 2345.0502546468624, 2355.422921384263, 2355.964660530102, 2361.2207971369407, 2326.5114325991563, 2344.1443872986238, 2345.3081341004445, 2349.941251468727, 2356.15178535727, 8924.598393072263, 8966.686165984225, 8967.372283940127, 8970.820583588356, 8971.685990990283, 5187.818426355059, 5254.343207099113, 5301.522862942354, 5324.520793128599, 5327.893442131174, 3580.1228698968657, 3626.075350785533, 3673.1735359544155, 3678.2091850252054, 3698.2418604186078, 932.6222879733651, 1003.8193125237455, 1055.5408397347178, 1097.7091070866147, 1103.9944800276028, 11486.885131148665, 11532.019778318769, 11575.652730418102, 11665.825012624817, 11684.649460516282, 4615.100055489147, 4708.552687494683, 4795.880102997453, 4844.297576851337, 4848.369711937426, 10029.348092373972, 10029.997000300058, 10032.347897386646, 10040.096391324816, 10045.49772511386, 5305.495977882095, 5358.33020872391, 5382.596305277119, 5386.218998245233, 5390.326209223847, 4381.6932814703305, 4743.0988112258565, 4883.853484395474, 4886.413630364379, 4938.358013458227, 3370.1574606348413, 3936.2127574485216, 4001.6398524132387, 4034.5561988181275, 4106.815193316248, 1285.7107150890974, 1294.4627979388636, 1301.102239454773, 1304.2696090189525, 1305.0407950156628, 804.8752443371287, 866.4021824940896, 934.4159900062461, 957.6169532187041, 975.3562648651997, 6037.698115094227, 6049.667268300198, 6115.84710382244, 6150.7232174552255, 6279.623222606659, 761.7333933123363, 950.4534892436876, 1027.2193133218807, 1076.9461526923621, 1089.7330154112294, 4020.43713880057, 4062.695297852673, 4071.8574849880706, 4137.234611596804, 4142.130152667974, 10645.84031239532, 10812.67561973142, 10917.072048875934, 10980.341179529254, 11014.50434730439, 9140.314476414296, 10621.734456638645, 10754.139668826476, 10914.508847101899, 10940.617078402376, 8290.129536398712, 8291.378146639026, 8412.242898139197, 8439.746807595782, 8484.448510846774, 5310.601704872072, 5647.6893770843, 6022.397760223943, 6035.547333949883, 6042.123892035718, 9952.303338766507, 10104.69685909424, 10198.33710808795, 10208.387496750218, 10281.74295642585, 8047.275745182962, 10155.39067655943, 10268.897311027093, 10301.072903438726, 10332.896671033193, 6994.125734283215, 7450.96274518624, 7633.1985141559335, 7710.730124445618, 7806.453548251568, 8519.020312664123, 8579.399442039246, 8607.913920860961, 8642.0, 8654.956725216334, 7520.135184453858, 7682.347000505019, 7737.767866964, 7755.069391673035, 7755.379569634303, 6942.576771761877, 7190.209077001421, 7273.3453989141235, 7344.779656610311, 7379.667914943733, 6358.523110766619, 7142.678579463833, 7162.0, 7204.675789589586, 7207.747728829466, 4921.50784921505, 4973.502649734997, 5052.621053421081, 5059.544640982329, 5102.719350435762, 4926.876828079184, 5047.2429135629945, 5065.265536497261, 5087.135187018142, 5277.920831187612], "value": 4630.462388724829, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.5403326060799, 315.2764405688944, 321.6220940395036, 324.40309829912957, 325.76870422000377, 4934.383202099738, 5032.616030591585, 5172.482751724826, 5600.52395546379, 5656.2929633795775, 4867.586255168315, 5711.828645140642, 5733.885322293551, 5743.856403589902, 5748.885022299552, 3816.0841398064404, 4208.45388539932, 4360.520342762302, 4387.670924680646, 4418.64650827933, 3556.697680697144, 3931.7051221158385, 4025.993501624594, 4397.714148580348, 4432.312991486308, 3382.560267165265, 3782.7895073576465, 4348.391225228471, 4348.999730062072, 4378.430803995476, 3570.982145089284, 3745.056525386491, 4257.041356257402, 4413.470383553962, 4423.469183697976, 3797.2215695782297, 3799.2211596622624, 3818.4654148419245, 3818.987968188432, 3819.598942111066, 4842.782074806642, 4936.98895620945, 5219.686818790885, 5616.63491873031, 5616.647098498655, 4460.264056430685, 4901.362822833044, 4936.333594964705, 4945.23348880924, 4966.566382472599, 5909.852253693649, 5995.820125396202, 6076.088586711984, 6097.664628445434, 6113.663748493831, 4032.6773858091283, 4061.6750659947133, 4061.97969010156, 4063.0, 4070.633642972147, 5425.860569280456, 6004.309504407005, 6266.749330026793, 6422.068800024017, 6481.513886458534, 3904.7266691331333, 3998.5601583825755, 4096.668582710631, 4109.404136400265, 4131.925699318199, 4149.651363306937, 4173.9982404222765, 4180.707350485498, 4193.316277582349, 4194.664426845845, 4503.572160644733, 4718.952810471851, 4920.803167873317, 4974.104661160954, 4984.601231901439, 5038.908852826109, 5418.295621569171, 5804.767809287666, 6064.302605200371, 6137.9079313810325, 1346.8787809097228, 1400.8108905297859, 1492.7611582146803, 1502.6168327076525, 1503.301269565384, 792.9088154862264, 902.8284625921185, 915.4736026784625, 933.5052422216236, 935.5088578496208, 4418.889527761831, 4818.590419814355, 4865.567216391804, 4874.561289483963, 4881.486034692065, 4435.179491794029, 4808.543188397097, 4984.728894131973, 5023.8492845214705, 5372.811951581676, 4098.8360465581045, 4294.291441912112, 4532.501424843264, 4867.756612169377, 4883.975580122076, 2211.81199598036, 2411.577169470021, 2777.125205560242, 2815.8310501369983, 2852.8445979378384, 5481.534069604048, 5517.393086760453, 5545.390007099216, 5549.94551035302, 5550.66783971852, 5465.016297066487, 5468.261784659099, 5544.445555444423, 5900.350961394243, 6486.189226346707, 6150.093471023997, 6582.341765823379, 6584.045313429526, 6622.536422450478, 6632.8673426531195, 6032.849178770566, 6345.748348606353, 6349.777757778455, 6357.745690172342, 6376.9043464349, 5183.248428977702, 6000.699965001645, 6219.657918814509, 6231.470325022424, 6246.219222597176, 6240.625562466266, 6331.715072821642, 6611.652863233483, 6629.867402651824, 6659.034440006269, 3588.8515674983755, 3612.8374223159494, 3972.9602703973746, 4030.234255491447, 4164.875053748392, 5790.0, 6224.502039836892, 6279.89145373025, 6298.016124920819, 6322.557420980487, 5857.970710146422, 6039.701464185046, 6108.908366374419, 6120.724567394389, 6136.6011209271255, 5272.209168624737, 5696.914546281726, 6012.3085845126625, 6012.963453455976, 6018.916595012764, 5926.140709597171, 5937.0, 5940.702964851826, 5943.435373639497, 5947.167396564398, 4752.52474752522, 5226.581873450191, 5727.651662818224, 6052.606580572248, 6142.3550527194, 4964.808445972868, 5761.818827140342, 5764.36591974874, 5975.342712301556, 6022.54830887694], "value": 4277.266981754258, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.3560014585925, 706.2443185791205, 711.3313485323795, 716.9641517924106, 818.3453237410071, 15273.389064437422, 15528.53414397567, 16076.196190190502, 16227.513174604752, 16369.918150409247, 14234.003619746596, 14264.358103885324, 14319.355628996695, 14344.71310573788, 14369.497067602637, 701.6842420910585, 717.720089165226, 876.6843936182969, 888.6800751729372, 897.5826240798027, 879.3185281406896, 894.7941973346134, 901.486152892848, 903.9457632542036, 909.122696597783, 954.3939598355025, 954.7040417470606, 957.7174733453647, 961.3174646001347, 961.8124465729186, 912.8585069314267, 918.7197904639082, 933.3326671429926, 947.5641205045687, 949.188443880486, 679.2867489136437, 687.5221720903974, 697.4699228586311, 707.4481904114747, 708.9078419805444, 15289.311980960883, 15526.301316440788, 15544.0, 15554.377824886991, 15562.766558501631, 11165.609203677832, 14983.625409364744, 14986.100833949999, 15053.774193387108, 15211.0, 11561.826572601418, 11737.943585077299, 11983.580574679932, 12052.879471205264, 12155.088368372408, 3857.7106716996336, 3860.6718428933295, 3990.5610382857863, 4089.815958281855, 4128.380742888561, 99595.50202248943, 113064.0, 113095.0, 114285.0, 114422.28366574508, 11199.0, 11500.309981401142, 11527.942360288313, 11599.536018559163, 11822.408879555987, 23568.0, 23685.407864803517, 24071.879640602034, 24072.87963560206, 24109.0, 8196.713115041064, 8217.30152937007, 8244.258016778398, 8317.792055198668, 8374.916250837536, 4424.203643344229, 4546.659000574904, 4547.0, 4551.613112885442, 4594.0, 3596.6583174598372, 3664.2854643344826, 3709.221063576679, 3714.0714821294678, 3725.0314918121485, 635.5932203389834, 657.3459407889085, 662.066486254379, 665.0622622102812, 666.5267659961385, 524.6275144647267, 640.5868215001298, 689.1902015132199, 703.9436845052384, 714.8320144765976, 8949.955250223707, 9489.335746497816, 9529.330162504844, 9681.951590242004, 9837.508124593742, 568.3435631845225, 630.5806638585381, 633.9746410143634, 683.1221879884325, 707.5719189890145, 4579.839705610288, 4597.218472859622, 4746.857594272177, 4760.238361862154, 4831.0, 83827.58086209653, 146454.0, 150839.0, 152806.7078993816, 154435.0, 122794.0, 123182.0, 125751.37124314503, 126285.0, 126416.0, 114019.85980140258, 117189.0, 119332.24340417844, 120014.7998520021, 122834.38582807028, 9138.17756401927, 9138.360314778167, 9155.587998539948, 9157.587908543997, 9484.57319420614, 46239.0, 49317.26024109713, 61334.0, 65191.674041629485, 66731.99902001377, 54411.0, 54652.726736366065, 85371.57314213637, 88600.5569972146, 97147.51426242823, 12871.871281287067, 12890.742185156432, 13622.38699258516, 13750.931245344109, 13922.09506382082, 12409.565665201675, 15449.304781284643, 15684.137372444626, 15733.44932927342, 16084.195790210677, 11326.886731132583, 14170.00809943294, 14424.0, 14667.706645866809, 14689.70620587561, 13713.862861371259, 13878.375473103937, 14293.608399337027, 14309.499167529086, 14788.186649733938, 13689.520866769615, 13829.239391833546, 13926.791098133739, 14159.64600884986, 14618.634534136732, 11490.88509114898, 11549.769004620028, 11620.593279235187, 11759.0, 11891.464884080064, 10439.843402349123, 11115.388653624128, 11185.440727963733, 11845.23006004607, 11845.466953987263], "value": 7944.199954208391, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1507.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 104.0, 116.0, 116.0, 116.0, 112.0, 117.0, 115.0, 117.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 106.0, 136.0, 152.0, 109.0, 118.0, 152.0, 136.0, 175.0, 109.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 199.0, 197.0, 214.0, 232.0, 198.0, 195.0, 199.0, 199.0, 196.0], "value": 201.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 80.0, 69.0, 110.0, 59.0, 61.0, 59.0, 72.0, 157.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 122.0, 70.0, 71.0, 80.0, 115.0, 70.0, 75.0, 119.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 88.0, 89.0, 87.0, 90.0, 87.0, 90.0, 88.0, 91.0, 87.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 98.0, 94.0, 96.0, 96.0, 124.0, 96.0, 95.0], "value": 98.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 91.0, 94.0, 94.0, 91.0, 90.0, 91.0, 89.0, 90.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 57.0, 58.0, 57.0, 58.0, 57.0, 59.0, 56.0, 55.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 77.0, 69.0, 75.0, 72.0, 69.0, 71.0, 73.0, 71.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 80.0, 88.0, 85.0, 87.0, 87.0, 86.0, 88.0, 103.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 130.0, 136.0, 139.0, 148.0, 123.0, 137.0, 145.0, 125.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [224.0, 157.0, 226.0, 228.0, 170.0, 162.0, 159.0, 188.0, 222.0, 158.0], "value": 189.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 68.0, 65.0, 66.0, 67.0, 66.0, 69.0, 64.0], "value": 66.3, "unit": "score"}]}]} 09:57:02 INFO - Return code: 0 09:57:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:57:02 ERROR - # TBPL SUCCESS # 09:57:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:57:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:57:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:57:02 INFO - 2016-07-12 09:57:02.969 screenresolution[1661:10152] starting screenresolution argv=screenresolution get 09:57:02 INFO - 2016-07-12 09:57:02.971 screenresolution[1661:10152] Display 0: 1600x1200x32@60 09:57:02 INFO - 2016-07-12 09:57:02.977 screenresolution[1662:10155] starting screenresolution argv=screenresolution list 09:57:02 INFO - Available Modes on Display 0 09:57:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:57:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:57:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:57:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:57:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:57:03 INFO - Intel Iris: 09:57:03 INFO - Chipset Model: Intel Iris 09:57:03 INFO - Type: GPU 09:57:03 INFO - Bus: Built-In 09:57:03 INFO - VRAM (Dynamic, Max): 1536 MB 09:57:03 INFO - Vendor: Intel (0x8086) 09:57:03 INFO - Device ID: 0x0a2e 09:57:03 INFO - Revision ID: 0x0009 09:57:03 INFO - Displays: 09:57:03 INFO - Display: 09:57:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:57:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:57:03 INFO - Display Serial Number: 1600x1200 60 09:57:03 INFO - Main Display: Yes 09:57:03 INFO - Mirror: Off 09:57:03 INFO - Online: Yes 09:57:03 INFO - Rotation: Supported 09:57:03 INFO - Return code: 0 09:57:03 INFO - Running post-action listener: _resource_record_post_action 09:57:03 INFO - ##### 09:57:03 INFO - ##### Finished run-tests step (success) 09:57:03 INFO - ##### 09:57:03 INFO - Running post-run listener: _resource_record_post_run 09:57:03 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 38008320; Write bytes: 707660800; Read time: 396; Write time: 1963 09:57:03 INFO - TinderboxPrint: CPU usage
54.2% 09:57:03 INFO - TinderboxPrint: I/O read bytes / time
38,008,320 / 396 09:57:03 INFO - TinderboxPrint: I/O write bytes / time
707,660,800 / 1,963 09:57:03 INFO - TinderboxPrint: CPU idle
2,213.1 (45.8%) 09:57:03 INFO - TinderboxPrint: CPU system
969.9 (20.1%) 09:57:03 INFO - TinderboxPrint: CPU user
1,646.7 (34.1%) 09:57:03 INFO - TinderboxPrint: Swap in / out
444,297,216 / 0 09:57:03 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 385550848; Write bytes: 380942336; Read time: 29259; Write time: 720 09:57:03 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 37053952; Write bytes: 297395200; Read time: 382; Write time: 1188 09:57:03 INFO - Running post-run listener: _upload_blobber_files 09:57:03 INFO - Blob upload gear active. 09:57:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:57:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:57:03 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:57:03 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:57:04 INFO - (blobuploader) - INFO - Open directory for files ... 09:57:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:57:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:05 INFO - (blobuploader) - INFO - Done attempting. 09:57:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:57:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:57:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:06 INFO - (blobuploader) - INFO - Done attempting. 09:57:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:57:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:57:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:08 INFO - (blobuploader) - INFO - Done attempting. 09:57:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:57:08 INFO - Return code: 0 09:57:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:57:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:57:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86cfcf1a8f0704d7e14f52c7b4d987928bb38b549db0f40ba3d383343c598fe7a487fed9800f829531f5cc748a15ed7d71162ecf640950df8452d6382c1e8aa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d3d618f6567041db0623a2225e1cf355b77bdbe3697b94ebdb1a7844bb6c3759436cf41b1fdfdda0bc35cee8251f3b0a9cca68bc4614985480a2c2490ecb5a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a406395efb23c9e446b45bf188d8d20216a34b9c8020409eff77853199296eedcf8ccc4b1f7f8aaa170255f36a41ac7e166cbb9bd4c8c64571ead7432857bb"} 09:57:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:57:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:57:08 INFO - Contents: 09:57:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86cfcf1a8f0704d7e14f52c7b4d987928bb38b549db0f40ba3d383343c598fe7a487fed9800f829531f5cc748a15ed7d71162ecf640950df8452d6382c1e8aa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d3d618f6567041db0623a2225e1cf355b77bdbe3697b94ebdb1a7844bb6c3759436cf41b1fdfdda0bc35cee8251f3b0a9cca68bc4614985480a2c2490ecb5a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a406395efb23c9e446b45bf188d8d20216a34b9c8020409eff77853199296eedcf8ccc4b1f7f8aaa170255f36a41ac7e166cbb9bd4c8c64571ead7432857bb"} 09:57:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:57:08 INFO - Copying logs to upload dir... 09:57:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:57:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.015637 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-12 09:57:08.687165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 09:57:08.690494) ========= 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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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/Firefox/sha512/86cfcf1a8f0704d7e14f52c7b4d987928bb38b549db0f40ba3d383343c598fe7a487fed9800f829531f5cc748a15ed7d71162ecf640950df8452d6382c1e8aa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d3d618f6567041db0623a2225e1cf355b77bdbe3697b94ebdb1a7844bb6c3759436cf41b1fdfdda0bc35cee8251f3b0a9cca68bc4614985480a2c2490ecb5a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a406395efb23c9e446b45bf188d8d20216a34b9c8020409eff77853199296eedcf8ccc4b1f7f8aaa170255f36a41ac7e166cbb9bd4c8c64571ead7432857bb"} build_url:https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010652 build_url: 'https://queue.taskcluster.net/v1/task/U0kpDf_fTmyHH8AVSmrnxQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86cfcf1a8f0704d7e14f52c7b4d987928bb38b549db0f40ba3d383343c598fe7a487fed9800f829531f5cc748a15ed7d71162ecf640950df8452d6382c1e8aa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d3d618f6567041db0623a2225e1cf355b77bdbe3697b94ebdb1a7844bb6c3759436cf41b1fdfdda0bc35cee8251f3b0a9cca68bc4614985480a2c2490ecb5a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a406395efb23c9e446b45bf188d8d20216a34b9c8020409eff77853199296eedcf8ccc4b1f7f8aaa170255f36a41ac7e166cbb9bd4c8c64571ead7432857bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 09:57:08.725661) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:57:08.726057) ========= 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.1oqDyryKJQ/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.XJ75SyyvQp/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.005079 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:57:08.774953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 09:57:08.778373) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 09:57:08.778718) ========= ========= Total master_lag: 0.18 =========