builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0298 starttime: 1468614913.93 results: success (0) buildid: 20160715110552 builduid: 414ae74d459a46868b9b8c3ffeb997f9 revision: ef57886bcaa6ba1423c1ca65f12b38ffb23d6ef8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:13.928835) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:13.929260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:13.929524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:13.955480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:13.955764) ========= 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.YK7xysAlV1/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.HWVLEKUPLa/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-15 13:35:13-- 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% 7.39M=0.002s 2016-07-15 13:35:14 (7.39 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:14.110053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:14.110572) ========= 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.YK7xysAlV1/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.HWVLEKUPLa/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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.021233 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:14.160362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 13:35:14.160685) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ef57886bcaa6ba1423c1ca65f12b38ffb23d6ef8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev ef57886bcaa6ba1423c1ca65f12b38ffb23d6ef8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YK7xysAlV1/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.HWVLEKUPLa/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-15 13:35:14,237 truncating revision to first 12 chars 2016-07-15 13:35:14,237 Setting DEBUG logging. 2016-07-15 13:35:14,238 attempt 1/10 2016-07-15 13:35:14,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ef57886bcaa6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 13:35:15,355 unpacking tar archive at: autoland-ef57886bcaa6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.471533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 13:35:15.653984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:15.654295) ========= script_repo_revision: ef57886bcaa6ba1423c1ca65f12b38ffb23d6ef8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:15.654692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:15.655018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 13:35:15.695578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-15 13:35:15.695991) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YK7xysAlV1/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.HWVLEKUPLa/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:35:15 INFO - MultiFileLogger online at 20160715 13:35:15 in /builds/slave/test 13:35:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 13:35:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:35:15 INFO - {'append_to_log': False, 13:35:15 INFO - 'base_work_dir': '/builds/slave/test', 13:35:15 INFO - 'blob_upload_branch': 'Autoland', 13:35:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:35:15 INFO - 'branch': 'Autoland', 13:35:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:35:15 INFO - 'config_files': ('talos/mac_config.py',), 13:35:15 INFO - 'default_actions': ('clobber', 13:35:15 INFO - 'read-buildbot-config', 13:35:15 INFO - 'download-and-extract', 13:35:15 INFO - 'populate-webroot', 13:35:15 INFO - 'create-virtualenv', 13:35:15 INFO - 'install', 13:35:15 INFO - 'run-tests'), 13:35:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:35:15 INFO - 'download_minidump_stackwalk': True, 13:35:15 INFO - 'download_symbols': 'ondemand', 13:35:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:35:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:35:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:35:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:35:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:35:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:35:15 INFO - 'installer_path': 'installer.exe', 13:35:15 INFO - 'log_level': 'info', 13:35:15 INFO - 'log_name': 'talos', 13:35:15 INFO - 'log_to_console': True, 13:35:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:35:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:35:15 INFO - 'opt_config_files': (), 13:35:15 INFO - 'pip_index': False, 13:35:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:35:15 INFO - 'cmd': ('bash', 13:35:15 INFO - '-c', 13:35:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:35:15 INFO - 'enabled': True, 13:35:15 INFO - 'halt_on_failure': False, 13:35:15 INFO - 'name': 'check_screen_resolution'},), 13:35:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:35:15 INFO - 'cmd': ('bash', 13:35:15 INFO - '-c', 13:35:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:35:15 INFO - 'enabled': True, 13:35:15 INFO - 'halt_on_failure': False, 13:35:15 INFO - 'name': 'check_screen_resolution'},), 13:35:15 INFO - 'run_cmd_checks_enabled': True, 13:35:15 INFO - 'sps_profile': False, 13:35:15 INFO - 'sps_profile_interval': 0, 13:35:15 INFO - 'suite': 'dromaeojs', 13:35:15 INFO - 'system_bits': '32', 13:35:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:35:15 INFO - 'title': 't-yosemite-r7-0298', 13:35:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:35:15 INFO - 'use_talos_json': True, 13:35:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:35:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:35:15 INFO - 'work_dir': 'build'} 13:35:15 INFO - ##### 13:35:15 INFO - ##### Running clobber step. 13:35:15 INFO - ##### 13:35:15 INFO - Running pre-action listener: _resource_record_pre_action 13:35:15 INFO - Running main action method: clobber 13:35:15 INFO - rmtree: /builds/slave/test/build 13:35:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:35:17 INFO - Running post-action listener: _resource_record_post_action 13:35:17 INFO - ##### 13:35:17 INFO - ##### Finished clobber step (success) 13:35:17 INFO - ##### 13:35:17 INFO - ##### 13:35:17 INFO - ##### Running read-buildbot-config step. 13:35:17 INFO - ##### 13:35:17 INFO - Running pre-action listener: _resource_record_pre_action 13:35:17 INFO - Running main action method: read_buildbot_config 13:35:17 INFO - Using buildbot properties: 13:35:17 INFO - { 13:35:17 INFO - "project": "", 13:35:17 INFO - "product": "firefox", 13:35:17 INFO - "script_repo_revision": "production", 13:35:17 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 13:35:17 INFO - "repository": "", 13:35:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 13:35:17 INFO - "buildid": "20160715110552", 13:35:17 INFO - "pgo_build": "False", 13:35:17 INFO - "basedir": "/builds/slave/test", 13:35:17 INFO - "buildnumber": 64, 13:35:17 INFO - "slavename": "t-yosemite-r7-0298", 13:35:17 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 13:35:17 INFO - "platform": "yosemite_r7", 13:35:17 INFO - "scheduler": "tests-autoland-macosx64-talos", 13:35:17 INFO - "branch": "autoland", 13:35:17 INFO - "repo_path": "integration/autoland", 13:35:17 INFO - "revision": "ef57886bcaa6ba1423c1ca65f12b38ffb23d6ef8", 13:35:17 INFO - "stage_platform": "macosx64", 13:35:17 INFO - "builduid": "414ae74d459a46868b9b8c3ffeb997f9", 13:35:17 INFO - "slavebuilddir": "test" 13:35:17 INFO - } 13:35:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 13:35:17 INFO - Running post-action listener: _resource_record_post_action 13:35:17 INFO - ##### 13:35:17 INFO - ##### Finished read-buildbot-config step (success) 13:35:17 INFO - ##### 13:35:17 INFO - ##### 13:35:17 INFO - ##### Running download-and-extract step. 13:35:17 INFO - ##### 13:35:17 INFO - Running pre-action listener: _resource_record_pre_action 13:35:17 INFO - Running main action method: download_and_extract 13:35:17 INFO - mkdir: /builds/slave/test/build/tests 13:35:17 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')]} 13:35:17 INFO - https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:35:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:35:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:35:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 13:35:18 INFO - Downloaded 1199 bytes. 13:35:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:35:18 INFO - Using the following test package requirements: 13:35:18 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:35:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:35:18 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 13:35:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:35:18 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 13:35:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:35:18 INFO - u'jsshell-mac.zip'], 13:35:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:35:18 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 13:35:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:35:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:35:18 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 13:35:18 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:35:18 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 13:35:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:35:18 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 13:35:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:35:18 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 13:35:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:35:18 INFO - https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:35:19 INFO - Downloaded 18829242 bytes. 13:35:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:35:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:35:23 INFO - Return code: 0 13:35:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:35:23 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')]} 13:35:23 INFO - https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:35:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:35:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:35:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:35:25 INFO - Downloaded 18829242 bytes. 13:35:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:35:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:35:28 INFO - Return code: 0 13:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:28 INFO - https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:35:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:35:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:35:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:35:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:35:29 INFO - Downloaded 14403317 bytes. 13:35:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:35:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:35:30 INFO - Return code: 0 13:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:30 INFO - https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:35:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:35:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:35:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 13:35:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 13:35:33 INFO - Downloaded 112750925 bytes. 13:35:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:35:33 INFO - mkdir: /builds/slave/test/properties 13:35:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:35:33 INFO - Writing to file /builds/slave/test/properties/build_url 13:35:33 INFO - Contents: 13:35:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:35:33 INFO - Running post-action listener: _resource_record_post_action 13:35:33 INFO - Running post-action listener: set_extra_try_arguments 13:35:33 INFO - ##### 13:35:33 INFO - ##### Finished download-and-extract step (success) 13:35:33 INFO - ##### 13:35:33 INFO - ##### 13:35:33 INFO - ##### Running populate-webroot step. 13:35:33 INFO - ##### 13:35:33 INFO - Running pre-action listener: _resource_record_pre_action 13:35:33 INFO - Running main action method: populate_webroot 13:35:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:35:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:35:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:35:33 INFO - '--tppagecycles', 13:35:33 INFO - '7'], 13:35:33 INFO - 'tests': ['tsvgm']}}, 13:35:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:35:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:35:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:35:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:35:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:33 INFO - 'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:33 INFO - 'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['damp', 'tps']}, 13:35:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:33 INFO - 'tests': ['damp', 'tps']}, 13:35:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['dromaeo_dom']}, 13:35:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:35:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['basic_compositor_video']}, 13:35:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:35:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['a11yr', 13:35:33 INFO - 'ts_paint', 13:35:33 INFO - 'tpaint', 13:35:33 INFO - 'sessionrestore', 13:35:33 INFO - 'sessionrestore_no_auto_restore', 13:35:33 INFO - 'tabpaint']}, 13:35:33 INFO - 'other-e10s': {'tests': ['a11yr', 13:35:33 INFO - 'ts_paint', 13:35:33 INFO - 'tpaint', 13:35:33 INFO - 'sessionrestore', 13:35:33 INFO - 'sessionrestore_no_auto_restore', 13:35:33 INFO - 'tabpaint']}, 13:35:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:35:33 INFO - 'ts_paint', 13:35:33 INFO - 'tpaint', 13:35:33 INFO - 'sessionrestore', 13:35:33 INFO - 'sessionrestore_no_auto_restore', 13:35:33 INFO - 'tabpaint']}, 13:35:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:35:33 INFO - 'ts_paint', 13:35:33 INFO - 'tpaint', 13:35:33 INFO - 'sessionrestore', 13:35:33 INFO - 'sessionrestore_no_auto_restore', 13:35:33 INFO - 'tabpaint']}, 13:35:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['a11yr', 13:35:33 INFO - 'ts_paint', 13:35:33 INFO - 'tpaint', 13:35:33 INFO - 'sessionrestore', 13:35:33 INFO - 'sessionrestore_no_auto_restore', 13:35:33 INFO - 'tabpaint']}, 13:35:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['a11yr', 13:35:33 INFO - 'ts_paint', 13:35:33 INFO - 'tpaint', 13:35:33 INFO - 'sessionrestore', 13:35:33 INFO - 'sessionrestore_no_auto_restore', 13:35:33 INFO - 'tabpaint']}, 13:35:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['tsvgx', 13:35:33 INFO - 'tsvgr_opacity', 13:35:33 INFO - 'tart', 13:35:33 INFO - 'tscrollx', 13:35:33 INFO - 'cart']}, 13:35:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:35:33 INFO - 'tsvgr_opacity', 13:35:33 INFO - 'tart', 13:35:33 INFO - 'tscrollx', 13:35:33 INFO - 'cart']}, 13:35:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:33 INFO - 'talos_options': ['--disable-e10s'], 13:35:33 INFO - 'tests': ['tp5o']}, 13:35:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:33 INFO - 'tests': ['tp5o']}, 13:35:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:33 INFO - 'talos_options': ['--disable-e10s', 13:35:33 INFO - '--xperf_path', 13:35:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:33 INFO - 'tests': ['tp5n']}, 13:35:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:33 INFO - 'talos_options': ['--xperf_path', 13:35:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:33 INFO - 'tests': ['tp5n']}}, 13:35:33 INFO - 'talos.zip': {'path': '', 13:35:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:35:33 INFO - Running post-action listener: _resource_record_post_action 13:35:33 INFO - ##### 13:35:33 INFO - ##### Finished populate-webroot step (success) 13:35:33 INFO - ##### 13:35:33 INFO - ##### 13:35:33 INFO - ##### Running create-virtualenv step. 13:35:33 INFO - ##### 13:35:33 INFO - Running pre-action listener: _resource_record_pre_action 13:35:33 INFO - Running main action method: create_virtualenv 13:35:33 INFO - Creating virtualenv /builds/slave/test/build/venv 13:35:33 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 13:35:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:35:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:35:34 INFO - Using real prefix '/tools/python27' 13:35:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:35:34 INFO - Installing distribute.............................................................................................................................................................................................done. 13:35:37 INFO - Installing pip.................done. 13:35:37 INFO - Return code: 0 13:35:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:35:37 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')]} 13:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:37 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')]} 13:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:37 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 0x1101cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe19495680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, '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.YK7xysAlV1/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.HWVLEKUPLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:35:37 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 13:35:37 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 13:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:37 INFO - 'HOME': '/Users/cltbld', 13:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:37 INFO - 'LOGNAME': 'cltbld', 13:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:37 INFO - 'MOZ_NO_REMOTE': '1', 13:35:37 INFO - 'NO_EM_RESTART': '1', 13:35:37 INFO - 'PAGER': '/bin/cat', 13:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:37 INFO - 'PWD': '/builds/slave/test', 13:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:37 INFO - 'SHELL': '/bin/bash', 13:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:35:37 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:37 INFO - 'USER': 'cltbld', 13:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:37 INFO - 'XPC_FLAGS': '0x0', 13:35:37 INFO - 'XPC_SERVICE_NAME': '0', 13:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:37 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 13:35:37 INFO - Cleaning up... 13:35:37 INFO - Return code: 0 13:35:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:35:37 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')]} 13:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:37 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')]} 13:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe19495680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, '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.YK7xysAlV1/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.HWVLEKUPLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:37 INFO - 'HOME': '/Users/cltbld', 13:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:37 INFO - 'LOGNAME': 'cltbld', 13:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:37 INFO - 'MOZ_NO_REMOTE': '1', 13:35:37 INFO - 'NO_EM_RESTART': '1', 13:35:37 INFO - 'PAGER': '/bin/cat', 13:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:37 INFO - 'PWD': '/builds/slave/test', 13:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:37 INFO - 'SHELL': '/bin/bash', 13:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:35:37 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:37 INFO - 'USER': 'cltbld', 13:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:37 INFO - 'XPC_FLAGS': '0x0', 13:35:37 INFO - 'XPC_SERVICE_NAME': '0', 13:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:38 INFO - Downloading/unpacking psutil>=3.1.1 13:35:38 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 13:35:38 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 13:35:38 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 13:35:38 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 13:35:38 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 13:35:38 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 13:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:41 INFO - Installing collected packages: psutil 13:35:41 INFO - Running setup.py install for psutil 13:35:41 INFO - building 'psutil._psutil_osx' extension 13:35:41 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 13:35:41 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 13:35:41 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 13:35:41 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 13:35:41 INFO - building 'psutil._psutil_posix' extension 13:35:41 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 13:35:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:35:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:35:41 INFO - ^ 13:35:41 INFO - 1 warning generated. 13:35:41 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 13:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:42 INFO - Successfully installed psutil 13:35:42 INFO - Cleaning up... 13:35:42 INFO - Return code: 0 13:35:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:35:42 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')]} 13:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:42 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')]} 13:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe19495680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, '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.YK7xysAlV1/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.HWVLEKUPLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:42 INFO - 'HOME': '/Users/cltbld', 13:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:42 INFO - 'LOGNAME': 'cltbld', 13:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:42 INFO - 'MOZ_NO_REMOTE': '1', 13:35:42 INFO - 'NO_EM_RESTART': '1', 13:35:42 INFO - 'PAGER': '/bin/cat', 13:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:42 INFO - 'PWD': '/builds/slave/test', 13:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:42 INFO - 'SHELL': '/bin/bash', 13:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:35:42 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:42 INFO - 'USER': 'cltbld', 13:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:42 INFO - 'XPC_FLAGS': '0x0', 13:35:42 INFO - 'XPC_SERVICE_NAME': '0', 13:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:35:44 INFO - Installing collected packages: mozsystemmonitor 13:35:44 INFO - Running setup.py install for mozsystemmonitor 13:35:45 INFO - Successfully installed mozsystemmonitor 13:35:45 INFO - Cleaning up... 13:35:45 INFO - Return code: 0 13:35:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe19495680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, '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.YK7xysAlV1/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.HWVLEKUPLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:35:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:35:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:35:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:45 INFO - 'HOME': '/Users/cltbld', 13:35:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:45 INFO - 'LOGNAME': 'cltbld', 13:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:45 INFO - 'MOZ_NO_REMOTE': '1', 13:35:45 INFO - 'NO_EM_RESTART': '1', 13:35:45 INFO - 'PAGER': '/bin/cat', 13:35:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:45 INFO - 'PWD': '/builds/slave/test', 13:35:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:45 INFO - 'SHELL': '/bin/bash', 13:35:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:35:45 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:35:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:45 INFO - 'USER': 'cltbld', 13:35:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:45 INFO - 'XPC_FLAGS': '0x0', 13:35:45 INFO - 'XPC_SERVICE_NAME': '0', 13:35:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:45 INFO - Downloading/unpacking jsonschema==2.5.1 13:35:45 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 13:35:45 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 13:35:45 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 13:35:45 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 13:35:45 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 13:35:45 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 13:35:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:35:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:48 INFO - Downloading functools32-3.2.3-2.tar.gz 13:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:35:48 INFO - warning: no files found matching '*.txt' 13:35:48 INFO - no previously-included directories found matching 'build' 13:35:48 INFO - no previously-included directories found matching 'dist' 13:35:48 INFO - no previously-included directories found matching '.git*' 13:35:48 INFO - Installing collected packages: jsonschema, functools32 13:35:48 INFO - Running setup.py install for functools32 13:35:48 INFO - warning: no files found matching '*.txt' 13:35:48 INFO - no previously-included directories found matching 'build' 13:35:48 INFO - no previously-included directories found matching 'dist' 13:35:48 INFO - no previously-included directories found matching '.git*' 13:35:48 INFO - Successfully installed jsonschema functools32 13:35:48 INFO - Cleaning up... 13:35:48 INFO - Return code: 0 13:35:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:48 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 0x1101cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe19495680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, '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.YK7xysAlV1/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.HWVLEKUPLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:35:48 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 13:35:48 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 13:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:48 INFO - 'HOME': '/Users/cltbld', 13:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:48 INFO - 'LOGNAME': 'cltbld', 13:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:48 INFO - 'MOZ_NO_REMOTE': '1', 13:35:48 INFO - 'NO_EM_RESTART': '1', 13:35:48 INFO - 'PAGER': '/bin/cat', 13:35:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:48 INFO - 'PWD': '/builds/slave/test', 13:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:48 INFO - 'SHELL': '/bin/bash', 13:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:35:48 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:48 INFO - 'USER': 'cltbld', 13:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:48 INFO - 'XPC_FLAGS': '0x0', 13:35:48 INFO - 'XPC_SERVICE_NAME': '0', 13:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:35:48 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 13:35:48 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 13:35:48 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 13:35:48 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 13:35:48 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 13:35:48 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 13:35:51 INFO - Downloading blobuploader-1.2.4.tar.gz 13:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:35:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:35:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:52 INFO - Downloading docopt-0.6.1.tar.gz 13:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:35:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:35:52 INFO - Running setup.py install for blobuploader 13:35:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:35:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:35:52 INFO - Running setup.py install for requests 13:35:53 INFO - Running setup.py install for docopt 13:35:53 INFO - Successfully installed blobuploader requests docopt 13:35:53 INFO - Cleaning up... 13:35:53 INFO - Return code: 0 13:35:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:53 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')]} 13:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:53 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')]} 13:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:53 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 0x1101cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe19495680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, '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.YK7xysAlV1/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.HWVLEKUPLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:35:53 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 13:35:53 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 13:35:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:35:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:53 INFO - 'HOME': '/Users/cltbld', 13:35:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:53 INFO - 'LOGNAME': 'cltbld', 13:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:53 INFO - 'MOZ_NO_REMOTE': '1', 13:35:53 INFO - 'NO_EM_RESTART': '1', 13:35:53 INFO - 'PAGER': '/bin/cat', 13:35:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:53 INFO - 'PWD': '/builds/slave/test', 13:35:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:53 INFO - 'SHELL': '/bin/bash', 13:35:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:35:53 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:35:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:53 INFO - 'USER': 'cltbld', 13:35:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:53 INFO - 'XPC_FLAGS': '0x0', 13:35:53 INFO - 'XPC_SERVICE_NAME': '0', 13:35:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:53 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-ZlmMZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:53 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-5K4Fd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:53 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-YX5qcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:53 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-MMNh9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:54 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-ROCXKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:54 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-hVi1x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:54 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-BpiqkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:54 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-y60XfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:54 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-avcz8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:54 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-3jjDdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:54 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-57J3q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:54 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-nglP7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:54 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-yGe6VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:55 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-zZ_bRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:55 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-fZNRy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:55 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-3_ZNHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:55 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-qlj2dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:35:55 INFO - Running setup.py install for manifestparser 13:35:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:35:55 INFO - Running setup.py install for mozcrash 13:35:55 INFO - Running setup.py install for mozdebug 13:35:55 INFO - Running setup.py install for mozdevice 13:35:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:35:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:35:56 INFO - Running setup.py install for mozfile 13:35:56 INFO - Running setup.py install for mozhttpd 13:35:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:35:56 INFO - Running setup.py install for mozinfo 13:35:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:35:56 INFO - Running setup.py install for mozInstall 13:35:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:35:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:35:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:35:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:35:56 INFO - Running setup.py install for mozleak 13:35:56 INFO - Running setup.py install for mozlog 13:35:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:35:56 INFO - Running setup.py install for moznetwork 13:35:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:35:57 INFO - Running setup.py install for mozprocess 13:35:57 INFO - Running setup.py install for mozprofile 13:35:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:35:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:35:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:35:57 INFO - Running setup.py install for mozrunner 13:35:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:35:57 INFO - Running setup.py install for mozscreenshot 13:35:57 INFO - Running setup.py install for moztest 13:35:57 INFO - Running setup.py install for mozversion 13:35:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:35:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:35:57 INFO - Cleaning up... 13:35:57 INFO - Return code: 0 13:35:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:57 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 0x1101cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe19495680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, '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.YK7xysAlV1/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.HWVLEKUPLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:35:57 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 13:35:57 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 13:35:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:35:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:57 INFO - 'HOME': '/Users/cltbld', 13:35:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:57 INFO - 'LOGNAME': 'cltbld', 13:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:57 INFO - 'MOZ_NO_REMOTE': '1', 13:35:57 INFO - 'NO_EM_RESTART': '1', 13:35:57 INFO - 'PAGER': '/bin/cat', 13:35:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:57 INFO - 'PWD': '/builds/slave/test', 13:35:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:57 INFO - 'SHELL': '/bin/bash', 13:35:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:35:57 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:35:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:57 INFO - 'USER': 'cltbld', 13:35:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:57 INFO - 'XPC_FLAGS': '0x0', 13:35:57 INFO - 'XPC_SERVICE_NAME': '0', 13:35:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:58 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-LGuqjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:58 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)) 13:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:58 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-0NygpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:58 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)) 13:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:58 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-rRn7qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:58 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)) 13:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:58 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-_pVLUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:58 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)) 13:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:58 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-p1D5eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:58 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)) 13:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:58 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-2v3xd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:58 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)) 13:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:58 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-AJhrz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:58 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)) 13:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:58 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-CiF0mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:59 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)) 13:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:59 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-QxSTIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:59 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)) 13:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:59 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-N7jnwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:59 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-_ufkM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:59 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)) 13:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:59 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-bUXgji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:59 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-zoNQND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:59 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)) 13:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:59 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-TAzdo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:59 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-7FWJkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:59 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)) 13:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:59 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-xyVpoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:59 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)) 13:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:59 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-0a2kmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:00 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)) 13:36:00 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)) 13:36:00 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)) 13:36:00 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)) 13:36:00 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)) 13:36:00 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)) 13:36:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:36:00 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 13:36:00 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 13:36:00 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 13:36:00 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 13:36:00 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 13:36:00 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 13:36:02 INFO - Downloading blessings-1.6.tar.gz 13:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:36:02 INFO - Installing collected packages: blessings 13:36:02 INFO - Running setup.py install for blessings 13:36:02 INFO - Successfully installed blessings 13:36:02 INFO - Cleaning up... 13:36:02 INFO - Return code: 0 13:36:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:36:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:03 INFO - Reading from file tmpfile_stdout 13:36:03 INFO - Current package versions: 13:36:03 INFO - blessings == 1.6 13:36:03 INFO - blobuploader == 1.2.4 13:36:03 INFO - docopt == 0.6.1 13:36:03 INFO - functools32 == 3.2.3-2 13:36:03 INFO - jsonschema == 2.5.1 13:36:03 INFO - manifestparser == 1.1 13:36:03 INFO - mozInstall == 1.12 13:36:03 INFO - mozcrash == 0.17 13:36:03 INFO - mozdebug == 0.1 13:36:03 INFO - mozdevice == 0.48 13:36:03 INFO - mozfile == 1.2 13:36:03 INFO - mozhttpd == 0.7 13:36:03 INFO - mozinfo == 0.9 13:36:03 INFO - mozleak == 0.1 13:36:03 INFO - mozlog == 3.2 13:36:03 INFO - moznetwork == 0.27 13:36:03 INFO - mozprocess == 0.23 13:36:03 INFO - mozprofile == 0.28 13:36:03 INFO - mozrunner == 6.12 13:36:03 INFO - mozscreenshot == 0.1 13:36:03 INFO - mozsystemmonitor == 0.3 13:36:03 INFO - moztest == 0.7 13:36:03 INFO - mozversion == 1.4 13:36:03 INFO - psutil == 3.1.1 13:36:03 INFO - requests == 1.2.3 13:36:03 INFO - wsgiref == 0.1.2 13:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:03 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 0x1101cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe19495680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, '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.YK7xysAlV1/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.HWVLEKUPLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:36:03 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 13:36:03 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 13:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:03 INFO - 'HOME': '/Users/cltbld', 13:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:03 INFO - 'LOGNAME': 'cltbld', 13:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:03 INFO - 'MOZ_NO_REMOTE': '1', 13:36:03 INFO - 'NO_EM_RESTART': '1', 13:36:03 INFO - 'PAGER': '/bin/cat', 13:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:03 INFO - 'PWD': '/builds/slave/test', 13:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:03 INFO - 'SHELL': '/bin/bash', 13:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:36:03 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:03 INFO - 'USER': 'cltbld', 13:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:03 INFO - 'XPC_FLAGS': '0x0', 13:36:03 INFO - 'XPC_SERVICE_NAME': '0', 13:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:03 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)) 13:36:03 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)) 13:36:03 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)) 13:36:03 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)) 13:36:03 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)) 13:36:03 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)) 13:36:03 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)) 13:36:03 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)) 13:36:03 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)) 13:36:03 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)) 13:36:03 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)) 13:36:03 INFO - Cleaning up... 13:36:03 INFO - Return code: 0 13:36:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:03 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 0x1101cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110261618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe19495680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, '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.YK7xysAlV1/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.HWVLEKUPLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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 13:36:03 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 13:36:03 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 13:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:03 INFO - 'HOME': '/Users/cltbld', 13:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:03 INFO - 'LOGNAME': 'cltbld', 13:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:03 INFO - 'MOZ_NO_REMOTE': '1', 13:36:03 INFO - 'NO_EM_RESTART': '1', 13:36:03 INFO - 'PAGER': '/bin/cat', 13:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:03 INFO - 'PWD': '/builds/slave/test', 13:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:03 INFO - 'SHELL': '/bin/bash', 13:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:36:03 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:03 INFO - 'USER': 'cltbld', 13:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:03 INFO - 'XPC_FLAGS': '0x0', 13:36:03 INFO - 'XPC_SERVICE_NAME': '0', 13:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:36:03 INFO - Cleaning up... 13:36:03 INFO - Return code: 0 13:36:03 INFO - Running post-action listener: _resource_record_post_action 13:36:03 INFO - Running post-action listener: _start_resource_monitoring 13:36:03 INFO - Starting resource monitoring. 13:36:03 INFO - ##### 13:36:03 INFO - ##### Finished create-virtualenv step (success) 13:36:03 INFO - ##### 13:36:03 INFO - ##### 13:36:03 INFO - ##### Running install step. 13:36:03 INFO - ##### 13:36:03 INFO - Running pre-action listener: _resource_record_pre_action 13:36:03 INFO - Running main action method: install 13:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:03 INFO - Reading from file tmpfile_stdout 13:36:03 INFO - Detecting whether we're running mozinstall >=1.0... 13:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:36:03 INFO - Reading from file tmpfile_stdout 13:36:03 INFO - Output received: 13:36:03 INFO - Usage: mozinstall [options] installer 13:36:03 INFO - Options: 13:36:03 INFO - -h, --help show this help message and exit 13:36:03 INFO - -d DEST, --destination=DEST 13:36:03 INFO - Directory to install application into. [default: 13:36:03 INFO - "/builds/slave/test"] 13:36:03 INFO - --app=APP Application being installed. [default: firefox] 13:36:03 INFO - mkdir: /builds/slave/test/build/application 13:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:36:38 INFO - Reading from file tmpfile_stdout 13:36:38 INFO - Output received: 13:36:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:36:38 INFO - Running post-action listener: _resource_record_post_action 13:36:38 INFO - ##### 13:36:38 INFO - ##### Finished install step (success) 13:36:38 INFO - ##### 13:36:38 INFO - ##### 13:36:38 INFO - ##### Running run-tests step. 13:36:38 INFO - ##### 13:36:38 INFO - Running pre-action listener: _resource_record_pre_action 13:36:38 INFO - Running main action method: run_tests 13:36:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:36:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:36:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:36:38 INFO - 2016-07-15 13:36:38.360 screenresolution[6686:113167] starting screenresolution argv=screenresolution get 13:36:38 INFO - 2016-07-15 13:36:38.363 screenresolution[6686:113167] Display 0: 1600x1200x32@60 13:36:38 INFO - 2016-07-15 13:36:38.368 screenresolution[6687:113169] starting screenresolution argv=screenresolution list 13:36:38 INFO - Available Modes on Display 0 13:36:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:36:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:36:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:36:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:36:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:36:38 INFO - Intel Iris: 13:36:38 INFO - Chipset Model: Intel Iris 13:36:38 INFO - Type: GPU 13:36:38 INFO - Bus: Built-In 13:36:38 INFO - VRAM (Dynamic, Max): 1536 MB 13:36:38 INFO - Vendor: Intel (0x8086) 13:36:38 INFO - Device ID: 0x0a2e 13:36:38 INFO - Revision ID: 0x0009 13:36:38 INFO - Displays: 13:36:38 INFO - Display: 13:36:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:36:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:36:38 INFO - Display Serial Number: 1600x1200 60 13:36:38 INFO - Main Display: Yes 13:36:38 INFO - Mirror: Off 13:36:38 INFO - Online: Yes 13:36:38 INFO - Rotation: Supported 13:36:38 INFO - Return code: 0 13:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:36:38 INFO - Python 2.7.3 13:36:38 INFO - Return code: 0 13:36:38 INFO - grabbing minidump binary from tooltool 13:36:38 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')]} 13:36:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110130d30>, '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 0x10fe95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110128b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:36:38 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 13:36:38 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 13:36:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:36:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:36:38 INFO - Return code: 0 13:36:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:36:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:36:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:36:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:36:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0298', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0298 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:36:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YK7xysAlV1/Render', 13:36:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:38 INFO - 'HOME': '/Users/cltbld', 13:36:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:38 INFO - 'LOGNAME': 'cltbld', 13:36:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:36:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:38 INFO - 'MOZ_NO_REMOTE': '1', 13:36:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:36:38 INFO - 'NO_EM_RESTART': '1', 13:36:38 INFO - 'PAGER': '/bin/cat', 13:36:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:38 INFO - 'PWD': '/builds/slave/test', 13:36:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:36:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:38 INFO - 'SHELL': '/bin/bash', 13:36:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HWVLEKUPLa/Listeners', 13:36:38 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:36:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:38 INFO - 'USER': 'cltbld', 13:36:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:38 INFO - 'XPC_FLAGS': '0x0', 13:36:38 INFO - 'XPC_SERVICE_NAME': '0', 13:36:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0298', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:36:38 INFO - mozversion application_buildid: 20160715110552 13:36:38 INFO - mozversion application_changeset: ef57886bcaa6ba1423c1ca65f12b38ffb23d6ef8 13:36:38 INFO - mozversion application_display_name: Nightly 13:36:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:36:38 INFO - mozversion application_name: Firefox 13:36:38 INFO - mozversion application_remotingname: firefox 13:36:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:36:38 INFO - mozversion application_vendor: Mozilla 13:36:38 INFO - mozversion application_version: 50.0a1 13:36:38 INFO - mozversion platform_buildid: 20160715110552 13:36:38 INFO - mozversion platform_changeset: ef57886bcaa6ba1423c1ca65f12b38ffb23d6ef8 13:36:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:36:38 INFO - mozversion platform_version: 50.0a1 13:36:38 INFO - using testdate: 1468614998 13:36:38 INFO - actual date: 1468614998 13:36:38 INFO - starting webserver on 'localhost:60081' 13:36:38 INFO - SUITE-START | Running 2 tests 13:36:38 INFO - TEST-START | dromaeo_css 13:36:38 INFO - operating with platform_type : mac_ 13:36:38 INFO - Initialising browser for dromaeo_css test... 13:36:38 INFO - TEST-INFO | started process 6697 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/tmpzIHfjs/profile http://localhost:60081/getInfo.html) 13:36:41 INFO - PROCESS | 6697 | __metrics Screen width/height:1600/1200 13:36:41 INFO - PROCESS | 6697 | colorDepth:24 13:36:41 INFO - PROCESS | 6697 | Browser inner width/height: 1024/689 13:36:41 INFO - PROCESS | 6697 | __metrics 13:36:41 INFO - PROCESS | 6697 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:36:41 INFO - PROCESS | 6697 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:36:42 INFO - TEST-INFO | 6697: exit 0 13:36:42 INFO - Browser initialized. 13:36:42 INFO - Running cycle 1/1 for dromaeo_css test... 13:36:42 INFO - TEST-INFO | started process 6699 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/tmpzIHfjs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:54 INFO - PROCESS | 6699 | RSS: Main: 243769344 13:36:54 INFO - PROCESS | 6699 | 13:37:45 INFO - PROCESS | 6699 | 1468615065575 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] 13:39:56 INFO - PROCESS | 6699 | Cycle 1(1): loaded http://localhost:60081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60081/tests/dromaeo/cssquery-ext.html) 13:39:57 INFO - PROCESS | 6699 | RSS: Main: 359051264 13:39:57 INFO - PROCESS | 6699 | 13:43:00 INFO - PROCESS | 6699 | Cycle 1(1): loaded http://localhost:60081/tests/dromaeo/cssquery-ext.html (next: http://localhost:60081/tests/dromaeo/cssquery-jquery.html) 13:43:01 INFO - PROCESS | 6699 | RSS: Main: 382529536 13:43:01 INFO - PROCESS | 6699 | 13:46:03 INFO - PROCESS | 6699 | Cycle 1(1): loaded http://localhost:60081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60081/tests/dromaeo/cssquery-mootools.html) 13:46:04 INFO - PROCESS | 6699 | RSS: Main: 371335168 13:46:04 INFO - PROCESS | 6699 | 13:49:06 INFO - PROCESS | 6699 | Cycle 1(1): loaded http://localhost:60081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60081/tests/dromaeo/cssquery-prototype.html) 13:49:06 INFO - PROCESS | 6699 | RSS: Main: 370941952 13:49:06 INFO - PROCESS | 6699 | 13:52:10 INFO - PROCESS | 6699 | Cycle 1(1): loaded http://localhost:60081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60081/tests/dromaeo/cssquery-yui.html) 13:52:11 INFO - PROCESS | 6699 | RSS: Main: 338264064 13:52:11 INFO - PROCESS | 6699 | 13:55:14 INFO - PROCESS | 6699 | Cycle 1(1): loaded http://localhost:60081/tests/dromaeo/cssquery-yui.html (next: http://localhost:60081/tests/dromaeo/cssquery-dojo.html) 13:55:14 INFO - PROCESS | 6699 | RSS: Main: 429322240 13:55:14 INFO - PROCESS | 6699 | 13:55:14 INFO - PROCESS | 6699 | __start_tp_report 13:55:14 INFO - PROCESS | 6699 | _x_x_mozilla_page_load 13:55:14 INFO - PROCESS | 6699 | _x_x_mozilla_page_load_details 13:55:14 INFO - PROCESS | 6699 | |i|pagename|runs| 13:55:14 INFO - PROCESS | 6699 | |0;dojo.html;2929.721676440738;3328.667133286673;3332.5167850661655;3351.7151042161413;3391.592489117015;5572.442755724435;5680.005998950178;5690.886182276352;5759.683217423045;5801.970990145049;5722.313322401307;5760.855978600526;5865.70671466426;5872.4127587241255;5914.467697907187;5163.561097306715;5182.818601348954;5224.085784987631;5230;5317.787288508455;5311.362636483627;5350.438203988583;5355.7857685692725;5379.193121031857;5384.946150538503;5148.176291793314;5212.53087222148;5212.661177023481;5224.555912747421;5270.367555893298;5243.947560524422;5244.265802787613;5249.580033597303;5283.207518872162;5308.177232528964;5261.42190326741;5279.102552566034;5300.337457817773;5356.6518176318805;5366.195070739382;5659.7453114609525;5731.398203188689;5803.854903627401;5813.418658134195;5914;6295;6340.3342649022115;6342.714577844008;6345.143405640226;6351.237851457809;6251.656158911258;6303.873922521524;6305.4009869062365;6308.432241098323;6311.463525600329;5757.539396848242;5817.243758311435;5918.201042859202;5941.881162376815;5962.5826192167;6342.143810585512;6360.618362898241;6373.139626150411;6379.106925030499;6386.425221730066;6272;6283.622982621057;6286.245650521967;6305.3379395163765;6307.05394190875;6144.907826382608;6196.659183744938;6248.656323902229;6261.7182226799905;6265.96867015662;6257.937420625826;6290.308066112724;6304.085907543381;6304.873902522016;6320.051992201206;6308.211473565804;6321.494280457552;6324.08300796382;6334;6335.176427064452;4901.730404827768;4948.455669876383;4992.425871024806;4992.575631071327;5032.823851165192;4447.777611119431;4552.817887284537;4562;4571.428571428572;4597.3793537872625;5903.852403689943;5905.970470147708;5906.852328691817;5917.171595976481;5939.821805345847;6196.783112591038;6233.657148856766;6251.59364641306;6258.43674069336;6263.342349053375;5681;5681.914771278434;5717.942180696585;5719.8570035749435;5837.708114594253;5425.728713564306;5436.565074794007;5444.128939369682;5457.345118585795;5472;6240.968795155995;6250.437460628475;6268.4671802896355;6273.404026617464;6273.780417685542;5199.870003249949;6180.938190618036;6194.442500175006;6282.1519094921605;6282.465990390685;6339.873202535831;6357.586756860789;6368.968155159195;6375.266844312778;6388.9041664376;5160.458151893997;6258.687065646608;6264.968675156777;6277.027060805583;6278.717457714322;6117.522930757332;6215.285242197205;6250.343713910156;6294.937050629435;6307.3377295383325;6208.844778880564;6217.160683307696;6224.190855188796;6239.220097487814;6244;5193.324867767166;5975.880482390415;6185.987717604421;6205.627662340274;6251.562390632794;6014.308354539284;6033.728482218223;6059.878802423838;6110.969445152746;6125.540584456095;6209.161763161916;6213.97469417541;6226.750929962932;6242.531810114168;6248.9062664059165;5853.853653658693;5921.3782552831335;6090.1169330445955;6094.847628809138;6106.938930610637 13:55:14 INFO - PROCESS | 6699 | |1;ext.html;458.7431038618376;466.1329926337013;521.3535216331745;527.8812267239872;540.6107602526182;31065.84467077664;41016.17967640649;42223.78888105559;42229.577704222946;42244.155116897644;43301;43845.561544384545;43857;44019.99999999992;44038.678839634864;8836.204741573258;9713.028697130283;9855.753606159868;9932.751681207992;9945.950270248639;8761.16768906956;11970.521179152824;12122.090843186752;12141.332226727527;12398.50405983764;12181.51273949041;12246.44890979908;12250.693732656666;12259.080568957319;12268.509259629604;8879.112088791133;9031.142041506113;12097;12166.270023798601;12175.817362739566;8944.10558944107;9030.774230644221;10062.547185376676;11680.299182049019;11918.225315354473;42093;42538.57461425377;42578.148437031086;42593;42610;3563.465480177968;3729.216864458467;3738.7009039277063;3941.2708648900043;4008.158286759784;31379.37241255185;31730.206744831332;32347.83826080878;32578.022659320257;32956.17609559756;2775.209989556745;3123.672014438474;3300.6864347886913;3345.9498107528407;3386.9661303386897;549323;549551.2522437403;551796.4820351786;553517;555185.9999999959;64289;64352.67823660852;64809.35190648127;64934.67532662401;65070;66538.00385988428;66692.666536667;66697.6665116681;66780;66885.66557167182;16240.187990600423;16757;16763.32946682119;16772.412965546147;16772.41296554639;11711.707207319885;11857.822132668018;12821.487140514275;12934.547290844775;12995.870041299466;19126.51355323799;19126.52183695391;19252.614947700968;19279.132439040277;19395.3211637592;6546.476281897437;7024.859502809915;7595.6961721531625;7919.2872641462545;7937;757.2768006553728;896.1979028769215;1017.7353887989176;1056.6724315462232;1157.7135158062758;28796.856015720205;30467.847660761556;31084.91202807936;31376.529352059737;31437.685623143934;1160.640201537526;1161.361251311775;1177.0348314382124;1199.8260252263374;1208.5588760102498;15827.446039388566;15890.841091588936;15938.36246550125;16100.516984490485;16295.022298662117;509122;521882;527865;529108;529617;60195;60940;60959;61042;61233.69383153145;1286.0676009892752;1325.5691900132304;1412.4279666734783;1420.9502667406591;1452.6005348529238;30749.692503074682;32103.67896321007;32296;32988.67011329952;33080.17299567434;50533;57470;58602;58775;62133;670856;679186;683708;685636;686455;36986;37659.05852353713;44115.77942110269;45154.77422612866;45831.54168458273;47342.05315893732;49144;49173;49737.75131124321;50843;41175.558855441115;41193.58806411897;41241.58758412377;41407.37888931729;42108;40450.1909961805;40521.18957620772;40744.18511629692;41182.794086029375;41633.58366416297;39319.41020884632;39471.802640986614;40017.79991100142;40139.59860401358;42120.157596848505;33589.83205083959;35565.64434355623;36422.635773642985;36646;36649;25804.483910321313;26182;26206.475870482864;26351.868240658674;26922.192334230003 13:55:14 INFO - PROCESS | 6699 | |2;jquery.html;353.33220213795914;372.75957007730005;374.8556805629832;382.96217251249095;393.9133390654055;15779.763303550442;16213.432529861457;20730.170793168294;21099.789002109956;21662.891685541552;21008.264710735126;21424.678629820526;21771.564568708618;22409.76746278954;22440.438989025242;5279.815206467774;5995.880082398349;6216.627002379872;6225;6238.812835614916;6084.543659225554;6144.877102457948;6148.538859585527;6148.877022459548;6156.815295541141;5826.708664566776;5939.109133629969;5977.6114552553945;5989.490893274077;6010.909836352458;5875.6474611523445;5943.554233432488;5961.612495187842;5968.373320801318;6070.271567411917;5122.359705036871;5220.243064755589;5239.764210610531;5241.921371179397;5242.266082748418;24199.153029644054;25291.747082529124;25540.467571945555;26606.33484162892;27178.32054198641;2352.3178278299274;2701.594760785898;3026.6007112064744;3045.969540304613;3091.1035799618307;10383.740406489822;11613.941930290295;12583.993280537536;15837;16151.95012324207;1847.9815201847944;1905.4378958207362;1914.3969649560345;1922.7884932657396;1924.8556358273186;114990.85009149885;115225;118086.40956795248;128939.71060289464;129372;11187.832182517268;11619.01238394729;11628.360440175702;11711;11741.47163377633;12055.51777928873;14398.928005360116;14534.927325363305;14564.49024284145;14574.927125364306;6908.965455172692;6997;8634.481931084156;8727.519986400808;8787.209151176425;8679.956600216958;8690.522021288889;8715.389922705477;8798.29613630908;8816.911830881738;4220.050488640031;4460.241758900995;4530.252508336153;4554.544545545419;4618.584327410482;1625.699245639537;1890.3289332287115;1890.413971668787;1939.4278687787137;1942.5143714071482;878.6309749904927;910.977225569366;939.3565407695751;968.1238479176357;984.5864736810556;20222.393328200178;21179.965409479133;21362.679559806616;22041.338759837232;22138.778612213995;925.4956048953337;946.8390373636498;947.0198344713189;989.6635144051057;990.0544979544518;9251.537423128817;11505.884941150649;11737.88262117385;11770.470328835223;11840.526378944918;607439;617425;620569;624688.8765556143;627627;79622.60188699019;83355;104575;134419;140939.2953035228;933.1834644685899;944.3106532231509;960.059142040804;967.1634036558467;969.6024629901707;15321.693566128837;18759.249630015194;19269.8073019268;19278.32525861588;19283;42163.156736865705;51285.97428051493;52761;53146.73426632842;54157;75883;76380.61809690917;76963.61518192373;77975;85932;7170.39051680613;8116.417298626947;8132;8203.138670439757;8382.832343352977;9056.230220431336;12678.87321126777;13444.731105378034;13602.183868967893;13724;11435.428228588704;11543.19197656156;11724.58963936258;11761.353125578175;11819.40902954866;11393.943030284796;11483.712907177052;11542.480588373375;11791.882081179421;11904.880951190376;11806.586769463027;11833.704157396134;11902.642920712393;12017.158798884344;12030.15788894804;7036.401905837856;7336.37640800538;7368.557886526825;8046.959765201136;8477.660893564189;8234.341252699889;10322.329048611817;11400.543978240778;11505.194636375374;11642.417879105842 13:55:14 INFO - PROCESS | 6699 | |3;mootools.html;1564.2413429486696;1615.1359022922736;1797.2182100786151;1917.4918646558656;1930.4980705016692;8506.064332923374;8760.43057201283;8952.149545793156;8962.910370896288;8968.013518512958;7793.961030194855;8026.759197224078;8509.234168924795;8735.388522803407;8743.038265790774;2347.0494449747835;2371.67982322386;2377.084822343393;2378.643203519477;2385.5348207099537;2321.651752237161;2328.53429314137;2360.3155085025323;2361.7520160383083;2364.4561750797325;2084.718562993999;2174.4781252499442;2293.334932869466;2363.621820508719;2372.3476044087843;2356.15178535727;2360.560058364405;2378.4767351182713;2382.106709983756;2393.844400113987;2348.459854233519;2363.7045369328835;2369.680093187415;2370.5377451396985;2379.7382287948312;8969.641214351419;9058.501782401965;9062.954685226598;9081.318901082444;9084.40951338161;5192.428832828424;5375.11310633745;5435.510804027656;5438.075527160392;5439.238506609078;3628.2017956049626;3640.2355505343908;3689.501917241165;3694.2796154749835;3702.777833329982;930.958106885185;1098.4837126550588;1098.774751176007;1113.7939481196004;1125.7917285302162;11803.822942655866;11811.291322520676;11829.585964491287;11835.171537992344;11840.88159118415;4588.839390621379;4600.791620022408;4807.495213002584;4821.831235906727;4838.467768545457;10062.798744025078;10064.043915827984;10066.295359324777;10071.043250891154;10073.59705611782;5369.301990741257;5370.355557333067;5371.167469042305;5375.5162035417;5375.9462405376225;4734.715917044989;4918.508149185053;4919.975400123048;4926;4959.628027897922;3344.2976974835556;3606.585242697071;3768.8680896168503;3777.433384992273;3803.2773772983046;1099.4667586220676;1114.9651885309343;1143.8684551276542;1155.78040172367;1165.7551914097965;810.8000159763465;894.1505569708803;925.6945208081318;944.17856464876;958.5446912716404;5995.700214989233;6117.265928088658;6140.938590614126;6195.81412557624;6250.124982502453;923.3490389275545;925.726910561386;956.4070276428658;966.5602151021268;1000.5047501486811;3969.4442778011103;4058.5941405859176;4091.3249313863475;4120.361343991686;4145.191687620945;10765.3540787553;11008.889911100787;11067.667969960914;11096.722581935515;11110.777784444428;10937.56249750017;11004.944975275232;11016.724581885517;11029.393383363831;11068.28056176362;7841.294283514511;8220.136885627042;8231.300339471092;8337.874931875906;8347.874781878276;6057.909131362945;6118.632882027093;6169.722362493789;6245.656488893154;6375.713092910737;8712.69505567302;10294.330868493824;10445.164386849186;10449.16406687448;10487.842682359618;10184.949075254577;10584.629537966135;10585.947070264907;10627.787444250916;10637.574497020032;7357.153927298429;7383.07711536058;7401.1488678802625;7419.777406677808;7499.2500749924575;8294.875576866472;8433.987921449465;8447.788805279917;8449.197326253996;8465.492070475791;7484.962575187307;7660.73187438437;7672.38620910337;7795.883061754192;7849.058113026245;7294.905764135422;7478.925210747823;7518.774436766906;7607.201243869536;7623.085229772463;7068.151821781419;7105.18290396611;7151.499395042505;7152.678129484081;7163.498555101093;5016.523430274118;5113.6165831969265;5179.689218646893;5198.4801519847715;5276.15581506957;5155.742212889266;5159.251908473176;5186.662866913639;5190.55880250183;5266.236395722675 13:55:14 INFO - PROCESS | 6699 | |4;prototype.html;301.19430523350036;303.0907278165503;311.6571771051843;318.28862492329654;319.8736499082861;4984.576311013564;5281.551068159206;5363.597730170233;5391.29913111295;5419.4012766233955;4809.735464549449;4978.278149668296;5086.931744333694;5210.661307015051;5325.174597937316;3825.59831217723;4070.287699652564;4103.138340948404;4109.116539943911;4153.356229784388;4123.422860712055;4143.378493226025;4143.502779666429;4177.603127702863;4181.268278051344;3776.0182352588386;3864.478295430123;3921.627445392683;4050.3519436890106;4102.118044620406;3178.8887388941275;3483.9548135559357;4061.8984525386804;4079.694022948261;4084.9591504084874;3137.7803553751246;3216.8391580420885;3336.9466937751927;3377.4596064629786;3573.9642603573893;4700.542831722177;4898.730569818658;4961.70229786214;5053.014662140884;5237.842864714026;4330.047389574289;4508.729476231437;4643.837465688718;4687.507811679793;4742.976285118552;5522.006038912994;5568.582356323252;5589.580781441408;5636.633618814764;5657.915131272993;3493.3188028334484;3564.465330200465;3981.2435637229123;3987.641112299907;4018.678505719535;4881.365422495053;5866.266716660418;5890.97054514729;5931.822045338604;5949.970250148722;3252.756043296715;3588.928221435609;3880.176317130944;3917.9654144424276;3923.293807114747;3510.1049232446076;3604.7656902301264;3763.7767725489325;3976.920461590752;3986.6212709793103;4485.8785303674085;4559.863204103882;4563.710820601686;4600.700954437951;4609.8156073757345;4606.723596584216;4950.900981980412;5202.92195617066;5326.92009619856;5690.800821971211;1288.1884412819863;1309.9913066938404;1332.2672530108402;1336.1315145155727;1341.9798703019462;718.6668729506794;736.3152268390342;864.9481031138151;884.1821315283337;888.7067267801739;3998.5001874765653;5180.663256888291;5208.348956380452;5226.066355448508;5247.2129180623215;5240.213967904845;5623.915641265385;5641.26663533738;5647.689377084218;5679.557790150193;4984.526469985346;5157.896842063213;5161.974190129025;5179.161397703836;5253.290805741176;2984.552492041358;3003.4443627928904;3011.337505748732;3019.74332181767;3020.652624948159;5461.651489859399;5872.941270587239;5878.853028674232;5884.705764711747;5934.495567876779;4937.679050861682;5387.757550910218;5833.774907269436;5839.416058394211;5842.808946645008;5209.661372010807;5418.699512117142;5509;5942.762289508371;5960.254968128984;5269.78920843162;5666.9716651416475;5676.524103733142;5689.032864412977;5767.480926716616;4672.971946171837;5065.696058236517;5372.092907018108;5608.747606357805;5618.578606604439;4735.952640473552;4993.452029870752;5285.462977770615;5816.651000939957;5834.358220595816;3571.624979377128;3583.362886670084;3907.4138879168354;3914.8042597870563;3940.5468371137686;4679.578837904605;5082.491750824888;5707.714614269187;5717.342505611741;5718.684702518361;4609.677322587387;4714.316424118552;4741.762911854325;5662.527742786988;5668.943310567007;5433.728313584384;5501.4163471497395;5585.888282234414;5614.41048689898;5645.322561292671;5303.390110137229;5441.319835020622;5504.5412965563355;5515.25544051564;5553.278073850373;5059.46875578059;5571.359293681278;5674.659520428788;5734.942650573607;5810.373095533258;5054.16606259963;5367.785288588413;5575.964772857797;5576.490579239439;5600.60795744294 13:55:14 INFO - PROCESS | 6699 | |5;yui.html;744.8622004929086;781.2539025230901;818.1940788323504;854.4104567848184;859.0722020218165;15116.773248401269;16341.5914602135;16359.182040897953;16366;16384.508464746075;14832.777508337384;14980.850191498082;15000.174990375524;15016.924915375435;15034.398624055051;690.0442886602042;707.5931339479794;712.7968528969245;715.1918332284512;863.9136086391342;702.9824254393629;708.0688894104262;864.1617630898019;894.5035505294559;895.6686026170294;939.1594522901999;939.4691999020565;939.4973689076346;940.1350757303297;943.3019565521499;917.5137177296044;932.4125800745554;932.4684929590069;932.5663566441638;932.6036434515338;551.5835544164171;564.3171762167782;567.2653913182438;700.2087640965727;701.7684164225793;12511.436985335591;12582.68543286416;14691.77962330566;15252.313645885852;15254.38982440701;14686;15077.396904123822;15086.54740357791;15106.924465377602;15312.234388280542;11996.820047699292;12056.457459414347;12188.164307726018;12389.008879289635;12503.74992500145;3841.42378643203;3956.624120708528;3996.5603783583783;4012.257732319501;4091.284025295561;102941;106937.46531267294;106972;107320.4633976833;107752.38371424435;11303.491342889589;11477.827832582518;11639.53441862316;11744.588939387251;11917.22538035025;23638.409039774142;24057.398565036015;24065.037398503864;24129.276121716375;24164.03343866261;8237.711680091168;8426.199511046441;8427.620757065946;8534.914650853412;8581.184787445183;4579.656525760582;4648.628109751279;4703.929441058387;4716.858494245178;4883.072216278895;3626.7461277710836;3764.8117594120185;3768.0768211788286;3769.1707824278615;3781.9432708509394;597.4921316880703;702.0101656664079;710.3713213805715;711.1004579207307;712.3090602115939;528.4636094364223;568.3038278109283;613.8833621611968;677.4749569083999;714.2892821642499;9318.86021709675;9380.24958003358;9493.90506094944;9792.461414622265;9830.557624906896;415.9771212583337;612.8100288910363;634.0040481009706;674.2653730026096;692.7506097804786;4055.1889622075705;4479.350494178326;4637.489876113692;4735.928961065587;4917.532834380728;132788;152929;156105.43894561136;157345;159557;99556;126165.36917315355;129060;134379;137204;76925.61537192279;99186.5040674792;111212;112057;118763.40618296854;10091.820906837487;10167.84748228792;10210.795784084128;10250.538725757508;10311.381317120997;64810.675946619966;67356.6632166836;67983.32016679968;69915;70101.19595216135;74910.25089749033;99184.50407747916;103745.06931702951;104856;105219.36951576272;12002.339871307162;13357.198568085945;13789.86210137926;13978;14089.295535222993;15715.764263536284;15950.361985520913;16117.95233309831;16157.75763363527;16226.269817858461;14338.784918226444;14397.928010359881;14520.201388923711;14534.927325363305;14954;9893.406395616286;13583.796243056164;14132.50536231227;14139.293035348397;14164.575062748134;13947.780626752236;13998.300084995506;14095.647608809863;14641.48754793577;14717.043392179474;10784;11303.886961130613;11388.37363944991;11703.882961170279;11793.587224447447;11246;11397.487113079766;11610.071194304604;11811.704707382385;11813.763724725286 13:55:14 INFO - PROCESS | 6699 | __end_tp_report 13:55:14 INFO - PROCESS | 6699 | __start_cc_report 13:55:14 INFO - PROCESS | 6699 | _x_x_mozilla_cycle_collect,1246 13:55:14 INFO - PROCESS | 6699 | __end_cc_report 13:55:14 INFO - PROCESS | 6699 | __startTimestamp1468616114537__endTimestamp 13:55:14 INFO - PROCESS | 6699 | 13:55:14 INFO - PROCESS | 6699 | ------- Summary: start ------- 13:55:14 INFO - PROCESS | 6699 | Number of tests: 6 13:55:14 INFO - PROCESS | 6699 | 13:55:14 INFO - PROCESS | 6699 | [#0] dojo.html Cycles:165 Average:5795.62 Median:6033.73 stddev:657.61 (10.9%) stddev-sans-first:620.01 13:55:14 INFO - PROCESS | 6699 | Values: 2929.7 3328.7 3332.5 3351.7 3391.6 5572.4 5680.0 5690.9 5759.7 5802.0 5722.3 5760.9 5865.7 5872.4 5914.5 5163.6 5182.8 5224.1 5230.0 5317.8 5311.4 5350.4 5355.8 5379.2 5384.9 5148.2 5212.5 5212.7 5224.6 5270.4 5243.9 5244.3 5249.6 5283.2 5308.2 5261.4 5279.1 5300.3 5356.7 5366.2 5659.7 5731.4 5803.9 5813.4 5914.0 6295.0 6340.3 6342.7 6345.1 6351.2 6251.7 6303.9 6305.4 6308.4 6311.5 5757.5 5817.2 5918.2 5941.9 5962.6 6342.1 6360.6 6373.1 6379.1 6386.4 6272.0 6283.6 6286.2 6305.3 6307.1 6144.9 6196.7 6248.7 6261.7 6266.0 6257.9 6290.3 6304.1 6304.9 6320.1 6308.2 6321.5 6324.1 6334.0 6335.2 4901.7 4948.5 4992.4 4992.6 5032.8 4447.8 4552.8 4562.0 4571.4 4597.4 5903.9 5906.0 5906.9 5917.2 5939.8 6196.8 6233.7 6251.6 6258.4 6263.3 5681.0 5681.9 5717.9 5719.9 5837.7 5425.7 5436.6 5444.1 5457.3 5472.0 6241.0 6250.4 6268.5 6273.4 6273.8 5199.9 6180.9 6194.4 6282.2 6282.5 6339.9 6357.6 6369.0 6375.3 6388.9 5160.5 6258.7 6265.0 6277.0 6278.7 6117.5 6215.3 6250.3 6294.9 6307.3 6208.8 6217.2 6224.2 6239.2 6244.0 5193.3 5975.9 6186.0 6205.6 6251.6 6014.3 6033.7 6059.9 6111.0 6125.5 6209.2 6214.0 6226.8 6242.5 6248.9 5853.9 5921.4 6090.1 6094.8 6106.9 13:55:14 INFO - PROCESS | 6699 | 13:55:14 INFO - PROCESS | 6699 | [#1] ext.html Cycles:180 Average:73351.63 Median:40485.69 stddev:157313.70 (388.6%) stddev-sans-first:157659.80 13:55:14 INFO - PROCESS | 6699 | Values: 458.7 466.1 521.4 527.9 540.6 31065.8 41016.2 42223.8 42229.6 42244.2 43301.0 43845.6 43857.0 44020.0 44038.7 8836.2 9713.0 9855.8 9932.8 9946.0 8761.2 11970.5 12122.1 12141.3 12398.5 12181.5 12246.4 12250.7 12259.1 12268.5 8879.1 9031.1 12097.0 12166.3 12175.8 8944.1 9030.8 10062.5 11680.3 11918.2 42093.0 42538.6 42578.1 42593.0 42610.0 3563.5 3729.2 3738.7 3941.3 4008.2 31379.4 31730.2 32347.8 32578.0 32956.2 2775.2 3123.7 3300.7 3345.9 3387.0 549323.0 549551.3 551796.5 553517.0 555186.0 64289.0 64352.7 64809.4 64934.7 65070.0 66538.0 66692.7 66697.7 66780.0 66885.7 16240.2 16757.0 16763.3 16772.4 16772.4 11711.7 11857.8 12821.5 12934.5 12995.9 19126.5 19126.5 19252.6 19279.1 19395.3 6546.5 7024.9 7595.7 7919.3 7937.0 757.3 896.2 1017.7 1056.7 1157.7 28796.9 30467.8 31084.9 31376.5 31437.7 1160.6 1161.4 1177.0 1199.8 1208.6 15827.4 15890.8 15938.4 16100.5 16295.0 509122.0 521882.0 527865.0 529108.0 529617.0 60195.0 60940.0 60959.0 61042.0 61233.7 1286.1 1325.6 1412.4 1421.0 1452.6 30749.7 32103.7 32296.0 32988.7 33080.2 50533.0 57470.0 58602.0 58775.0 62133.0 670856.0 679186.0 683708.0 685636.0 686455.0 36986.0 37659.1 44115.8 45154.8 45831.5 47342.1 49144.0 49173.0 49737.8 50843.0 41175.6 41193.6 41241.6 41407.4 42108.0 40450.2 40521.2 40744.2 41182.8 41633.6 39319.4 39471.8 40017.8 40139.6 42120.2 33589.8 35565.6 36422.6 36646.0 36649.0 25804.5 26182.0 26206.5 26351.9 26922.2 13:55:14 INFO - PROCESS | 6699 | 13:55:14 INFO - PROCESS | 6699 | [#2] jquery.html Cycles:180 Average:35268.14 Median:363.05 stddev:102918.81 (28348.7%) stddev-sans-first:103174.13 13:55:14 INFO - PROCESS | 6699 | Values: 353.3 372.8 374.9 383.0 393.9 15779.8 16213.4 20730.2 21099.8 21662.9 21008.3 21424.7 21771.6 22409.8 22440.4 5279.8 5995.9 6216.6 6225.0 6238.8 6084.5 6144.9 6148.5 6148.9 6156.8 5826.7 5939.1 5977.6 5989.5 6010.9 5875.6 5943.6 5961.6 5968.4 6070.3 5122.4 5220.2 5239.8 5241.9 5242.3 24199.2 25291.7 25540.5 26606.3 27178.3 2352.3 2701.6 3026.6 3046.0 3091.1 10383.7 11613.9 12584.0 15837.0 16152.0 1848.0 1905.4 1914.4 1922.8 1924.9 114990.9 115225.0 118086.4 128939.7 129372.0 11187.8 11619.0 11628.4 11711.0 11741.5 12055.5 14398.9 14534.9 14564.5 14574.9 6909.0 6997.0 8634.5 8727.5 8787.2 8680.0 8690.5 8715.4 8798.3 8816.9 4220.1 4460.2 4530.3 4554.5 4618.6 1625.7 1890.3 1890.4 1939.4 1942.5 878.6 911.0 939.4 968.1 984.6 20222.4 21180.0 21362.7 22041.3 22138.8 925.5 946.8 947.0 989.7 990.1 9251.5 11505.9 11737.9 11770.5 11840.5 607439.0 617425.0 620569.0 624688.9 627627.0 79622.6 83355.0 104575.0 134419.0 140939.3 933.2 944.3 960.1 967.2 969.6 15321.7 18759.2 19269.8 19278.3 19283.0 42163.2 51286.0 52761.0 53146.7 54157.0 75883.0 76380.6 76963.6 77975.0 85932.0 7170.4 8116.4 8132.0 8203.1 8382.8 9056.2 12678.9 13444.7 13602.2 13724.0 11435.4 11543.2 11724.6 11761.4 11819.4 11393.9 11483.7 11542.5 11791.9 11904.9 11806.6 11833.7 11902.6 12017.2 12030.2 7036.4 7336.4 7368.6 8047.0 8477.7 8234.3 10322.3 11400.5 11505.2 11642.4 13:55:14 INFO - PROCESS | 6699 | 13:55:14 INFO - PROCESS | 6699 | [#3] mootools.html Cycles:180 Average:5809.02 Median:4919.24 stddev:3271.23 (66.5%) stddev-sans-first:3264.85 13:55:14 INFO - PROCESS | 6699 | Values: 1564.2 1615.1 1797.2 1917.5 1930.5 8506.1 8760.4 8952.1 8962.9 8968.0 7794.0 8026.8 8509.2 8735.4 8743.0 2347.0 2371.7 2377.1 2378.6 2385.5 2321.7 2328.5 2360.3 2361.8 2364.5 2084.7 2174.5 2293.3 2363.6 2372.3 2356.2 2360.6 2378.5 2382.1 2393.8 2348.5 2363.7 2369.7 2370.5 2379.7 8969.6 9058.5 9063.0 9081.3 9084.4 5192.4 5375.1 5435.5 5438.1 5439.2 3628.2 3640.2 3689.5 3694.3 3702.8 931.0 1098.5 1098.8 1113.8 1125.8 11803.8 11811.3 11829.6 11835.2 11840.9 4588.8 4600.8 4807.5 4821.8 4838.5 10062.8 10064.0 10066.3 10071.0 10073.6 5369.3 5370.4 5371.2 5375.5 5375.9 4734.7 4918.5 4920.0 4926.0 4959.6 3344.3 3606.6 3768.9 3777.4 3803.3 1099.5 1115.0 1143.9 1155.8 1165.8 810.8 894.2 925.7 944.2 958.5 5995.7 6117.3 6140.9 6195.8 6250.1 923.3 925.7 956.4 966.6 1000.5 3969.4 4058.6 4091.3 4120.4 4145.2 10765.4 11008.9 11067.7 11096.7 11110.8 10937.6 11004.9 11016.7 11029.4 11068.3 7841.3 8220.1 8231.3 8337.9 8347.9 6057.9 6118.6 6169.7 6245.7 6375.7 8712.7 10294.3 10445.2 10449.2 10487.8 10184.9 10584.6 10585.9 10627.8 10637.6 7357.2 7383.1 7401.1 7419.8 7499.3 8294.9 8434.0 8447.8 8449.2 8465.5 7485.0 7660.7 7672.4 7795.9 7849.1 7294.9 7478.9 7518.8 7607.2 7623.1 7068.2 7105.2 7151.5 7152.7 7163.5 5016.5 5113.6 5179.7 5198.5 5276.2 5155.7 5159.3 5186.7 5190.6 5266.2 13:55:14 INFO - PROCESS | 6699 | 13:55:14 INFO - PROCESS | 6699 | [#4] prototype.html Cycles:180 Average:4502.76 Median:5056.82 stddev:1379.66 (27.3%) stddev-sans-first:1347.00 13:55:14 INFO - PROCESS | 6699 | Values: 301.2 303.1 311.7 318.3 319.9 4984.6 5281.6 5363.6 5391.3 5419.4 4809.7 4978.3 5086.9 5210.7 5325.2 3825.6 4070.3 4103.1 4109.1 4153.4 4123.4 4143.4 4143.5 4177.6 4181.3 3776.0 3864.5 3921.6 4050.4 4102.1 3178.9 3484.0 4061.9 4079.7 4085.0 3137.8 3216.8 3336.9 3377.5 3574.0 4700.5 4898.7 4961.7 5053.0 5237.8 4330.0 4508.7 4643.8 4687.5 4743.0 5522.0 5568.6 5589.6 5636.6 5657.9 3493.3 3564.5 3981.2 3987.6 4018.7 4881.4 5866.3 5891.0 5931.8 5950.0 3252.8 3588.9 3880.2 3918.0 3923.3 3510.1 3604.8 3763.8 3976.9 3986.6 4485.9 4559.9 4563.7 4600.7 4609.8 4606.7 4950.9 5202.9 5326.9 5690.8 1288.2 1310.0 1332.3 1336.1 1342.0 718.7 736.3 864.9 884.2 888.7 3998.5 5180.7 5208.3 5226.1 5247.2 5240.2 5623.9 5641.3 5647.7 5679.6 4984.5 5157.9 5162.0 5179.2 5253.3 2984.6 3003.4 3011.3 3019.7 3020.7 5461.7 5872.9 5878.9 5884.7 5934.5 4937.7 5387.8 5833.8 5839.4 5842.8 5209.7 5418.7 5509.0 5942.8 5960.3 5269.8 5667.0 5676.5 5689.0 5767.5 4673.0 5065.7 5372.1 5608.7 5618.6 4736.0 4993.5 5285.5 5816.7 5834.4 3571.6 3583.4 3907.4 3914.8 3940.5 4679.6 5082.5 5707.7 5717.3 5718.7 4609.7 4714.3 4741.8 5662.5 5668.9 5433.7 5501.4 5585.9 5614.4 5645.3 5303.4 5441.3 5504.5 5515.3 5553.3 5059.5 5571.4 5674.7 5734.9 5810.4 5054.2 5367.8 5576.0 5576.5 5600.6 13:55:14 INFO - PROCESS | 6699 | 13:55:14 INFO - PROCESS | 6699 | [#5] yui.html Cycles:180 Average:25197.98 Median:24061.22 stddev:39590.56 (164.5%) stddev-sans-first:39659.05 13:55:14 INFO - PROCESS | 6699 | Values: 744.9 781.3 818.2 854.4 859.1 15116.8 16341.6 16359.2 16366.0 16384.5 14832.8 14980.9 15000.2 15016.9 15034.4 690.0 707.6 712.8 715.2 863.9 703.0 708.1 864.2 894.5 895.7 939.2 939.5 939.5 940.1 943.3 917.5 932.4 932.5 932.6 932.6 551.6 564.3 567.3 700.2 701.8 12511.4 12582.7 14691.8 15252.3 15254.4 14686.0 15077.4 15086.5 15106.9 15312.2 11996.8 12056.5 12188.2 12389.0 12503.7 3841.4 3956.6 3996.6 4012.3 4091.3 102941.0 106937.5 106972.0 107320.5 107752.4 11303.5 11477.8 11639.5 11744.6 11917.2 23638.4 24057.4 24065.0 24129.3 24164.0 8237.7 8426.2 8427.6 8534.9 8581.2 4579.7 4648.6 4703.9 4716.9 4883.1 3626.7 3764.8 3768.1 3769.2 3781.9 597.5 702.0 710.4 711.1 712.3 528.5 568.3 613.9 677.5 714.3 9318.9 9380.2 9493.9 9792.5 9830.6 416.0 612.8 634.0 674.3 692.8 4055.2 4479.4 4637.5 4735.9 4917.5 132788.0 152929.0 156105.4 157345.0 159557.0 99556.0 126165.4 129060.0 134379.0 137204.0 76925.6 99186.5 111212.0 112057.0 118763.4 10091.8 10167.8 10210.8 10250.5 10311.4 64810.7 67356.7 67983.3 69915.0 70101.2 74910.3 99184.5 103745.1 104856.0 105219.4 12002.3 13357.2 13789.9 13978.0 14089.3 15715.8 15950.4 16118.0 16157.8 16226.3 14338.8 14397.9 14520.2 14534.9 14954.0 9893.4 13583.8 14132.5 14139.3 14164.6 13947.8 13998.3 14095.6 14641.5 14717.0 10784.0 11303.9 11388.4 11703.9 11793.6 11246.0 11397.5 11610.1 11811.7 11813.8 13:55:14 INFO - PROCESS | 6699 | -------- Summary: end -------- 13:55:14 INFO - PROCESS | 6699 | 13:55:15 INFO - TEST-INFO | 6699: exit 0 13:55:15 INFO - TEST-OK | dromaeo_css | took 1116209ms 13:55:15 INFO - TEST-START | kraken 13:55:15 INFO - operating with platform_type : mac_ 13:55:15 INFO - Initialising browser for kraken test... 13:55:15 INFO - TEST-INFO | started process 6702 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/tmprkaeH5/profile http://localhost:60081/getInfo.html) 13:55:17 INFO - PROCESS | 6702 | __metrics Screen width/height:1600/1200 13:55:17 INFO - PROCESS | 6702 | colorDepth:24 13:55:17 INFO - PROCESS | 6702 | Browser inner width/height: 1024/689 13:55:17 INFO - PROCESS | 6702 | __metrics 13:55:17 INFO - PROCESS | 6702 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:55:17 INFO - PROCESS | 6702 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:55:18 INFO - TEST-INFO | 6702: exit 0 13:55:18 INFO - Browser initialized. 13:55:18 INFO - Running cycle 1/1 for kraken test... 13:55:18 INFO - TEST-INFO | started process 6703 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/tmprkaeH5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:55:30 INFO - PROCESS | 6703 | RSS: Main: 243933184 13:55:30 INFO - PROCESS | 6703 | 13:55:32 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60081/tests/kraken/driver.html?testName=audio-beat-detection) 13:55:33 INFO - PROCESS | 6703 | RSS: Main: 294002688 13:55:33 INFO - PROCESS | 6703 | 13:55:36 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60081/tests/kraken/driver.html?testName=audio-dft) 13:55:37 INFO - PROCESS | 6703 | RSS: Main: 304611328 13:55:37 INFO - PROCESS | 6703 | 13:55:40 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60081/tests/kraken/driver.html?testName=audio-fft) 13:55:41 INFO - PROCESS | 6703 | RSS: Main: 392818688 13:55:41 INFO - PROCESS | 6703 | 13:55:43 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60081/tests/kraken/driver.html?testName=audio-oscillator) 13:55:43 INFO - PROCESS | 6703 | RSS: Main: 293326848 13:55:43 INFO - PROCESS | 6703 | 13:55:45 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:55:46 INFO - PROCESS | 6703 | RSS: Main: 297701376 13:55:46 INFO - PROCESS | 6703 | 13:55:49 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60081/tests/kraken/driver.html?testName=imaging-darkroom) 13:55:49 INFO - PROCESS | 6703 | RSS: Main: 334630912 13:55:49 INFO - PROCESS | 6703 | 13:55:52 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60081/tests/kraken/driver.html?testName=imaging-desaturate) 13:55:53 INFO - PROCESS | 6703 | RSS: Main: 334675968 13:55:53 INFO - PROCESS | 6703 | 13:55:56 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60081/tests/kraken/driver.html?testName=json-parse-financial) 13:55:57 INFO - PROCESS | 6703 | RSS: Main: 335765504 13:55:57 INFO - PROCESS | 6703 | 13:55:58 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:55:59 INFO - PROCESS | 6703 | RSS: Main: 313917440 13:55:59 INFO - PROCESS | 6703 | 13:56:01 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60081/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:56:01 INFO - PROCESS | 6703 | RSS: Main: 321466368 13:56:01 INFO - PROCESS | 6703 | 13:56:03 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:56:04 INFO - PROCESS | 6703 | RSS: Main: 318119936 13:56:04 INFO - PROCESS | 6703 | 13:56:07 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:56:08 INFO - PROCESS | 6703 | RSS: Main: 326660096 13:56:08 INFO - PROCESS | 6703 | 13:56:10 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:56:11 INFO - PROCESS | 6703 | RSS: Main: 329412608 13:56:11 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:60081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60081/tests/kraken/driver.html?testName=ai-astar) 13:56:13 INFO - PROCESS | 6703 | RSS: Main: 372936704 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | __start_tp_report 13:56:13 INFO - PROCESS | 6703 | _x_x_mozilla_page_load 13:56:13 INFO - PROCESS | 6703 | _x_x_mozilla_page_load_details 13:56:13 INFO - PROCESS | 6703 | |i|pagename|runs| 13:56:13 INFO - PROCESS | 6703 | |0;ai-astar;100;110;112;112;112;111;112;111;112;113 13:56:13 INFO - PROCESS | 6703 | |1;audio-beat-detection;145;109;104;159;104;106;125;105;138;107 13:56:13 INFO - PROCESS | 6703 | |2;audio-dft;184;182;187;184;186;182;183;181;183;183 13:56:13 INFO - PROCESS | 6703 | |3;audio-fft;79;73;58;88;59;57;66;61;83;58 13:56:13 INFO - PROCESS | 6703 | |4;audio-oscillator;85;92;93;72;77;69;98;71;68;103 13:56:13 INFO - PROCESS | 6703 | |5;imaging-gaussian-blur;87;88;135;84;86;83;87;85;88;83 13:56:13 INFO - PROCESS | 6703 | |6;imaging-darkroom;93;94;94;102;93;94;94;94;93;100 13:56:13 INFO - PROCESS | 6703 | |7;imaging-desaturate;84;80;86;85;85;83;112;142;139;88 13:56:13 INFO - PROCESS | 6703 | |8;json-parse-financial;55;54;55;56;56;55;55;53;53;55 13:56:13 INFO - PROCESS | 6703 | |9;json-stringify-tinderbox;66;70;74;79;72;72;72;70;83;107 13:56:13 INFO - PROCESS | 6703 | |10;stanford-crypto-aes;84;83;82;84;85;82;87;80;83;87 13:56:13 INFO - PROCESS | 6703 | |11;stanford-crypto-ccm;137;137;135;135;136;133;136;133;217;136 13:56:13 INFO - PROCESS | 6703 | |12;stanford-crypto-pbkdf2;164;162;164;163;163;164;160;167;161;163 13:56:13 INFO - PROCESS | 6703 | |13;stanford-crypto-sha256-iterative;66;68;67;66;65;65;66;66;66;64 13:56:13 INFO - PROCESS | 6703 | __end_tp_report 13:56:13 INFO - PROCESS | 6703 | __start_cc_report 13:56:13 INFO - PROCESS | 6703 | _x_x_mozilla_cycle_collect,2019 13:56:13 INFO - PROCESS | 6703 | __end_cc_report 13:56:13 INFO - PROCESS | 6703 | __startTimestamp1468616173541__endTimestamp 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | ------- Summary: start ------- 13:56:13 INFO - PROCESS | 6703 | Number of tests: 14 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.78 (3.4%) stddev-sans-first:0.87 13:56:13 INFO - PROCESS | 6703 | Values: 100.0 110.0 112.0 112.0 112.0 111.0 112.0 111.0 112.0 113.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:117.00 stddev:20.32 (17.4%) stddev-sans-first:19.48 13:56:13 INFO - PROCESS | 6703 | Values: 145.0 109.0 104.0 159.0 104.0 106.0 125.0 105.0 138.0 107.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:1.84 (1.0%) stddev-sans-first:1.94 13:56:13 INFO - PROCESS | 6703 | Values: 184.0 182.0 187.0 184.0 186.0 182.0 183.0 181.0 183.0 183.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#3] audio-fft Cycles:10 Average:68.20 Median:69.50 stddev:11.67 (16.8%) stddev-sans-first:11.70 13:56:13 INFO - PROCESS | 6703 | Values: 79.0 73.0 58.0 88.0 59.0 57.0 66.0 61.0 83.0 58.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#4] audio-oscillator Cycles:10 Average:82.80 Median:81.00 stddev:13.05 (16.1%) stddev-sans-first:13.81 13:56:13 INFO - PROCESS | 6703 | Values: 85.0 92.0 93.0 72.0 77.0 69.0 98.0 71.0 68.0 103.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:86.50 stddev:15.71 (18.2%) stddev-sans-first:16.61 13:56:13 INFO - PROCESS | 6703 | Values: 87.0 88.0 135.0 84.0 86.0 83.0 87.0 85.0 88.0 83.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:94.00 stddev:3.18 (3.4%) stddev-sans-first:3.28 13:56:13 INFO - PROCESS | 6703 | Values: 93.0 94.0 94.0 102.0 93.0 94.0 94.0 94.0 93.0 100.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:84.50 stddev:23.89 (28.3%) stddev-sans-first:24.77 13:56:13 INFO - PROCESS | 6703 | Values: 84.0 80.0 86.0 85.0 85.0 83.0 112.0 142.0 139.0 88.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.12 13:56:13 INFO - PROCESS | 6703 | Values: 55.0 54.0 55.0 56.0 56.0 55.0 55.0 53.0 53.0 55.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#9] json-stringify-tinderbox Cycles:10 Average:76.50 Median:72.00 stddev:11.74 (16.3%) stddev-sans-first:11.82 13:56:13 INFO - PROCESS | 6703 | Values: 66.0 70.0 74.0 79.0 72.0 72.0 72.0 70.0 83.0 107.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:2.21 (2.6%) stddev-sans-first:2.35 13:56:13 INFO - PROCESS | 6703 | Values: 84.0 83.0 82.0 84.0 85.0 82.0 87.0 80.0 83.0 87.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:136.00 stddev:25.86 (19.0%) stddev-sans-first:27.33 13:56:13 INFO - PROCESS | 6703 | Values: 137.0 137.0 135.0 135.0 136.0 133.0 136.0 133.0 217.0 136.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.50 stddev:1.91 (1.2%) stddev-sans-first:2.00 13:56:13 INFO - PROCESS | 6703 | Values: 164.0 162.0 164.0 163.0 163.0 164.0 160.0 167.0 161.0 163.0 13:56:13 INFO - PROCESS | 6703 | 13:56:13 INFO - PROCESS | 6703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 13:56:13 INFO - PROCESS | 6703 | Values: 66.0 68.0 67.0 66.0 65.0 65.0 66.0 66.0 66.0 64.0 13:56:13 INFO - PROCESS | 6703 | -------- Summary: end -------- 13:56:13 INFO - PROCESS | 6703 | 13:56:14 INFO - TEST-INFO | 6703: exit 0 13:56:14 INFO - TEST-OK | kraken | took 59198ms 13:56:14 INFO - SUITE-END | took 1175s 13:56:14 INFO - Completed test suite (00:19:35) 13:56:14 INFO - javascript benchmark 13:56:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2929.721676440738, 3328.667133286673, 3332.5167850661655, 3351.7151042161413, 3391.592489117015, 5572.442755724435, 5680.005998950178, 5690.886182276352, 5759.683217423045, 5801.970990145049, 5722.313322401307, 5760.855978600526, 5865.70671466426, 5872.4127587241255, 5914.467697907187, 5163.561097306715, 5182.818601348954, 5224.085784987631, 5230.0, 5317.787288508455, 5311.362636483627, 5350.438203988583, 5355.7857685692725, 5379.193121031857, 5384.946150538503, 5148.176291793314, 5212.53087222148, 5212.661177023481, 5224.555912747421, 5270.367555893298, 5243.947560524422, 5244.265802787613, 5249.580033597303, 5283.207518872162, 5308.177232528964, 5261.42190326741, 5279.102552566034, 5300.337457817773, 5356.6518176318805, 5366.195070739382, 5659.7453114609525, 5731.398203188689, 5803.854903627401, 5813.418658134195, 5914.0, 6295.0, 6340.3342649022115, 6342.714577844008, 6345.143405640226, 6351.237851457809, 6251.656158911258, 6303.873922521524, 6305.4009869062365, 6308.432241098323, 6311.463525600329, 5757.539396848242, 5817.243758311435, 5918.201042859202, 5941.881162376815, 5962.5826192167, 6342.143810585512, 6360.618362898241, 6373.139626150411, 6379.106925030499, 6386.425221730066, 6272.0, 6283.622982621057, 6286.245650521967, 6305.3379395163765, 6307.05394190875, 6144.907826382608, 6196.659183744938, 6248.656323902229, 6261.7182226799905, 6265.96867015662, 6257.937420625826, 6290.308066112724, 6304.085907543381, 6304.873902522016, 6320.051992201206, 6308.211473565804, 6321.494280457552, 6324.08300796382, 6334.0, 6335.176427064452, 4901.730404827768, 4948.455669876383, 4992.425871024806, 4992.575631071327, 5032.823851165192, 4447.777611119431, 4552.817887284537, 4562.0, 4571.428571428572, 4597.3793537872625, 5903.852403689943, 5905.970470147708, 5906.852328691817, 5917.171595976481, 5939.821805345847, 6196.783112591038, 6233.657148856766, 6251.59364641306, 6258.43674069336, 6263.342349053375, 5681.0, 5681.914771278434, 5717.942180696585, 5719.8570035749435, 5837.708114594253, 5425.728713564306, 5436.565074794007, 5444.128939369682, 5457.345118585795, 5472.0, 6240.968795155995, 6250.437460628475, 6268.4671802896355, 6273.404026617464, 6273.780417685542, 5199.870003249949, 6180.938190618036, 6194.442500175006, 6282.1519094921605, 6282.465990390685, 6339.873202535831, 6357.586756860789, 6368.968155159195, 6375.266844312778, 6388.9041664376, 5160.458151893997, 6258.687065646608, 6264.968675156777, 6277.027060805583, 6278.717457714322, 6117.522930757332, 6215.285242197205, 6250.343713910156, 6294.937050629435, 6307.3377295383325, 6208.844778880564, 6217.160683307696, 6224.190855188796, 6239.220097487814, 6244.0, 5193.324867767166, 5975.880482390415, 6185.987717604421, 6205.627662340274, 6251.562390632794, 6014.308354539284, 6033.728482218223, 6059.878802423838, 6110.969445152746, 6125.540584456095, 6209.161763161916, 6213.97469417541, 6226.750929962932, 6242.531810114168, 6248.9062664059165, 5853.853653658693, 5921.3782552831335, 6090.1169330445955, 6094.847628809138, 6106.938930610637], "value": 5752.320545695497, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.7431038618376, 466.1329926337013, 521.3535216331745, 527.8812267239872, 540.6107602526182, 31065.84467077664, 41016.17967640649, 42223.78888105559, 42229.577704222946, 42244.155116897644, 43301.0, 43845.561544384545, 43857.0, 44019.99999999992, 44038.678839634864, 8836.204741573258, 9713.028697130283, 9855.753606159868, 9932.751681207992, 9945.950270248639, 8761.16768906956, 11970.521179152824, 12122.090843186752, 12141.332226727527, 12398.50405983764, 12181.51273949041, 12246.44890979908, 12250.693732656666, 12259.080568957319, 12268.509259629604, 8879.112088791133, 9031.142041506113, 12097.0, 12166.270023798601, 12175.817362739566, 8944.10558944107, 9030.774230644221, 10062.547185376676, 11680.299182049019, 11918.225315354473, 42093.0, 42538.57461425377, 42578.148437031086, 42593.0, 42610.0, 3563.465480177968, 3729.216864458467, 3738.7009039277063, 3941.2708648900043, 4008.158286759784, 31379.37241255185, 31730.206744831332, 32347.83826080878, 32578.022659320257, 32956.17609559756, 2775.209989556745, 3123.672014438474, 3300.6864347886913, 3345.9498107528407, 3386.9661303386897, 549323.0, 549551.2522437403, 551796.4820351786, 553517.0, 555185.9999999959, 64289.0, 64352.67823660852, 64809.35190648127, 64934.67532662401, 65070.0, 66538.00385988428, 66692.666536667, 66697.6665116681, 66780.0, 66885.66557167182, 16240.187990600423, 16757.0, 16763.32946682119, 16772.412965546147, 16772.41296554639, 11711.707207319885, 11857.822132668018, 12821.487140514275, 12934.547290844775, 12995.870041299466, 19126.51355323799, 19126.52183695391, 19252.614947700968, 19279.132439040277, 19395.3211637592, 6546.476281897437, 7024.859502809915, 7595.6961721531625, 7919.2872641462545, 7937.0, 757.2768006553728, 896.1979028769215, 1017.7353887989176, 1056.6724315462232, 1157.7135158062758, 28796.856015720205, 30467.847660761556, 31084.91202807936, 31376.529352059737, 31437.685623143934, 1160.640201537526, 1161.361251311775, 1177.0348314382124, 1199.8260252263374, 1208.5588760102498, 15827.446039388566, 15890.841091588936, 15938.36246550125, 16100.516984490485, 16295.022298662117, 509122.0, 521882.0, 527865.0, 529108.0, 529617.0, 60195.0, 60940.0, 60959.0, 61042.0, 61233.69383153145, 1286.0676009892752, 1325.5691900132304, 1412.4279666734783, 1420.9502667406591, 1452.6005348529238, 30749.692503074682, 32103.67896321007, 32296.0, 32988.67011329952, 33080.17299567434, 50533.0, 57470.0, 58602.0, 58775.0, 62133.0, 670856.0, 679186.0, 683708.0, 685636.0, 686455.0, 36986.0, 37659.05852353713, 44115.77942110269, 45154.77422612866, 45831.54168458273, 47342.05315893732, 49144.0, 49173.0, 49737.75131124321, 50843.0, 41175.558855441115, 41193.58806411897, 41241.58758412377, 41407.37888931729, 42108.0, 40450.1909961805, 40521.18957620772, 40744.18511629692, 41182.794086029375, 41633.58366416297, 39319.41020884632, 39471.802640986614, 40017.79991100142, 40139.59860401358, 42120.157596848505, 33589.83205083959, 35565.64434355623, 36422.635773642985, 36646.0, 36649.0, 25804.483910321313, 26182.0, 26206.475870482864, 26351.868240658674, 26922.192334230003], "value": 21288.69995032181, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.33220213795914, 372.75957007730005, 374.8556805629832, 382.96217251249095, 393.9133390654055, 15779.763303550442, 16213.432529861457, 20730.170793168294, 21099.789002109956, 21662.891685541552, 21008.264710735126, 21424.678629820526, 21771.564568708618, 22409.76746278954, 22440.438989025242, 5279.815206467774, 5995.880082398349, 6216.627002379872, 6225.0, 6238.812835614916, 6084.543659225554, 6144.877102457948, 6148.538859585527, 6148.877022459548, 6156.815295541141, 5826.708664566776, 5939.109133629969, 5977.6114552553945, 5989.490893274077, 6010.909836352458, 5875.6474611523445, 5943.554233432488, 5961.612495187842, 5968.373320801318, 6070.271567411917, 5122.359705036871, 5220.243064755589, 5239.764210610531, 5241.921371179397, 5242.266082748418, 24199.153029644054, 25291.747082529124, 25540.467571945555, 26606.33484162892, 27178.32054198641, 2352.3178278299274, 2701.594760785898, 3026.6007112064744, 3045.969540304613, 3091.1035799618307, 10383.740406489822, 11613.941930290295, 12583.993280537536, 15837.0, 16151.95012324207, 1847.9815201847944, 1905.4378958207362, 1914.3969649560345, 1922.7884932657396, 1924.8556358273186, 114990.85009149885, 115225.0, 118086.40956795248, 128939.71060289464, 129372.0, 11187.832182517268, 11619.01238394729, 11628.360440175702, 11711.0, 11741.47163377633, 12055.51777928873, 14398.928005360116, 14534.927325363305, 14564.49024284145, 14574.927125364306, 6908.965455172692, 6997.0, 8634.481931084156, 8727.519986400808, 8787.209151176425, 8679.956600216958, 8690.522021288889, 8715.389922705477, 8798.29613630908, 8816.911830881738, 4220.050488640031, 4460.241758900995, 4530.252508336153, 4554.544545545419, 4618.584327410482, 1625.699245639537, 1890.3289332287115, 1890.413971668787, 1939.4278687787137, 1942.5143714071482, 878.6309749904927, 910.977225569366, 939.3565407695751, 968.1238479176357, 984.5864736810556, 20222.393328200178, 21179.965409479133, 21362.679559806616, 22041.338759837232, 22138.778612213995, 925.4956048953337, 946.8390373636498, 947.0198344713189, 989.6635144051057, 990.0544979544518, 9251.537423128817, 11505.884941150649, 11737.88262117385, 11770.470328835223, 11840.526378944918, 607439.0, 617425.0, 620569.0, 624688.8765556143, 627627.0, 79622.60188699019, 83355.0, 104575.0, 134419.0, 140939.2953035228, 933.1834644685899, 944.3106532231509, 960.059142040804, 967.1634036558467, 969.6024629901707, 15321.693566128837, 18759.249630015194, 19269.8073019268, 19278.32525861588, 19283.0, 42163.156736865705, 51285.97428051493, 52761.0, 53146.73426632842, 54157.0, 75883.0, 76380.61809690917, 76963.61518192373, 77975.0, 85932.0, 7170.39051680613, 8116.417298626947, 8132.0, 8203.138670439757, 8382.832343352977, 9056.230220431336, 12678.87321126777, 13444.731105378034, 13602.183868967893, 13724.0, 11435.428228588704, 11543.19197656156, 11724.58963936258, 11761.353125578175, 11819.40902954866, 11393.943030284796, 11483.712907177052, 11542.480588373375, 11791.882081179421, 11904.880951190376, 11806.586769463027, 11833.704157396134, 11902.642920712393, 12017.158798884344, 12030.15788894804, 7036.401905837856, 7336.37640800538, 7368.557886526825, 8046.959765201136, 8477.660893564189, 8234.341252699889, 10322.329048611817, 11400.543978240778, 11505.194636375374, 11642.417879105842], "value": 9674.494122789265, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1564.2413429486696, 1615.1359022922736, 1797.2182100786151, 1917.4918646558656, 1930.4980705016692, 8506.064332923374, 8760.43057201283, 8952.149545793156, 8962.910370896288, 8968.013518512958, 7793.961030194855, 8026.759197224078, 8509.234168924795, 8735.388522803407, 8743.038265790774, 2347.0494449747835, 2371.67982322386, 2377.084822343393, 2378.643203519477, 2385.5348207099537, 2321.651752237161, 2328.53429314137, 2360.3155085025323, 2361.7520160383083, 2364.4561750797325, 2084.718562993999, 2174.4781252499442, 2293.334932869466, 2363.621820508719, 2372.3476044087843, 2356.15178535727, 2360.560058364405, 2378.4767351182713, 2382.106709983756, 2393.844400113987, 2348.459854233519, 2363.7045369328835, 2369.680093187415, 2370.5377451396985, 2379.7382287948312, 8969.641214351419, 9058.501782401965, 9062.954685226598, 9081.318901082444, 9084.40951338161, 5192.428832828424, 5375.11310633745, 5435.510804027656, 5438.075527160392, 5439.238506609078, 3628.2017956049626, 3640.2355505343908, 3689.501917241165, 3694.2796154749835, 3702.777833329982, 930.958106885185, 1098.4837126550588, 1098.774751176007, 1113.7939481196004, 1125.7917285302162, 11803.822942655866, 11811.291322520676, 11829.585964491287, 11835.171537992344, 11840.88159118415, 4588.839390621379, 4600.791620022408, 4807.495213002584, 4821.831235906727, 4838.467768545457, 10062.798744025078, 10064.043915827984, 10066.295359324777, 10071.043250891154, 10073.59705611782, 5369.301990741257, 5370.355557333067, 5371.167469042305, 5375.5162035417, 5375.9462405376225, 4734.715917044989, 4918.508149185053, 4919.975400123048, 4926.0, 4959.628027897922, 3344.2976974835556, 3606.585242697071, 3768.8680896168503, 3777.433384992273, 3803.2773772983046, 1099.4667586220676, 1114.9651885309343, 1143.8684551276542, 1155.78040172367, 1165.7551914097965, 810.8000159763465, 894.1505569708803, 925.6945208081318, 944.17856464876, 958.5446912716404, 5995.700214989233, 6117.265928088658, 6140.938590614126, 6195.81412557624, 6250.124982502453, 923.3490389275545, 925.726910561386, 956.4070276428658, 966.5602151021268, 1000.5047501486811, 3969.4442778011103, 4058.5941405859176, 4091.3249313863475, 4120.361343991686, 4145.191687620945, 10765.3540787553, 11008.889911100787, 11067.667969960914, 11096.722581935515, 11110.777784444428, 10937.56249750017, 11004.944975275232, 11016.724581885517, 11029.393383363831, 11068.28056176362, 7841.294283514511, 8220.136885627042, 8231.300339471092, 8337.874931875906, 8347.874781878276, 6057.909131362945, 6118.632882027093, 6169.722362493789, 6245.656488893154, 6375.713092910737, 8712.69505567302, 10294.330868493824, 10445.164386849186, 10449.16406687448, 10487.842682359618, 10184.949075254577, 10584.629537966135, 10585.947070264907, 10627.787444250916, 10637.574497020032, 7357.153927298429, 7383.07711536058, 7401.1488678802625, 7419.777406677808, 7499.2500749924575, 8294.875576866472, 8433.987921449465, 8447.788805279917, 8449.197326253996, 8465.492070475791, 7484.962575187307, 7660.73187438437, 7672.38620910337, 7795.883061754192, 7849.058113026245, 7294.905764135422, 7478.925210747823, 7518.774436766906, 7607.201243869536, 7623.085229772463, 7068.151821781419, 7105.18290396611, 7151.499395042505, 7152.678129484081, 7163.498555101093, 5016.523430274118, 5113.6165831969265, 5179.689218646893, 5198.4801519847715, 5276.15581506957, 5155.742212889266, 5159.251908473176, 5186.662866913639, 5190.55880250183, 5266.236395722675], "value": 4648.974816927588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.19430523350036, 303.0907278165503, 311.6571771051843, 318.28862492329654, 319.8736499082861, 4984.576311013564, 5281.551068159206, 5363.597730170233, 5391.29913111295, 5419.4012766233955, 4809.735464549449, 4978.278149668296, 5086.931744333694, 5210.661307015051, 5325.174597937316, 3825.59831217723, 4070.287699652564, 4103.138340948404, 4109.116539943911, 4153.356229784388, 4123.422860712055, 4143.378493226025, 4143.502779666429, 4177.603127702863, 4181.268278051344, 3776.0182352588386, 3864.478295430123, 3921.627445392683, 4050.3519436890106, 4102.118044620406, 3178.8887388941275, 3483.9548135559357, 4061.8984525386804, 4079.694022948261, 4084.9591504084874, 3137.7803553751246, 3216.8391580420885, 3336.9466937751927, 3377.4596064629786, 3573.9642603573893, 4700.542831722177, 4898.730569818658, 4961.70229786214, 5053.014662140884, 5237.842864714026, 4330.047389574289, 4508.729476231437, 4643.837465688718, 4687.507811679793, 4742.976285118552, 5522.006038912994, 5568.582356323252, 5589.580781441408, 5636.633618814764, 5657.915131272993, 3493.3188028334484, 3564.465330200465, 3981.2435637229123, 3987.641112299907, 4018.678505719535, 4881.365422495053, 5866.266716660418, 5890.97054514729, 5931.822045338604, 5949.970250148722, 3252.756043296715, 3588.928221435609, 3880.176317130944, 3917.9654144424276, 3923.293807114747, 3510.1049232446076, 3604.7656902301264, 3763.7767725489325, 3976.920461590752, 3986.6212709793103, 4485.8785303674085, 4559.863204103882, 4563.710820601686, 4600.700954437951, 4609.8156073757345, 4606.723596584216, 4950.900981980412, 5202.92195617066, 5326.92009619856, 5690.800821971211, 1288.1884412819863, 1309.9913066938404, 1332.2672530108402, 1336.1315145155727, 1341.9798703019462, 718.6668729506794, 736.3152268390342, 864.9481031138151, 884.1821315283337, 888.7067267801739, 3998.5001874765653, 5180.663256888291, 5208.348956380452, 5226.066355448508, 5247.2129180623215, 5240.213967904845, 5623.915641265385, 5641.26663533738, 5647.689377084218, 5679.557790150193, 4984.526469985346, 5157.896842063213, 5161.974190129025, 5179.161397703836, 5253.290805741176, 2984.552492041358, 3003.4443627928904, 3011.337505748732, 3019.74332181767, 3020.652624948159, 5461.651489859399, 5872.941270587239, 5878.853028674232, 5884.705764711747, 5934.495567876779, 4937.679050861682, 5387.757550910218, 5833.774907269436, 5839.416058394211, 5842.808946645008, 5209.661372010807, 5418.699512117142, 5509.0, 5942.762289508371, 5960.254968128984, 5269.78920843162, 5666.9716651416475, 5676.524103733142, 5689.032864412977, 5767.480926716616, 4672.971946171837, 5065.696058236517, 5372.092907018108, 5608.747606357805, 5618.578606604439, 4735.952640473552, 4993.452029870752, 5285.462977770615, 5816.651000939957, 5834.358220595816, 3571.624979377128, 3583.362886670084, 3907.4138879168354, 3914.8042597870563, 3940.5468371137686, 4679.578837904605, 5082.491750824888, 5707.714614269187, 5717.342505611741, 5718.684702518361, 4609.677322587387, 4714.316424118552, 4741.762911854325, 5662.527742786988, 5668.943310567007, 5433.728313584384, 5501.4163471497395, 5585.888282234414, 5614.41048689898, 5645.322561292671, 5303.390110137229, 5441.319835020622, 5504.5412965563355, 5515.25544051564, 5553.278073850373, 5059.46875578059, 5571.359293681278, 5674.659520428788, 5734.942650573607, 5810.373095533258, 5054.16606259963, 5367.785288588413, 5575.964772857797, 5576.490579239439, 5600.60795744294], "value": 4059.490195689434, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.8622004929086, 781.2539025230901, 818.1940788323504, 854.4104567848184, 859.0722020218165, 15116.773248401269, 16341.5914602135, 16359.182040897953, 16366.0, 16384.508464746075, 14832.777508337384, 14980.850191498082, 15000.174990375524, 15016.924915375435, 15034.398624055051, 690.0442886602042, 707.5931339479794, 712.7968528969245, 715.1918332284512, 863.9136086391342, 702.9824254393629, 708.0688894104262, 864.1617630898019, 894.5035505294559, 895.6686026170294, 939.1594522901999, 939.4691999020565, 939.4973689076346, 940.1350757303297, 943.3019565521499, 917.5137177296044, 932.4125800745554, 932.4684929590069, 932.5663566441638, 932.6036434515338, 551.5835544164171, 564.3171762167782, 567.2653913182438, 700.2087640965727, 701.7684164225793, 12511.436985335591, 12582.68543286416, 14691.77962330566, 15252.313645885852, 15254.38982440701, 14686.0, 15077.396904123822, 15086.54740357791, 15106.924465377602, 15312.234388280542, 11996.820047699292, 12056.457459414347, 12188.164307726018, 12389.008879289635, 12503.74992500145, 3841.42378643203, 3956.624120708528, 3996.5603783583783, 4012.257732319501, 4091.284025295561, 102941.0, 106937.46531267294, 106972.0, 107320.4633976833, 107752.38371424435, 11303.491342889589, 11477.827832582518, 11639.53441862316, 11744.588939387251, 11917.22538035025, 23638.409039774142, 24057.398565036015, 24065.037398503864, 24129.276121716375, 24164.03343866261, 8237.711680091168, 8426.199511046441, 8427.620757065946, 8534.914650853412, 8581.184787445183, 4579.656525760582, 4648.628109751279, 4703.929441058387, 4716.858494245178, 4883.072216278895, 3626.7461277710836, 3764.8117594120185, 3768.0768211788286, 3769.1707824278615, 3781.9432708509394, 597.4921316880703, 702.0101656664079, 710.3713213805715, 711.1004579207307, 712.3090602115939, 528.4636094364223, 568.3038278109283, 613.8833621611968, 677.4749569083999, 714.2892821642499, 9318.86021709675, 9380.24958003358, 9493.90506094944, 9792.461414622265, 9830.557624906896, 415.9771212583337, 612.8100288910363, 634.0040481009706, 674.2653730026096, 692.7506097804786, 4055.1889622075705, 4479.350494178326, 4637.489876113692, 4735.928961065587, 4917.532834380728, 132788.0, 152929.0, 156105.43894561136, 157345.0, 159557.0, 99556.0, 126165.36917315355, 129060.0, 134379.0, 137204.0, 76925.61537192279, 99186.5040674792, 111212.0, 112057.0, 118763.40618296854, 10091.820906837487, 10167.84748228792, 10210.795784084128, 10250.538725757508, 10311.381317120997, 64810.675946619966, 67356.6632166836, 67983.32016679968, 69915.0, 70101.19595216135, 74910.25089749033, 99184.50407747916, 103745.06931702951, 104856.0, 105219.36951576272, 12002.339871307162, 13357.198568085945, 13789.86210137926, 13978.0, 14089.295535222993, 15715.764263536284, 15950.361985520913, 16117.95233309831, 16157.75763363527, 16226.269817858461, 14338.784918226444, 14397.928010359881, 14520.201388923711, 14534.927325363305, 14954.0, 9893.406395616286, 13583.796243056164, 14132.50536231227, 14139.293035348397, 14164.575062748134, 13947.780626752236, 13998.300084995506, 14095.647608809863, 14641.48754793577, 14717.043392179474, 10784.0, 11303.886961130613, 11388.37363944991, 11703.882961170279, 11793.587224447447, 11246.0, 11397.487113079766, 11610.071194304604, 11811.704707382385, 11813.763724725286], "value": 8010.776239261428, "unit": "score"}], "name": "dromaeo_css", "value": 7508.076416951321, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 112.0, 112.0, 112.0, 111.0, 112.0, 111.0, 112.0, 113.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 104.0, 159.0, 104.0, 106.0, 125.0, 105.0, 138.0, 107.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 187.0, 184.0, 186.0, 182.0, 183.0, 181.0, 183.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 58.0, 88.0, 59.0, 57.0, 66.0, 61.0, 83.0, 58.0], "value": 68.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 92.0, 93.0, 72.0, 77.0, 69.0, 98.0, 71.0, 68.0, 103.0], "value": 82.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 135.0, 84.0, 86.0, 83.0, 87.0, 85.0, 88.0, 83.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 102.0, 93.0, 94.0, 94.0, 94.0, 93.0, 100.0], "value": 95.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 86.0, 85.0, 85.0, 83.0, 112.0, 142.0, 139.0, 88.0], "value": 98.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 56.0, 56.0, 55.0, 55.0, 53.0, 53.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 74.0, 79.0, 72.0, 72.0, 72.0, 70.0, 83.0, 107.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 84.0, 85.0, 82.0, 87.0, 80.0, 83.0, 87.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 135.0, 135.0, 136.0, 133.0, 136.0, 133.0, 217.0, 136.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 163.0, 163.0, 164.0, 160.0, 167.0, 161.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 64.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1436.7, "alertThreshold": 2.0}]} 13:56:14 INFO - Return code: 0 13:56:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:56:14 INFO - # TBPL SUCCESS # 13:56:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:56:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:56:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:56:14 INFO - 2016-07-15 13:56:14.874 screenresolution[6707:115058] starting screenresolution argv=screenresolution get 13:56:14 INFO - 2016-07-15 13:56:14.877 screenresolution[6707:115058] Display 0: 1600x1200x32@60 13:56:14 INFO - 2016-07-15 13:56:14.883 screenresolution[6708:115061] starting screenresolution argv=screenresolution list 13:56:14 INFO - Available Modes on Display 0 13:56:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:56:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:56:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:56:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:56:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:56:15 INFO - Intel Iris: 13:56:15 INFO - Chipset Model: Intel Iris 13:56:15 INFO - Type: GPU 13:56:15 INFO - Bus: Built-In 13:56:15 INFO - VRAM (Dynamic, Max): 1536 MB 13:56:15 INFO - Vendor: Intel (0x8086) 13:56:15 INFO - Device ID: 0x0a2e 13:56:15 INFO - Revision ID: 0x0009 13:56:15 INFO - Displays: 13:56:15 INFO - Display: 13:56:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:56:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:56:15 INFO - Display Serial Number: 1600x1200 60 13:56:15 INFO - Main Display: Yes 13:56:15 INFO - Mirror: Off 13:56:15 INFO - Online: Yes 13:56:15 INFO - Rotation: Supported 13:56:15 INFO - Return code: 0 13:56:15 INFO - Running post-action listener: _resource_record_post_action 13:56:15 INFO - ##### 13:56:15 INFO - ##### Finished run-tests step (success) 13:56:15 INFO - ##### 13:56:15 INFO - Running post-run listener: _resource_record_post_run 13:56:15 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 802816; Write bytes: 702775808; Read time: 6; Write time: 1931 13:56:15 INFO - TinderboxPrint: CPU usage
53.4% 13:56:15 INFO - TinderboxPrint: I/O read bytes / time
802,816 / 6 13:56:15 INFO - TinderboxPrint: I/O write bytes / time
702,775,808 / 1,931 13:56:15 INFO - TinderboxPrint: CPU idle
2,259.9 (46.6%) 13:56:15 INFO - TinderboxPrint: CPU system
966.0 (19.9%) 13:56:15 INFO - TinderboxPrint: CPU user
1,619.8 (33.4%) 13:56:15 INFO - TinderboxPrint: Swap in / out
407,375,872 / 0 13:56:15 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394510848; Write bytes: 388429824; Read time: 29658; Write time: 794 13:56:15 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 802816; Write bytes: 293374464; Read time: 6; Write time: 1085 13:56:15 INFO - Running post-run listener: _upload_blobber_files 13:56:15 INFO - Blob upload gear active. 13:56:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:56:15 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 13:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:56:15 INFO - (blobuploader) - INFO - Open directory for files ... 13:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:56:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:17 INFO - (blobuploader) - INFO - Done attempting. 13:56:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:56:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:56:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:19 INFO - (blobuploader) - INFO - Done attempting. 13:56:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:56:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:56:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:21 INFO - (blobuploader) - INFO - Done attempting. 13:56:21 INFO - (blobuploader) - INFO - Iteration through files over. 13:56:21 INFO - Return code: 0 13:56:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:56:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:56:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e45a58383b6a3aec02a5701a1efdeddc1069627c67e89c0f541aad602d212b0b6ea259af977573a2f8e14ffb10f69d3cc46f6ef72cb3c272e1b00803c58a124d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d4183b46b8d3b349a915e2ee79666a7851c29065ed1916abea58ddb12b6c61797bbd14da8930cba5bc1e2242b298485d6934ae9449fdb0f5236c61c695b9350c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3137d7f83068068c3e977ea61b891729c3439ccf6bb44e9609beace2a544fc451cac6583b0a5ad548e4902e3c5a3ca0368359004085dbde6dac35936c3f3104b"} 13:56:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:56:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:56:21 INFO - Contents: 13:56:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e45a58383b6a3aec02a5701a1efdeddc1069627c67e89c0f541aad602d212b0b6ea259af977573a2f8e14ffb10f69d3cc46f6ef72cb3c272e1b00803c58a124d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d4183b46b8d3b349a915e2ee79666a7851c29065ed1916abea58ddb12b6c61797bbd14da8930cba5bc1e2242b298485d6934ae9449fdb0f5236c61c695b9350c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3137d7f83068068c3e977ea61b891729c3439ccf6bb44e9609beace2a544fc451cac6583b0a5ad548e4902e3c5a3ca0368359004085dbde6dac35936c3f3104b"} 13:56:21 INFO - Running post-run listener: copy_logs_to_upload_dir 13:56:21 INFO - Copying logs to upload dir... 13:56:21 INFO - mkdir: /builds/slave/test/build/upload/logs 13:56:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.948388 ========= master_lag: 1.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-15 13:56:22.997169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:56:23.001096) ========= 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.YK7xysAlV1/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.HWVLEKUPLa/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e45a58383b6a3aec02a5701a1efdeddc1069627c67e89c0f541aad602d212b0b6ea259af977573a2f8e14ffb10f69d3cc46f6ef72cb3c272e1b00803c58a124d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d4183b46b8d3b349a915e2ee79666a7851c29065ed1916abea58ddb12b6c61797bbd14da8930cba5bc1e2242b298485d6934ae9449fdb0f5236c61c695b9350c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3137d7f83068068c3e977ea61b891729c3439ccf6bb44e9609beace2a544fc451cac6583b0a5ad548e4902e3c5a3ca0368359004085dbde6dac35936c3f3104b"} build_url:https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011596 build_url: 'https://queue.taskcluster.net/v1/task/Jv1-Z8F7QB6-yfYhxMaQig/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e45a58383b6a3aec02a5701a1efdeddc1069627c67e89c0f541aad602d212b0b6ea259af977573a2f8e14ffb10f69d3cc46f6ef72cb3c272e1b00803c58a124d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d4183b46b8d3b349a915e2ee79666a7851c29065ed1916abea58ddb12b6c61797bbd14da8930cba5bc1e2242b298485d6934ae9449fdb0f5236c61c695b9350c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3137d7f83068068c3e977ea61b891729c3439ccf6bb44e9609beace2a544fc451cac6583b0a5ad548e4902e3c5a3ca0368359004085dbde6dac35936c3f3104b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:56:23.038738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:56:23.039072) ========= 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.YK7xysAlV1/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.HWVLEKUPLa/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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.005307 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:56:23.087548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:56:23.087877) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:56:23.088193) ========= ========= Total master_lag: 1.50 =========