builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0033 starttime: 1461764193.3 results: success (0) buildid: 20160427045809 builduid: e979a483308241ffb30e2dae288d1e9b revision: a8386cc2b749b7c73b3e3e718eb3b50b7d5aa8e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:33.301905) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:33.302351) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:33.302637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:33.442252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:33.442620) ========= 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.4KYfIJ334O/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.MFSsk3njYe/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-27 06:36:33-- 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% 9.17M=0.001s 2016-04-27 06:36:33 (9.17 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.303484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:33.764047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:33.764395) ========= 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.4KYfIJ334O/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.MFSsk3njYe/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.027402 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:33.813719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 06:36:33.814079) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a8386cc2b749b7c73b3e3e718eb3b50b7d5aa8e0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a8386cc2b749b7c73b3e3e718eb3b50b7d5aa8e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4KYfIJ334O/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.MFSsk3njYe/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-27 06:36:33,897 truncating revision to first 12 chars 2016-04-27 06:36:33,897 Setting DEBUG logging. 2016-04-27 06:36:33,897 attempt 1/10 2016-04-27 06:36:33,897 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a8386cc2b749?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 06:36:34,948 unpacking tar archive at: fx-team-a8386cc2b749/testing/mozharness/ program finished with exit code 0 elapsedTime=1.290439 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 06:36:35.127205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:35.127506) ========= script_repo_revision: a8386cc2b749b7c73b3e3e718eb3b50b7d5aa8e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:35.127893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:35.128154) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 06:36:35.141758) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-27 06:36:35.142144) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4KYfIJ334O/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.MFSsk3njYe/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:36:35 INFO - MultiFileLogger online at 20160427 06:36:35 in /builds/slave/test 06:36:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:36:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:35 INFO - {'append_to_log': False, 06:36:35 INFO - 'base_work_dir': '/builds/slave/test', 06:36:35 INFO - 'blob_upload_branch': 'Fx-Team', 06:36:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:35 INFO - 'branch': 'Fx-Team', 06:36:35 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:35 INFO - 'config_files': ('talos/mac_config.py',), 06:36:35 INFO - 'default_actions': ('clobber', 06:36:35 INFO - 'read-buildbot-config', 06:36:35 INFO - 'download-and-extract', 06:36:35 INFO - 'populate-webroot', 06:36:35 INFO - 'create-virtualenv', 06:36:35 INFO - 'install', 06:36:35 INFO - 'run-tests'), 06:36:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:35 INFO - 'download_minidump_stackwalk': True, 06:36:35 INFO - 'download_symbols': 'ondemand', 06:36:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:35 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:35 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:35 INFO - 'installer_path': 'installer.exe', 06:36:35 INFO - 'log_level': 'info', 06:36:35 INFO - 'log_name': 'talos', 06:36:35 INFO - 'log_to_console': True, 06:36:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:36:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:36:35 INFO - 'opt_config_files': (), 06:36:35 INFO - 'pip_index': False, 06:36:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:35 INFO - 'cmd': ('bash', 06:36:35 INFO - '-c', 06:36:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:35 INFO - 'enabled': True, 06:36:35 INFO - 'halt_on_failure': False, 06:36:35 INFO - 'name': 'check_screen_resolution'},), 06:36:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:35 INFO - 'cmd': ('bash', 06:36:35 INFO - '-c', 06:36:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:35 INFO - 'enabled': True, 06:36:35 INFO - 'halt_on_failure': False, 06:36:35 INFO - 'name': 'check_screen_resolution'},), 06:36:35 INFO - 'run_cmd_checks_enabled': True, 06:36:35 INFO - 'sps_profile': False, 06:36:35 INFO - 'sps_profile_interval': 0, 06:36:35 INFO - 'suite': 'dromaeojs', 06:36:35 INFO - 'system_bits': '32', 06:36:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:35 INFO - 'title': 't-yosemite-r7-0033', 06:36:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:35 INFO - 'use_talos_json': True, 06:36:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:35 INFO - 'work_dir': 'build'} 06:36:35 INFO - ##### 06:36:35 INFO - ##### Running clobber step. 06:36:35 INFO - ##### 06:36:35 INFO - Running pre-action listener: _resource_record_pre_action 06:36:35 INFO - Running main action method: clobber 06:36:35 INFO - rmtree: /builds/slave/test/build 06:36:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:36 INFO - Running post-action listener: _resource_record_post_action 06:36:36 INFO - ##### 06:36:36 INFO - ##### Running read-buildbot-config step. 06:36:36 INFO - ##### 06:36:36 INFO - Running pre-action listener: _resource_record_pre_action 06:36:36 INFO - Running main action method: read_buildbot_config 06:36:36 INFO - Using buildbot properties: 06:36:36 INFO - { 06:36:36 INFO - "project": "", 06:36:36 INFO - "product": "firefox", 06:36:36 INFO - "script_repo_revision": "production", 06:36:36 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:36:36 INFO - "repository": "", 06:36:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:36:36 INFO - "buildid": "20160427045809", 06:36:36 INFO - "pgo_build": "False", 06:36:36 INFO - "basedir": "/builds/slave/test", 06:36:36 INFO - "buildnumber": 672, 06:36:36 INFO - "slavename": "t-yosemite-r7-0033", 06:36:36 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:36:36 INFO - "platform": "yosemite_r7", 06:36:36 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:36:36 INFO - "branch": "fx-team", 06:36:36 INFO - "repo_path": "integration/fx-team", 06:36:36 INFO - "revision": "a8386cc2b749b7c73b3e3e718eb3b50b7d5aa8e0", 06:36:36 INFO - "stage_platform": "macosx64", 06:36:36 INFO - "builduid": "e979a483308241ffb30e2dae288d1e9b", 06:36:36 INFO - "slavebuilddir": "test" 06:36:36 INFO - } 06:36:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 06:36:36 INFO - Running post-action listener: _resource_record_post_action 06:36:36 INFO - ##### 06:36:36 INFO - ##### Running download-and-extract step. 06:36:36 INFO - ##### 06:36:36 INFO - Running pre-action listener: _resource_record_pre_action 06:36:36 INFO - Running main action method: download_and_extract 06:36:36 INFO - mkdir: /builds/slave/test/build/tests 06:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:36 INFO - https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:36:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:36:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:36:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 06:36:42 INFO - Downloaded 1199 bytes. 06:36:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:36:42 INFO - Using the following test package requirements: 06:36:42 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:36:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:36:42 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 06:36:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:36:42 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 06:36:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:36:42 INFO - u'jsshell-mac.zip'], 06:36:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:36:42 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 06:36:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:36:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:36:42 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 06:36:42 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:36:42 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 06:36:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:36:42 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 06:36:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:36:42 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 06:36:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:36: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')]} 06:36:42 INFO - https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:36:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:36:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:36:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:36:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:36:45 INFO - Downloaded 18117253 bytes. 06:36:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:36:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:36:48 INFO - Return code: 0 06:36:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:36: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')]} 06:36:48 INFO - https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:36:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:36:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:36:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:37:04 INFO - Downloaded 18117253 bytes. 06:37:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:37:08 INFO - Return code: 0 06:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:08 INFO - https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:37:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:37:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:37:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:37:09 INFO - Downloaded 10840145 bytes. 06:37:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:37:09 INFO - Return code: 0 06:37:09 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')]} 06:37:09 INFO - https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:37:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:37:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:37:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 06:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 06:37:12 INFO - Downloaded 110185941 bytes. 06:37:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:37:12 INFO - mkdir: /builds/slave/test/properties 06:37:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:12 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:12 INFO - Contents: 06:37:12 INFO - build_url:https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:37:13 INFO - Running post-action listener: _resource_record_post_action 06:37:13 INFO - Running post-action listener: set_extra_try_arguments 06:37:13 INFO - ##### 06:37:13 INFO - ##### Running populate-webroot step. 06:37:13 INFO - ##### 06:37:13 INFO - Running pre-action listener: _resource_record_pre_action 06:37:13 INFO - Running main action method: populate_webroot 06:37:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:13 INFO - '--tppagecycles', 06:37:13 INFO - '7'], 06:37:13 INFO - 'tests': ['tsvgm']}}, 06:37:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:13 INFO - 'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:13 INFO - 'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['damp', 'tps']}, 06:37:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:13 INFO - 'tests': ['damp', 'tps']}, 06:37:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['dromaeo_dom']}, 06:37:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['a11yr', 06:37:13 INFO - 'ts_paint', 06:37:13 INFO - 'tpaint', 06:37:13 INFO - 'sessionrestore', 06:37:13 INFO - 'sessionrestore_no_auto_restore', 06:37:13 INFO - 'tabpaint']}, 06:37:13 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:13 INFO - 'ts_paint', 06:37:13 INFO - 'tpaint', 06:37:13 INFO - 'sessionrestore', 06:37:13 INFO - 'sessionrestore_no_auto_restore', 06:37:13 INFO - 'tabpaint']}, 06:37:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:13 INFO - 'ts_paint', 06:37:13 INFO - 'tpaint', 06:37:13 INFO - 'sessionrestore', 06:37:13 INFO - 'sessionrestore_no_auto_restore', 06:37:13 INFO - 'tabpaint']}, 06:37:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:13 INFO - 'ts_paint', 06:37:13 INFO - 'tpaint', 06:37:13 INFO - 'sessionrestore', 06:37:13 INFO - 'sessionrestore_no_auto_restore', 06:37:13 INFO - 'tabpaint']}, 06:37:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['a11yr', 06:37:13 INFO - 'ts_paint', 06:37:13 INFO - 'tpaint', 06:37:13 INFO - 'sessionrestore', 06:37:13 INFO - 'sessionrestore_no_auto_restore', 06:37:13 INFO - 'tabpaint']}, 06:37:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['a11yr', 06:37:13 INFO - 'ts_paint', 06:37:13 INFO - 'tpaint', 06:37:13 INFO - 'sessionrestore', 06:37:13 INFO - 'sessionrestore_no_auto_restore', 06:37:13 INFO - 'tabpaint']}, 06:37:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['tsvgx', 06:37:13 INFO - 'tsvgr_opacity', 06:37:13 INFO - 'tart', 06:37:13 INFO - 'tscrollx', 06:37:13 INFO - 'cart']}, 06:37:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:13 INFO - 'tsvgr_opacity', 06:37:13 INFO - 'tart', 06:37:13 INFO - 'tscrollx', 06:37:13 INFO - 'cart']}, 06:37:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:13 INFO - 'talos_options': ['--disable-e10s'], 06:37:13 INFO - 'tests': ['tp5o']}, 06:37:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:13 INFO - 'tests': ['tp5o']}, 06:37:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:13 INFO - 'talos_options': ['--disable-e10s', 06:37:13 INFO - '--xperf_path', 06:37:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:13 INFO - 'tests': ['tp5n']}, 06:37:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:13 INFO - 'talos_options': ['--xperf_path', 06:37:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:13 INFO - 'tests': ['tp5n']}}, 06:37:13 INFO - 'talos.zip': {'path': '', 06:37:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:13 INFO - Running post-action listener: _resource_record_post_action 06:37:13 INFO - ##### 06:37:13 INFO - ##### Running create-virtualenv step. 06:37:13 INFO - ##### 06:37:13 INFO - Running pre-action listener: _resource_record_pre_action 06:37:13 INFO - Running main action method: create_virtualenv 06:37:13 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:13 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 06:37:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:13 INFO - Using real prefix '/tools/python27' 06:37:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:14 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:16 INFO - Installing pip.................done. 06:37:16 INFO - Return code: 0 06:37:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37:16 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')]} 06:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:16 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')]} 06:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:16 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 0x103327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb802d70dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, '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.4KYfIJ334O/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.MFSsk3njYe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:37:16 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 06:37:16 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 06:37:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:37:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:16 INFO - 'HOME': '/Users/cltbld', 06:37:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:16 INFO - 'LOGNAME': 'cltbld', 06:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:16 INFO - 'MOZ_NO_REMOTE': '1', 06:37:16 INFO - 'NO_EM_RESTART': '1', 06:37:16 INFO - 'PAGER': '/bin/cat', 06:37:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:16 INFO - 'PWD': '/builds/slave/test', 06:37:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:16 INFO - 'SHELL': '/bin/bash', 06:37:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:37:16 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:37:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:16 INFO - 'USER': 'cltbld', 06:37:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:16 INFO - 'XPC_FLAGS': '0x0', 06:37:16 INFO - 'XPC_SERVICE_NAME': '0', 06:37:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:17 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 06:37:17 INFO - Cleaning up... 06:37:17 INFO - Return code: 0 06:37:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb802d70dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, '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.4KYfIJ334O/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.MFSsk3njYe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:37:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:37:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:37:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:17 INFO - 'HOME': '/Users/cltbld', 06:37:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:17 INFO - 'LOGNAME': 'cltbld', 06:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:17 INFO - 'MOZ_NO_REMOTE': '1', 06:37:17 INFO - 'NO_EM_RESTART': '1', 06:37:17 INFO - 'PAGER': '/bin/cat', 06:37:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:17 INFO - 'PWD': '/builds/slave/test', 06:37:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:17 INFO - 'SHELL': '/bin/bash', 06:37:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:37:17 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:37:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:17 INFO - 'USER': 'cltbld', 06:37:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:17 INFO - 'XPC_FLAGS': '0x0', 06:37:17 INFO - 'XPC_SERVICE_NAME': '0', 06:37:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:17 INFO - Downloading/unpacking psutil>=0.7.1 06:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:20 INFO - Installing collected packages: psutil 06:37:20 INFO - Running setup.py install for psutil 06:37:20 INFO - building 'psutil._psutil_osx' extension 06:37:20 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 06:37:21 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 06:37:21 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 06:37:21 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 06:37:21 INFO - building 'psutil._psutil_posix' extension 06:37:21 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 06:37:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:37:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:37:21 INFO - ^ 06:37:21 INFO - 1 warning generated. 06:37:21 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 06:37:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:21 INFO - Successfully installed psutil 06:37:21 INFO - Cleaning up... 06:37:21 INFO - Return code: 0 06:37:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb802d70dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, '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.4KYfIJ334O/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.MFSsk3njYe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:37:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:37:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:21 INFO - 'HOME': '/Users/cltbld', 06:37:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:21 INFO - 'LOGNAME': 'cltbld', 06:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:21 INFO - 'MOZ_NO_REMOTE': '1', 06:37:21 INFO - 'NO_EM_RESTART': '1', 06:37:21 INFO - 'PAGER': '/bin/cat', 06:37:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:21 INFO - 'PWD': '/builds/slave/test', 06:37:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:21 INFO - 'SHELL': '/bin/bash', 06:37:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:37:21 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:37:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:21 INFO - 'USER': 'cltbld', 06:37:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:21 INFO - 'XPC_FLAGS': '0x0', 06:37:21 INFO - 'XPC_SERVICE_NAME': '0', 06:37:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:37:21 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 06:37:21 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 06:37:21 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 06:37:21 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 06:37:21 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 06:37:21 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 06:37:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:37:24 INFO - Installing collected packages: mozsystemmonitor 06:37:24 INFO - Running setup.py install for mozsystemmonitor 06:37:24 INFO - Successfully installed mozsystemmonitor 06:37:24 INFO - Cleaning up... 06:37:24 INFO - Return code: 0 06:37:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:37:24 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')]} 06:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:24 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')]} 06:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:24 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 0x103327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb802d70dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, '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.4KYfIJ334O/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.MFSsk3njYe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:37:24 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 06:37:24 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 06:37:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:37:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:24 INFO - 'HOME': '/Users/cltbld', 06:37:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:24 INFO - 'LOGNAME': 'cltbld', 06:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:24 INFO - 'MOZ_NO_REMOTE': '1', 06:37:24 INFO - 'NO_EM_RESTART': '1', 06:37:24 INFO - 'PAGER': '/bin/cat', 06:37:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:24 INFO - 'PWD': '/builds/slave/test', 06:37:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:24 INFO - 'SHELL': '/bin/bash', 06:37:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:37:24 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:37:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:24 INFO - 'USER': 'cltbld', 06:37:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:24 INFO - 'XPC_FLAGS': '0x0', 06:37:24 INFO - 'XPC_SERVICE_NAME': '0', 06:37:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:24 INFO - Downloading/unpacking blobuploader==1.2.4 06:37:24 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 06:37:24 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 06:37:24 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 06:37:24 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 06:37:24 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 06:37:24 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 06:37:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:37:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:37:27 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 06:37:27 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 06:37:27 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 06:37:27 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 06:37:27 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 06:37:27 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 06:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37:28 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 06:37:28 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 06:37:28 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 06:37:28 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 06:37:28 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 06:37:28 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 06:37:28 INFO - Downloading docopt-0.6.1.tar.gz 06:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:28 INFO - Running setup.py install for blobuploader 06:37:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:28 INFO - Running setup.py install for requests 06:37:29 INFO - Running setup.py install for docopt 06:37:29 INFO - Successfully installed blobuploader requests docopt 06:37:29 INFO - Cleaning up... 06:37:29 INFO - Return code: 0 06:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:29 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')]} 06:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:29 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')]} 06:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:29 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 0x103327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb802d70dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, '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.4KYfIJ334O/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.MFSsk3njYe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:37:29 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 06:37:29 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 06:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:29 INFO - 'HOME': '/Users/cltbld', 06:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:29 INFO - 'LOGNAME': 'cltbld', 06:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:29 INFO - 'MOZ_NO_REMOTE': '1', 06:37:29 INFO - 'NO_EM_RESTART': '1', 06:37:29 INFO - 'PAGER': '/bin/cat', 06:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:29 INFO - 'PWD': '/builds/slave/test', 06:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:29 INFO - 'SHELL': '/bin/bash', 06:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:37:29 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:29 INFO - 'USER': 'cltbld', 06:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:29 INFO - 'XPC_FLAGS': '0x0', 06:37:29 INFO - 'XPC_SERVICE_NAME': '0', 06:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:29 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-qskkqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:29 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-aRg2wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:29 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-74DXoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-fZrOdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-50NP7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-zp7e_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-XVvvpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-vrksXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-U_UFdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-C9jvMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-vlgHY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Ky4jjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:30 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-lbdEnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:31 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-MhC0lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:31 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-y2qGHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:31 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-XAXKPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:31 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-uIVwmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:31 INFO - Running setup.py install for manifestparser 06:37:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:31 INFO - Running setup.py install for mozcrash 06:37:31 INFO - Running setup.py install for mozdebug 06:37:31 INFO - Running setup.py install for mozdevice 06:37:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Running setup.py install for mozfile 06:37:32 INFO - Running setup.py install for mozhttpd 06:37:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Running setup.py install for mozinfo 06:37:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Running setup.py install for mozInstall 06:37:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Running setup.py install for mozleak 06:37:32 INFO - Running setup.py install for mozlog 06:37:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:32 INFO - Running setup.py install for moznetwork 06:37:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:33 INFO - Running setup.py install for mozprocess 06:37:33 INFO - Running setup.py install for mozprofile 06:37:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:33 INFO - Running setup.py install for mozrunner 06:37:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:33 INFO - Running setup.py install for mozscreenshot 06:37:33 INFO - Running setup.py install for moztest 06:37:33 INFO - Running setup.py install for mozversion 06:37:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:33 INFO - Cleaning up... 06:37:33 INFO - Return code: 0 06:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:33 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 0x103327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb802d70dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, '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.4KYfIJ334O/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.MFSsk3njYe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:37:33 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 06:37:33 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 06:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:33 INFO - 'HOME': '/Users/cltbld', 06:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:33 INFO - 'LOGNAME': 'cltbld', 06:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:33 INFO - 'MOZ_NO_REMOTE': '1', 06:37:33 INFO - 'NO_EM_RESTART': '1', 06:37:33 INFO - 'PAGER': '/bin/cat', 06:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:34 INFO - 'PWD': '/builds/slave/test', 06:37:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:34 INFO - 'SHELL': '/bin/bash', 06:37:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:37:34 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:37:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:34 INFO - 'USER': 'cltbld', 06:37:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:34 INFO - 'XPC_FLAGS': '0x0', 06:37:34 INFO - 'XPC_SERVICE_NAME': '0', 06:37:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:34 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-__gGg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:34 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)) 06:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:34 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-QA6j4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:34 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)) 06:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:34 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-kNecc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:34 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)) 06:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:34 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-qSXGRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:34 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)) 06:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:34 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-BIf2tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:34 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)) 06:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:34 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-vMsnvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:34 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)) 06:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:34 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-QLxnVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:34 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)) 06:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:34 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-m8V0p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:35 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)) 06:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:35 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-EEMiuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:35 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)) 06:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:35 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Vhc4EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:35 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ZaHS0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:35 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)) 06:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:35 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-u3cG5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:35 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-mniVsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:35 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)) 06:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:35 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-iFiUD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:35 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-tYbD0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:35 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)) 06:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:35 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-RoPU4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:35 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)) 06:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:35 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-VAxCyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 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)) 06:37:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:38 INFO - Downloading blessings-1.6.tar.gz 06:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:37:38 INFO - Installing collected packages: blessings 06:37:38 INFO - Running setup.py install for blessings 06:37:39 INFO - Successfully installed blessings 06:37:39 INFO - Cleaning up... 06:37:39 INFO - Return code: 0 06:37:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:39 INFO - Reading from file tmpfile_stdout 06:37:39 INFO - Current package versions: 06:37:39 INFO - blessings == 1.6 06:37:39 INFO - blobuploader == 1.2.4 06:37:39 INFO - docopt == 0.6.1 06:37:39 INFO - manifestparser == 1.1 06:37:39 INFO - mozInstall == 1.12 06:37:39 INFO - mozcrash == 0.17 06:37:39 INFO - mozdebug == 0.1 06:37:39 INFO - mozdevice == 0.48 06:37:39 INFO - mozfile == 1.2 06:37:39 INFO - mozhttpd == 0.7 06:37:39 INFO - mozinfo == 0.9 06:37:39 INFO - mozleak == 0.1 06:37:39 INFO - mozlog == 3.1 06:37:39 INFO - moznetwork == 0.27 06:37:39 INFO - mozprocess == 0.22 06:37:39 INFO - mozprofile == 0.28 06:37:39 INFO - mozrunner == 6.11 06:37:39 INFO - mozscreenshot == 0.1 06:37:39 INFO - mozsystemmonitor == 0.0 06:37:39 INFO - moztest == 0.7 06:37:39 INFO - mozversion == 1.4 06:37:39 INFO - psutil == 3.1.1 06:37:39 INFO - requests == 1.2.3 06:37:39 INFO - wsgiref == 0.1.2 06:37:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:39 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 0x103327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb802d70dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, '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.4KYfIJ334O/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.MFSsk3njYe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:37:39 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 06:37:39 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 06:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:39 INFO - 'HOME': '/Users/cltbld', 06:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:39 INFO - 'LOGNAME': 'cltbld', 06:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:39 INFO - 'MOZ_NO_REMOTE': '1', 06:37:39 INFO - 'NO_EM_RESTART': '1', 06:37:39 INFO - 'PAGER': '/bin/cat', 06:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:39 INFO - 'PWD': '/builds/slave/test', 06:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:39 INFO - 'SHELL': '/bin/bash', 06:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:37:39 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:39 INFO - 'USER': 'cltbld', 06:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:39 INFO - 'XPC_FLAGS': '0x0', 06:37:39 INFO - 'XPC_SERVICE_NAME': '0', 06:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:39 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)) 06:37:39 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)) 06:37:39 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)) 06:37:39 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)) 06:37:39 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)) 06:37:39 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)) 06:37:39 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)) 06:37:39 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)) 06:37:39 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)) 06:37:39 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)) 06:37:39 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)) 06:37:39 INFO - Cleaning up... 06:37:39 INFO - Return code: 0 06:37:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb802d70dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, '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.4KYfIJ334O/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.MFSsk3njYe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:39 INFO - 'HOME': '/Users/cltbld', 06:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:39 INFO - 'LOGNAME': 'cltbld', 06:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:39 INFO - 'MOZ_NO_REMOTE': '1', 06:37:39 INFO - 'NO_EM_RESTART': '1', 06:37:39 INFO - 'PAGER': '/bin/cat', 06:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:39 INFO - 'PWD': '/builds/slave/test', 06:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:39 INFO - 'SHELL': '/bin/bash', 06:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:37:39 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:39 INFO - 'USER': 'cltbld', 06:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:39 INFO - 'XPC_FLAGS': '0x0', 06:37:39 INFO - 'XPC_SERVICE_NAME': '0', 06:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:39 INFO - Downloading/unpacking jsonschema 06:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:37:42 INFO - Downloading/unpacking functools32 (from jsonschema) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:42 INFO - Downloading functools32-3.2.3-2.tar.gz 06:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:37:42 INFO - warning: no files found matching '*.txt' 06:37:42 INFO - no previously-included directories found matching 'build' 06:37:42 INFO - no previously-included directories found matching 'dist' 06:37:42 INFO - no previously-included directories found matching '.git*' 06:37:42 INFO - Installing collected packages: jsonschema, functools32 06:37:42 INFO - Running setup.py install for functools32 06:37:43 INFO - warning: no files found matching '*.txt' 06:37:43 INFO - no previously-included directories found matching 'build' 06:37:43 INFO - no previously-included directories found matching 'dist' 06:37:43 INFO - no previously-included directories found matching '.git*' 06:37:43 INFO - Successfully installed jsonschema functools32 06:37:43 INFO - Cleaning up... 06:37:43 INFO - Return code: 0 06:37:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:37:43 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')]} 06:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:43 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')]} 06:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb802d70dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, '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.4KYfIJ334O/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.MFSsk3njYe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 06:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:43 INFO - 'HOME': '/Users/cltbld', 06:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:43 INFO - 'LOGNAME': 'cltbld', 06:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:43 INFO - 'MOZ_NO_REMOTE': '1', 06:37:43 INFO - 'NO_EM_RESTART': '1', 06:37:43 INFO - 'PAGER': '/bin/cat', 06:37:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:43 INFO - 'PWD': '/builds/slave/test', 06:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:43 INFO - 'SHELL': '/bin/bash', 06:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:37:43 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:43 INFO - 'USER': 'cltbld', 06:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:43 INFO - 'XPC_FLAGS': '0x0', 06:37:43 INFO - 'XPC_SERVICE_NAME': '0', 06:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:43 INFO - Downloading/unpacking flake8 06:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:37:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:37:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:37:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:37:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:37:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:37:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:37:47 INFO - no previously-included directories found matching 'docs/_build' 06:37:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:37:47 INFO - Running setup.py install for pep8 06:37:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:37:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:37:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:37:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:37:47 INFO - no previously-included directories found matching 'docs/_build' 06:37:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:37:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:37:47 INFO - Cleaning up... 06:37:47 INFO - Return code: 0 06:37:47 INFO - Running post-action listener: _resource_record_post_action 06:37:47 INFO - Running post-action listener: _start_resource_monitoring 06:37:47 INFO - Starting resource monitoring. 06:37:47 INFO - ##### 06:37:47 INFO - ##### Running install step. 06:37:47 INFO - ##### 06:37:47 INFO - Running pre-action listener: _resource_record_pre_action 06:37:47 INFO - Running main action method: install 06:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:47 INFO - Reading from file tmpfile_stdout 06:37:47 INFO - Detecting whether we're running mozinstall >=1.0... 06:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:37:47 INFO - Reading from file tmpfile_stdout 06:37:47 INFO - Output received: 06:37:47 INFO - Usage: mozinstall [options] installer 06:37:47 INFO - Options: 06:37:47 INFO - -h, --help show this help message and exit 06:37:47 INFO - -d DEST, --destination=DEST 06:37:47 INFO - Directory to install application into. [default: 06:37:47 INFO - "/builds/slave/test"] 06:37:47 INFO - --app=APP Application being installed. [default: firefox] 06:37:47 INFO - mkdir: /builds/slave/test/build/application 06:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:38:21 INFO - Reading from file tmpfile_stdout 06:38:21 INFO - Output received: 06:38:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:38:21 INFO - Running post-action listener: _resource_record_post_action 06:38:21 INFO - ##### 06:38:21 INFO - ##### Running run-tests step. 06:38:21 INFO - ##### 06:38:21 INFO - Running pre-action listener: _resource_record_pre_action 06:38:21 INFO - Running main action method: run_tests 06:38:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:38:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:38:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:38:21 INFO - 2016-04-27 06:38:21.188 screenresolution[1645:7874] starting screenresolution argv=screenresolution get 06:38:21 INFO - 2016-04-27 06:38:21.190 screenresolution[1645:7874] Display 0: 1600x1200x32@60 06:38:21 INFO - 2016-04-27 06:38:21.196 screenresolution[1646:7876] starting screenresolution argv=screenresolution list 06:38:21 INFO - Available Modes on Display 0 06:38:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:38:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:38:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:38:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:38:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:38:21 INFO - Intel Iris: 06:38:21 INFO - Chipset Model: Intel Iris 06:38:21 INFO - Type: GPU 06:38:21 INFO - Bus: Built-In 06:38:21 INFO - VRAM (Dynamic, Max): 1536 MB 06:38:21 INFO - Vendor: Intel (0x8086) 06:38:21 INFO - Device ID: 0x0a2e 06:38:21 INFO - Revision ID: 0x0009 06:38:21 INFO - Displays: 06:38:21 INFO - Display: 06:38:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:38:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:38:21 INFO - Display Serial Number: 1600x1200 60 06:38:21 INFO - Main Display: Yes 06:38:21 INFO - Mirror: Off 06:38:21 INFO - Online: Yes 06:38:21 INFO - Rotation: Supported 06:38:21 INFO - Return code: 0 06:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:38:21 INFO - Python 2.7.3 06:38:21 INFO - Return code: 0 06:38:21 INFO - grabbing minidump binary from tooltool 06:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c6e00>, '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 0x102fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031c1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:38:21 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 06:38:21 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 06:38:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:38:21 INFO - Return code: 0 06:38:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:38:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:38:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:38:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:38:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:38:22 INFO - Return code: 0 06:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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 06:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0033 --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 06:38:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4KYfIJ334O/Render', 06:38:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:22 INFO - 'HOME': '/Users/cltbld', 06:38:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:22 INFO - 'LOGNAME': 'cltbld', 06:38:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:38:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:22 INFO - 'MOZ_NO_REMOTE': '1', 06:38:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:38:22 INFO - 'NO_EM_RESTART': '1', 06:38:22 INFO - 'PAGER': '/bin/cat', 06:38:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:22 INFO - 'PWD': '/builds/slave/test', 06:38:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:38:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:22 INFO - 'SHELL': '/bin/bash', 06:38:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFSsk3njYe/Listeners', 06:38:22 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 06:38:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:22 INFO - 'USER': 'cltbld', 06:38:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:22 INFO - 'XPC_FLAGS': '0x0', 06:38:22 INFO - 'XPC_SERVICE_NAME': '0', 06:38:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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 06:38:22 INFO - mozversion application_buildid: 20160427045809 06:38:22 INFO - mozversion application_changeset: a8386cc2b749b7c73b3e3e718eb3b50b7d5aa8e0 06:38:22 INFO - mozversion application_display_name: Nightly 06:38:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:38:22 INFO - mozversion application_name: Firefox 06:38:22 INFO - mozversion application_remotingname: firefox 06:38:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:38:22 INFO - mozversion application_vendor: Mozilla 06:38:22 INFO - mozversion application_version: 49.0a1 06:38:22 INFO - mozversion platform_buildid: 20160427045809 06:38:22 INFO - mozversion platform_changeset: a8386cc2b749b7c73b3e3e718eb3b50b7d5aa8e0 06:38:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:38:22 INFO - mozversion platform_version: 49.0a1 06:38:22 INFO - using testdate: 1461764302 06:38:22 INFO - actual date: 1461764302 06:38:22 INFO - starting webserver on 'localhost:49275' 06:38:22 INFO - SUITE-START | Running 2 tests 06:38:22 INFO - TEST-START | dromaeo_css 06:38:22 INFO - operating with platform_type : mac_ 06:38:22 INFO - Initialising browser for dromaeo_css test... 06:38:23 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpoQM5YN/profile http://localhost:49275/getInfo.html) 06:38:25 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 06:38:25 INFO - PROCESS | 1664 | colorDepth:24 06:38:25 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 06:38:25 INFO - PROCESS | 1664 | __metrics 06:38:25 INFO - PROCESS | 1664 | 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" 06:38:25 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:38:26 INFO - TEST-INFO | 1664: exit 0 06:38:26 INFO - Browser initialized. 06:38:26 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:26 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpoQM5YN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:38 INFO - PROCESS | 1666 | RSS: Main: 239005696 06:38:38 INFO - PROCESS | 1666 | 06:39:28 INFO - PROCESS | 1666 | 1461764368984 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] 06:41:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 06:41:41 INFO - PROCESS | 1666 | RSS: Main: 368492544 06:41:41 INFO - PROCESS | 1666 | 06:44:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 06:44:44 INFO - PROCESS | 1666 | RSS: Main: 376262656 06:44:44 INFO - PROCESS | 1666 | 06:47:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 06:47:47 INFO - PROCESS | 1666 | RSS: Main: 375324672 06:47:47 INFO - PROCESS | 1666 | 06:50:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 06:50:50 INFO - PROCESS | 1666 | RSS: Main: 379162624 06:50:50 INFO - PROCESS | 1666 | 06:53:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 06:53:54 INFO - PROCESS | 1666 | RSS: Main: 346554368 06:53:54 INFO - PROCESS | 1666 | 06:56:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 06:56:57 INFO - PROCESS | 1666 | RSS: Main: 381054976 06:56:57 INFO - PROCESS | 1666 | 06:56:57 INFO - PROCESS | 1666 | __start_tp_report 06:56:57 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 06:56:57 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 06:56:57 INFO - PROCESS | 1666 | |i|pagename|runs| 06:56:57 INFO - PROCESS | 1666 | |0;dojo.html;3314.386838434889;3394.4908263760417;3415.077928959181;3433.7253019758423;3460.4463285874267;5456.372517160527;5570.192322113291;5578.330600327961;5579.8605034874145;5610.831675049745;5457.208704737811;5539.9169012464845;5596.356419011815;5601.523870471005;5625.774969001245;4124.608162224584;5046.520580544842;5081.136206844827;5090.160123579605;5253.317068781053;5172.353455818023;5197.1424714922;5199.4800519948085;5202.583793296546;5259;4986.950130498685;5077.949220507821;5124.359455068116;5161.329027226455;5180.481951804827;5138.229265610151;5141.460146684619;5149.9485005149845;5151.381834179885;5157.896842063138;5045.772940217662;5073.543381095719;5110.872228194287;5115.104856650109;5116.462771409023;4625.676202665814;5466.890662186734;5477.75350109246;5549.889002219933;5574.944250557483;5067.873303167414;6121.816345509597;6157.907631385533;6170;6175.289841668221;5944.524438044946;6156.692165391757;6192.9380706192815;6204.534659900525;6216.409441103088;5637.408072152406;5649.435056494359;5703.771849126071;5730.36965933747;5745.712714364265;6276.184096067574;6289.937100628935;6298.1812364392335;6303.716332765037;6304;5808.593398462067;6033.728482218223;6036.577439579275;6061.727222275008;6062.090686396988;5734.16854556087;5820.621659592113;6098.280951554018;6118.449339559461;6174.25908890927;6063.727132279058;6064.272287325461;6072.726727297282;6076.817695469143;6086.6652334122045;6012.729427175787;6043.335233124353;6100.176476175659;6109.236345456818;6114.11345354921;4792.784324705397;4828.106800241896;4856.562909338177;4900.411950565955;4904.166291730415;4290.227759003347;4298.763568003727;4302.548232435612;4304.461942257218;4362.192994296065;5493.23094766733;5533.916991245134;5551.111822108443;5551.889622075601;5575.4424557543925;6107.886786452505;6122.785702500391;6195.070739389038;6235.033569796688;6237.563370564017;4634.768261586907;4783.95216047835;5579.330480342303;5597.776088956396;5602.775888964396;5227.686338819683;5317.0960936640095;5332.493413125747;5339.985402773461;5394.78420863169;6224.190855188796;6270.028145637433;6288.151099601495;6288.151099601495;6336.398042185985;5137.87155321105;6086.6348019119;6136.6011209271255;6176.289726681489;6180.938190618216;6149.169862068564;6243.438090571689;6246.843828904313;6256.562040657111;6268.592541484789;6011.458968692838;6079.635221886524;6095.2685677718955;6095.770848210624;6132.724027418866;5954.434328738763;6137.171481849893;6157.353477884758;6159;6160.260768707783;5899.941000590111;5900.911486327623;5976.970115149396;5988.37122102173;6004.819855404345;5991.281046274475;6015.338312785678;6017.699115044318;6022.849428764316;6074.78738244177;5833.649981001154;5848.795292164754;5852.707364631666;5859.472647461749;5864.618799778001;5771.451712087345;5912.970435147797;5984.730687119177;6022;6030.276366836008;5827.650340979555;5856.765729370948;5862.237909071793;5868.5305175585;5898.94101058984 06:56:57 INFO - PROCESS | 1666 | |1;ext.html;531.0229178311903;535.5661913849782;561.0630247486697;591.0631648836594;609.9085137229415;28633.713662863363;29280.707192928065;29729.85135074327;34772;36849.26301473969;39326;39701.60298397015;39727.60272397275;39750.40374394379;39753;9342.766430839232;9620.56707448163;9628.47043412612;9653.179479744194;9659.75850603737;8343.916560834405;10966.396848173346;11211.831822522669;11243.100551955864;11257.662270131908;11232.775344493106;11382.544698212061;11387.886121138765;11412.31526108436;11412.54349826006;11225.60710375137;11377.2035957483;11380.374079425628;11387.430628468543;11396.316221026682;11058.502367393487;11186.216964812467;11206.719832004184;11213.327200368005;11311.773764524745;38372.04069898247;38735;38745;38748.41877371842;38755.41866871971;3187.3306605612847;3281.3273278977754;3470.930581388358;3804.657580817712;3954.307996100671;27469.17592472209;28107;28215.57676634852;28262.15213543597;29052;2727.3727042780074;2730.385663225778;2735.822171558862;2870.181998130523;2940.8088474249107;309742;309827;310187;311311;311933;56798.7160064197;57102.42897571054;57199.71400143056;57203;57321;59931;60053.69973150194;60246.39753602495;60283.09575356373;60283.69858150769;13962.301884905713;15729.292181851844;15942.681146377008;15946.28241729125;15974.840251597569;11138.721531961766;11269.830952535718;11284.435778211056;12109.576164834189;12311.569095081808;15101.697966040618;15612.92193539025;15777.974431661905;15843.920780396023;15866.603334916488;7091.680874360666;7265.89101163483;7277.417806575461;7338.192798792129;7408.147763163125;925.8750068740768;975.5561219645044;983.1201075037801;1022.25375475903;1198.7962046452124;25936.61095083575;26629.733702663114;27253.318667033484;27294.5905811413;27448.313792155357;1072.0619457974271;1076.5424694504961;1171.1333613126396;1198.8621308549627;1263.2546797389584;11245;14051.437942482185;14095.929520352332;14237.43050277998;14278.07192532482;403551;451893.74053129525;479733;483023;485282;45586;55302.72348638231;55418.72290638521;55454;55646.16530752042;1332.3338330834583;1459.6861674740194;1492.723846088477;1496.648287652379;1501.6621260216364;28034;28188.43623127485;28715.71284287214;28803.855980719964;28829;44750.552494474636;45134.64596062124;45700.771496142304;45711.771441142584;45811.62565123052;319874;320640;321187.3940630282;321295;321768;21788.89105554462;22305.996230169356;24610.753892460845;25179.622305665063;25212.369690757878;41516.79241603773;41757.791211043754;41922.58077419309;42297.86680931186;42694;34463.31073378468;34638;34918.23849064876;35403.58385664545;35511;34506.82746586351;34791.47812782861;35410.46884296686;36102.4584631236;36468.817655912615;35024.29951401009;35361.29277414386;35603;35995.1001224961;36192.81903590465;29863.402731944803;30842.537361940038;31060;31886.84056579702;32693;23185.420364491023;23409;23833.52332953366;23874.641880371462;23967.04131834707 06:56:57 INFO - PROCESS | 1666 | |2;jquery.html;341.27138559176166;401.66461005060773;404.937234728617;405.76262886211566;415.24218301599586;14758.933749275084;17759.378421755242;19429.902850485745;20104.4973875653;20133;15703.115626124882;17761.7335739964;19393.933333666642;19500.927448990336;19835.801641983577;5079.2635067915135;5579.274694289747;5875.911861322063;5923.141144534062;5926.436988486087;5743.798967036155;5801.448862358069;5808.796692115777;5855.414458554132;5889.087191485327;5578.330600327967;5732.856678583048;5767.163761254616;5768.653880767147;5774.884502309951;5295.682259064469;5444.591655625804;5680.914786278209;5765.625234359774;5770.826875193751;4607.9308810367875;5047.899042019176;5066.974665126688;5074.797008119671;5076.670016448919;23723.525529489485;23905.880470597534;25119.497610047696;25129.99480020815;25140;2101.9474513137143;2284.7029886114697;2290.9805136714167;2702.177971375214;3030.5605687175457;13948.093373930662;14321.427142914272;14437.566872993826;14881;15087.24563771807;1673.171779968911;1725.6289897671936;1738.9130543472902;1758.6922288599444;1778.9377371791925;83659.16340836574;103981.48009259906;106220;107266.99999999921;108739;10341.37951722884;10584.841227381596;10793.730156745987;11132.721681958015;11166.218364714554;13610.727785444236;13674.453021879212;13681.931590341985;13684.589462315947;13697.657558560917;7560.395168386516;7791.727289544839;7830.92169078302;8195.95902020486;8400.705975290835;8163.673453061811;8175.836483270301;8284.8343033139;8409.95795021021;8450.535220562928;5405.891882162335;6422.967885160638;6530.249021362509;6555.80332590023;6575.408213260734;1656.900585964846;1838.6230822681318;1846.771896688714;1897.6109897470985;1928.8264056235007;849.4223927729204;890.4345740454858;967.9128878400837;983.4148681534475;1024.9538770755184;16266;19754.70367944482;19953.900230499046;20053.598928021358;20283.8985805073;926.5274709897866;960.4093482508207;974.9610015599438;978.3787295067683;997.546116516983;10748.247622666495;11047.668569942914;11063.834042489369;11075.446227688582;11084.61203857861;611190.944045277;614505;622534;633386;633620;92995.28018879304;97189;97755;98758;98987;1051.1118105201247;1053.7207639975413;1069.3102948598112;1069.8234791259356;1072.881982981887;14918;17335.393261235797;17604.207810648295;17843.37548185807;18095.36666216676;39425;43718.56281437145;44549;44910.77544612256;45057.774711126236;59044.59454750922;59479.702601486715;59879.70060149671;60491.39508604858;66436.00345994717;7646.426518011061;7854.6858125674335;7896;8121.918780812116;8266.628001739817;7425.265669377044;10192.3374980629;10418;12121.27272363661;12844;10083.949580252052;10523.368597884151;10823.458827058774;10938.45307734626;11072.114230861673;10446.791064178522;10530.262881598215;10647.30792498485;10767.838482422614;10933.398663073607;10529.73675658084;10642.722873254948;11091.112710983263;11220.046296064926;11277.436128193722;8019.879701804594;8038.718644847402;8176.141505141874;8204.097549269694;8411.53736544496;9296.674616388394;10260.948695256775;10659.520321585393;10997.285176463503;11026.558937642405 06:56:57 INFO - PROCESS | 1666 | |3;mootools.html;1421.211227768588;1472.6980968901373;1595.7367034439314;1827.552249698824;1989.9104540295675;7885.842283154333;8457.112003239663;8681.435706679078;8687.391882568223;8718.694845680402;8329.750107496784;8557.272631826303;8562.14378562145;8562.443441176334;8565.785855353619;1988.79117692642;2132.275026490993;2360.657704632827;2430.4652976345265;2437.6587277781123;2434.4400787818813;2456.9508609827794;2457.606782914734;2459.434330104077;2459.6187590923437;2387.283814855545;2412.529556736437;2432.3797431654903;2433.6227884677905;2435.756424357568;1813.836754692084;2345.2495201535517;2393.700787401575;2415.118481754147;2416.565018296706;2428.963565546518;2447.669564608773;2455.6316552517087;2456.361346050022;2458.8443431587125;8564.486130832107;8634.870476942851;8644.870326945102;8644.956775216147;8676.132386761337;4988.226824842155;5340.332458442695;5359.008583412042;5364.007658583136;5366.517013468807;3418.572678415198;3480.060383696388;3558.7864728116397;3575.535180426554;3596.514470546495;1013.1438934100747;1023.1661196125209;1028.70167651381;1032.2980373346122;1035.29082578434;11105.944470277678;11267.929546693133;11287.661370158827;11506.999999999916;11510.366929818856;4709.387779588632;4715.339852420664;4826.927596086061;4836.782344794493;4864.562189402971;9949.602015919427;9962.103410692927;9970.45162516054;9997.000299969945;10005.44970026641;4595.241785105421;5338.572914166857;5340.332458442695;5367.275417818622;5386.272853164851;4334.718243314174;4512.864614061584;4732.929006064912;4854.466008739036;4861.052094841542;3850.422436634471;3890.3077161434867;3955.485786847749;3957.5053118360206;3999.4800675911947;1319.8944084473412;1341.2153889974475;1341.8658134186699;1352.4049418255936;1355.5187908292612;815.6329651656778;861.6036623153419;909.7725568607848;912.3886995712888;949.9550494456043;5587.69267690281;5758.942410575924;5845.415458454206;5853.180554722342;5959.642421454727;913.981720365589;946.9857952130724;949.392388871123;949.9525023748785;993.8012397520525;3707.832032909625;3817.2365526894732;3855.7879316637855;3887.6501114899793;3906.570277269498;10043.096121349114;10375.94812025935;10587.523561439753;10588.735281618021;10607.57569697219;10488.213383996232;10536.525856336484;10716.94641526803;10737.463126843782;10743.08683761889;7874.212578742195;8013.879791803244;8063.556504392314;8106.675732970733;8153;5593.888122237451;5601.6358936668985;5731.5128214100605;5884.176215329771;5890.4698577128265;9090.818213625178;9319.906800932175;9611.423314601147;9630.759231019281;9635.710928672152;9189.264858811413;9637.566309516229;9702.27232957517;9706.9029309706;9769.80460390774;6995.125609298838;7393.223711510429;7638.732644357421;8014.198580142172;8228.50628962264;7702.229777022253;8250.917490825015;8285.668573257002;8291.917080829115;8296.83406331882;7289.817754556178;7315.743948961761;7329.047223860864;7416.66625001887;7487.176410594721;7180.102487189101;7198.7840364789145;7250.492465527363;7339.816504587215;7352.228016058237;6799.966000170165;6885.51801373899;6950.721971121098;6985;6995.265497122728;4757.548032936866;4764.2615394613895;4822.541858523435;4871;4991.625628077982;4855.708657480563;4856.68431551948;4909.4845041270155;4930.778114984762;5004.974975125101 06:56:57 INFO - PROCESS | 1666 | |4;prototype.html;309.4769838972137;319.72982829509067;328.1746407784424;331.0383336407735;332.396699989519;4374.912501749963;4396.6043056124945;4495.258282383411;5341.450979216028;5382.327209098863;5035.420926593443;5101.7194054327;5171.793128274864;5187.210412407722;5323.920141197876;3404.438267685829;3855.6529912307888;3967.809657102872;4151.750894946298;4164.521080075785;3852.595477474867;4089.26393249215;4123.381492776092;4142.384470056665;4165.770882601456;3973.582773808752;4091.774952377618;4114.650254728352;4126.216018956404;4129;3297.3734990351995;4037.9596204037875;4038.5355684096266;4051.9262395465225;4101.63085322321;2960.86676099576;3531.2054787672823;3531.8057506837113;3534.4698295255916;3556.946645800315;4486.8878278042985;4758.762061896891;4892.290617860426;4929.742915556546;5219;4621.69958952667;4658.790354434059;4691.906161876777;4707.152712511746;4719.787609557578;4914.262860570907;5492.972535137299;5614.091208988963;5641.294838145232;5649;3883.8446462141483;3888.475055867478;3890.9416358754643;3892.5718171001167;3894.6300101490315;4762.904741905177;5012.974935125301;5555.694436805974;6006.579539432241;6011;3435.639257877937;3867.690584753213;3954.7231693781737;3970.4242884782125;3973;3696.630336966282;4002.4396584478195;4010.9197816044098;4013.5986401359633;4048.2308361411237;4521.178228514769;4522.010315461186;4659.720416774937;4664;4666.183417901853;5183.948160518346;5661.716914154275;5703.201551782754;5708.828735137952;5729.455701708414;1243.7636848998661;1270.5045032437356;1304.8695130487065;1455.2360010994312;1477.8620462244012;909.2544113826599;946.9384490008127;970.2238209432426;970.7815741458256;973.1387721866058;5411.567074634098;5816.248519704766;5841.4450627190345;5853.853653658693;5888.735006924699;5673.602847800615;6390.5077019962255;6415.486761059104;6420.1974753155855;6456.386643268882;4761.047790441926;5117.718525481134;5142.331496905378;5423.945760542423;5494.395616482184;2740.369714965569;3000.1749518882484;3311.8344082795766;3338.1988322802354;3396.711279541217;5650.7174641267775;5794.638260008895;6416.518761092937;6416.550841441054;6760.087388202628;6410.1987251593555;6581.374769396995;6606.10817539626;6620.602763834186;6658.500612454085;5651.689157096317;5879.5002424794375;5883.235179426732;6435.935640643627;6784.457243420613;5872.823815285548;6412.294647588668;6439.581427207217;6453.483721302191;6455.935440645533;4886.853394398174;5905.320888097924;6115.217576002997;6385.13800636908;6423.325550817097;5147.974260128675;5309.36287645485;5862.67755273447;6174.598651087665;6180.938190618216;3906.3945088511327;3977.92044159121;4000.659943904684;4010.4585880905706;4028.71798974069;4894.388201474816;5121.948780512296;5338.706371149624;5595.524380427546;5968.850778730566;4838.145843529369;5137.280780690631;5454.863628409322;5726.914096288476;5789.755202631454;4838.395200599925;5416.647917885325;5725.656460612377;5749.425057494384;5773.971130144322;4930.137225985366;5431.782728690808;5499.487640898785;5622.915656265078;5705.286839145107;5744.281964754406;5746.511546518425;5757.136429535436;5769.480746732646;5772.451617096369;4995.900081998412;5387.595930305164;5453.481919217668;5618.101103823368;5677 06:56:57 INFO - PROCESS | 1666 | |5;yui.html;657.9243387010494;671.9966400167998;675.6959368284273;733.3949491669371;750.1785544828412;14447.434535217411;14506.63733406664;14938.178400187999;14976.400943962228;15202.923985380057;13546.39041243144;13548.525801596947;13561.11852729572;13567.932160339209;13644.044916855824;753.9849203015937;777.0054330457024;908.9999999999983;937.9624815007392;938.8779458670364;912.4023764434306;948.5873644964428;951.8001219743862;954.5227386306847;960.5389413081725;984.9507524623776;987.0474991633073;989.5101924547359;993.7515621094726;994.8358520844088;772.7025095338336;950.1306304731231;981.4160574458186;982.6266018912839;985.2512090810964;743.6542007966268;744.240874308208;745.228688307599;745.3887811994167;745.8843879198679;14819.925900370428;14904.478343257933;14905.552833415015;14910.105393676415;14931.776023359658;12513.124081314312;12627.684307892285;12763.425645845959;12863.356832158355;12893.935530322382;9937.35407198537;10132.94933525335;10137.54381052847;10164.237682173867;10812.135029197645;3470.4620783778555;3511.736619753529;3550.218951830619;3564.679178873888;3638.3450978823803;82136;83409.58295208485;83482;83634;85083.14916850877;9425.437683916476;9548.474833884204;9654.131128198496;9862.654807081717;9983.700488985342;22594.661080083813;22657.206997754998;22666;22696.886515567316;22782.31653050411;7235.3126452987935;7342.4493163012985;7376.815579610446;7452.06849143857;7488.438367122379;3831.7892515911894;3897.006263402814;3908.6091390861257;3924.50943632046;3927.8036098194975;3509.280597477511;3641.817909104534;3644.2711457708565;3647.708183345326;3652.3973544365413;619.4115590189339;629.4618101523223;631.4537924695197;638.3552611862053;651.4267444648774;555.3696554410692;582.5950964079924;609.7560975609703;618.653554009756;623.1027320658237;7352.729045319101;7830.2952734254195;7904.525728456311;8171.346292296602;8301.501909885306;521.7495602111007;544.8855740294582;562.5752556819575;588.6997631208029;607.5413063137303;3794.4308353746605;3832.5017747692623;3842.442845787401;3901.7073719471155;4037.8182981765303;95955.52022239844;100550;101789.49105254427;102099;102509;66647.33352666508;70332.29667703359;74703;75237.12009589713;77183.61408193035;69128.96306555405;69760.30239697538;69773.3022669777;69938.65030674916;70751.93872091922;6769.018492318488;8107.594620269081;8140.185981401813;8301.08793880783;8353.647009660961;41771.791141045316;42538.57461425346;44549;45043.77478112588;45336.31995520136;60204;63282;63330.78342257999;63460.36539634729;63934.96715361214;10888.782224355311;11046.944765276123;11238.831417528907;11240.494177761857;11421.543138274375;11753.529858805894;12029.939850300692;12206.328651923874;12384.690382740144;13044.217346959213;7729.497582657109;11436.085113190758;11529;11800.763984720086;11908.940455297668;9539.904600953902;11345.48945297447;11409.60066397672;11470.541178352772;11497.482613282255;10894.61868834587;10996.890031099587;11142.164337674545;11144.944275278573;11154.386508742096;7878.330341921001;9549;9759.251890170997;9822.852657210291;9965;9427.62289508412;9508.85736713936;9554.52227388614;9617.951910240405;9629.374090684083 06:56:57 INFO - PROCESS | 1666 | __end_tp_report 06:56:57 INFO - PROCESS | 1666 | __start_cc_report 06:56:57 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1333 06:56:57 INFO - PROCESS | 1666 | __end_cc_report 06:56:57 INFO - PROCESS | 1666 | __startTimestamp1461765417343__endTimestamp 06:56:57 INFO - PROCESS | 1666 | 06:56:57 INFO - PROCESS | 1666 | ------- Summary: start ------- 06:56:57 INFO - PROCESS | 1666 | Number of tests: 6 06:56:57 INFO - PROCESS | 1666 | 06:56:57 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5614.80 Median:5833.65 stddev:644.13 (11.0%) stddev-sans-first:620.31 06:56:57 INFO - PROCESS | 1666 | Values: 3314.4 3394.5 3415.1 3433.7 3460.4 5456.4 5570.2 5578.3 5579.9 5610.8 5457.2 5539.9 5596.4 5601.5 5625.8 4124.6 5046.5 5081.1 5090.2 5253.3 5172.4 5197.1 5199.5 5202.6 5259.0 4987.0 5077.9 5124.4 5161.3 5180.5 5138.2 5141.5 5149.9 5151.4 5157.9 5045.8 5073.5 5110.9 5115.1 5116.5 4625.7 5466.9 5477.8 5549.9 5574.9 5067.9 6121.8 6157.9 6170.0 6175.3 5944.5 6156.7 6192.9 6204.5 6216.4 5637.4 5649.4 5703.8 5730.4 5745.7 6276.2 6289.9 6298.2 6303.7 6304.0 5808.6 6033.7 6036.6 6061.7 6062.1 5734.2 5820.6 6098.3 6118.4 6174.3 6063.7 6064.3 6072.7 6076.8 6086.7 6012.7 6043.3 6100.2 6109.2 6114.1 4792.8 4828.1 4856.6 4900.4 4904.2 4290.2 4298.8 4302.5 4304.5 4362.2 5493.2 5533.9 5551.1 5551.9 5575.4 6107.9 6122.8 6195.1 6235.0 6237.6 4634.8 4784.0 5579.3 5597.8 5602.8 5227.7 5317.1 5332.5 5340.0 5394.8 6224.2 6270.0 6288.2 6288.2 6336.4 5137.9 6086.6 6136.6 6176.3 6180.9 6149.2 6243.4 6246.8 6256.6 6268.6 6011.5 6079.6 6095.3 6095.8 6132.7 5954.4 6137.2 6157.4 6159.0 6160.3 5899.9 5900.9 5977.0 5988.4 6004.8 5991.3 6015.3 6017.7 6022.8 6074.8 5833.6 5848.8 5852.7 5859.5 5864.6 5771.5 5913.0 5984.7 6022.0 6030.3 5827.7 5856.8 5862.2 5868.5 5898.9 06:56:57 INFO - PROCESS | 1666 | 06:56:57 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:51594.24 Median:311622.00 stddev:98054.76 (31.5%) stddev-sans-first:98254.87 06:56:57 INFO - PROCESS | 1666 | Values: 531.0 535.6 561.1 591.1 609.9 28633.7 29280.7 29729.9 34772.0 36849.3 39326.0 39701.6 39727.6 39750.4 39753.0 9342.8 9620.6 9628.5 9653.2 9659.8 8343.9 10966.4 11211.8 11243.1 11257.7 11232.8 11382.5 11387.9 11412.3 11412.5 11225.6 11377.2 11380.4 11387.4 11396.3 11058.5 11186.2 11206.7 11213.3 11311.8 38372.0 38735.0 38745.0 38748.4 38755.4 3187.3 3281.3 3470.9 3804.7 3954.3 27469.2 28107.0 28215.6 28262.2 29052.0 2727.4 2730.4 2735.8 2870.2 2940.8 309742.0 309827.0 310187.0 311311.0 311933.0 56798.7 57102.4 57199.7 57203.0 57321.0 59931.0 60053.7 60246.4 60283.1 60283.7 13962.3 15729.3 15942.7 15946.3 15974.8 11138.7 11269.8 11284.4 12109.6 12311.6 15101.7 15612.9 15778.0 15843.9 15866.6 7091.7 7265.9 7277.4 7338.2 7408.1 925.9 975.6 983.1 1022.3 1198.8 25936.6 26629.7 27253.3 27294.6 27448.3 1072.1 1076.5 1171.1 1198.9 1263.3 11245.0 14051.4 14095.9 14237.4 14278.1 403551.0 451893.7 479733.0 483023.0 485282.0 45586.0 55302.7 55418.7 55454.0 55646.2 1332.3 1459.7 1492.7 1496.6 1501.7 28034.0 28188.4 28715.7 28803.9 28829.0 44750.6 45134.6 45700.8 45711.8 45811.6 319874.0 320640.0 321187.4 321295.0 321768.0 21788.9 22306.0 24610.8 25179.6 25212.4 41516.8 41757.8 41922.6 42297.9 42694.0 34463.3 34638.0 34918.2 35403.6 35511.0 34506.8 34791.5 35410.5 36102.5 36468.8 35024.3 35361.3 35603.0 35995.1 36192.8 29863.4 30842.5 31060.0 31886.8 32693.0 23185.4 23409.0 23833.5 23874.6 23967.0 06:56:57 INFO - PROCESS | 1666 | 06:56:57 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:33441.90 Median:13921.09 stddev:102649.08 (737.4%) stddev-sans-first:102906.95 06:56:57 INFO - PROCESS | 1666 | Values: 341.3 401.7 404.9 405.8 415.2 14758.9 17759.4 19429.9 20104.5 20133.0 15703.1 17761.7 19393.9 19500.9 19835.8 5079.3 5579.3 5875.9 5923.1 5926.4 5743.8 5801.4 5808.8 5855.4 5889.1 5578.3 5732.9 5767.2 5768.7 5774.9 5295.7 5444.6 5680.9 5765.6 5770.8 4607.9 5047.9 5067.0 5074.8 5076.7 23723.5 23905.9 25119.5 25130.0 25140.0 2101.9 2284.7 2291.0 2702.2 3030.6 13948.1 14321.4 14437.6 14881.0 15087.2 1673.2 1725.6 1738.9 1758.7 1778.9 83659.2 103981.5 106220.0 107267.0 108739.0 10341.4 10584.8 10793.7 11132.7 11166.2 13610.7 13674.5 13681.9 13684.6 13697.7 7560.4 7791.7 7830.9 8196.0 8400.7 8163.7 8175.8 8284.8 8410.0 8450.5 5405.9 6423.0 6530.2 6555.8 6575.4 1656.9 1838.6 1846.8 1897.6 1928.8 849.4 890.4 967.9 983.4 1025.0 16266.0 19754.7 19953.9 20053.6 20283.9 926.5 960.4 975.0 978.4 997.5 10748.2 11047.7 11063.8 11075.4 11084.6 611190.9 614505.0 622534.0 633386.0 633620.0 92995.3 97189.0 97755.0 98758.0 98987.0 1051.1 1053.7 1069.3 1069.8 1072.9 14918.0 17335.4 17604.2 17843.4 18095.4 39425.0 43718.6 44549.0 44910.8 45057.8 59044.6 59479.7 59879.7 60491.4 66436.0 7646.4 7854.7 7896.0 8121.9 8266.6 7425.3 10192.3 10418.0 12121.3 12844.0 10083.9 10523.4 10823.5 10938.5 11072.1 10446.8 10530.3 10647.3 10767.8 10933.4 10529.7 10642.7 11091.1 11220.0 11277.4 8019.9 8038.7 8176.1 8204.1 8411.5 9296.7 10260.9 10659.5 10997.3 11026.6 06:56:57 INFO - PROCESS | 1666 | 06:56:57 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5632.61 Median:4989.93 stddev:3111.84 (62.4%) stddev-sans-first:3104.47 06:56:57 INFO - PROCESS | 1666 | Values: 1421.2 1472.7 1595.7 1827.6 1989.9 7885.8 8457.1 8681.4 8687.4 8718.7 8329.8 8557.3 8562.1 8562.4 8565.8 1988.8 2132.3 2360.7 2430.5 2437.7 2434.4 2457.0 2457.6 2459.4 2459.6 2387.3 2412.5 2432.4 2433.6 2435.8 1813.8 2345.2 2393.7 2415.1 2416.6 2429.0 2447.7 2455.6 2456.4 2458.8 8564.5 8634.9 8644.9 8645.0 8676.1 4988.2 5340.3 5359.0 5364.0 5366.5 3418.6 3480.1 3558.8 3575.5 3596.5 1013.1 1023.2 1028.7 1032.3 1035.3 11105.9 11267.9 11287.7 11507.0 11510.4 4709.4 4715.3 4826.9 4836.8 4864.6 9949.6 9962.1 9970.5 9997.0 10005.4 4595.2 5338.6 5340.3 5367.3 5386.3 4334.7 4512.9 4732.9 4854.5 4861.1 3850.4 3890.3 3955.5 3957.5 3999.5 1319.9 1341.2 1341.9 1352.4 1355.5 815.6 861.6 909.8 912.4 950.0 5587.7 5758.9 5845.4 5853.2 5959.6 914.0 947.0 949.4 950.0 993.8 3707.8 3817.2 3855.8 3887.7 3906.6 10043.1 10375.9 10587.5 10588.7 10607.6 10488.2 10536.5 10716.9 10737.5 10743.1 7874.2 8013.9 8063.6 8106.7 8153.0 5593.9 5601.6 5731.5 5884.2 5890.5 9090.8 9319.9 9611.4 9630.8 9635.7 9189.3 9637.6 9702.3 9706.9 9769.8 6995.1 7393.2 7638.7 8014.2 8228.5 7702.2 8250.9 8285.7 8291.9 8296.8 7289.8 7315.7 7329.0 7416.7 7487.2 7180.1 7198.8 7250.5 7339.8 7352.2 6800.0 6885.5 6950.7 6985.0 6995.3 4757.5 4764.3 4822.5 4871.0 4991.6 4855.7 4856.7 4909.5 4930.8 5005.0 06:56:57 INFO - PROCESS | 1666 | 06:56:57 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4681.20 Median:5129.61 stddev:1480.67 (28.9%) stddev-sans-first:1448.01 06:56:57 INFO - PROCESS | 1666 | Values: 309.5 319.7 328.2 331.0 332.4 4374.9 4396.6 4495.3 5341.5 5382.3 5035.4 5101.7 5171.8 5187.2 5323.9 3404.4 3855.7 3967.8 4151.8 4164.5 3852.6 4089.3 4123.4 4142.4 4165.8 3973.6 4091.8 4114.7 4126.2 4129.0 3297.4 4038.0 4038.5 4051.9 4101.6 2960.9 3531.2 3531.8 3534.5 3556.9 4486.9 4758.8 4892.3 4929.7 5219.0 4621.7 4658.8 4691.9 4707.2 4719.8 4914.3 5493.0 5614.1 5641.3 5649.0 3883.8 3888.5 3890.9 3892.6 3894.6 4762.9 5013.0 5555.7 6006.6 6011.0 3435.6 3867.7 3954.7 3970.4 3973.0 3696.6 4002.4 4010.9 4013.6 4048.2 4521.2 4522.0 4659.7 4664.0 4666.2 5183.9 5661.7 5703.2 5708.8 5729.5 1243.8 1270.5 1304.9 1455.2 1477.9 909.3 946.9 970.2 970.8 973.1 5411.6 5816.2 5841.4 5853.9 5888.7 5673.6 6390.5 6415.5 6420.2 6456.4 4761.0 5117.7 5142.3 5423.9 5494.4 2740.4 3000.2 3311.8 3338.2 3396.7 5650.7 5794.6 6416.5 6416.6 6760.1 6410.2 6581.4 6606.1 6620.6 6658.5 5651.7 5879.5 5883.2 6435.9 6784.5 5872.8 6412.3 6439.6 6453.5 6455.9 4886.9 5905.3 6115.2 6385.1 6423.3 5148.0 5309.4 5862.7 6174.6 6180.9 3906.4 3977.9 4000.7 4010.5 4028.7 4894.4 5121.9 5338.7 5595.5 5968.9 4838.1 5137.3 5454.9 5726.9 5789.8 4838.4 5416.6 5725.7 5749.4 5774.0 4930.1 5431.8 5499.5 5622.9 5705.3 5744.3 5746.5 5757.1 5769.5 5772.5 4995.9 5387.6 5453.5 5618.1 5677.0 06:56:57 INFO - PROCESS | 1666 | 06:56:57 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18129.86 Median:619.03 stddev:25843.80 (4174.9%) stddev-sans-first:25883.00 06:56:57 INFO - PROCESS | 1666 | Values: 657.9 672.0 675.7 733.4 750.2 14447.4 14506.6 14938.2 14976.4 15202.9 13546.4 13548.5 13561.1 13567.9 13644.0 754.0 777.0 909.0 938.0 938.9 912.4 948.6 951.8 954.5 960.5 985.0 987.0 989.5 993.8 994.8 772.7 950.1 981.4 982.6 985.3 743.7 744.2 745.2 745.4 745.9 14819.9 14904.5 14905.6 14910.1 14931.8 12513.1 12627.7 12763.4 12863.4 12893.9 9937.4 10132.9 10137.5 10164.2 10812.1 3470.5 3511.7 3550.2 3564.7 3638.3 82136.0 83409.6 83482.0 83634.0 85083.1 9425.4 9548.5 9654.1 9862.7 9983.7 22594.7 22657.2 22666.0 22696.9 22782.3 7235.3 7342.4 7376.8 7452.1 7488.4 3831.8 3897.0 3908.6 3924.5 3927.8 3509.3 3641.8 3644.3 3647.7 3652.4 619.4 629.5 631.5 638.4 651.4 555.4 582.6 609.8 618.7 623.1 7352.7 7830.3 7904.5 8171.3 8301.5 521.7 544.9 562.6 588.7 607.5 3794.4 3832.5 3842.4 3901.7 4037.8 95955.5 100550.0 101789.5 102099.0 102509.0 66647.3 70332.3 74703.0 75237.1 77183.6 69129.0 69760.3 69773.3 69938.7 70751.9 6769.0 8107.6 8140.2 8301.1 8353.6 41771.8 42538.6 44549.0 45043.8 45336.3 60204.0 63282.0 63330.8 63460.4 63935.0 10888.8 11046.9 11238.8 11240.5 11421.5 11753.5 12029.9 12206.3 12384.7 13044.2 7729.5 11436.1 11529.0 11800.8 11908.9 9539.9 11345.5 11409.6 11470.5 11497.5 10894.6 10996.9 11142.2 11144.9 11154.4 7878.3 9549.0 9759.3 9822.9 9965.0 9427.6 9508.9 9554.5 9618.0 9629.4 06:56:57 INFO - PROCESS | 1666 | -------- Summary: end -------- 06:56:57 INFO - PROCESS | 1666 | 06:56:57 INFO - TEST-INFO | 1666: exit 0 06:56:57 INFO - TEST-OK | dromaeo_css | took 1114924ms 06:56:57 INFO - TEST-START | kraken 06:56:57 INFO - operating with platform_type : mac_ 06:56:57 INFO - Initialising browser for kraken test... 06:56:57 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmp56bCPb/profile http://localhost:49275/getInfo.html) 06:57:00 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 06:57:00 INFO - PROCESS | 1673 | colorDepth:24 06:57:00 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 06:57:00 INFO - PROCESS | 1673 | __metrics 06:57:00 INFO - PROCESS | 1673 | 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" 06:57:00 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:57:00 INFO - TEST-INFO | 1673: exit 0 06:57:00 INFO - Browser initialized. 06:57:00 INFO - Running cycle 1/1 for kraken test... 06:57:00 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmp56bCPb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:12 INFO - PROCESS | 1675 | RSS: Main: 239382528 06:57:12 INFO - PROCESS | 1675 | 06:57:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:16 INFO - PROCESS | 1675 | RSS: Main: 286576640 06:57:16 INFO - PROCESS | 1675 | 06:57:18 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 06:57:19 INFO - PROCESS | 1675 | RSS: Main: 299868160 06:57:19 INFO - PROCESS | 1675 | 06:57:23 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 06:57:23 INFO - PROCESS | 1675 | RSS: Main: 389107712 06:57:23 INFO - PROCESS | 1675 | 06:57:25 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 06:57:26 INFO - PROCESS | 1675 | RSS: Main: 290140160 06:57:26 INFO - PROCESS | 1675 | 06:57:28 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:29 INFO - PROCESS | 1675 | RSS: Main: 294191104 06:57:29 INFO - PROCESS | 1675 | 06:57:31 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:32 INFO - PROCESS | 1675 | RSS: Main: 332271616 06:57:32 INFO - PROCESS | 1675 | 06:57:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:35 INFO - PROCESS | 1675 | RSS: Main: 333602816 06:57:35 INFO - PROCESS | 1675 | 06:57:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 06:57:39 INFO - PROCESS | 1675 | RSS: Main: 332845056 06:57:39 INFO - PROCESS | 1675 | 06:57:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:57:41 INFO - PROCESS | 1675 | RSS: Main: 321445888 06:57:41 INFO - PROCESS | 1675 | 06:57:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:57:43 INFO - PROCESS | 1675 | RSS: Main: 328302592 06:57:43 INFO - PROCESS | 1675 | 06:57:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:57:46 INFO - PROCESS | 1675 | RSS: Main: 330522624 06:57:46 INFO - PROCESS | 1675 | 06:57:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:57:50 INFO - PROCESS | 1675 | RSS: Main: 334696448 06:57:50 INFO - PROCESS | 1675 | 06:57:53 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:57:54 INFO - PROCESS | 1675 | RSS: Main: 332595200 06:57:54 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 06:57:56 INFO - PROCESS | 1675 | RSS: Main: 397705216 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | __start_tp_report 06:57:56 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 06:57:56 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 06:57:56 INFO - PROCESS | 1675 | |i|pagename|runs| 06:57:56 INFO - PROCESS | 1675 | |0;ai-astar;111;111;110;159;112;113;111;110;102;113 06:57:56 INFO - PROCESS | 1675 | |1;audio-beat-detection;156;120;143;170;116;141;138;119;172;121 06:57:56 INFO - PROCESS | 1675 | |2;audio-dft;183;189;186;186;192;226;184;181;230;184 06:57:56 INFO - PROCESS | 1675 | |3;audio-fft;77;72;88;89;58;58;57;80;76;56 06:57:56 INFO - PROCESS | 1675 | |4;audio-oscillator;89;91;135;77;81;85;121;80;78;128 06:57:56 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;85;83;86;83;86;83;87;84;90;85 06:57:56 INFO - PROCESS | 1675 | |6;imaging-darkroom;92;92;91;92;92;91;92;92;92;92 06:57:56 INFO - PROCESS | 1675 | |7;imaging-desaturate;88;87;84;87;85;86;85;83;90;84 06:57:56 INFO - PROCESS | 1675 | |8;json-parse-financial;59;59;58;56;58;58;58;79;58;56 06:57:56 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;65;63;65;79;70;68;67;67;67;68 06:57:56 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;82;95;103;107;84;79;78;81;81;82 06:57:56 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;139;138;143;158;123;148;155;152;180;145 06:57:56 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;211;198;204;197;198;200;197;196;207;203 06:57:56 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;73;70;71;72;71;70;69;72;69;71 06:57:56 INFO - PROCESS | 1675 | __end_tp_report 06:57:56 INFO - PROCESS | 1675 | __start_cc_report 06:57:56 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,2110 06:57:56 INFO - PROCESS | 1675 | __end_cc_report 06:57:56 INFO - PROCESS | 1675 | __startTimestamp1461765476285__endTimestamp 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | ------- Summary: start ------- 06:57:56 INFO - PROCESS | 1675 | Number of tests: 14 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:115.20 Median:111.50 stddev:15.70 (14.1%) stddev-sans-first:16.58 06:57:56 INFO - PROCESS | 1675 | Values: 111.0 111.0 110.0 159.0 112.0 113.0 111.0 110.0 102.0 113.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:142.00 stddev:21.00 (14.8%) stddev-sans-first:21.42 06:57:56 INFO - PROCESS | 1675 | Values: 156.0 120.0 143.0 170.0 116.0 141.0 138.0 119.0 172.0 121.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:194.10 Median:187.50 stddev:18.16 (9.7%) stddev-sans-first:18.81 06:57:56 INFO - PROCESS | 1675 | Values: 183.0 189.0 186.0 186.0 192.0 226.0 184.0 181.0 230.0 184.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:71.10 Median:76.50 stddev:12.97 (17.0%) stddev-sans-first:13.58 06:57:56 INFO - PROCESS | 1675 | Values: 77.0 72.0 88.0 89.0 58.0 58.0 57.0 80.0 76.0 56.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:80.50 stddev:22.43 (27.9%) stddev-sans-first:23.63 06:57:56 INFO - PROCESS | 1675 | Values: 89.0 91.0 135.0 77.0 81.0 85.0 121.0 80.0 78.0 128.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:85.50 stddev:2.20 (2.6%) stddev-sans-first:2.33 06:57:56 INFO - PROCESS | 1675 | Values: 85.0 83.0 86.0 83.0 86.0 83.0 87.0 84.0 90.0 85.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:91.80 Median:92.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 06:57:56 INFO - PROCESS | 1675 | Values: 92.0 92.0 91.0 92.0 92.0 91.0 92.0 92.0 92.0 92.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.50 stddev:2.13 (2.5%) stddev-sans-first:2.12 06:57:56 INFO - PROCESS | 1675 | Values: 88.0 87.0 84.0 87.0 85.0 86.0 85.0 83.0 90.0 84.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:58.00 stddev:6.79 (11.7%) stddev-sans-first:7.19 06:57:56 INFO - PROCESS | 1675 | Values: 59.0 59.0 58.0 56.0 58.0 58.0 58.0 79.0 58.0 56.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.50 stddev:4.36 (6.5%) stddev-sans-first:4.49 06:57:56 INFO - PROCESS | 1675 | Values: 65.0 63.0 65.0 79.0 70.0 68.0 67.0 67.0 67.0 68.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:81.50 stddev:10.52 (12.9%) stddev-sans-first:10.99 06:57:56 INFO - PROCESS | 1675 | Values: 82.0 95.0 103.0 107.0 84.0 79.0 78.0 81.0 81.0 82.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:150.00 stddev:15.01 (10.0%) stddev-sans-first:15.56 06:57:56 INFO - PROCESS | 1675 | Values: 139.0 138.0 143.0 158.0 123.0 148.0 155.0 152.0 180.0 145.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.10 Median:201.50 stddev:5.00 (2.5%) stddev-sans-first:3.81 06:57:56 INFO - PROCESS | 1675 | Values: 211.0 198.0 204.0 197.0 198.0 200.0 197.0 196.0 207.0 203.0 06:57:56 INFO - PROCESS | 1675 | 06:57:56 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.32 (1.9%) stddev-sans-first:1.13 06:57:56 INFO - PROCESS | 1675 | Values: 73.0 70.0 71.0 72.0 71.0 70.0 69.0 72.0 69.0 71.0 06:57:56 INFO - PROCESS | 1675 | -------- Summary: end -------- 06:57:56 INFO - PROCESS | 1675 | 06:57:57 INFO - TEST-INFO | 1675: exit 0 06:57:57 INFO - TEST-OK | kraken | took 59137ms 06:57:57 INFO - SUITE-END | took 1174s 06:57:57 INFO - Completed test suite (00:19:34) 06:57:57 INFO - javascript benchmark 06:57:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.386838434889, 3394.4908263760417, 3415.077928959181, 3433.7253019758423, 3460.4463285874267, 5456.372517160527, 5570.192322113291, 5578.330600327961, 5579.8605034874145, 5610.831675049745, 5457.208704737811, 5539.9169012464845, 5596.356419011815, 5601.523870471005, 5625.774969001245, 4124.608162224584, 5046.520580544842, 5081.136206844827, 5090.160123579605, 5253.317068781053, 5172.353455818023, 5197.1424714922, 5199.4800519948085, 5202.583793296546, 5259.0, 4986.950130498685, 5077.949220507821, 5124.359455068116, 5161.329027226455, 5180.481951804827, 5138.229265610151, 5141.460146684619, 5149.9485005149845, 5151.381834179885, 5157.896842063138, 5045.772940217662, 5073.543381095719, 5110.872228194287, 5115.104856650109, 5116.462771409023, 4625.676202665814, 5466.890662186734, 5477.75350109246, 5549.889002219933, 5574.944250557483, 5067.873303167414, 6121.816345509597, 6157.907631385533, 6170.0, 6175.289841668221, 5944.524438044946, 6156.692165391757, 6192.9380706192815, 6204.534659900525, 6216.409441103088, 5637.408072152406, 5649.435056494359, 5703.771849126071, 5730.36965933747, 5745.712714364265, 6276.184096067574, 6289.937100628935, 6298.1812364392335, 6303.716332765037, 6304.0, 5808.593398462067, 6033.728482218223, 6036.577439579275, 6061.727222275008, 6062.090686396988, 5734.16854556087, 5820.621659592113, 6098.280951554018, 6118.449339559461, 6174.25908890927, 6063.727132279058, 6064.272287325461, 6072.726727297282, 6076.817695469143, 6086.6652334122045, 6012.729427175787, 6043.335233124353, 6100.176476175659, 6109.236345456818, 6114.11345354921, 4792.784324705397, 4828.106800241896, 4856.562909338177, 4900.411950565955, 4904.166291730415, 4290.227759003347, 4298.763568003727, 4302.548232435612, 4304.461942257218, 4362.192994296065, 5493.23094766733, 5533.916991245134, 5551.111822108443, 5551.889622075601, 5575.4424557543925, 6107.886786452505, 6122.785702500391, 6195.070739389038, 6235.033569796688, 6237.563370564017, 4634.768261586907, 4783.95216047835, 5579.330480342303, 5597.776088956396, 5602.775888964396, 5227.686338819683, 5317.0960936640095, 5332.493413125747, 5339.985402773461, 5394.78420863169, 6224.190855188796, 6270.028145637433, 6288.151099601495, 6288.151099601495, 6336.398042185985, 5137.87155321105, 6086.6348019119, 6136.6011209271255, 6176.289726681489, 6180.938190618216, 6149.169862068564, 6243.438090571689, 6246.843828904313, 6256.562040657111, 6268.592541484789, 6011.458968692838, 6079.635221886524, 6095.2685677718955, 6095.770848210624, 6132.724027418866, 5954.434328738763, 6137.171481849893, 6157.353477884758, 6159.0, 6160.260768707783, 5899.941000590111, 5900.911486327623, 5976.970115149396, 5988.37122102173, 6004.819855404345, 5991.281046274475, 6015.338312785678, 6017.699115044318, 6022.849428764316, 6074.78738244177, 5833.649981001154, 5848.795292164754, 5852.707364631666, 5859.472647461749, 5864.618799778001, 5771.451712087345, 5912.970435147797, 5984.730687119177, 6022.0, 6030.276366836008, 5827.650340979555, 5856.765729370948, 5862.237909071793, 5868.5305175585, 5898.94101058984], "value": 5575.049702641165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.0229178311903, 535.5661913849782, 561.0630247486697, 591.0631648836594, 609.9085137229415, 28633.713662863363, 29280.707192928065, 29729.85135074327, 34772.0, 36849.26301473969, 39326.0, 39701.60298397015, 39727.60272397275, 39750.40374394379, 39753.0, 9342.766430839232, 9620.56707448163, 9628.47043412612, 9653.179479744194, 9659.75850603737, 8343.916560834405, 10966.396848173346, 11211.831822522669, 11243.100551955864, 11257.662270131908, 11232.775344493106, 11382.544698212061, 11387.886121138765, 11412.31526108436, 11412.54349826006, 11225.60710375137, 11377.2035957483, 11380.374079425628, 11387.430628468543, 11396.316221026682, 11058.502367393487, 11186.216964812467, 11206.719832004184, 11213.327200368005, 11311.773764524745, 38372.04069898247, 38735.0, 38745.0, 38748.41877371842, 38755.41866871971, 3187.3306605612847, 3281.3273278977754, 3470.930581388358, 3804.657580817712, 3954.307996100671, 27469.17592472209, 28107.0, 28215.57676634852, 28262.15213543597, 29052.0, 2727.3727042780074, 2730.385663225778, 2735.822171558862, 2870.181998130523, 2940.8088474249107, 309742.0, 309827.0, 310187.0, 311311.0, 311933.0, 56798.7160064197, 57102.42897571054, 57199.71400143056, 57203.0, 57321.0, 59931.0, 60053.69973150194, 60246.39753602495, 60283.09575356373, 60283.69858150769, 13962.301884905713, 15729.292181851844, 15942.681146377008, 15946.28241729125, 15974.840251597569, 11138.721531961766, 11269.830952535718, 11284.435778211056, 12109.576164834189, 12311.569095081808, 15101.697966040618, 15612.92193539025, 15777.974431661905, 15843.920780396023, 15866.603334916488, 7091.680874360666, 7265.89101163483, 7277.417806575461, 7338.192798792129, 7408.147763163125, 925.8750068740768, 975.5561219645044, 983.1201075037801, 1022.25375475903, 1198.7962046452124, 25936.61095083575, 26629.733702663114, 27253.318667033484, 27294.5905811413, 27448.313792155357, 1072.0619457974271, 1076.5424694504961, 1171.1333613126396, 1198.8621308549627, 1263.2546797389584, 11245.0, 14051.437942482185, 14095.929520352332, 14237.43050277998, 14278.07192532482, 403551.0, 451893.74053129525, 479733.0, 483023.0, 485282.0, 45586.0, 55302.72348638231, 55418.72290638521, 55454.0, 55646.16530752042, 1332.3338330834583, 1459.6861674740194, 1492.723846088477, 1496.648287652379, 1501.6621260216364, 28034.0, 28188.43623127485, 28715.71284287214, 28803.855980719964, 28829.0, 44750.552494474636, 45134.64596062124, 45700.771496142304, 45711.771441142584, 45811.62565123052, 319874.0, 320640.0, 321187.3940630282, 321295.0, 321768.0, 21788.89105554462, 22305.996230169356, 24610.753892460845, 25179.622305665063, 25212.369690757878, 41516.79241603773, 41757.791211043754, 41922.58077419309, 42297.86680931186, 42694.0, 34463.31073378468, 34638.0, 34918.23849064876, 35403.58385664545, 35511.0, 34506.82746586351, 34791.47812782861, 35410.46884296686, 36102.4584631236, 36468.817655912615, 35024.29951401009, 35361.29277414386, 35603.0, 35995.1001224961, 36192.81903590465, 29863.402731944803, 30842.537361940038, 31060.0, 31886.84056579702, 32693.0, 23185.420364491023, 23409.0, 23833.52332953366, 23874.641880371462, 23967.04131834707], "value": 18622.224756882526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.27138559176166, 401.66461005060773, 404.937234728617, 405.76262886211566, 415.24218301599586, 14758.933749275084, 17759.378421755242, 19429.902850485745, 20104.4973875653, 20133.0, 15703.115626124882, 17761.7335739964, 19393.933333666642, 19500.927448990336, 19835.801641983577, 5079.2635067915135, 5579.274694289747, 5875.911861322063, 5923.141144534062, 5926.436988486087, 5743.798967036155, 5801.448862358069, 5808.796692115777, 5855.414458554132, 5889.087191485327, 5578.330600327967, 5732.856678583048, 5767.163761254616, 5768.653880767147, 5774.884502309951, 5295.682259064469, 5444.591655625804, 5680.914786278209, 5765.625234359774, 5770.826875193751, 4607.9308810367875, 5047.899042019176, 5066.974665126688, 5074.797008119671, 5076.670016448919, 23723.525529489485, 23905.880470597534, 25119.497610047696, 25129.99480020815, 25140.0, 2101.9474513137143, 2284.7029886114697, 2290.9805136714167, 2702.177971375214, 3030.5605687175457, 13948.093373930662, 14321.427142914272, 14437.566872993826, 14881.0, 15087.24563771807, 1673.171779968911, 1725.6289897671936, 1738.9130543472902, 1758.6922288599444, 1778.9377371791925, 83659.16340836574, 103981.48009259906, 106220.0, 107266.99999999921, 108739.0, 10341.37951722884, 10584.841227381596, 10793.730156745987, 11132.721681958015, 11166.218364714554, 13610.727785444236, 13674.453021879212, 13681.931590341985, 13684.589462315947, 13697.657558560917, 7560.395168386516, 7791.727289544839, 7830.92169078302, 8195.95902020486, 8400.705975290835, 8163.673453061811, 8175.836483270301, 8284.8343033139, 8409.95795021021, 8450.535220562928, 5405.891882162335, 6422.967885160638, 6530.249021362509, 6555.80332590023, 6575.408213260734, 1656.900585964846, 1838.6230822681318, 1846.771896688714, 1897.6109897470985, 1928.8264056235007, 849.4223927729204, 890.4345740454858, 967.9128878400837, 983.4148681534475, 1024.9538770755184, 16266.0, 19754.70367944482, 19953.900230499046, 20053.598928021358, 20283.8985805073, 926.5274709897866, 960.4093482508207, 974.9610015599438, 978.3787295067683, 997.546116516983, 10748.247622666495, 11047.668569942914, 11063.834042489369, 11075.446227688582, 11084.61203857861, 611190.944045277, 614505.0, 622534.0, 633386.0, 633620.0, 92995.28018879304, 97189.0, 97755.0, 98758.0, 98987.0, 1051.1118105201247, 1053.7207639975413, 1069.3102948598112, 1069.8234791259356, 1072.881982981887, 14918.0, 17335.393261235797, 17604.207810648295, 17843.37548185807, 18095.36666216676, 39425.0, 43718.56281437145, 44549.0, 44910.77544612256, 45057.774711126236, 59044.59454750922, 59479.702601486715, 59879.70060149671, 60491.39508604858, 66436.00345994717, 7646.426518011061, 7854.6858125674335, 7896.0, 8121.918780812116, 8266.628001739817, 7425.265669377044, 10192.3374980629, 10418.0, 12121.27272363661, 12844.0, 10083.949580252052, 10523.368597884151, 10823.458827058774, 10938.45307734626, 11072.114230861673, 10446.791064178522, 10530.262881598215, 10647.30792498485, 10767.838482422614, 10933.398663073607, 10529.73675658084, 10642.722873254948, 11091.112710983263, 11220.046296064926, 11277.436128193722, 8019.879701804594, 8038.718644847402, 8176.141505141874, 8204.097549269694, 8411.53736544496, 9296.674616388394, 10260.948695256775, 10659.520321585393, 10997.285176463503, 11026.558937642405], "value": 9264.613010424062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.211227768588, 1472.6980968901373, 1595.7367034439314, 1827.552249698824, 1989.9104540295675, 7885.842283154333, 8457.112003239663, 8681.435706679078, 8687.391882568223, 8718.694845680402, 8329.750107496784, 8557.272631826303, 8562.14378562145, 8562.443441176334, 8565.785855353619, 1988.79117692642, 2132.275026490993, 2360.657704632827, 2430.4652976345265, 2437.6587277781123, 2434.4400787818813, 2456.9508609827794, 2457.606782914734, 2459.434330104077, 2459.6187590923437, 2387.283814855545, 2412.529556736437, 2432.3797431654903, 2433.6227884677905, 2435.756424357568, 1813.836754692084, 2345.2495201535517, 2393.700787401575, 2415.118481754147, 2416.565018296706, 2428.963565546518, 2447.669564608773, 2455.6316552517087, 2456.361346050022, 2458.8443431587125, 8564.486130832107, 8634.870476942851, 8644.870326945102, 8644.956775216147, 8676.132386761337, 4988.226824842155, 5340.332458442695, 5359.008583412042, 5364.007658583136, 5366.517013468807, 3418.572678415198, 3480.060383696388, 3558.7864728116397, 3575.535180426554, 3596.514470546495, 1013.1438934100747, 1023.1661196125209, 1028.70167651381, 1032.2980373346122, 1035.29082578434, 11105.944470277678, 11267.929546693133, 11287.661370158827, 11506.999999999916, 11510.366929818856, 4709.387779588632, 4715.339852420664, 4826.927596086061, 4836.782344794493, 4864.562189402971, 9949.602015919427, 9962.103410692927, 9970.45162516054, 9997.000299969945, 10005.44970026641, 4595.241785105421, 5338.572914166857, 5340.332458442695, 5367.275417818622, 5386.272853164851, 4334.718243314174, 4512.864614061584, 4732.929006064912, 4854.466008739036, 4861.052094841542, 3850.422436634471, 3890.3077161434867, 3955.485786847749, 3957.5053118360206, 3999.4800675911947, 1319.8944084473412, 1341.2153889974475, 1341.8658134186699, 1352.4049418255936, 1355.5187908292612, 815.6329651656778, 861.6036623153419, 909.7725568607848, 912.3886995712888, 949.9550494456043, 5587.69267690281, 5758.942410575924, 5845.415458454206, 5853.180554722342, 5959.642421454727, 913.981720365589, 946.9857952130724, 949.392388871123, 949.9525023748785, 993.8012397520525, 3707.832032909625, 3817.2365526894732, 3855.7879316637855, 3887.6501114899793, 3906.570277269498, 10043.096121349114, 10375.94812025935, 10587.523561439753, 10588.735281618021, 10607.57569697219, 10488.213383996232, 10536.525856336484, 10716.94641526803, 10737.463126843782, 10743.08683761889, 7874.212578742195, 8013.879791803244, 8063.556504392314, 8106.675732970733, 8153.0, 5593.888122237451, 5601.6358936668985, 5731.5128214100605, 5884.176215329771, 5890.4698577128265, 9090.818213625178, 9319.906800932175, 9611.423314601147, 9630.759231019281, 9635.710928672152, 9189.264858811413, 9637.566309516229, 9702.27232957517, 9706.9029309706, 9769.80460390774, 6995.125609298838, 7393.223711510429, 7638.732644357421, 8014.198580142172, 8228.50628962264, 7702.229777022253, 8250.917490825015, 8285.668573257002, 8291.917080829115, 8296.83406331882, 7289.817754556178, 7315.743948961761, 7329.047223860864, 7416.66625001887, 7487.176410594721, 7180.102487189101, 7198.7840364789145, 7250.492465527363, 7339.816504587215, 7352.228016058237, 6799.966000170165, 6885.51801373899, 6950.721971121098, 6985.0, 6995.265497122728, 4757.548032936866, 4764.2615394613895, 4822.541858523435, 4871.0, 4991.625628077982, 4855.708657480563, 4856.68431551948, 4909.4845041270155, 4930.778114984762, 5004.974975125101], "value": 4553.1440751398795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.4769838972137, 319.72982829509067, 328.1746407784424, 331.0383336407735, 332.396699989519, 4374.912501749963, 4396.6043056124945, 4495.258282383411, 5341.450979216028, 5382.327209098863, 5035.420926593443, 5101.7194054327, 5171.793128274864, 5187.210412407722, 5323.920141197876, 3404.438267685829, 3855.6529912307888, 3967.809657102872, 4151.750894946298, 4164.521080075785, 3852.595477474867, 4089.26393249215, 4123.381492776092, 4142.384470056665, 4165.770882601456, 3973.582773808752, 4091.774952377618, 4114.650254728352, 4126.216018956404, 4129.0, 3297.3734990351995, 4037.9596204037875, 4038.5355684096266, 4051.9262395465225, 4101.63085322321, 2960.86676099576, 3531.2054787672823, 3531.8057506837113, 3534.4698295255916, 3556.946645800315, 4486.8878278042985, 4758.762061896891, 4892.290617860426, 4929.742915556546, 5219.0, 4621.69958952667, 4658.790354434059, 4691.906161876777, 4707.152712511746, 4719.787609557578, 4914.262860570907, 5492.972535137299, 5614.091208988963, 5641.294838145232, 5649.0, 3883.8446462141483, 3888.475055867478, 3890.9416358754643, 3892.5718171001167, 3894.6300101490315, 4762.904741905177, 5012.974935125301, 5555.694436805974, 6006.579539432241, 6011.0, 3435.639257877937, 3867.690584753213, 3954.7231693781737, 3970.4242884782125, 3973.0, 3696.630336966282, 4002.4396584478195, 4010.9197816044098, 4013.5986401359633, 4048.2308361411237, 4521.178228514769, 4522.010315461186, 4659.720416774937, 4664.0, 4666.183417901853, 5183.948160518346, 5661.716914154275, 5703.201551782754, 5708.828735137952, 5729.455701708414, 1243.7636848998661, 1270.5045032437356, 1304.8695130487065, 1455.2360010994312, 1477.8620462244012, 909.2544113826599, 946.9384490008127, 970.2238209432426, 970.7815741458256, 973.1387721866058, 5411.567074634098, 5816.248519704766, 5841.4450627190345, 5853.853653658693, 5888.735006924699, 5673.602847800615, 6390.5077019962255, 6415.486761059104, 6420.1974753155855, 6456.386643268882, 4761.047790441926, 5117.718525481134, 5142.331496905378, 5423.945760542423, 5494.395616482184, 2740.369714965569, 3000.1749518882484, 3311.8344082795766, 3338.1988322802354, 3396.711279541217, 5650.7174641267775, 5794.638260008895, 6416.518761092937, 6416.550841441054, 6760.087388202628, 6410.1987251593555, 6581.374769396995, 6606.10817539626, 6620.602763834186, 6658.500612454085, 5651.689157096317, 5879.5002424794375, 5883.235179426732, 6435.935640643627, 6784.457243420613, 5872.823815285548, 6412.294647588668, 6439.581427207217, 6453.483721302191, 6455.935440645533, 4886.853394398174, 5905.320888097924, 6115.217576002997, 6385.13800636908, 6423.325550817097, 5147.974260128675, 5309.36287645485, 5862.67755273447, 6174.598651087665, 6180.938190618216, 3906.3945088511327, 3977.92044159121, 4000.659943904684, 4010.4585880905706, 4028.71798974069, 4894.388201474816, 5121.948780512296, 5338.706371149624, 5595.524380427546, 5968.850778730566, 4838.145843529369, 5137.280780690631, 5454.863628409322, 5726.914096288476, 5789.755202631454, 4838.395200599925, 5416.647917885325, 5725.656460612377, 5749.425057494384, 5773.971130144322, 4930.137225985366, 5431.782728690808, 5499.487640898785, 5622.915656265078, 5705.286839145107, 5744.281964754406, 5746.511546518425, 5757.136429535436, 5769.480746732646, 5772.451617096369, 4995.900081998412, 5387.595930305164, 5453.481919217668, 5618.101103823368, 5677.0], "value": 4219.245421213325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.9243387010494, 671.9966400167998, 675.6959368284273, 733.3949491669371, 750.1785544828412, 14447.434535217411, 14506.63733406664, 14938.178400187999, 14976.400943962228, 15202.923985380057, 13546.39041243144, 13548.525801596947, 13561.11852729572, 13567.932160339209, 13644.044916855824, 753.9849203015937, 777.0054330457024, 908.9999999999983, 937.9624815007392, 938.8779458670364, 912.4023764434306, 948.5873644964428, 951.8001219743862, 954.5227386306847, 960.5389413081725, 984.9507524623776, 987.0474991633073, 989.5101924547359, 993.7515621094726, 994.8358520844088, 772.7025095338336, 950.1306304731231, 981.4160574458186, 982.6266018912839, 985.2512090810964, 743.6542007966268, 744.240874308208, 745.228688307599, 745.3887811994167, 745.8843879198679, 14819.925900370428, 14904.478343257933, 14905.552833415015, 14910.105393676415, 14931.776023359658, 12513.124081314312, 12627.684307892285, 12763.425645845959, 12863.356832158355, 12893.935530322382, 9937.35407198537, 10132.94933525335, 10137.54381052847, 10164.237682173867, 10812.135029197645, 3470.4620783778555, 3511.736619753529, 3550.218951830619, 3564.679178873888, 3638.3450978823803, 82136.0, 83409.58295208485, 83482.0, 83634.0, 85083.14916850877, 9425.437683916476, 9548.474833884204, 9654.131128198496, 9862.654807081717, 9983.700488985342, 22594.661080083813, 22657.206997754998, 22666.0, 22696.886515567316, 22782.31653050411, 7235.3126452987935, 7342.4493163012985, 7376.815579610446, 7452.06849143857, 7488.438367122379, 3831.7892515911894, 3897.006263402814, 3908.6091390861257, 3924.50943632046, 3927.8036098194975, 3509.280597477511, 3641.817909104534, 3644.2711457708565, 3647.708183345326, 3652.3973544365413, 619.4115590189339, 629.4618101523223, 631.4537924695197, 638.3552611862053, 651.4267444648774, 555.3696554410692, 582.5950964079924, 609.7560975609703, 618.653554009756, 623.1027320658237, 7352.729045319101, 7830.2952734254195, 7904.525728456311, 8171.346292296602, 8301.501909885306, 521.7495602111007, 544.8855740294582, 562.5752556819575, 588.6997631208029, 607.5413063137303, 3794.4308353746605, 3832.5017747692623, 3842.442845787401, 3901.7073719471155, 4037.8182981765303, 95955.52022239844, 100550.0, 101789.49105254427, 102099.0, 102509.0, 66647.33352666508, 70332.29667703359, 74703.0, 75237.12009589713, 77183.61408193035, 69128.96306555405, 69760.30239697538, 69773.3022669777, 69938.65030674916, 70751.93872091922, 6769.018492318488, 8107.594620269081, 8140.185981401813, 8301.08793880783, 8353.647009660961, 41771.791141045316, 42538.57461425346, 44549.0, 45043.77478112588, 45336.31995520136, 60204.0, 63282.0, 63330.78342257999, 63460.36539634729, 63934.96715361214, 10888.782224355311, 11046.944765276123, 11238.831417528907, 11240.494177761857, 11421.543138274375, 11753.529858805894, 12029.939850300692, 12206.328651923874, 12384.690382740144, 13044.217346959213, 7729.497582657109, 11436.085113190758, 11529.0, 11800.763984720086, 11908.940455297668, 9539.904600953902, 11345.48945297447, 11409.60066397672, 11470.541178352772, 11497.482613282255, 10894.61868834587, 10996.890031099587, 11142.164337674545, 11144.944275278573, 11154.386508742096, 7878.330341921001, 9549.0, 9759.251890170997, 9822.852657210291, 9965.0, 9427.62289508412, 9508.85736713936, 9554.52227388614, 9617.951910240405, 9629.374090684083], "value": 6857.566033462532, "unit": "score"}], "name": "dromaeo_css", "value": 7087.248140675072, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 159.0, 112.0, 113.0, 111.0, 110.0, 102.0, 113.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 120.0, 143.0, 170.0, 116.0, 141.0, 138.0, 119.0, 172.0, 121.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 189.0, 186.0, 186.0, 192.0, 226.0, 184.0, 181.0, 230.0, 184.0], "value": 194.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 88.0, 89.0, 58.0, 58.0, 57.0, 80.0, 76.0, 56.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 135.0, 77.0, 81.0, 85.0, 121.0, 80.0, 78.0, 128.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 83.0, 86.0, 83.0, 87.0, 84.0, 90.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 91.0, 92.0, 92.0, 91.0, 92.0, 92.0, 92.0, 92.0], "value": 91.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 84.0, 87.0, 85.0, 86.0, 85.0, 83.0, 90.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 56.0, 58.0, 58.0, 58.0, 79.0, 58.0, 56.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 79.0, 70.0, 68.0, 67.0, 67.0, 67.0, 68.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 95.0, 103.0, 107.0, 84.0, 79.0, 78.0, 81.0, 81.0, 82.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 143.0, 158.0, 123.0, 148.0, 155.0, 152.0, 180.0, 145.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 198.0, 204.0, 197.0, 198.0, 200.0, 197.0, 196.0, 207.0, 203.0], "value": 201.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 71.0, 72.0, 71.0, 70.0, 69.0, 72.0, 69.0, 71.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1514.3999999999996, "alertThreshold": 2.0}]} 06:57:57 INFO - Return code: 0 06:57:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:57:57 ERROR - # TBPL SUCCESS # 06:57:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:57:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:57:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:57:57 INFO - 2016-04-27 06:57:57.600 screenresolution[1679:9979] starting screenresolution argv=screenresolution get 06:57:57 INFO - 2016-04-27 06:57:57.602 screenresolution[1679:9979] Display 0: 1600x1200x32@60 06:57:57 INFO - 2016-04-27 06:57:57.608 screenresolution[1680:9982] starting screenresolution argv=screenresolution list 06:57:57 INFO - Available Modes on Display 0 06:57:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:57:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:57:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:57:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:57:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:57:57 INFO - Intel Iris: 06:57:57 INFO - Chipset Model: Intel Iris 06:57:57 INFO - Type: GPU 06:57:57 INFO - Bus: Built-In 06:57:57 INFO - VRAM (Dynamic, Max): 1536 MB 06:57:57 INFO - Vendor: Intel (0x8086) 06:57:57 INFO - Device ID: 0x0a2e 06:57:57 INFO - Revision ID: 0x0009 06:57:57 INFO - Displays: 06:57:57 INFO - Display: 06:57:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:57:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:57:57 INFO - Display Serial Number: 1600x1200 60 06:57:57 INFO - Main Display: Yes 06:57:57 INFO - Mirror: Off 06:57:57 INFO - Online: Yes 06:57:57 INFO - Rotation: Supported 06:57:57 INFO - Return code: 0 06:57:57 INFO - Running post-action listener: _resource_record_post_action 06:57:57 INFO - Running post-run listener: _resource_record_post_run 06:57:58 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37918208; Write bytes: 692634624; Read time: 425; Write time: 1960 06:57:58 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386079232; Write bytes: 376064000; Read time: 28137; Write time: 809 06:57:58 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31669760; Write bytes: 293411840; Read time: 309; Write time: 1107 06:57:58 INFO - Running post-run listener: _upload_blobber_files 06:57:58 INFO - Blob upload gear active. 06:57:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:57:58 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 06:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:57:59 INFO - (blobuploader) - INFO - Open directory for files ... 06:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:00 INFO - (blobuploader) - INFO - Done attempting. 06:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:58:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:01 INFO - (blobuploader) - INFO - Done attempting. 06:58:01 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:01 INFO - Return code: 0 06:58:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:58:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea293e98d0b1144539310b14e1934be2e9a63718114f990606719a80cf6f668ac7c104177261942b2cd654c1e11564975ba55f155a01c2c4aa494f031b0f9a77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e5c96ee1294a9bffb489b7d3149f98e4da606dfd0a77cd2df831b8bd57d61f3a720910e7be62dea510b175bd4cfa1a4f180b227b691702bf941666ccf23914f"} 06:58:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:58:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:58:01 INFO - Contents: 06:58:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea293e98d0b1144539310b14e1934be2e9a63718114f990606719a80cf6f668ac7c104177261942b2cd654c1e11564975ba55f155a01c2c4aa494f031b0f9a77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e5c96ee1294a9bffb489b7d3149f98e4da606dfd0a77cd2df831b8bd57d61f3a720910e7be62dea510b175bd4cfa1a4f180b227b691702bf941666ccf23914f"} 06:58:01 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:01 INFO - Copying logs to upload dir... 06:58:01 INFO - mkdir: /builds/slave/test/build/upload/logs 06:58:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.337829 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-27 06:58:01.517983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 06:58:01.521396) ========= 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.4KYfIJ334O/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.MFSsk3njYe/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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/Fx-Team/sha512/ea293e98d0b1144539310b14e1934be2e9a63718114f990606719a80cf6f668ac7c104177261942b2cd654c1e11564975ba55f155a01c2c4aa494f031b0f9a77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e5c96ee1294a9bffb489b7d3149f98e4da606dfd0a77cd2df831b8bd57d61f3a720910e7be62dea510b175bd4cfa1a4f180b227b691702bf941666ccf23914f"} build_url:https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/JB52uGpLQnudDSuywzQyHw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea293e98d0b1144539310b14e1934be2e9a63718114f990606719a80cf6f668ac7c104177261942b2cd654c1e11564975ba55f155a01c2c4aa494f031b0f9a77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e5c96ee1294a9bffb489b7d3149f98e4da606dfd0a77cd2df831b8bd57d61f3a720910e7be62dea510b175bd4cfa1a4f180b227b691702bf941666ccf23914f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 06:58:01.550921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:58:01.551349) ========= 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.4KYfIJ334O/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.MFSsk3njYe/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.004386 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:58:01.600085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 06:58:01.600591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 06:58:01.601277) ========= ========= Total master_lag: 0.16 =========