builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0149 starttime: 1461610157.92 results: success (0) buildid: 20160425083752 builduid: 08d4e1319d244485b787c038d1ac9858 revision: 352d365eb4eda3aab7c3680b0e80ce17e178b5ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:17.924111) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:17.924855) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:17.928484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:17.952965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:17.953468) ========= 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.mqnikKyyF2/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.ECVPOApt4p/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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-04-25 11:49:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-04-25 11:49:18 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113732 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:18.093386) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:18.093991) ========= 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.mqnikKyyF2/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.ECVPOApt4p/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.019921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:18.147402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 11:49:18.147777) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 352d365eb4eda3aab7c3680b0e80ce17e178b5ee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 352d365eb4eda3aab7c3680b0e80ce17e178b5ee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mqnikKyyF2/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.ECVPOApt4p/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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-04-25 11:49:18,241 truncating revision to first 12 chars 2016-04-25 11:49:18,241 Setting DEBUG logging. 2016-04-25 11:49:18,241 attempt 1/10 2016-04-25 11:49:18,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/352d365eb4ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 11:49:19,919 unpacking tar archive at: fx-team-352d365eb4ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.924885 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 11:49:20.095673) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:20.096077) ========= script_repo_revision: 352d365eb4eda3aab7c3680b0e80ce17e178b5ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:20.096519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:20.096793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 11:49:20.113370) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-25 11:49:20.113736) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mqnikKyyF2/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.ECVPOApt4p/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:49:20 INFO - MultiFileLogger online at 20160425 11:49:20 in /builds/slave/test 11:49:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:49:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:20 INFO - {'append_to_log': False, 11:49:20 INFO - 'base_work_dir': '/builds/slave/test', 11:49:20 INFO - 'blob_upload_branch': 'Fx-Team', 11:49:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:20 INFO - 'branch': 'Fx-Team', 11:49:20 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:20 INFO - 'config_files': ('talos/mac_config.py',), 11:49:20 INFO - 'default_actions': ('clobber', 11:49:20 INFO - 'read-buildbot-config', 11:49:20 INFO - 'download-and-extract', 11:49:20 INFO - 'populate-webroot', 11:49:20 INFO - 'create-virtualenv', 11:49:20 INFO - 'install', 11:49:20 INFO - 'run-tests'), 11:49:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:20 INFO - 'download_minidump_stackwalk': True, 11:49:20 INFO - 'download_symbols': 'ondemand', 11:49:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:20 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:20 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:20 INFO - 'installer_path': 'installer.exe', 11:49:20 INFO - 'log_level': 'info', 11:49:20 INFO - 'log_name': 'talos', 11:49:20 INFO - 'log_to_console': True, 11:49:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:49:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:49:20 INFO - 'opt_config_files': (), 11:49:20 INFO - 'pip_index': False, 11:49:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:49:20 INFO - 'cmd': ('bash', 11:49:20 INFO - '-c', 11:49:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:49:20 INFO - 'enabled': True, 11:49:20 INFO - 'halt_on_failure': False, 11:49:20 INFO - 'name': 'check_screen_resolution'},), 11:49:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:49:20 INFO - 'cmd': ('bash', 11:49:20 INFO - '-c', 11:49:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:49:20 INFO - 'enabled': True, 11:49:20 INFO - 'halt_on_failure': False, 11:49:20 INFO - 'name': 'check_screen_resolution'},), 11:49:20 INFO - 'run_cmd_checks_enabled': True, 11:49:20 INFO - 'sps_profile': False, 11:49:20 INFO - 'sps_profile_interval': 0, 11:49:20 INFO - 'suite': 'dromaeojs-e10s', 11:49:20 INFO - 'system_bits': '32', 11:49:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:20 INFO - 'title': 't-yosemite-r7-0149', 11:49:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:20 INFO - 'use_talos_json': True, 11:49:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:20 INFO - 'work_dir': 'build'} 11:49:20 INFO - ##### 11:49:20 INFO - ##### Running clobber step. 11:49:20 INFO - ##### 11:49:20 INFO - Running pre-action listener: _resource_record_pre_action 11:49:20 INFO - Running main action method: clobber 11:49:20 INFO - rmtree: /builds/slave/test/build 11:49:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:21 INFO - Running post-action listener: _resource_record_post_action 11:49:21 INFO - ##### 11:49:21 INFO - ##### Running read-buildbot-config step. 11:49:21 INFO - ##### 11:49:21 INFO - Running pre-action listener: _resource_record_pre_action 11:49:21 INFO - Running main action method: read_buildbot_config 11:49:21 INFO - Using buildbot properties: 11:49:21 INFO - { 11:49:21 INFO - "project": "", 11:49:21 INFO - "product": "firefox", 11:49:21 INFO - "script_repo_revision": "production", 11:49:21 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:49:21 INFO - "repository": "", 11:49:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:49:21 INFO - "buildid": "20160425083752", 11:49:21 INFO - "pgo_build": "False", 11:49:21 INFO - "basedir": "/builds/slave/test", 11:49:21 INFO - "buildnumber": 727, 11:49:21 INFO - "slavename": "t-yosemite-r7-0149", 11:49:21 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:49:21 INFO - "platform": "yosemite_r7", 11:49:21 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:49:21 INFO - "branch": "fx-team", 11:49:21 INFO - "repo_path": "integration/fx-team", 11:49:21 INFO - "revision": "352d365eb4eda3aab7c3680b0e80ce17e178b5ee", 11:49:21 INFO - "stage_platform": "macosx64", 11:49:21 INFO - "builduid": "08d4e1319d244485b787c038d1ac9858", 11:49:21 INFO - "slavebuilddir": "test" 11:49:21 INFO - } 11:49:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:49:21 INFO - Running post-action listener: _resource_record_post_action 11:49:21 INFO - ##### 11:49:21 INFO - ##### Running download-and-extract step. 11:49:21 INFO - ##### 11:49:21 INFO - Running pre-action listener: _resource_record_pre_action 11:49:21 INFO - Running main action method: download_and_extract 11:49:21 INFO - mkdir: /builds/slave/test/build/tests 11:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:21 INFO - https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:49:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:49:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:49:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 11:49:22 INFO - Downloaded 1199 bytes. 11:49:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:49:22 INFO - Using the following test package requirements: 11:49:22 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:49:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:49:22 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:49:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:49:22 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:49:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:49:22 INFO - u'jsshell-mac.zip'], 11:49:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:49:22 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:49:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:49:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:49:22 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:49:22 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:49:22 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:49:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:49:22 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:49:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:49:22 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:49:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:49:22 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')]} 11:49:22 INFO - https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:49:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:49:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:49:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:49:23 INFO - Downloaded 18111487 bytes. 11:49:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:49:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:49:27 INFO - Return code: 0 11:49:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:27 INFO - https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:49:28 INFO - Downloaded 18111487 bytes. 11:49:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:49:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:49:31 INFO - Return code: 0 11:49:31 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')]} 11:49:31 INFO - https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:49:32 INFO - Downloaded 10840145 bytes. 11:49:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:49:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:49:33 INFO - Return code: 0 11:49: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')]} 11:49:33 INFO - https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 11:49:36 INFO - Downloaded 110151443 bytes. 11:49:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:49:36 INFO - mkdir: /builds/slave/test/properties 11:49:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:36 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:36 INFO - Contents: 11:49:36 INFO - build_url:https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:49:36 INFO - Running post-action listener: _resource_record_post_action 11:49:36 INFO - Running post-action listener: set_extra_try_arguments 11:49:36 INFO - ##### 11:49:36 INFO - ##### Running populate-webroot step. 11:49:36 INFO - ##### 11:49:36 INFO - Running pre-action listener: _resource_record_pre_action 11:49:36 INFO - Running main action method: populate_webroot 11:49:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:36 INFO - '--tppagecycles', 11:49:36 INFO - '7'], 11:49:36 INFO - 'tests': ['tsvgm']}}, 11:49:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['damp', 'tps']}, 11:49:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'tests': ['damp', 'tps']}, 11:49:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['dromaeo_dom']}, 11:49:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore', 11:49:36 INFO - 'tabpaint']}, 11:49:36 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore', 11:49:36 INFO - 'tabpaint']}, 11:49:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore', 11:49:36 INFO - 'tabpaint']}, 11:49:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore', 11:49:36 INFO - 'tabpaint']}, 11:49:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore', 11:49:36 INFO - 'tabpaint']}, 11:49:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore', 11:49:36 INFO - 'tabpaint']}, 11:49:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['tsvgx', 11:49:36 INFO - 'tsvgr_opacity', 11:49:36 INFO - 'tart', 11:49:36 INFO - 'tscrollx', 11:49:36 INFO - 'cart']}, 11:49:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:36 INFO - 'tsvgr_opacity', 11:49:36 INFO - 'tart', 11:49:36 INFO - 'tscrollx', 11:49:36 INFO - 'cart']}, 11:49:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--disable-e10s'], 11:49:36 INFO - 'tests': ['tp5o']}, 11:49:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'tests': ['tp5o']}, 11:49:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--disable-e10s', 11:49:36 INFO - '--xperf_path', 11:49:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:36 INFO - 'tests': ['tp5n']}, 11:49:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--xperf_path', 11:49:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:36 INFO - 'tests': ['tp5n']}}, 11:49:36 INFO - 'talos.zip': {'path': '', 11:49:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:36 INFO - Running post-action listener: _resource_record_post_action 11:49:36 INFO - ##### 11:49:36 INFO - ##### Running create-virtualenv step. 11:49:36 INFO - ##### 11:49:36 INFO - Running pre-action listener: _resource_record_pre_action 11:49:36 INFO - Running main action method: create_virtualenv 11:49:36 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:36 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 11:49:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:37 INFO - Using real prefix '/tools/python27' 11:49:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:37 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:40 INFO - Installing pip.................done. 11:49:40 INFO - Return code: 0 11:49:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 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 0x1095f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109602420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf085d0fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, '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.mqnikKyyF2/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.ECVPOApt4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:49:40 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 11:49:40 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 11:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:40 INFO - 'HOME': '/Users/cltbld', 11:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:40 INFO - 'LOGNAME': 'cltbld', 11:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:40 INFO - 'MOZ_NO_REMOTE': '1', 11:49:40 INFO - 'NO_EM_RESTART': '1', 11:49:40 INFO - 'PAGER': '/bin/cat', 11:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:40 INFO - 'PWD': '/builds/slave/test', 11:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:40 INFO - 'SHELL': '/bin/bash', 11:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:49:40 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:40 INFO - 'USER': 'cltbld', 11:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:40 INFO - 'XPC_FLAGS': '0x0', 11:49:40 INFO - 'XPC_SERVICE_NAME': '0', 11:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:40 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 11:49:40 INFO - Cleaning up... 11:49:40 INFO - Return code: 0 11:49:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109602420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf085d0fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, '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.mqnikKyyF2/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.ECVPOApt4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:49:40 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>=0.7.1'] in /builds/slave/test/build 11:49:40 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>=0.7.1 11:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:40 INFO - 'HOME': '/Users/cltbld', 11:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:40 INFO - 'LOGNAME': 'cltbld', 11:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:40 INFO - 'MOZ_NO_REMOTE': '1', 11:49:40 INFO - 'NO_EM_RESTART': '1', 11:49:40 INFO - 'PAGER': '/bin/cat', 11:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:40 INFO - 'PWD': '/builds/slave/test', 11:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:40 INFO - 'SHELL': '/bin/bash', 11:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:49:40 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:40 INFO - 'USER': 'cltbld', 11:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:40 INFO - 'XPC_FLAGS': '0x0', 11:49:40 INFO - 'XPC_SERVICE_NAME': '0', 11:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:41 INFO - Downloading/unpacking psutil>=0.7.1 11:49:41 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 11:49:41 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 11:49:41 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 11:49:41 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 11:49:41 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 11:49:41 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 11:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:43 INFO - Installing collected packages: psutil 11:49:43 INFO - Running setup.py install for psutil 11:49:43 INFO - building 'psutil._psutil_osx' extension 11:49:43 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 11:49:44 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 11:49:44 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 11:49:44 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 11:49:44 INFO - building 'psutil._psutil_posix' extension 11:49:44 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 11:49:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:49:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:49:44 INFO - ^ 11:49:44 INFO - 1 warning generated. 11:49:44 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 11:49:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:44 INFO - Successfully installed psutil 11:49:44 INFO - Cleaning up... 11:49:44 INFO - Return code: 0 11:49:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:44 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109602420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf085d0fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, '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.mqnikKyyF2/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.ECVPOApt4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:49:44 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.0.0'] in /builds/slave/test/build 11:49:44 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.0.0 11:49:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:49:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:44 INFO - 'HOME': '/Users/cltbld', 11:49:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:44 INFO - 'LOGNAME': 'cltbld', 11:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:44 INFO - 'MOZ_NO_REMOTE': '1', 11:49:44 INFO - 'NO_EM_RESTART': '1', 11:49:44 INFO - 'PAGER': '/bin/cat', 11:49:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:44 INFO - 'PWD': '/builds/slave/test', 11:49:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:44 INFO - 'SHELL': '/bin/bash', 11:49:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:49:44 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:49:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:44 INFO - 'USER': 'cltbld', 11:49:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:44 INFO - 'XPC_FLAGS': '0x0', 11:49:44 INFO - 'XPC_SERVICE_NAME': '0', 11:49:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:49:44 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 11:49:44 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 11:49:44 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 11:49:44 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 11:49:44 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 11:49:44 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 11:49:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:49:47 INFO - Installing collected packages: mozsystemmonitor 11:49:47 INFO - Running setup.py install for mozsystemmonitor 11:49:47 INFO - Successfully installed mozsystemmonitor 11:49:47 INFO - Cleaning up... 11:49:47 INFO - Return code: 0 11:49:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:47 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')]} 11:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:47 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')]} 11:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:47 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 0x1095f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109602420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf085d0fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, '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.mqnikKyyF2/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.ECVPOApt4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:49:47 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 11:49:47 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 11:49:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:49:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:47 INFO - 'HOME': '/Users/cltbld', 11:49:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:47 INFO - 'LOGNAME': 'cltbld', 11:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:47 INFO - 'MOZ_NO_REMOTE': '1', 11:49:47 INFO - 'NO_EM_RESTART': '1', 11:49:47 INFO - 'PAGER': '/bin/cat', 11:49:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:47 INFO - 'PWD': '/builds/slave/test', 11:49:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:47 INFO - 'SHELL': '/bin/bash', 11:49:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:49:47 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:49:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:47 INFO - 'USER': 'cltbld', 11:49:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:47 INFO - 'XPC_FLAGS': '0x0', 11:49:47 INFO - 'XPC_SERVICE_NAME': '0', 11:49:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:47 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:47 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 11:49:47 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 11:49:47 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 11:49:47 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 11:49:47 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 11:49:47 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 11:49:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 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 11:49:51 INFO - Downloading docopt-0.6.1.tar.gz 11:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:51 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:51 INFO - Running setup.py install for blobuploader 11:49:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:51 INFO - Running setup.py install for requests 11:49:52 INFO - Running setup.py install for docopt 11:49:52 INFO - Successfully installed blobuploader requests docopt 11:49:52 INFO - Cleaning up... 11:49:52 INFO - Return code: 0 11:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:52 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')]} 11:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:52 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')]} 11:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:52 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 0x1095f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109602420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf085d0fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, '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.mqnikKyyF2/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.ECVPOApt4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:49:52 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 11:49:52 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 11:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:52 INFO - 'HOME': '/Users/cltbld', 11:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:52 INFO - 'LOGNAME': 'cltbld', 11:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:52 INFO - 'MOZ_NO_REMOTE': '1', 11:49:52 INFO - 'NO_EM_RESTART': '1', 11:49:52 INFO - 'PAGER': '/bin/cat', 11:49:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:52 INFO - 'PWD': '/builds/slave/test', 11:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:52 INFO - 'SHELL': '/bin/bash', 11:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:49:52 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:52 INFO - 'USER': 'cltbld', 11:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:52 INFO - 'XPC_FLAGS': '0x0', 11:49:52 INFO - 'XPC_SERVICE_NAME': '0', 11:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:52 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Ng0zb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:52 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-C2bEUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:52 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-i2zIDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:52 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-mFu8Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-75t9wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-r4HvNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-uH8KFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-ZKWZyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-9rbB7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-OnrJBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-0dLDmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-nTyZxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Pzu0GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:53 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-U287R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:54 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-GIps11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:54 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-IlqVdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:54 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-GmUtkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:54 INFO - Running setup.py install for manifestparser 11:49:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Running setup.py install for mozcrash 11:49:54 INFO - Running setup.py install for mozdebug 11:49:54 INFO - Running setup.py install for mozdevice 11:49:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozfile 11:49:55 INFO - Running setup.py install for mozhttpd 11:49:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozinfo 11:49:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozInstall 11:49:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozleak 11:49:55 INFO - Running setup.py install for mozlog 11:49:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for moznetwork 11:49:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Running setup.py install for mozprocess 11:49:56 INFO - Running setup.py install for mozprofile 11:49:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Running setup.py install for mozrunner 11:49:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Running setup.py install for mozscreenshot 11:49:56 INFO - Running setup.py install for moztest 11:49:56 INFO - Running setup.py install for mozversion 11:49:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:56 INFO - Cleaning up... 11:49:56 INFO - Return code: 0 11:49:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 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 0x1095f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109602420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf085d0fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, '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.mqnikKyyF2/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.ECVPOApt4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:49:56 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 11:49:56 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 11:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:56 INFO - 'HOME': '/Users/cltbld', 11:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:56 INFO - 'LOGNAME': 'cltbld', 11:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:56 INFO - 'MOZ_NO_REMOTE': '1', 11:49:56 INFO - 'NO_EM_RESTART': '1', 11:49:56 INFO - 'PAGER': '/bin/cat', 11:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:56 INFO - 'PWD': '/builds/slave/test', 11:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:56 INFO - 'SHELL': '/bin/bash', 11:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:49:56 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:56 INFO - 'USER': 'cltbld', 11:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:56 INFO - 'XPC_FLAGS': '0x0', 11:49:56 INFO - 'XPC_SERVICE_NAME': '0', 11:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:57 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Khi5wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:57 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-4XWVoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:57 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-ATOxLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:57 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-P0Qvpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:57 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-WPRzq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:57 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-PpsyFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:57 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-jVcrhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:57 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Ri9zi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:58 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-3q6k0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:58 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-r0ArbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:58 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-nbmrBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:58 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-KolCh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:58 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-BH3zyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:58 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-be7Zxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:58 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-lK8R6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:58 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-mU_JPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:58 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-i6c2TH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:59 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)) 11:49:59 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)) 11:49:59 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)) 11:49:59 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)) 11:49:59 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)) 11:49:59 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)) 11:49:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:01 INFO - Downloading blessings-1.6.tar.gz 11:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:50:01 INFO - Installing collected packages: blessings 11:50:01 INFO - Running setup.py install for blessings 11:50:01 INFO - Successfully installed blessings 11:50:01 INFO - Cleaning up... 11:50:01 INFO - Return code: 0 11:50:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:50:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:02 INFO - Reading from file tmpfile_stdout 11:50:02 INFO - Current package versions: 11:50:02 INFO - blessings == 1.6 11:50:02 INFO - blobuploader == 1.2.4 11:50:02 INFO - docopt == 0.6.1 11:50:02 INFO - manifestparser == 1.1 11:50:02 INFO - mozInstall == 1.12 11:50:02 INFO - mozcrash == 0.17 11:50:02 INFO - mozdebug == 0.1 11:50:02 INFO - mozdevice == 0.48 11:50:02 INFO - mozfile == 1.2 11:50:02 INFO - mozhttpd == 0.7 11:50:02 INFO - mozinfo == 0.9 11:50:02 INFO - mozleak == 0.1 11:50:02 INFO - mozlog == 3.1 11:50:02 INFO - moznetwork == 0.27 11:50:02 INFO - mozprocess == 0.22 11:50:02 INFO - mozprofile == 0.28 11:50:02 INFO - mozrunner == 6.11 11:50:02 INFO - mozscreenshot == 0.1 11:50:02 INFO - mozsystemmonitor == 0.0 11:50:02 INFO - moztest == 0.7 11:50:02 INFO - mozversion == 1.4 11:50:02 INFO - psutil == 3.1.1 11:50:02 INFO - requests == 1.2.3 11:50:02 INFO - wsgiref == 0.1.2 11:50:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:02 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 0x1095f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109602420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf085d0fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, '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.mqnikKyyF2/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.ECVPOApt4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:50:02 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 11:50:02 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 11:50:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:50:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:02 INFO - 'HOME': '/Users/cltbld', 11:50:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:02 INFO - 'LOGNAME': 'cltbld', 11:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:02 INFO - 'MOZ_NO_REMOTE': '1', 11:50:02 INFO - 'NO_EM_RESTART': '1', 11:50:02 INFO - 'PAGER': '/bin/cat', 11:50:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:02 INFO - 'PWD': '/builds/slave/test', 11:50:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:02 INFO - 'SHELL': '/bin/bash', 11:50:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:50:02 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:50:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:02 INFO - 'USER': 'cltbld', 11:50:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:02 INFO - 'XPC_FLAGS': '0x0', 11:50:02 INFO - 'XPC_SERVICE_NAME': '0', 11:50:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:02 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)) 11:50:02 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)) 11:50:02 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)) 11:50:02 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)) 11:50:02 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)) 11:50:02 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)) 11:50:02 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)) 11:50:02 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)) 11:50:02 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)) 11:50:02 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)) 11:50:02 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)) 11:50:02 INFO - Cleaning up... 11:50:02 INFO - Return code: 0 11:50:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109602420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf085d0fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, '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.mqnikKyyF2/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.ECVPOApt4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:50:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:50:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:50:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:02 INFO - 'HOME': '/Users/cltbld', 11:50:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:02 INFO - 'LOGNAME': 'cltbld', 11:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:02 INFO - 'MOZ_NO_REMOTE': '1', 11:50:02 INFO - 'NO_EM_RESTART': '1', 11:50:02 INFO - 'PAGER': '/bin/cat', 11:50:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:02 INFO - 'PWD': '/builds/slave/test', 11:50:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:02 INFO - 'SHELL': '/bin/bash', 11:50:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:50:02 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:50:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:02 INFO - 'USER': 'cltbld', 11:50:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:02 INFO - 'XPC_FLAGS': '0x0', 11:50:02 INFO - 'XPC_SERVICE_NAME': '0', 11:50:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:02 INFO - Downloading/unpacking jsonschema 11:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:50:05 INFO - Downloading/unpacking functools32 (from jsonschema) 11:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:50:05 INFO - warning: no files found matching '*.txt' 11:50:05 INFO - no previously-included directories found matching 'build' 11:50:05 INFO - no previously-included directories found matching 'dist' 11:50:05 INFO - no previously-included directories found matching '.git*' 11:50:05 INFO - Installing collected packages: jsonschema, functools32 11:50:05 INFO - Running setup.py install for functools32 11:50:05 INFO - warning: no files found matching '*.txt' 11:50:05 INFO - no previously-included directories found matching 'build' 11:50:05 INFO - no previously-included directories found matching 'dist' 11:50:05 INFO - no previously-included directories found matching '.git*' 11:50:05 INFO - Successfully installed jsonschema functools32 11:50:05 INFO - Cleaning up... 11:50:06 INFO - Return code: 0 11:50:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:50: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')]} 11:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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')]} 11:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109602420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf085d0fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, '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.mqnikKyyF2/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.ECVPOApt4p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 11:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:06 INFO - 'HOME': '/Users/cltbld', 11:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:06 INFO - 'LOGNAME': 'cltbld', 11:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:06 INFO - 'MOZ_NO_REMOTE': '1', 11:50:06 INFO - 'NO_EM_RESTART': '1', 11:50:06 INFO - 'PAGER': '/bin/cat', 11:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:06 INFO - 'PWD': '/builds/slave/test', 11:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:06 INFO - 'SHELL': '/bin/bash', 11:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:50:06 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:06 INFO - 'USER': 'cltbld', 11:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:06 INFO - 'XPC_FLAGS': '0x0', 11:50:06 INFO - 'XPC_SERVICE_NAME': '0', 11:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:06 INFO - Downloading/unpacking flake8 11:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:50:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:50:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:50:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:50:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:50:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:50:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:50:09 INFO - no previously-included directories found matching 'docs/_build' 11:50:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:50:10 INFO - Running setup.py install for pep8 11:50:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:50:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:50:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:50:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:50:10 INFO - no previously-included directories found matching 'docs/_build' 11:50:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:50:10 INFO - Cleaning up... 11:50:10 INFO - Return code: 0 11:50:10 INFO - Running post-action listener: _resource_record_post_action 11:50:10 INFO - Running post-action listener: _start_resource_monitoring 11:50:10 INFO - Starting resource monitoring. 11:50:10 INFO - ##### 11:50:10 INFO - ##### Running install step. 11:50:10 INFO - ##### 11:50:10 INFO - Running pre-action listener: _resource_record_pre_action 11:50:10 INFO - Running main action method: install 11:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:10 INFO - Reading from file tmpfile_stdout 11:50:10 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:10 INFO - Reading from file tmpfile_stdout 11:50:10 INFO - Output received: 11:50:10 INFO - Usage: mozinstall [options] installer 11:50:10 INFO - Options: 11:50:10 INFO - -h, --help show this help message and exit 11:50:10 INFO - -d DEST, --destination=DEST 11:50:10 INFO - Directory to install application into. [default: 11:50:10 INFO - "/builds/slave/test"] 11:50:10 INFO - --app=APP Application being installed. [default: firefox] 11:50:10 INFO - mkdir: /builds/slave/test/build/application 11:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:50:44 INFO - Reading from file tmpfile_stdout 11:50:44 INFO - Output received: 11:50:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:50:44 INFO - Running post-action listener: _resource_record_post_action 11:50:44 INFO - ##### 11:50:44 INFO - ##### Running run-tests step. 11:50:44 INFO - ##### 11:50:44 INFO - Running pre-action listener: _resource_record_pre_action 11:50:44 INFO - Running main action method: run_tests 11:50:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:50:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:50:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:50:44 INFO - 2016-04-25 11:50:44.440 screenresolution[1932:12309] starting screenresolution argv=screenresolution get 11:50:44 INFO - 2016-04-25 11:50:44.443 screenresolution[1932:12309] Display 0: 1600x1200x32@60 11:50:44 INFO - 2016-04-25 11:50:44.448 screenresolution[1933:12311] starting screenresolution argv=screenresolution list 11:50:44 INFO - Available Modes on Display 0 11:50:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:50:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:50:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:50:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:50:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:50:44 INFO - Intel Iris: 11:50:44 INFO - Chipset Model: Intel Iris 11:50:44 INFO - Type: GPU 11:50:44 INFO - Bus: Built-In 11:50:44 INFO - VRAM (Dynamic, Max): 1536 MB 11:50:44 INFO - Vendor: Intel (0x8086) 11:50:44 INFO - Device ID: 0x0a2e 11:50:44 INFO - Revision ID: 0x0009 11:50:44 INFO - Displays: 11:50:44 INFO - Display: 11:50:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:50:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:50:44 INFO - Display Serial Number: 1600x1200 60 11:50:44 INFO - Main Display: Yes 11:50:44 INFO - Mirror: Off 11:50:44 INFO - Online: Yes 11:50:44 INFO - Rotation: Supported 11:50:44 INFO - Return code: 0 11:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:44 INFO - Python 2.7.3 11:50:44 INFO - Return code: 0 11:50:44 INFO - grabbing minidump binary from tooltool 11:50: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')]} 11:50:44 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109491e00>, '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 0x1092fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10948cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:44 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 11:50:44 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 11:50:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:44 INFO - Return code: 0 11:50:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:50:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:50:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:50:45 INFO - Return code: 0 11:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--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 11:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0149 --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 11:50:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mqnikKyyF2/Render', 11:50:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:45 INFO - 'HOME': '/Users/cltbld', 11:50:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:45 INFO - 'LOGNAME': 'cltbld', 11:50:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:45 INFO - 'MOZ_NO_REMOTE': '1', 11:50:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:45 INFO - 'NO_EM_RESTART': '1', 11:50:45 INFO - 'PAGER': '/bin/cat', 11:50:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:45 INFO - 'PWD': '/builds/slave/test', 11:50:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:45 INFO - 'SHELL': '/bin/bash', 11:50:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECVPOApt4p/Listeners', 11:50:45 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 11:50:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:45 INFO - 'USER': 'cltbld', 11:50:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:45 INFO - 'XPC_FLAGS': '0x0', 11:50:45 INFO - 'XPC_SERVICE_NAME': '0', 11:50:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--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 11:50:46 INFO - mozversion application_buildid: 20160425083752 11:50:46 INFO - mozversion application_changeset: 352d365eb4eda3aab7c3680b0e80ce17e178b5ee 11:50:46 INFO - mozversion application_display_name: Nightly 11:50:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:46 INFO - mozversion application_name: Firefox 11:50:46 INFO - mozversion application_remotingname: firefox 11:50:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:50:46 INFO - mozversion application_vendor: Mozilla 11:50:46 INFO - mozversion application_version: 48.0a1 11:50:46 INFO - mozversion platform_buildid: 20160425083752 11:50:46 INFO - mozversion platform_changeset: 352d365eb4eda3aab7c3680b0e80ce17e178b5ee 11:50:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:50:46 INFO - mozversion platform_version: 48.0a1 11:50:46 INFO - using testdate: 1461610246 11:50:46 INFO - actual date: 1461610246 11:50:46 INFO - starting webserver on 'localhost:51880' 11:50:46 INFO - SUITE-START | Running 2 tests 11:50:46 INFO - TEST-START | dromaeo_css 11:50:46 INFO - operating with platform_type : mac_ 11:50:46 INFO - Initialising browser for dromaeo_css test... 11:50:46 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmphgHXgB/profile http://localhost:51880/getInfo.html) 11:50:48 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 11:50:48 INFO - PROCESS | 1951 | colorDepth:24 11:50:48 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 11:50:48 INFO - PROCESS | 1951 | __metrics 11:50:49 ERROR - PROCESS | 1951 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:50:49 INFO - TEST-INFO | 1951: exit 0 11:50:49 INFO - Browser initialized. 11:50:49 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:49 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmphgHXgB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:01 INFO - PROCESS | 1954 | RSS: Main: 249995264 11:51:01 INFO - PROCESS | 1954 | 11:51:51 INFO - PROCESS | 1954 | 1461610311420 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] 11:54:02 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51880/tests/dromaeo/cssquery-ext.html) 11:54:03 INFO - PROCESS | 1954 | RSS: Main: 261984256 11:54:03 INFO - PROCESS | 1954 | 11:57:05 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-ext.html (next: http://localhost:51880/tests/dromaeo/cssquery-jquery.html) 11:57:06 INFO - PROCESS | 1954 | RSS: Main: 273743872 11:57:06 INFO - PROCESS | 1954 | 12:00:08 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51880/tests/dromaeo/cssquery-mootools.html) 12:00:08 INFO - PROCESS | 1954 | RSS: Main: 275968000 12:00:08 INFO - PROCESS | 1954 | 12:03:10 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51880/tests/dromaeo/cssquery-prototype.html) 12:03:11 INFO - PROCESS | 1954 | RSS: Main: 277581824 12:03:11 INFO - PROCESS | 1954 | 12:06:13 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51880/tests/dromaeo/cssquery-yui.html) 12:06:14 INFO - PROCESS | 1954 | RSS: Main: 280477696 12:06:14 INFO - PROCESS | 1954 | 12:09:17 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51880/tests/dromaeo/cssquery-yui.html (next: http://localhost:51880/tests/dromaeo/cssquery-dojo.html) 12:09:17 INFO - PROCESS | 1954 | RSS: Main: 281706496 12:09:17 INFO - PROCESS | 1954 | 12:09:17 INFO - PROCESS | 1954 | __start_tp_report 12:09:17 INFO - PROCESS | 1954 | _x_x_mozilla_page_load 12:09:17 INFO - PROCESS | 1954 | _x_x_mozilla_page_load_details 12:09:17 INFO - PROCESS | 1954 | |i|pagename|runs| 12:09:17 INFO - PROCESS | 1954 | |0;dojo.html;3414.3000684859603;3440.7935523868564;3456.187795867972;3458.2391873787774;3497.5453191085153;5664.263645726055;5710.229119068925;5721.628094173881;5728.4557966993125;5739.598228124033;4977.780443791276;5598.300212473441;5644.774209031634;5696.658200507962;5748.655080695161;4235.8093885775215;5154.69071855688;5160.612954028454;5220.112580861243;5294;273.9713548487008;5248.947510524903;5257.868553286179;5268.683878967255;5296.629235953485;5174.094533456649;5212.921806172911;5224.111900976843;5226.7125308108225;5234.0840352938085;5126.2054381570915;5258.8685282867855;5271.789128434858;5311.760970756287;5335.359756829166;5144.511271429208;5162.664426812283;5219.347581552306;5229.477052294778;5255.5795536357;5380.7309634518115;5524.972375138139;5554.555635549187;5567.582431317667;5595.440455954413;6081.3614570470345;6104.853288833277;6203.596766210182;6211.16149319845;6219.315875253718;6200.503959683215;6238.9376106238815;6268.1851359323;6282.811515654537;6308.842278943017;5852.297724273115;5869.50109240715;5876.024743253899;5906.82279531619;5962.1951036609935;6176.073588961692;6235.719392627252;6264.780732674334;6314.778982735582;6327.588706734047;6161.291451483047;6169.413905678954;6172.69136543171;6204.534659900525;6223.097650840693;6188.752449901954;6231.345708700612;6253.5622506424115;6277.403646653561;6288.371162883675;6044.123602077674;6131.927227014014;6211.81364559064;6232.532560058014;6250.1874756281395;6087.208662873887;6169.876602467925;6289.496840252768;6297.937020629735;6306.495480361652;4870.586000189953;4908.410990681141;4916.385451818523;4953;4962.379702537183;4386.824527018884;4404.823807047746;4425.291953287458;4451.666125040635;4513.255312873404;4898.461169271377;5827.562932780059;5841.853953651108;5869.266341707286;5895.145203945404;6238.532110091671;6267.247930248308;6285.308616052231;6287.245530536365;6295;5723.627964182315;5820.156077368758;5900.085486749561;5929.199558059693;5949.494292985145;5425.457454254543;5435.864103397446;5458.235846981426;5461.481159289861;5465.098258787335;6302.086197501245;6444.903326450107;6455.4512866406885;6472.061551075068;6502.934970650327;6180.690965451619;6227.470664993345;6255.843603909939;6271.090691849748;6286.339934306832;4850.490698476609;6397.424231818973;6403.967980160256;6440.452561532322;6442.162518872517;6079.969600152148;6137.591499645514;6224.533160013108;6261.467775238973;6276.560640755103;6194.38056194395;6231;6260.718267677874;6278;6298.149749783904;6166.938330616636;6189.071639254148;6193.504519638508;6206.658633775186;6224.782132625336;6053.061775424816;6075.301340345917;6123.648682309428;6181;6228.626282423069;4553.726776393427;4957.752112394438;5052.621053420935;5317.229001794641;5567.721613919369;6167.444929956326;6201.379862013943;6202.906956395567;6203.503719702323;6204.689765511796;5949.52403807703;6004.789832355847;6008.8798224036145;6085.361037091218;6091.086337049478 12:09:17 INFO - PROCESS | 1954 | |1;ext.html;501.7215445427787;523.6229914461588;561.334818240385;580.7038410410689;589.9557533185009;32266.838665806637;34831;35488.822555887185;39704.20591588166;39966.20067598646;40325.798371008175;41078.178436431255;41088.79455602725;41127;41161;8513.19124683154;9462.668806591753;9517.904820951771;9708.41749495029;9710.951445242765;9653.71038868835;9791.167750741195;9891.159251463634;9921.503924803766;9944.15474684649;9801.656942007032;9845.852312215322;9863;9954.452505112216;9966.352187107852;9814.803703925953;9829.950850245774;9907.25695572835;9907.70276891698;9936.801263974752;8330.291925186366;9634.084761947604;9740.805183896353;9756.658516951873;9759.707208783748;39423.60576394228;39627.40558891619;39783;40252.79241622756;40289.79855100706;2828.61813655156;3052.282713562311;3097.845107744626;3430.073880052397;3614.2410093880317;26176.214713558624;26184;27054.5941810873;27144.91420343184;28339.57490637642;2618.1883616079076;2655.3361659585103;2662.6671666041743;2763.088180900298;2807.873645685949;345382;347998;352272;352673;354487.99999999744;58572;58763.530911726695;58933.41066589365;58940.82118357609;59016;61091;61868;61951.52193912193;62437.68781156065;62470;16366.590835228977;16592.336306547604;16859.662806743796;16879;16917.154142293082;12547.247165169936;12819.16675416095;12970.351482425842;13028.08803383773;13059.542915997894;19228.404165437765;19336.32697309212;19614.411567652995;19743.40769776909;19769.703454448194;8222.38332125093;8275.54484503358;8308.792280193044;8370.916290837136;8372.623231954454;900.2707806676613;916.702071826659;922.7508572685338;982.3369225772575;1011.327467234281;29688.406231875673;29756.256093597833;29816.850915745283;30253.546196807067;30340.54489182664;1046.864152394645;1083.664064140119;1103.9227254092298;1112.4882554025078;1264.6206138158516;15252.618684532976;15293.311800968982;15381.846181538265;15629.843701562839;15647.765283520755;558318;563619;572441;572770;575332;59960.10059849106;60293.794124117274;60893.69553152206;60993.695031524556;61008.77982440326;1452.9491467798787;1463.1294379843976;1470.1399681186626;1482.6367539952564;1487.2192099147817;29100.563491547222;29393.85303073471;29432.705672942997;30065.849670751508;30090.3981920356;39778.403323949584;50783;51560.484395157066;51613.96772064463;51758.482415175364;376342;384244;384797;385271;387279;25890.611640825027;26116.91064714856;26326.341841454116;26561.60157597676;26652.733472665026;44518.777406112764;45306.54693453023;45513;46230.76884615555;46594.76702616465;37337.81331093436;37436.43845342377;37814;38286.23427531378;38386.65646702352;37407.81296093502;37721.81139094397;37856.810715946245;38103;38596.22807543777;30643.846780765954;34917.650823492455;36056.4591531122;37414;38296.85109446721;30698.69301307048;31144.00369049464;32163.67836321607;32264.677353227107;32672.673273266962;24632.507349853262;24633.507329853663;24655.260342189762;24725.258242252763;24799.876000619883 12:09:17 INFO - PROCESS | 1954 | |2;jquery.html;335.6760725899507;355.8665500437334;391.6318660459169;405.44049212087316;405.44251653975783;19563.902180489094;20494.077766500504;20595.38213853585;20852.687209691867;20981.580368392624;18496.705230633863;19621;20406;20855.895720521414;21395.037223324947;4558.997917310232;5951.256092988377;6158.137860699506;6171.629702217859;6174.969125154368;6104;6154.538409619274;6163.352847950945;6164.383561643845;6179.907301390483;4679.625629949596;5316.6544174628525;5377.8117765878205;5774.8267551973295;6085.908711369333;5759.16492108644;5962.373950735176;6022.939770602304;6153.230846144232;6156.076588511714;5739.110437882135;5909.645421274738;5921.822345329647;5928.081147422156;5936.584439089265;14589.70820583593;21362.465938351666;25159.748402515925;25389.873050634815;26180.73819261802;1997.9200831966705;1999.57009243012;2170.4790850195996;2224.677421773834;2241.0699559682876;9841.950790246003;9939.254555908263;10090.545925433373;10108.696739097839;10122.342047766871;1721.9139043047924;1750.5711100780263;1812.2932056497975;1843.2903332217193;1974.6544354738007;98788;126998;130788;141946.29026854903;143005.2849735755;11485.425728713531;11551.653450396501;11616.477258523386;11805.645830625095;11927.642170734893;14534.982551221314;14850;14881.702365952837;14935.253237338307;14968.625784355478;8755.912440875638;8791.939976860642;8916.331275154389;8943.195112439911;9067.501287429255;8992.055834137453;9002.50486223264;9025.458472491671;9037.77405564853;9085.091490850995;3787.7348585598743;4582.106489234568;4641.419822522184;4645.187092258841;4699.130660827758;1943.4752616793387;1991.7709463411893;1993.900304984745;2011.4971257185703;2021.676531754912;338.9423797954354;394.83326769396365;398.1420039814205;850.8128211793396;866.536403024379;11570.247933884271;11611.129165312635;11790.056795456343;11869;11955.64133076009;436.2322312729619;875.8993164198793;903.7514683461969;908.1644886704248;964.5996911281879;8788.560571971377;10191.133753631024;10557.260991730505;10658.840117398246;10804.297720648132;573315;580217;581182;584524;590797;104600.81257276998;127591;131109;140388;142786;986.1814693804125;1051.8422236664408;1067.071647666535;1068.8129577323937;1071.6677829872608;17241.827581724523;17779.822201778334;18158.364457243933;18171.273149073888;18548.44354669362;54559.90880182454;54799.63000925009;54953.60909731424;55374;55926.16110758423;73118.26881731328;76174;77253;80606;85705;6457.579332546832;7813.765587032398;7838.608069596383;7898.210178982055;8129.959350203448;8617.310615150647;11051.502682379472;12373.443195056065;12517.123801334183;12555.246685198917;7483.289087536676;9339.57971891253;9727.416355018722;10434.530446129791;10866.185036122164;10709.250352475252;10781.02970732638;10782.353058816496;11141.997220250216;11199.216054876406;9072.183503484717;9984.801823781192;11042.006219440289;11164.832527511931;11548.01841843419;8016.679332826621;8071.313938315309;8180.345572354078;8184.345252379914;8387.035490918623;8043.798905027421;8157.469764465291;11028.22802403856;11074.003339699466;11160 12:09:17 INFO - PROCESS | 1954 | |3;mootools.html;1457.8833693304534;1561.898476599021;1609.0024185005295;1934.9226030958762;1948.3083505355607;6589.308122647125;8470.91529084709;8475.279601233888;8833.867491987625;8849.29205663547;7242.167150777649;8630.827383452342;8642.91357086429;8731.17053879882;8769.736907892773;2460.9138680146198;2478.4423504711476;2492.750724927511;2499.6250562415603;2503.2240005598323;2451.350392146083;2470.950580988379;2504.373906523369;2506.586413241813;2521.6091505816626;2113.471632091977;2466.2108125399877;2474.8762561871927;2496.213692686807;2511.221521328385;1888.707250376187;2378.131981826638;2413.4931664350333;2442.511497700467;2456.938576535592;2396.496735685508;2414.372263211578;2437.5612389770013;2437.6831011968507;2440.414300567851;8697.478151310941;8807.031226565072;8827.029026807046;8828.028916819145;8862.20240178387;4299.247631664478;5447.863803404907;5449.7275136243425;5450.972745136289;5455.809046683386;3412.897613071612;3549.2546565221332;3572.1962558424148;3641.981790091059;3644.9817750911343;988.3822610868208;1029.8506716526138;1036.8392899100652;1040.9375437473775;1041.4274445587141;9374.625014999392;11154.386508742016;11250.437478126061;11416.942915285454;11425.714357141054;4566.383538222364;4636.165490211794;4686.3204835299375;4710.788014539354;4728.976355118202;9081.59132839024;9133.223675987483;9135.360524763335;9157;9168.31237657165;5246.737663116829;5276.868078298074;5291.417944026154;5330.466953304638;5338.492843179892;4463.642908567307;4791.281307803857;4934.580560652313;5007.599392048627;5008.323876276656;3783.3379158647126;3864.265789500042;4063.065494936122;4084.231769621487;4154.937675934863;1348.7707089794562;1367.4871923028863;1379.1793882639813;1382.4539306973688;1393.8815200708054;822.1942496353488;866.7963028688254;894.7226359828474;901.0133903375793;964.1274646444979;5642.153676948491;5794.739236734357;5974.074018527135;6055.878882422327;6089;452.77587594141113;456.97943592538417;467.8666580024745;469.57034313602674;473.6187369167784;3925.1953349563273;4013.819378127991;4037.1320166164414;4067.2272268268935;4087.734297270668;10199.337043092175;10611.84082238767;10673.412962286993;10750.623728169476;10779.083777878968;10065.446400448045;10483.895161048444;10564.630237941636;10596.258261921592;10727.87357327485;7966.322862556747;8012.2388373103295;8133.674653013813;8166.795830104176;8244.29923456501;5146.665466744649;5885.117232415172;6031.969840150771;6066.181065556093;6101.206843110367;9589.041095890634;9812.705618831447;9893.25800564946;9901.15840153595;9930.900690992998;9865.852012219679;10003.549840257061;10035.548400321857;10192.643257485952;10232.334898231591;6883.862322753617;7289.708411663474;7461.626918654154;7465.029546158965;7597.696092156473;5993.790217342372;7937.444378893422;7954.721584744506;7957.244061814118;8050.637721302438;6064.666443345482;6957.686904089429;7129.786106416608;7142.071530700976;7309.8903516446235;7242.782716518513;7276.163241227115;7324.377427918686;7325.6337183141695;7424.220456852169;6828.863422731617;7072.292770723092;7078.292170782881;7081.610511421715;7086.751963681247;3982.581828907923;4830.396200474941;4930.285108659296;4953.900921981468;5063.468335824686;4940.407151141886;4976.2038073908;5008.148614735576;5017.096922553976;5189.506996835295 12:09:17 INFO - PROCESS | 1954 | |4;prototype.html;309.86365998960457;317.24495700233444;324.4678726887903;325.38664617196577;325.95599594054795;4481.9327710084335;4923.5076492350745;5208.062548741225;5368.087425137726;5392.460753924605;4511.210538155818;4948.832747041896;5463.508284254416;5500.339959204891;5507.9449205507935;4140.337545992642;4186.995121170912;4203.327467605184;4203.495580530341;4222.366645003259;3699.8150092495403;3881.4760007399063;4209.557996410364;4210.326347784355;4213.43118678979;4073.531543872463;4091.8363265469347;4098.6516146127615;4102.5076990761;4104.610062044116;3184.394964956674;4117.826419470466;4122.268647168196;4134.855280065183;4172.582741725833;3558;3569.446735755962;3572.8392222350058;3576.624454432273;3621.2033352662634;4906.435759887623;5171.043356978971;5192.3249977503065;5203.739813009334;5254.4220135785035;3532.7703699259464;3919.098607320332;3954.387070004154;4703.811847526094;4718.9292160617615;5628.774849006035;5699;5757.222774925373;5777.555611097226;5805.448482394166;3687.446882967576;3913.4912461380122;3939.4242303078713;3940.4483372327895;3958.34687276599;5159.458256883011;6040.667763273018;6066.726997285089;6089.878202435971;6117.969410152965;3737.2151848112203;3982.3230050891416;3987.7009224307712;3992.301347264217;4055.270051390778;3043.832589207615;3610.4764809102535;3930.76415415076;3985.70107241958;4043.3732771420478;3962.5443074046852;4712.3742308903375;4717.160307480085;4718.150732868048;4752.239641657318;5526.58550608706;5805.158252053428;5809;5823.941760582425;5831.154482599999;1489.2256026866185;1496.872765814918;1541.0676540692718;1543.2669481995963;1553.4252326639216;1012.6253286284121;1014.5941623350571;1039.7088815131776;1041.739565108723;1043.7703705184847;5748.48263656273;5811.4479124483105;5822.243108395882;5828.329742079631;5834.27071616048;5648.548116150698;5943.227380440515;6391.488680905516;6394.538102830351;6470;4559.430071241095;4642.558956899089;4708.4820669726305;5354.732263386815;5565.276514053228;2825.7033011533904;3079.692030796947;3087.6603573606885;3170.223295292668;3407.3866703993517;5557.749901254453;6131.754729810757;6179.907301390483;6585.407313341822;6659.633720145342;6203.8138855834395;6220.471259942865;6246.875062498815;6250.218722659668;6299.937000630027;5578.191162281365;5818.912716309174;6286.874262514724;6296.653684047421;6346.365363463709;5046.520580544842;5166.844994650167;5846.210761547137;5976.282846058501;6087.965045942112;5877.617954832922;5913.70431478433;5928.547505861092;5935.792247271324;5965.34381218057;5712.0860662293835;5878.265216847894;6246.656433895998;6249.531285153541;6259.280182779039;3343.7460952142947;3381.9492707609897;3943.38877473992;3962.445257663872;4003.5796241394232;5078.238264260391;5105.84682459512;5705.400932902152;5975.940240597713;6030.819075427744;5021.924671130009;5074.198659475833;5487.807926722546;5774.797882074107;5847.415258474119;4892.657513973988;5717.228174196596;5774.769009239583;5776.971115144397;5799.159121927381;5336.893262134813;5649;5679.233303503974;5684.573656975661;5702.600817942704;5779.711014449176;5811.86668599636;5813.186153938367;5828.533717302521;5832.970835145967;5023.668727787066;5407.648502847303;5665.631733937281;5680.801171958961;5689.6586204827845 12:09:17 INFO - PROCESS | 1954 | |5;yui.html;619.8295468746095;755.3768141283439;757.56440046973;762.1806557950201;762.6034462079718;12056.879431205685;14609.269536523172;15163.848361516382;15180.848191518082;15371.461998830044;10619.522121504531;11092.889071109286;14281.50014749484;14299.142051476918;14305.856941430582;721.2030706069796;890.7728529225038;916.4684482999844;920.7744102694849;928.2944961828991;786.9252421020022;931.8136372725448;942.1379437814392;942.5664194470552;943.5188054092428;965.8020105878278;976.8046390721884;991.4844280973889;991.8859331176935;994.1102713071797;946.857971304303;948.2840455456155;985.9309848310621;987.3680844259679;987.7579992901749;712.1276436365463;712.5617745086735;726.8001299642588;729.0595132279353;733.3619750816823;14787.260636968109;15013.624659383493;15098;15144;15164.696706065817;12864.678383040406;12936.547220847226;13055.477780888754;13113.541026064042;13199.736005279841;10127.64553240633;10306.381617102998;10333.689989300334;10401.895981040245;10410.68767936963;3444.8277586120594;3456.87900923469;3531.5938667053106;3582.5342705448124;3631.328204282216;77154.22845771526;77447;82076;83284;84091.57954210251;9226.446413215228;9254.67608633708;9278.443293402417;9516.95241523788;9518.428894266366;18646;22811.31566053021;22830.885845570665;22910.7708922912;22959.426014349774;7506.849863002819;7675.577843218565;7691.769246922601;7723.227677232344;7880.2513761192595;4073.490813648294;4128.731632443882;4131.793410329472;4132.607402296777;4136.9793151034655;3406.625271220164;3463.0995941055508;3472.9131771705406;3478.113081164287;3901.882943511699;718.2888939949516;719.5035425556454;723.5730918757853;726.2193142371972;730.4594599995964;388.89888628956675;410.452046517896;528.5137673340536;571.2431028886741;582.1936617784314;7387.187409384964;7826.452148349561;8235.794105147419;8296.294814940798;8421.073681894986;559.5831105826186;560.4227645525116;572.4790440699027;620.3796203796204;634.8317695810614;3415.0267173855827;3988.3419235826345;4021.1756589899;4048.817803198863;4083.571225021389;97576.51211744038;98221;100449.99550004407;101202;102445;71088.22279442952;71201;71873;76138.61930690311;80178.59910700409;66233;67217.65564688777;70823;71650.64174679198;73402;7025.297470252934;8195.016598008277;8558.358123140664;8572.52851093196;8618.698345557876;33665.66334336625;42780;43762.56237437712;43816;44282.55717442784;63032.36967630265;63061;63581;64630.67684661547;65198;10983.121350292116;11066.833997489883;11393.772124557629;11474.311541307548;11628.01161901214;11879.643610691694;11887;11903.404829758305;12316.13787034899;12393.566225182436;11461.484233209692;11572.24780389272;11614.767704646029;11705.824412633647;11758.311350909218;11594.420278986187;11713.824292635787;11859.932606065495;11997.280163190237;12125.272483650657;11362.772744545227;11544;11628.127890408423;11868;12231.816522751988;9624.518774061129;9735;9794.363366381162;9833.754156145867;9931.602735890483;8366.163383661586;9041.819163616823;9410.717678469657;9446.291528135554;9721.4653194075 12:09:17 INFO - PROCESS | 1954 | __end_tp_report 12:09:17 INFO - PROCESS | 1954 | __start_cc_report 12:09:17 INFO - PROCESS | 1954 | _x_x_mozilla_cycle_collect,417 12:09:17 INFO - PROCESS | 1954 | __end_cc_report 12:09:17 INFO - PROCESS | 1954 | __startTimestamp1461611357567__endTimestamp 12:09:17 INFO - PROCESS | 1954 | 12:09:17 INFO - PROCESS | 1954 | ------- Summary: start ------- 12:09:17 INFO - PROCESS | 1954 | Number of tests: 6 12:09:17 INFO - PROCESS | 1954 | 12:09:17 INFO - PROCESS | 1954 | [#0] dojo.html Cycles:165 Average:5699.82 Median:6004.79 stddev:790.93 (13.2%) stddev-sans-first:772.77 12:09:17 INFO - PROCESS | 1954 | Values: 3414.3 3440.8 3456.2 3458.2 3497.5 5664.3 5710.2 5721.6 5728.5 5739.6 4977.8 5598.3 5644.8 5696.7 5748.7 4235.8 5154.7 5160.6 5220.1 5294.0 274.0 5248.9 5257.9 5268.7 5296.6 5174.1 5212.9 5224.1 5226.7 5234.1 5126.2 5258.9 5271.8 5311.8 5335.4 5144.5 5162.7 5219.3 5229.5 5255.6 5380.7 5525.0 5554.6 5567.6 5595.4 6081.4 6104.9 6203.6 6211.2 6219.3 6200.5 6238.9 6268.2 6282.8 6308.8 5852.3 5869.5 5876.0 5906.8 5962.2 6176.1 6235.7 6264.8 6314.8 6327.6 6161.3 6169.4 6172.7 6204.5 6223.1 6188.8 6231.3 6253.6 6277.4 6288.4 6044.1 6131.9 6211.8 6232.5 6250.2 6087.2 6169.9 6289.5 6297.9 6306.5 4870.6 4908.4 4916.4 4953.0 4962.4 4386.8 4404.8 4425.3 4451.7 4513.3 4898.5 5827.6 5841.9 5869.3 5895.1 6238.5 6267.2 6285.3 6287.2 6295.0 5723.6 5820.2 5900.1 5929.2 5949.5 5425.5 5435.9 5458.2 5461.5 5465.1 6302.1 6444.9 6455.5 6472.1 6502.9 6180.7 6227.5 6255.8 6271.1 6286.3 4850.5 6397.4 6404.0 6440.5 6442.2 6080.0 6137.6 6224.5 6261.5 6276.6 6194.4 6231.0 6260.7 6278.0 6298.1 6166.9 6189.1 6193.5 6206.7 6224.8 6053.1 6075.3 6123.6 6181.0 6228.6 4553.7 4957.8 5052.6 5317.2 5567.7 6167.4 6201.4 6202.9 6203.5 6204.7 5949.5 6004.8 6008.9 6085.4 6091.1 12:09:17 INFO - PROCESS | 1954 | 12:09:17 INFO - PROCESS | 1954 | [#1] ext.html Cycles:180 Average:58556.58 Median:38194.62 stddev:118242.37 (309.6%) stddev-sans-first:118493.73 12:09:17 INFO - PROCESS | 1954 | Values: 501.7 523.6 561.3 580.7 590.0 32266.8 34831.0 35488.8 39704.2 39966.2 40325.8 41078.2 41088.8 41127.0 41161.0 8513.2 9462.7 9517.9 9708.4 9711.0 9653.7 9791.2 9891.2 9921.5 9944.2 9801.7 9845.9 9863.0 9954.5 9966.4 9814.8 9830.0 9907.3 9907.7 9936.8 8330.3 9634.1 9740.8 9756.7 9759.7 39423.6 39627.4 39783.0 40252.8 40289.8 2828.6 3052.3 3097.8 3430.1 3614.2 26176.2 26184.0 27054.6 27144.9 28339.6 2618.2 2655.3 2662.7 2763.1 2807.9 345382.0 347998.0 352272.0 352673.0 354488.0 58572.0 58763.5 58933.4 58940.8 59016.0 61091.0 61868.0 61951.5 62437.7 62470.0 16366.6 16592.3 16859.7 16879.0 16917.2 12547.2 12819.2 12970.4 13028.1 13059.5 19228.4 19336.3 19614.4 19743.4 19769.7 8222.4 8275.5 8308.8 8370.9 8372.6 900.3 916.7 922.8 982.3 1011.3 29688.4 29756.3 29816.9 30253.5 30340.5 1046.9 1083.7 1103.9 1112.5 1264.6 15252.6 15293.3 15381.8 15629.8 15647.8 558318.0 563619.0 572441.0 572770.0 575332.0 59960.1 60293.8 60893.7 60993.7 61008.8 1452.9 1463.1 1470.1 1482.6 1487.2 29100.6 29393.9 29432.7 30065.8 30090.4 39778.4 50783.0 51560.5 51614.0 51758.5 376342.0 384244.0 384797.0 385271.0 387279.0 25890.6 26116.9 26326.3 26561.6 26652.7 44518.8 45306.5 45513.0 46230.8 46594.8 37337.8 37436.4 37814.0 38286.2 38386.7 37407.8 37721.8 37856.8 38103.0 38596.2 30643.8 34917.7 36056.5 37414.0 38296.9 30698.7 31144.0 32163.7 32264.7 32672.7 24632.5 24633.5 24655.3 24725.3 24799.9 12:09:17 INFO - PROCESS | 1954 | 12:09:17 INFO - PROCESS | 1954 | [#2] jquery.html Cycles:180 Average:34488.30 Median:2089.68 stddev:97771.68 (4678.8%) stddev-sans-first:98012.32 12:09:17 INFO - PROCESS | 1954 | Values: 335.7 355.9 391.6 405.4 405.4 19563.9 20494.1 20595.4 20852.7 20981.6 18496.7 19621.0 20406.0 20855.9 21395.0 4559.0 5951.3 6158.1 6171.6 6175.0 6104.0 6154.5 6163.4 6164.4 6179.9 4679.6 5316.7 5377.8 5774.8 6085.9 5759.2 5962.4 6022.9 6153.2 6156.1 5739.1 5909.6 5921.8 5928.1 5936.6 14589.7 21362.5 25159.7 25389.9 26180.7 1997.9 1999.6 2170.5 2224.7 2241.1 9842.0 9939.3 10090.5 10108.7 10122.3 1721.9 1750.6 1812.3 1843.3 1974.7 98788.0 126998.0 130788.0 141946.3 143005.3 11485.4 11551.7 11616.5 11805.6 11927.6 14535.0 14850.0 14881.7 14935.3 14968.6 8755.9 8791.9 8916.3 8943.2 9067.5 8992.1 9002.5 9025.5 9037.8 9085.1 3787.7 4582.1 4641.4 4645.2 4699.1 1943.5 1991.8 1993.9 2011.5 2021.7 338.9 394.8 398.1 850.8 866.5 11570.2 11611.1 11790.1 11869.0 11955.6 436.2 875.9 903.8 908.2 964.6 8788.6 10191.1 10557.3 10658.8 10804.3 573315.0 580217.0 581182.0 584524.0 590797.0 104600.8 127591.0 131109.0 140388.0 142786.0 986.2 1051.8 1067.1 1068.8 1071.7 17241.8 17779.8 18158.4 18171.3 18548.4 54559.9 54799.6 54953.6 55374.0 55926.2 73118.3 76174.0 77253.0 80606.0 85705.0 6457.6 7813.8 7838.6 7898.2 8130.0 8617.3 11051.5 12373.4 12517.1 12555.2 7483.3 9339.6 9727.4 10434.5 10866.2 10709.3 10781.0 10782.4 11142.0 11199.2 9072.2 9984.8 11042.0 11164.8 11548.0 8016.7 8071.3 8180.3 8184.3 8387.0 8043.8 8157.5 11028.2 11074.0 11160.0 12:09:17 INFO - PROCESS | 1954 | 12:09:17 INFO - PROCESS | 1954 | [#3] mootools.html Cycles:180 Average:5597.65 Median:4965.05 stddev:3086.57 (62.2%) stddev-sans-first:3079.55 12:09:17 INFO - PROCESS | 1954 | Values: 1457.9 1561.9 1609.0 1934.9 1948.3 6589.3 8470.9 8475.3 8833.9 8849.3 7242.2 8630.8 8642.9 8731.2 8769.7 2460.9 2478.4 2492.8 2499.6 2503.2 2451.4 2471.0 2504.4 2506.6 2521.6 2113.5 2466.2 2474.9 2496.2 2511.2 1888.7 2378.1 2413.5 2442.5 2456.9 2396.5 2414.4 2437.6 2437.7 2440.4 8697.5 8807.0 8827.0 8828.0 8862.2 4299.2 5447.9 5449.7 5451.0 5455.8 3412.9 3549.3 3572.2 3642.0 3645.0 988.4 1029.9 1036.8 1040.9 1041.4 9374.6 11154.4 11250.4 11416.9 11425.7 4566.4 4636.2 4686.3 4710.8 4729.0 9081.6 9133.2 9135.4 9157.0 9168.3 5246.7 5276.9 5291.4 5330.5 5338.5 4463.6 4791.3 4934.6 5007.6 5008.3 3783.3 3864.3 4063.1 4084.2 4154.9 1348.8 1367.5 1379.2 1382.5 1393.9 822.2 866.8 894.7 901.0 964.1 5642.2 5794.7 5974.1 6055.9 6089.0 452.8 457.0 467.9 469.6 473.6 3925.2 4013.8 4037.1 4067.2 4087.7 10199.3 10611.8 10673.4 10750.6 10779.1 10065.4 10483.9 10564.6 10596.3 10727.9 7966.3 8012.2 8133.7 8166.8 8244.3 5146.7 5885.1 6032.0 6066.2 6101.2 9589.0 9812.7 9893.3 9901.2 9930.9 9865.9 10003.5 10035.5 10192.6 10232.3 6883.9 7289.7 7461.6 7465.0 7597.7 5993.8 7937.4 7954.7 7957.2 8050.6 6064.7 6957.7 7129.8 7142.1 7309.9 7242.8 7276.2 7324.4 7325.6 7424.2 6828.9 7072.3 7078.3 7081.6 7086.8 3982.6 4830.4 4930.3 4953.9 5063.5 4940.4 4976.2 5008.1 5017.1 5189.5 12:09:17 INFO - PROCESS | 1954 | 12:09:17 INFO - PROCESS | 1954 | [#4] prototype.html Cycles:180 Average:4702.53 Median:5163.15 stddev:1469.50 (28.5%) stddev-sans-first:1436.16 12:09:17 INFO - PROCESS | 1954 | Values: 309.9 317.2 324.5 325.4 326.0 4481.9 4923.5 5208.1 5368.1 5392.5 4511.2 4948.8 5463.5 5500.3 5507.9 4140.3 4187.0 4203.3 4203.5 4222.4 3699.8 3881.5 4209.6 4210.3 4213.4 4073.5 4091.8 4098.7 4102.5 4104.6 3184.4 4117.8 4122.3 4134.9 4172.6 3558.0 3569.4 3572.8 3576.6 3621.2 4906.4 5171.0 5192.3 5203.7 5254.4 3532.8 3919.1 3954.4 4703.8 4718.9 5628.8 5699.0 5757.2 5777.6 5805.4 3687.4 3913.5 3939.4 3940.4 3958.3 5159.5 6040.7 6066.7 6089.9 6118.0 3737.2 3982.3 3987.7 3992.3 4055.3 3043.8 3610.5 3930.8 3985.7 4043.4 3962.5 4712.4 4717.2 4718.2 4752.2 5526.6 5805.2 5809.0 5823.9 5831.2 1489.2 1496.9 1541.1 1543.3 1553.4 1012.6 1014.6 1039.7 1041.7 1043.8 5748.5 5811.4 5822.2 5828.3 5834.3 5648.5 5943.2 6391.5 6394.5 6470.0 4559.4 4642.6 4708.5 5354.7 5565.3 2825.7 3079.7 3087.7 3170.2 3407.4 5557.7 6131.8 6179.9 6585.4 6659.6 6203.8 6220.5 6246.9 6250.2 6299.9 5578.2 5818.9 6286.9 6296.7 6346.4 5046.5 5166.8 5846.2 5976.3 6088.0 5877.6 5913.7 5928.5 5935.8 5965.3 5712.1 5878.3 6246.7 6249.5 6259.3 3343.7 3381.9 3943.4 3962.4 4003.6 5078.2 5105.8 5705.4 5975.9 6030.8 5021.9 5074.2 5487.8 5774.8 5847.4 4892.7 5717.2 5774.8 5777.0 5799.2 5336.9 5649.0 5679.2 5684.6 5702.6 5779.7 5811.9 5813.2 5828.5 5833.0 5023.7 5407.6 5665.6 5680.8 5689.7 12:09:17 INFO - PROCESS | 1954 | 12:09:17 INFO - PROCESS | 1954 | [#5] yui.html Cycles:180 Average:18086.05 Median:601.01 stddev:25659.61 (4269.4%) stddev-sans-first:25698.08 12:09:17 INFO - PROCESS | 1954 | Values: 619.8 755.4 757.6 762.2 762.6 12056.9 14609.3 15163.8 15180.8 15371.5 10619.5 11092.9 14281.5 14299.1 14305.9 721.2 890.8 916.5 920.8 928.3 786.9 931.8 942.1 942.6 943.5 965.8 976.8 991.5 991.9 994.1 946.9 948.3 985.9 987.4 987.8 712.1 712.6 726.8 729.1 733.4 14787.3 15013.6 15098.0 15144.0 15164.7 12864.7 12936.5 13055.5 13113.5 13199.7 10127.6 10306.4 10333.7 10401.9 10410.7 3444.8 3456.9 3531.6 3582.5 3631.3 77154.2 77447.0 82076.0 83284.0 84091.6 9226.4 9254.7 9278.4 9517.0 9518.4 18646.0 22811.3 22830.9 22910.8 22959.4 7506.8 7675.6 7691.8 7723.2 7880.3 4073.5 4128.7 4131.8 4132.6 4137.0 3406.6 3463.1 3472.9 3478.1 3901.9 718.3 719.5 723.6 726.2 730.5 388.9 410.5 528.5 571.2 582.2 7387.2 7826.5 8235.8 8296.3 8421.1 559.6 560.4 572.5 620.4 634.8 3415.0 3988.3 4021.2 4048.8 4083.6 97576.5 98221.0 100450.0 101202.0 102445.0 71088.2 71201.0 71873.0 76138.6 80178.6 66233.0 67217.7 70823.0 71650.6 73402.0 7025.3 8195.0 8558.4 8572.5 8618.7 33665.7 42780.0 43762.6 43816.0 44282.6 63032.4 63061.0 63581.0 64630.7 65198.0 10983.1 11066.8 11393.8 11474.3 11628.0 11879.6 11887.0 11903.4 12316.1 12393.6 11461.5 11572.2 11614.8 11705.8 11758.3 11594.4 11713.8 11859.9 11997.3 12125.3 11362.8 11544.0 11628.1 11868.0 12231.8 9624.5 9735.0 9794.4 9833.8 9931.6 8366.2 9041.8 9410.7 9446.3 9721.5 12:09:17 INFO - PROCESS | 1954 | -------- Summary: end -------- 12:09:17 INFO - PROCESS | 1954 | 12:09:18 INFO - TEST-INFO | 1954: exit 0 12:09:18 INFO - TEST-OK | dromaeo_css | took 1112087ms 12:09:18 INFO - TEST-START | kraken 12:09:18 INFO - operating with platform_type : mac_ 12:09:18 INFO - Initialising browser for kraken test... 12:09:18 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmptSmhLh/profile http://localhost:51880/getInfo.html) 12:09:20 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 12:09:20 INFO - PROCESS | 1961 | colorDepth:24 12:09:20 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 12:09:20 INFO - PROCESS | 1961 | __metrics 12:09:21 ERROR - PROCESS | 1961 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:09:21 INFO - TEST-INFO | 1961: exit 0 12:09:21 INFO - Browser initialized. 12:09:21 INFO - Running cycle 1/1 for kraken test... 12:09:21 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmptSmhLh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:33 INFO - PROCESS | 1964 | RSS: Main: 250314752 12:09:33 INFO - PROCESS | 1964 | 12:09:36 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51880/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:37 INFO - PROCESS | 1964 | RSS: Main: 262340608 12:09:37 INFO - PROCESS | 1964 | 12:09:40 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51880/tests/kraken/driver.html?testName=audio-dft) 12:09:40 INFO - PROCESS | 1964 | RSS: Main: 271425536 12:09:40 INFO - PROCESS | 1964 | 12:09:44 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51880/tests/kraken/driver.html?testName=audio-fft) 12:09:44 INFO - PROCESS | 1964 | RSS: Main: 274300928 12:09:44 INFO - PROCESS | 1964 | 12:09:46 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51880/tests/kraken/driver.html?testName=audio-oscillator) 12:09:47 INFO - PROCESS | 1964 | RSS: Main: 276283392 12:09:47 INFO - PROCESS | 1964 | 12:09:49 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:50 INFO - PROCESS | 1964 | RSS: Main: 276766720 12:09:50 INFO - PROCESS | 1964 | 12:09:52 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51880/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:53 INFO - PROCESS | 1964 | RSS: Main: 277753856 12:09:53 INFO - PROCESS | 1964 | 12:09:56 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51880/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:56 INFO - PROCESS | 1964 | RSS: Main: 277848064 12:09:56 INFO - PROCESS | 1964 | 12:09:59 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51880/tests/kraken/driver.html?testName=json-parse-financial) 12:10:00 INFO - PROCESS | 1964 | RSS: Main: 277983232 12:10:00 INFO - PROCESS | 1964 | 12:10:02 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:10:02 INFO - PROCESS | 1964 | RSS: Main: 277880832 12:10:02 INFO - PROCESS | 1964 | 12:10:04 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:10:05 INFO - PROCESS | 1964 | RSS: Main: 277188608 12:10:05 INFO - PROCESS | 1964 | 12:10:07 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:10:08 INFO - PROCESS | 1964 | RSS: Main: 277413888 12:10:08 INFO - PROCESS | 1964 | 12:10:11 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:10:12 INFO - PROCESS | 1964 | RSS: Main: 277635072 12:10:12 INFO - PROCESS | 1964 | 12:10:15 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:10:15 INFO - PROCESS | 1964 | RSS: Main: 277688320 12:10:15 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:51880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51880/tests/kraken/driver.html?testName=ai-astar) 12:10:17 INFO - PROCESS | 1964 | RSS: Main: 279220224 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | __start_tp_report 12:10:17 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 12:10:17 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 12:10:17 INFO - PROCESS | 1964 | |i|pagename|runs| 12:10:17 INFO - PROCESS | 1964 | |0;ai-astar;115;111;117;142;172;168;116;116;116;118 12:10:17 INFO - PROCESS | 1964 | |1;audio-beat-detection;156;144;186;202;118;141;151;124;167;121 12:10:17 INFO - PROCESS | 1964 | |2;audio-dft;205;206;220;209;197;196;196;201;203;198 12:10:17 INFO - PROCESS | 1964 | |3;audio-fft;71;72;74;152;86;66;57;64;114;48 12:10:17 INFO - PROCESS | 1964 | |4;audio-oscillator;80;91;128;77;79;80;119;80;79;118 12:10:17 INFO - PROCESS | 1964 | |5;imaging-gaussian-blur;90;88;92;89;92;88;92;88;92;88 12:10:17 INFO - PROCESS | 1964 | |6;imaging-darkroom;96;96;96;97;97;97;98;98;95;96 12:10:17 INFO - PROCESS | 1964 | |7;imaging-desaturate;91;91;89;90;98;125;90;111;147;88 12:10:17 INFO - PROCESS | 1964 | |8;json-parse-financial;59;63;61;62;61;63;62;75;63;61 12:10:17 INFO - PROCESS | 1964 | |9;json-stringify-tinderbox;62;96;102;98;81;74;71;69;71;70 12:10:17 INFO - PROCESS | 1964 | |10;stanford-crypto-aes;85;82;83;81;99;85;83;85;87;85 12:10:17 INFO - PROCESS | 1964 | |11;stanford-crypto-ccm;153;164;188;122;165;152;152;164;176;150 12:10:17 INFO - PROCESS | 1964 | |12;stanford-crypto-pbkdf2;176;227;167;164;236;225;186;230;180;217 12:10:17 INFO - PROCESS | 1964 | |13;stanford-crypto-sha256-iterative;69;67;71;67;69;68;70;67;71;71 12:10:17 INFO - PROCESS | 1964 | __end_tp_report 12:10:17 INFO - PROCESS | 1964 | __start_cc_report 12:10:17 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,1078 12:10:17 INFO - PROCESS | 1964 | __end_cc_report 12:10:17 INFO - PROCESS | 1964 | __startTimestamp1461611417808__endTimestamp 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | ------- Summary: start ------- 12:10:17 INFO - PROCESS | 1964 | Number of tests: 14 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#0] ai-astar Cycles:10 Average:129.10 Median:117.50 stddev:23.17 (19.7%) stddev-sans-first:24.01 12:10:17 INFO - PROCESS | 1964 | Values: 115.0 111.0 117.0 142.0 172.0 168.0 116.0 116.0 116.0 118.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:153.50 stddev:27.84 (18.1%) stddev-sans-first:29.47 12:10:17 INFO - PROCESS | 1964 | Values: 156.0 144.0 186.0 202.0 118.0 141.0 151.0 124.0 167.0 121.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#2] audio-dft Cycles:10 Average:203.10 Median:204.00 stddev:7.46 (3.7%) stddev-sans-first:7.88 12:10:17 INFO - PROCESS | 1964 | Values: 205.0 206.0 220.0 209.0 197.0 196.0 196.0 201.0 203.0 198.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#3] audio-fft Cycles:10 Average:80.40 Median:68.50 stddev:30.84 (45.0%) stddev-sans-first:32.52 12:10:17 INFO - PROCESS | 1964 | Values: 71.0 72.0 74.0 152.0 86.0 66.0 57.0 64.0 114.0 48.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:79.50 stddev:20.23 (25.5%) stddev-sans-first:20.90 12:10:17 INFO - PROCESS | 1964 | Values: 80.0 91.0 128.0 77.0 79.0 80.0 119.0 80.0 79.0 118.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:91.00 stddev:1.91 (2.1%) stddev-sans-first:2.03 12:10:17 INFO - PROCESS | 1964 | Values: 90.0 88.0 92.0 89.0 92.0 88.0 92.0 88.0 92.0 88.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:97.00 stddev:0.97 (1.0%) stddev-sans-first:1.00 12:10:17 INFO - PROCESS | 1964 | Values: 96.0 96.0 96.0 97.0 97.0 97.0 98.0 98.0 95.0 96.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#7] imaging-desaturate Cycles:10 Average:102.00 Median:90.00 stddev:19.85 (22.1%) stddev-sans-first:20.65 12:10:17 INFO - PROCESS | 1964 | Values: 91.0 91.0 89.0 90.0 98.0 125.0 90.0 111.0 147.0 88.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:62.50 stddev:4.40 (7.0%) stddev-sans-first:4.42 12:10:17 INFO - PROCESS | 1964 | Values: 59.0 63.0 61.0 62.0 61.0 63.0 62.0 75.0 63.0 61.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#9] json-stringify-tinderbox Cycles:10 Average:79.40 Median:72.50 stddev:14.16 (19.5%) stddev-sans-first:13.55 12:10:17 INFO - PROCESS | 1964 | Values: 62.0 96.0 102.0 98.0 81.0 74.0 71.0 69.0 71.0 70.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:5.06 (6.0%) stddev-sans-first:5.36 12:10:17 INFO - PROCESS | 1964 | Values: 85.0 82.0 83.0 81.0 99.0 85.0 83.0 85.0 87.0 85.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#11] stanford-crypto-ccm Cycles:10 Average:158.60 Median:164.00 stddev:17.63 (10.8%) stddev-sans-first:18.59 12:10:17 INFO - PROCESS | 1964 | Values: 153.0 164.0 188.0 122.0 165.0 152.0 152.0 164.0 176.0 150.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.80 Median:221.00 stddev:28.65 (13.0%) stddev-sans-first:28.95 12:10:17 INFO - PROCESS | 1964 | Values: 176.0 227.0 167.0 164.0 236.0 225.0 186.0 230.0 180.0 217.0 12:10:17 INFO - PROCESS | 1964 | 12:10:17 INFO - PROCESS | 1964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.70 (2.4%) stddev-sans-first:1.80 12:10:17 INFO - PROCESS | 1964 | Values: 69.0 67.0 71.0 67.0 69.0 68.0 70.0 67.0 71.0 71.0 12:10:17 INFO - PROCESS | 1964 | -------- Summary: end -------- 12:10:17 INFO - PROCESS | 1964 | 12:10:18 INFO - TEST-INFO | 1964: exit 0 12:10:18 INFO - TEST-OK | kraken | took 60409ms 12:10:18 INFO - SUITE-END | took 1172s 12:10:18 INFO - Completed test suite (00:19:32) 12:10:18 INFO - javascript benchmark 12:10:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3414.3000684859603, 3440.7935523868564, 3456.187795867972, 3458.2391873787774, 3497.5453191085153, 5664.263645726055, 5710.229119068925, 5721.628094173881, 5728.4557966993125, 5739.598228124033, 4977.780443791276, 5598.300212473441, 5644.774209031634, 5696.658200507962, 5748.655080695161, 4235.8093885775215, 5154.69071855688, 5160.612954028454, 5220.112580861243, 5294.0, 273.9713548487008, 5248.947510524903, 5257.868553286179, 5268.683878967255, 5296.629235953485, 5174.094533456649, 5212.921806172911, 5224.111900976843, 5226.7125308108225, 5234.0840352938085, 5126.2054381570915, 5258.8685282867855, 5271.789128434858, 5311.760970756287, 5335.359756829166, 5144.511271429208, 5162.664426812283, 5219.347581552306, 5229.477052294778, 5255.5795536357, 5380.7309634518115, 5524.972375138139, 5554.555635549187, 5567.582431317667, 5595.440455954413, 6081.3614570470345, 6104.853288833277, 6203.596766210182, 6211.16149319845, 6219.315875253718, 6200.503959683215, 6238.9376106238815, 6268.1851359323, 6282.811515654537, 6308.842278943017, 5852.297724273115, 5869.50109240715, 5876.024743253899, 5906.82279531619, 5962.1951036609935, 6176.073588961692, 6235.719392627252, 6264.780732674334, 6314.778982735582, 6327.588706734047, 6161.291451483047, 6169.413905678954, 6172.69136543171, 6204.534659900525, 6223.097650840693, 6188.752449901954, 6231.345708700612, 6253.5622506424115, 6277.403646653561, 6288.371162883675, 6044.123602077674, 6131.927227014014, 6211.81364559064, 6232.532560058014, 6250.1874756281395, 6087.208662873887, 6169.876602467925, 6289.496840252768, 6297.937020629735, 6306.495480361652, 4870.586000189953, 4908.410990681141, 4916.385451818523, 4953.0, 4962.379702537183, 4386.824527018884, 4404.823807047746, 4425.291953287458, 4451.666125040635, 4513.255312873404, 4898.461169271377, 5827.562932780059, 5841.853953651108, 5869.266341707286, 5895.145203945404, 6238.532110091671, 6267.247930248308, 6285.308616052231, 6287.245530536365, 6295.0, 5723.627964182315, 5820.156077368758, 5900.085486749561, 5929.199558059693, 5949.494292985145, 5425.457454254543, 5435.864103397446, 5458.235846981426, 5461.481159289861, 5465.098258787335, 6302.086197501245, 6444.903326450107, 6455.4512866406885, 6472.061551075068, 6502.934970650327, 6180.690965451619, 6227.470664993345, 6255.843603909939, 6271.090691849748, 6286.339934306832, 4850.490698476609, 6397.424231818973, 6403.967980160256, 6440.452561532322, 6442.162518872517, 6079.969600152148, 6137.591499645514, 6224.533160013108, 6261.467775238973, 6276.560640755103, 6194.38056194395, 6231.0, 6260.718267677874, 6278.0, 6298.149749783904, 6166.938330616636, 6189.071639254148, 6193.504519638508, 6206.658633775186, 6224.782132625336, 6053.061775424816, 6075.301340345917, 6123.648682309428, 6181.0, 6228.626282423069, 4553.726776393427, 4957.752112394438, 5052.621053420935, 5317.229001794641, 5567.721613919369, 6167.444929956326, 6201.379862013943, 6202.906956395567, 6203.503719702323, 6204.689765511796, 5949.52403807703, 6004.789832355847, 6008.8798224036145, 6085.361037091218, 6091.086337049478], "value": 5651.975293856956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.7215445427787, 523.6229914461588, 561.334818240385, 580.7038410410689, 589.9557533185009, 32266.838665806637, 34831.0, 35488.822555887185, 39704.20591588166, 39966.20067598646, 40325.798371008175, 41078.178436431255, 41088.79455602725, 41127.0, 41161.0, 8513.19124683154, 9462.668806591753, 9517.904820951771, 9708.41749495029, 9710.951445242765, 9653.71038868835, 9791.167750741195, 9891.159251463634, 9921.503924803766, 9944.15474684649, 9801.656942007032, 9845.852312215322, 9863.0, 9954.452505112216, 9966.352187107852, 9814.803703925953, 9829.950850245774, 9907.25695572835, 9907.70276891698, 9936.801263974752, 8330.291925186366, 9634.084761947604, 9740.805183896353, 9756.658516951873, 9759.707208783748, 39423.60576394228, 39627.40558891619, 39783.0, 40252.79241622756, 40289.79855100706, 2828.61813655156, 3052.282713562311, 3097.845107744626, 3430.073880052397, 3614.2410093880317, 26176.214713558624, 26184.0, 27054.5941810873, 27144.91420343184, 28339.57490637642, 2618.1883616079076, 2655.3361659585103, 2662.6671666041743, 2763.088180900298, 2807.873645685949, 345382.0, 347998.0, 352272.0, 352673.0, 354487.99999999744, 58572.0, 58763.530911726695, 58933.41066589365, 58940.82118357609, 59016.0, 61091.0, 61868.0, 61951.52193912193, 62437.68781156065, 62470.0, 16366.590835228977, 16592.336306547604, 16859.662806743796, 16879.0, 16917.154142293082, 12547.247165169936, 12819.16675416095, 12970.351482425842, 13028.08803383773, 13059.542915997894, 19228.404165437765, 19336.32697309212, 19614.411567652995, 19743.40769776909, 19769.703454448194, 8222.38332125093, 8275.54484503358, 8308.792280193044, 8370.916290837136, 8372.623231954454, 900.2707806676613, 916.702071826659, 922.7508572685338, 982.3369225772575, 1011.327467234281, 29688.406231875673, 29756.256093597833, 29816.850915745283, 30253.546196807067, 30340.54489182664, 1046.864152394645, 1083.664064140119, 1103.9227254092298, 1112.4882554025078, 1264.6206138158516, 15252.618684532976, 15293.311800968982, 15381.846181538265, 15629.843701562839, 15647.765283520755, 558318.0, 563619.0, 572441.0, 572770.0, 575332.0, 59960.10059849106, 60293.794124117274, 60893.69553152206, 60993.695031524556, 61008.77982440326, 1452.9491467798787, 1463.1294379843976, 1470.1399681186626, 1482.6367539952564, 1487.2192099147817, 29100.563491547222, 29393.85303073471, 29432.705672942997, 30065.849670751508, 30090.3981920356, 39778.403323949584, 50783.0, 51560.484395157066, 51613.96772064463, 51758.482415175364, 376342.0, 384244.0, 384797.0, 385271.0, 387279.0, 25890.611640825027, 26116.91064714856, 26326.341841454116, 26561.60157597676, 26652.733472665026, 44518.777406112764, 45306.54693453023, 45513.0, 46230.76884615555, 46594.76702616465, 37337.81331093436, 37436.43845342377, 37814.0, 38286.23427531378, 38386.65646702352, 37407.81296093502, 37721.81139094397, 37856.810715946245, 38103.0, 38596.22807543777, 30643.846780765954, 34917.650823492455, 36056.4591531122, 37414.0, 38296.85109446721, 30698.69301307048, 31144.00369049464, 32163.67836321607, 32264.677353227107, 32672.673273266962, 24632.507349853262, 24633.507329853663, 24655.260342189762, 24725.258242252763, 24799.876000619883], "value": 19314.534749892184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.6760725899507, 355.8665500437334, 391.6318660459169, 405.44049212087316, 405.44251653975783, 19563.902180489094, 20494.077766500504, 20595.38213853585, 20852.687209691867, 20981.580368392624, 18496.705230633863, 19621.0, 20406.0, 20855.895720521414, 21395.037223324947, 4558.997917310232, 5951.256092988377, 6158.137860699506, 6171.629702217859, 6174.969125154368, 6104.0, 6154.538409619274, 6163.352847950945, 6164.383561643845, 6179.907301390483, 4679.625629949596, 5316.6544174628525, 5377.8117765878205, 5774.8267551973295, 6085.908711369333, 5759.16492108644, 5962.373950735176, 6022.939770602304, 6153.230846144232, 6156.076588511714, 5739.110437882135, 5909.645421274738, 5921.822345329647, 5928.081147422156, 5936.584439089265, 14589.70820583593, 21362.465938351666, 25159.748402515925, 25389.873050634815, 26180.73819261802, 1997.9200831966705, 1999.57009243012, 2170.4790850195996, 2224.677421773834, 2241.0699559682876, 9841.950790246003, 9939.254555908263, 10090.545925433373, 10108.696739097839, 10122.342047766871, 1721.9139043047924, 1750.5711100780263, 1812.2932056497975, 1843.2903332217193, 1974.6544354738007, 98788.0, 126998.0, 130788.0, 141946.29026854903, 143005.2849735755, 11485.425728713531, 11551.653450396501, 11616.477258523386, 11805.645830625095, 11927.642170734893, 14534.982551221314, 14850.0, 14881.702365952837, 14935.253237338307, 14968.625784355478, 8755.912440875638, 8791.939976860642, 8916.331275154389, 8943.195112439911, 9067.501287429255, 8992.055834137453, 9002.50486223264, 9025.458472491671, 9037.77405564853, 9085.091490850995, 3787.7348585598743, 4582.106489234568, 4641.419822522184, 4645.187092258841, 4699.130660827758, 1943.4752616793387, 1991.7709463411893, 1993.900304984745, 2011.4971257185703, 2021.676531754912, 338.9423797954354, 394.83326769396365, 398.1420039814205, 850.8128211793396, 866.536403024379, 11570.247933884271, 11611.129165312635, 11790.056795456343, 11869.0, 11955.64133076009, 436.2322312729619, 875.8993164198793, 903.7514683461969, 908.1644886704248, 964.5996911281879, 8788.560571971377, 10191.133753631024, 10557.260991730505, 10658.840117398246, 10804.297720648132, 573315.0, 580217.0, 581182.0, 584524.0, 590797.0, 104600.81257276998, 127591.0, 131109.0, 140388.0, 142786.0, 986.1814693804125, 1051.8422236664408, 1067.071647666535, 1068.8129577323937, 1071.6677829872608, 17241.827581724523, 17779.822201778334, 18158.364457243933, 18171.273149073888, 18548.44354669362, 54559.90880182454, 54799.63000925009, 54953.60909731424, 55374.0, 55926.16110758423, 73118.26881731328, 76174.0, 77253.0, 80606.0, 85705.0, 6457.579332546832, 7813.765587032398, 7838.608069596383, 7898.210178982055, 8129.959350203448, 8617.310615150647, 11051.502682379472, 12373.443195056065, 12517.123801334183, 12555.246685198917, 7483.289087536676, 9339.57971891253, 9727.416355018722, 10434.530446129791, 10866.185036122164, 10709.250352475252, 10781.02970732638, 10782.353058816496, 11141.997220250216, 11199.216054876406, 9072.183503484717, 9984.801823781192, 11042.006219440289, 11164.832527511931, 11548.01841843419, 8016.679332826621, 8071.313938315309, 8180.345572354078, 8184.345252379914, 8387.035490918623, 8043.798905027421, 8157.469764465291, 11028.22802403856, 11074.003339699466, 11160.0], "value": 9146.4064830627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.8833693304534, 1561.898476599021, 1609.0024185005295, 1934.9226030958762, 1948.3083505355607, 6589.308122647125, 8470.91529084709, 8475.279601233888, 8833.867491987625, 8849.29205663547, 7242.167150777649, 8630.827383452342, 8642.91357086429, 8731.17053879882, 8769.736907892773, 2460.9138680146198, 2478.4423504711476, 2492.750724927511, 2499.6250562415603, 2503.2240005598323, 2451.350392146083, 2470.950580988379, 2504.373906523369, 2506.586413241813, 2521.6091505816626, 2113.471632091977, 2466.2108125399877, 2474.8762561871927, 2496.213692686807, 2511.221521328385, 1888.707250376187, 2378.131981826638, 2413.4931664350333, 2442.511497700467, 2456.938576535592, 2396.496735685508, 2414.372263211578, 2437.5612389770013, 2437.6831011968507, 2440.414300567851, 8697.478151310941, 8807.031226565072, 8827.029026807046, 8828.028916819145, 8862.20240178387, 4299.247631664478, 5447.863803404907, 5449.7275136243425, 5450.972745136289, 5455.809046683386, 3412.897613071612, 3549.2546565221332, 3572.1962558424148, 3641.981790091059, 3644.9817750911343, 988.3822610868208, 1029.8506716526138, 1036.8392899100652, 1040.9375437473775, 1041.4274445587141, 9374.625014999392, 11154.386508742016, 11250.437478126061, 11416.942915285454, 11425.714357141054, 4566.383538222364, 4636.165490211794, 4686.3204835299375, 4710.788014539354, 4728.976355118202, 9081.59132839024, 9133.223675987483, 9135.360524763335, 9157.0, 9168.31237657165, 5246.737663116829, 5276.868078298074, 5291.417944026154, 5330.466953304638, 5338.492843179892, 4463.642908567307, 4791.281307803857, 4934.580560652313, 5007.599392048627, 5008.323876276656, 3783.3379158647126, 3864.265789500042, 4063.065494936122, 4084.231769621487, 4154.937675934863, 1348.7707089794562, 1367.4871923028863, 1379.1793882639813, 1382.4539306973688, 1393.8815200708054, 822.1942496353488, 866.7963028688254, 894.7226359828474, 901.0133903375793, 964.1274646444979, 5642.153676948491, 5794.739236734357, 5974.074018527135, 6055.878882422327, 6089.0, 452.77587594141113, 456.97943592538417, 467.8666580024745, 469.57034313602674, 473.6187369167784, 3925.1953349563273, 4013.819378127991, 4037.1320166164414, 4067.2272268268935, 4087.734297270668, 10199.337043092175, 10611.84082238767, 10673.412962286993, 10750.623728169476, 10779.083777878968, 10065.446400448045, 10483.895161048444, 10564.630237941636, 10596.258261921592, 10727.87357327485, 7966.322862556747, 8012.2388373103295, 8133.674653013813, 8166.795830104176, 8244.29923456501, 5146.665466744649, 5885.117232415172, 6031.969840150771, 6066.181065556093, 6101.206843110367, 9589.041095890634, 9812.705618831447, 9893.25800564946, 9901.15840153595, 9930.900690992998, 9865.852012219679, 10003.549840257061, 10035.548400321857, 10192.643257485952, 10232.334898231591, 6883.862322753617, 7289.708411663474, 7461.626918654154, 7465.029546158965, 7597.696092156473, 5993.790217342372, 7937.444378893422, 7954.721584744506, 7957.244061814118, 8050.637721302438, 6064.666443345482, 6957.686904089429, 7129.786106416608, 7142.071530700976, 7309.8903516446235, 7242.782716518513, 7276.163241227115, 7324.377427918686, 7325.6337183141695, 7424.220456852169, 6828.863422731617, 7072.292770723092, 7078.292170782881, 7081.610511421715, 7086.751963681247, 3982.581828907923, 4830.396200474941, 4930.285108659296, 4953.900921981468, 5063.468335824686, 4940.407151141886, 4976.2038073908, 5008.148614735576, 5017.096922553976, 5189.506996835295], "value": 4473.643346763936, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.86365998960457, 317.24495700233444, 324.4678726887903, 325.38664617196577, 325.95599594054795, 4481.9327710084335, 4923.5076492350745, 5208.062548741225, 5368.087425137726, 5392.460753924605, 4511.210538155818, 4948.832747041896, 5463.508284254416, 5500.339959204891, 5507.9449205507935, 4140.337545992642, 4186.995121170912, 4203.327467605184, 4203.495580530341, 4222.366645003259, 3699.8150092495403, 3881.4760007399063, 4209.557996410364, 4210.326347784355, 4213.43118678979, 4073.531543872463, 4091.8363265469347, 4098.6516146127615, 4102.5076990761, 4104.610062044116, 3184.394964956674, 4117.826419470466, 4122.268647168196, 4134.855280065183, 4172.582741725833, 3558.0, 3569.446735755962, 3572.8392222350058, 3576.624454432273, 3621.2033352662634, 4906.435759887623, 5171.043356978971, 5192.3249977503065, 5203.739813009334, 5254.4220135785035, 3532.7703699259464, 3919.098607320332, 3954.387070004154, 4703.811847526094, 4718.9292160617615, 5628.774849006035, 5699.0, 5757.222774925373, 5777.555611097226, 5805.448482394166, 3687.446882967576, 3913.4912461380122, 3939.4242303078713, 3940.4483372327895, 3958.34687276599, 5159.458256883011, 6040.667763273018, 6066.726997285089, 6089.878202435971, 6117.969410152965, 3737.2151848112203, 3982.3230050891416, 3987.7009224307712, 3992.301347264217, 4055.270051390778, 3043.832589207615, 3610.4764809102535, 3930.76415415076, 3985.70107241958, 4043.3732771420478, 3962.5443074046852, 4712.3742308903375, 4717.160307480085, 4718.150732868048, 4752.239641657318, 5526.58550608706, 5805.158252053428, 5809.0, 5823.941760582425, 5831.154482599999, 1489.2256026866185, 1496.872765814918, 1541.0676540692718, 1543.2669481995963, 1553.4252326639216, 1012.6253286284121, 1014.5941623350571, 1039.7088815131776, 1041.739565108723, 1043.7703705184847, 5748.48263656273, 5811.4479124483105, 5822.243108395882, 5828.329742079631, 5834.27071616048, 5648.548116150698, 5943.227380440515, 6391.488680905516, 6394.538102830351, 6470.0, 4559.430071241095, 4642.558956899089, 4708.4820669726305, 5354.732263386815, 5565.276514053228, 2825.7033011533904, 3079.692030796947, 3087.6603573606885, 3170.223295292668, 3407.3866703993517, 5557.749901254453, 6131.754729810757, 6179.907301390483, 6585.407313341822, 6659.633720145342, 6203.8138855834395, 6220.471259942865, 6246.875062498815, 6250.218722659668, 6299.937000630027, 5578.191162281365, 5818.912716309174, 6286.874262514724, 6296.653684047421, 6346.365363463709, 5046.520580544842, 5166.844994650167, 5846.210761547137, 5976.282846058501, 6087.965045942112, 5877.617954832922, 5913.70431478433, 5928.547505861092, 5935.792247271324, 5965.34381218057, 5712.0860662293835, 5878.265216847894, 6246.656433895998, 6249.531285153541, 6259.280182779039, 3343.7460952142947, 3381.9492707609897, 3943.38877473992, 3962.445257663872, 4003.5796241394232, 5078.238264260391, 5105.84682459512, 5705.400932902152, 5975.940240597713, 6030.819075427744, 5021.924671130009, 5074.198659475833, 5487.807926722546, 5774.797882074107, 5847.415258474119, 4892.657513973988, 5717.228174196596, 5774.769009239583, 5776.971115144397, 5799.159121927381, 5336.893262134813, 5649.0, 5679.233303503974, 5684.573656975661, 5702.600817942704, 5779.711014449176, 5811.86668599636, 5813.186153938367, 5828.533717302521, 5832.970835145967, 5023.668727787066, 5407.648502847303, 5665.631733937281, 5680.801171958961, 5689.6586204827845], "value": 4251.978069756831, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.8295468746095, 755.3768141283439, 757.56440046973, 762.1806557950201, 762.6034462079718, 12056.879431205685, 14609.269536523172, 15163.848361516382, 15180.848191518082, 15371.461998830044, 10619.522121504531, 11092.889071109286, 14281.50014749484, 14299.142051476918, 14305.856941430582, 721.2030706069796, 890.7728529225038, 916.4684482999844, 920.7744102694849, 928.2944961828991, 786.9252421020022, 931.8136372725448, 942.1379437814392, 942.5664194470552, 943.5188054092428, 965.8020105878278, 976.8046390721884, 991.4844280973889, 991.8859331176935, 994.1102713071797, 946.857971304303, 948.2840455456155, 985.9309848310621, 987.3680844259679, 987.7579992901749, 712.1276436365463, 712.5617745086735, 726.8001299642588, 729.0595132279353, 733.3619750816823, 14787.260636968109, 15013.624659383493, 15098.0, 15144.0, 15164.696706065817, 12864.678383040406, 12936.547220847226, 13055.477780888754, 13113.541026064042, 13199.736005279841, 10127.64553240633, 10306.381617102998, 10333.689989300334, 10401.895981040245, 10410.68767936963, 3444.8277586120594, 3456.87900923469, 3531.5938667053106, 3582.5342705448124, 3631.328204282216, 77154.22845771526, 77447.0, 82076.0, 83284.0, 84091.57954210251, 9226.446413215228, 9254.67608633708, 9278.443293402417, 9516.95241523788, 9518.428894266366, 18646.0, 22811.31566053021, 22830.885845570665, 22910.7708922912, 22959.426014349774, 7506.849863002819, 7675.577843218565, 7691.769246922601, 7723.227677232344, 7880.2513761192595, 4073.490813648294, 4128.731632443882, 4131.793410329472, 4132.607402296777, 4136.9793151034655, 3406.625271220164, 3463.0995941055508, 3472.9131771705406, 3478.113081164287, 3901.882943511699, 718.2888939949516, 719.5035425556454, 723.5730918757853, 726.2193142371972, 730.4594599995964, 388.89888628956675, 410.452046517896, 528.5137673340536, 571.2431028886741, 582.1936617784314, 7387.187409384964, 7826.452148349561, 8235.794105147419, 8296.294814940798, 8421.073681894986, 559.5831105826186, 560.4227645525116, 572.4790440699027, 620.3796203796204, 634.8317695810614, 3415.0267173855827, 3988.3419235826345, 4021.1756589899, 4048.817803198863, 4083.571225021389, 97576.51211744038, 98221.0, 100449.99550004407, 101202.0, 102445.0, 71088.22279442952, 71201.0, 71873.0, 76138.61930690311, 80178.59910700409, 66233.0, 67217.65564688777, 70823.0, 71650.64174679198, 73402.0, 7025.297470252934, 8195.016598008277, 8558.358123140664, 8572.52851093196, 8618.698345557876, 33665.66334336625, 42780.0, 43762.56237437712, 43816.0, 44282.55717442784, 63032.36967630265, 63061.0, 63581.0, 64630.67684661547, 65198.0, 10983.121350292116, 11066.833997489883, 11393.772124557629, 11474.311541307548, 11628.01161901214, 11879.643610691694, 11887.0, 11903.404829758305, 12316.13787034899, 12393.566225182436, 11461.484233209692, 11572.24780389272, 11614.767704646029, 11705.824412633647, 11758.311350909218, 11594.420278986187, 11713.824292635787, 11859.932606065495, 11997.280163190237, 12125.272483650657, 11362.772744545227, 11544.0, 11628.127890408423, 11868.0, 12231.816522751988, 9624.518774061129, 9735.0, 9794.363366381162, 9833.754156145867, 9931.602735890483, 8366.163383661586, 9041.819163616823, 9410.717678469657, 9446.291528135554, 9721.4653194075], "value": 6892.00257376888, "unit": "score"}], "name": "dromaeo_css", "value": 7125.729937970085, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 117.0, 142.0, 172.0, 168.0, 116.0, 116.0, 116.0, 118.0], "value": 129.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 144.0, 186.0, 202.0, 118.0, 141.0, 151.0, 124.0, 167.0, 121.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 206.0, 220.0, 209.0, 197.0, 196.0, 196.0, 201.0, 203.0, 198.0], "value": 203.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 74.0, 152.0, 86.0, 66.0, 57.0, 64.0, 114.0, 48.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 91.0, 128.0, 77.0, 79.0, 80.0, 119.0, 80.0, 79.0, 118.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 92.0, 89.0, 92.0, 88.0, 92.0, 88.0, 92.0, 88.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 98.0, 98.0, 95.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 89.0, 90.0, 98.0, 125.0, 90.0, 111.0, 147.0, 88.0], "value": 102.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 61.0, 62.0, 61.0, 63.0, 62.0, 75.0, 63.0, 61.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 96.0, 102.0, 98.0, 81.0, 74.0, 71.0, 69.0, 71.0, 70.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 83.0, 81.0, 99.0, 85.0, 83.0, 85.0, 87.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 164.0, 188.0, 122.0, 165.0, 152.0, 152.0, 164.0, 176.0, 150.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 227.0, 167.0, 164.0, 236.0, 225.0, 186.0, 230.0, 180.0, 217.0], "value": 200.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 71.0, 67.0, 69.0, 68.0, 70.0, 67.0, 71.0, 71.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1601.5, "alertThreshold": 2.0}]} 12:10:19 INFO - Return code: 0 12:10:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:10:19 ERROR - # TBPL SUCCESS # 12:10:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:10:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:10:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:10:19 INFO - 2016-04-25 12:10:19.117 screenresolution[1969:14904] starting screenresolution argv=screenresolution get 12:10:19 INFO - 2016-04-25 12:10:19.120 screenresolution[1969:14904] Display 0: 1600x1200x32@60 12:10:19 INFO - 2016-04-25 12:10:19.126 screenresolution[1970:14907] starting screenresolution argv=screenresolution list 12:10:19 INFO - Available Modes on Display 0 12:10:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:10:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:10:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:10:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:10:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:10:19 INFO - Intel Iris: 12:10:19 INFO - Chipset Model: Intel Iris 12:10:19 INFO - Type: GPU 12:10:19 INFO - Bus: Built-In 12:10:19 INFO - VRAM (Dynamic, Max): 1536 MB 12:10:19 INFO - Vendor: Intel (0x8086) 12:10:19 INFO - Device ID: 0x0a2e 12:10:19 INFO - Revision ID: 0x0009 12:10:19 INFO - Displays: 12:10:19 INFO - Display: 12:10:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:10:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:10:19 INFO - Display Serial Number: 1600x1200 60 12:10:19 INFO - Main Display: Yes 12:10:19 INFO - Mirror: Off 12:10:19 INFO - Online: Yes 12:10:19 INFO - Rotation: Supported 12:10:19 INFO - Return code: 0 12:10:19 INFO - Running post-action listener: _resource_record_post_action 12:10:19 INFO - Running post-run listener: _resource_record_post_run 12:10:20 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 544768; Write bytes: 696924160; Read time: 10; Write time: 1922 12:10:20 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 396030464; Write bytes: 397408256; Read time: 29828; Write time: 787 12:10:20 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 520192; Write bytes: 298668032; Read time: 9; Write time: 1132 12:10:20 INFO - Running post-run listener: _upload_blobber_files 12:10:20 INFO - Blob upload gear active. 12:10:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:10:20 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 12:10:20 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:10:20 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:10:20 INFO - (blobuploader) - INFO - Open directory for files ... 12:10:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:10:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:10:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:21 INFO - (blobuploader) - INFO - Done attempting. 12:10:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:10:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:10:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:23 INFO - (blobuploader) - INFO - Done attempting. 12:10:23 INFO - (blobuploader) - INFO - Iteration through files over. 12:10:23 INFO - Return code: 0 12:10:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:10:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:10:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56930b24f624ba9ca94b4b5085f87ac07201581a2d3f35844c38a74034ab5815ac58ae817cc6909a1c39cbb0cd0a5cc373dbcc151e1c025bb3d944c9712452e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6152693d81e9fa3f842d63824fc0c5ef2d3cfa9a69d91ae622b820921e89ec3f31f01967ee781d76efc3f214c4a3ae8ecfadabe7831447e5b7d508b84340a4c1"} 12:10:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:10:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:10:23 INFO - Contents: 12:10:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56930b24f624ba9ca94b4b5085f87ac07201581a2d3f35844c38a74034ab5815ac58ae817cc6909a1c39cbb0cd0a5cc373dbcc151e1c025bb3d944c9712452e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6152693d81e9fa3f842d63824fc0c5ef2d3cfa9a69d91ae622b820921e89ec3f31f01967ee781d76efc3f214c4a3ae8ecfadabe7831447e5b7d508b84340a4c1"} 12:10:23 INFO - Running post-run listener: copy_logs_to_upload_dir 12:10:23 INFO - Copying logs to upload dir... 12:10:23 INFO - mkdir: /builds/slave/test/build/upload/logs 12:10:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.114192 ========= master_lag: 2.71 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-25 12:10:25.941390) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-25 12:10:25.945542) ========= 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.mqnikKyyF2/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.ECVPOApt4p/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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/Fx-Team/sha512/56930b24f624ba9ca94b4b5085f87ac07201581a2d3f35844c38a74034ab5815ac58ae817cc6909a1c39cbb0cd0a5cc373dbcc151e1c025bb3d944c9712452e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6152693d81e9fa3f842d63824fc0c5ef2d3cfa9a69d91ae622b820921e89ec3f31f01967ee781d76efc3f214c4a3ae8ecfadabe7831447e5b7d508b84340a4c1"} build_url:https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011093 build_url: 'https://queue.taskcluster.net/v1/task/LyknnSryT7uAU8qjQFMsUA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56930b24f624ba9ca94b4b5085f87ac07201581a2d3f35844c38a74034ab5815ac58ae817cc6909a1c39cbb0cd0a5cc373dbcc151e1c025bb3d944c9712452e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6152693d81e9fa3f842d63824fc0c5ef2d3cfa9a69d91ae622b820921e89ec3f31f01967ee781d76efc3f214c4a3ae8ecfadabe7831447e5b7d508b84340a4c1"}' ========= master_lag: 1.93 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-25 12:10:27.886570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:10:27.886934) ========= 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.mqnikKyyF2/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.ECVPOApt4p/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.005129 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:10:27.964808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 12:10:27.965139) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 12:10:27.966956) ========= ========= Total master_lag: 4.80 =========