builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0150 starttime: 1461070771.54 results: success (0) buildid: 20160419030056 builduid: bd5eb86fb01844748181336b72825a7b revision: 170eb8db5f8c99212b07756ce67ef86c45d7c229 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:31.538618) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:31.539199) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:31.539478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:31.560344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:31.560613) ========= 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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-19 05:59:31-- 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% 15.3M=0.001s 2016-04-19 05:59:31 (15.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122179 ========= master_lag: 0.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:32.193765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:32.194079) ========= 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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.027123 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:32.242883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 05:59:32.246218) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 170eb8db5f8c99212b07756ce67ef86c45d7c229 --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 170eb8db5f8c99212b07756ce67ef86c45d7c229 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F4TKy8h4r6/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.rjnDOzbBkI/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-19 05:59:32,309 truncating revision to first 12 chars 2016-04-19 05:59:32,309 Setting DEBUG logging. 2016-04-19 05:59:32,309 attempt 1/10 2016-04-19 05:59:32,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/170eb8db5f8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 05:59:33,300 unpacking tar archive at: fx-team-170eb8db5f8c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.238768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 05:59:33.505387) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:33.505737) ========= script_repo_revision: 170eb8db5f8c99212b07756ce67ef86c45d7c229 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:33.506160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:33.506423) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 05:59:33.520223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-19 05:59:33.520598) ========= /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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 05:59:33 INFO - MultiFileLogger online at 20160419 05:59:33 in /builds/slave/test 05:59:33 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 05:59:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:59:33 INFO - {'append_to_log': False, 05:59:33 INFO - 'base_work_dir': '/builds/slave/test', 05:59:33 INFO - 'blob_upload_branch': 'Fx-Team', 05:59:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:59:33 INFO - 'branch': 'Fx-Team', 05:59:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:59:33 INFO - 'config_files': ('talos/mac_config.py',), 05:59:33 INFO - 'default_actions': ('clobber', 05:59:33 INFO - 'read-buildbot-config', 05:59:33 INFO - 'download-and-extract', 05:59:33 INFO - 'populate-webroot', 05:59:33 INFO - 'create-virtualenv', 05:59:33 INFO - 'install', 05:59:33 INFO - 'run-tests'), 05:59:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:59:33 INFO - 'download_minidump_stackwalk': True, 05:59:33 INFO - 'download_symbols': 'ondemand', 05:59:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:59:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:59:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:59:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:59:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:59:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:59:33 INFO - 'installer_path': 'installer.exe', 05:59:33 INFO - 'log_level': 'info', 05:59:33 INFO - 'log_name': 'talos', 05:59:33 INFO - 'log_to_console': True, 05:59:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:59:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:59:33 INFO - 'opt_config_files': (), 05:59:33 INFO - 'pip_index': False, 05:59:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:59:33 INFO - 'cmd': ('bash', 05:59:33 INFO - '-c', 05:59:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:59:33 INFO - 'enabled': True, 05:59:33 INFO - 'halt_on_failure': False, 05:59:33 INFO - 'name': 'check_screen_resolution'},), 05:59:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:59:33 INFO - 'cmd': ('bash', 05:59:33 INFO - '-c', 05:59:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:59:33 INFO - 'enabled': True, 05:59:33 INFO - 'halt_on_failure': False, 05:59:33 INFO - 'name': 'check_screen_resolution'},), 05:59:33 INFO - 'run_cmd_checks_enabled': True, 05:59:33 INFO - 'sps_profile': False, 05:59:33 INFO - 'sps_profile_interval': 0, 05:59:33 INFO - 'suite': 'dromaeojs', 05:59:33 INFO - 'system_bits': '32', 05:59:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:59:33 INFO - 'title': 't-yosemite-r7-0150', 05:59:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:59:33 INFO - 'use_talos_json': True, 05:59:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:59:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:59:33 INFO - 'work_dir': 'build'} 05:59:33 INFO - ##### 05:59:33 INFO - ##### Running clobber step. 05:59:33 INFO - ##### 05:59:33 INFO - Running pre-action listener: _resource_record_pre_action 05:59:33 INFO - Running main action method: clobber 05:59:33 INFO - rmtree: /builds/slave/test/build 05:59:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:59:35 INFO - Running post-action listener: _resource_record_post_action 05:59:35 INFO - ##### 05:59:35 INFO - ##### Running read-buildbot-config step. 05:59:35 INFO - ##### 05:59:35 INFO - Running pre-action listener: _resource_record_pre_action 05:59:35 INFO - Running main action method: read_buildbot_config 05:59:35 INFO - Using buildbot properties: 05:59:35 INFO - { 05:59:35 INFO - "project": "", 05:59:35 INFO - "product": "firefox", 05:59:35 INFO - "script_repo_revision": "production", 05:59:35 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:59:35 INFO - "repository": "", 05:59:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:59:35 INFO - "buildid": "20160419030056", 05:59:35 INFO - "pgo_build": "False", 05:59:35 INFO - "basedir": "/builds/slave/test", 05:59:35 INFO - "buildnumber": 738, 05:59:35 INFO - "slavename": "t-yosemite-r7-0150", 05:59:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:59:35 INFO - "platform": "yosemite_r7", 05:59:35 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:59:35 INFO - "branch": "fx-team", 05:59:35 INFO - "repo_path": "integration/fx-team", 05:59:35 INFO - "revision": "170eb8db5f8c99212b07756ce67ef86c45d7c229", 05:59:35 INFO - "stage_platform": "macosx64", 05:59:35 INFO - "builduid": "bd5eb86fb01844748181336b72825a7b", 05:59:35 INFO - "slavebuilddir": "test" 05:59:35 INFO - } 05:59:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:59:35 INFO - Running post-action listener: _resource_record_post_action 05:59:35 INFO - ##### 05:59:35 INFO - ##### Running download-and-extract step. 05:59:35 INFO - ##### 05:59:35 INFO - Running pre-action listener: _resource_record_pre_action 05:59:35 INFO - Running main action method: download_and_extract 05:59:35 INFO - mkdir: /builds/slave/test/build/tests 05:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:35 INFO - https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:59:37 INFO - Downloaded 1199 bytes. 05:59:37 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:59:37 INFO - Using the following test package requirements: 05:59:37 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:59:37 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:59:37 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:59:37 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:59:37 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:59:37 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:59:37 INFO - u'jsshell-mac.zip'], 05:59:37 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:59:37 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:59:37 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:59:37 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:59:37 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:59:37 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:59:37 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:59:37 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:59:37 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:59:37 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:59:37 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:59:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:37 INFO - https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:59:39 INFO - Downloaded 18037984 bytes. 05:59:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:59:42 INFO - Return code: 0 05:59:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:59: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')]} 05:59:42 INFO - https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:59:43 INFO - Downloaded 18037984 bytes. 05:59:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:59:47 INFO - Return code: 0 05:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:47 INFO - https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:59:48 INFO - Downloaded 10845952 bytes. 05:59:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:59:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:59:48 INFO - Return code: 0 05:59: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')]} 05:59:49 INFO - https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:59:52 INFO - Downloaded 109950643 bytes. 05:59:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:59:52 INFO - mkdir: /builds/slave/test/properties 05:59:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:59:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:59:52 INFO - Contents: 05:59:52 INFO - build_url:https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:59:53 INFO - Running post-action listener: _resource_record_post_action 05:59:53 INFO - Running post-action listener: set_extra_try_arguments 05:59:53 INFO - ##### 05:59:53 INFO - ##### Running populate-webroot step. 05:59:53 INFO - ##### 05:59:53 INFO - Running pre-action listener: _resource_record_pre_action 05:59:53 INFO - Running main action method: populate_webroot 05:59:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:53 INFO - '--tppagecycles', 05:59:53 INFO - '7'], 05:59:53 INFO - 'tests': ['tsvgm']}}, 05:59:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:59:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:59:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:59:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:53 INFO - 'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:53 INFO - 'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['damp', 'tps']}, 05:59:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:53 INFO - 'tests': ['damp', 'tps']}, 05:59:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['dromaeo_dom']}, 05:59:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['a11yr', 05:59:53 INFO - 'ts_paint', 05:59:53 INFO - 'tpaint', 05:59:53 INFO - 'sessionrestore', 05:59:53 INFO - 'sessionrestore_no_auto_restore', 05:59:53 INFO - 'tabpaint']}, 05:59:53 INFO - 'other-e10s': {'tests': ['a11yr', 05:59:53 INFO - 'ts_paint', 05:59:53 INFO - 'tpaint', 05:59:53 INFO - 'sessionrestore', 05:59:53 INFO - 'sessionrestore_no_auto_restore', 05:59:53 INFO - 'tabpaint']}, 05:59:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:59:53 INFO - 'ts_paint', 05:59:53 INFO - 'tpaint', 05:59:53 INFO - 'sessionrestore', 05:59:53 INFO - 'sessionrestore_no_auto_restore', 05:59:53 INFO - 'tabpaint']}, 05:59:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:59:53 INFO - 'ts_paint', 05:59:53 INFO - 'tpaint', 05:59:53 INFO - 'sessionrestore', 05:59:53 INFO - 'sessionrestore_no_auto_restore', 05:59:53 INFO - 'tabpaint']}, 05:59:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['a11yr', 05:59:53 INFO - 'ts_paint', 05:59:53 INFO - 'tpaint', 05:59:53 INFO - 'sessionrestore', 05:59:53 INFO - 'sessionrestore_no_auto_restore', 05:59:53 INFO - 'tabpaint']}, 05:59:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['a11yr', 05:59:53 INFO - 'ts_paint', 05:59:53 INFO - 'tpaint', 05:59:53 INFO - 'sessionrestore', 05:59:53 INFO - 'sessionrestore_no_auto_restore', 05:59:53 INFO - 'tabpaint']}, 05:59:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['tsvgx', 05:59:53 INFO - 'tsvgr_opacity', 05:59:53 INFO - 'tart', 05:59:53 INFO - 'tscrollx', 05:59:53 INFO - 'cart']}, 05:59:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:59:53 INFO - 'tsvgr_opacity', 05:59:53 INFO - 'tart', 05:59:53 INFO - 'tscrollx', 05:59:53 INFO - 'cart']}, 05:59:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:53 INFO - 'talos_options': ['--disable-e10s'], 05:59:53 INFO - 'tests': ['tp5o']}, 05:59:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:53 INFO - 'tests': ['tp5o']}, 05:59:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:53 INFO - 'talos_options': ['--disable-e10s', 05:59:53 INFO - '--xperf_path', 05:59:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:53 INFO - 'tests': ['tp5n']}, 05:59:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:53 INFO - 'talos_options': ['--xperf_path', 05:59:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:53 INFO - 'tests': ['tp5n']}}, 05:59:53 INFO - 'talos.zip': {'path': '', 05:59:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:53 INFO - Running post-action listener: _resource_record_post_action 05:59:53 INFO - ##### 05:59:53 INFO - ##### Running create-virtualenv step. 05:59:53 INFO - ##### 05:59:53 INFO - Running pre-action listener: _resource_record_pre_action 05:59:53 INFO - Running main action method: create_virtualenv 05:59:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:59:53 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 05:59:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:59:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:53 INFO - Using real prefix '/tools/python27' 05:59:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:59:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:56 INFO - Installing pip.................done. 05:59:56 INFO - Return code: 0 05:59:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:56 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 0x10335ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34159f1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, '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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 05:59:56 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 05:59:56 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 05:59:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 05:59:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:56 INFO - 'HOME': '/Users/cltbld', 05:59:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:56 INFO - 'LOGNAME': 'cltbld', 05:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:56 INFO - 'MOZ_NO_REMOTE': '1', 05:59:56 INFO - 'NO_EM_RESTART': '1', 05:59:56 INFO - 'PAGER': '/bin/cat', 05:59:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:56 INFO - 'PWD': '/builds/slave/test', 05:59:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:56 INFO - 'SHELL': '/bin/bash', 05:59:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 05:59:56 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:59:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:56 INFO - 'USER': 'cltbld', 05:59:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:56 INFO - 'XPC_FLAGS': '0x0', 05:59:56 INFO - 'XPC_SERVICE_NAME': '0', 05:59:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:57 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 05:59:57 INFO - Cleaning up... 05:59:57 INFO - Return code: 0 05:59:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:57 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 0x10335ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34159f1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, '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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 05:59:57 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 05:59:57 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 05:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 05:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:57 INFO - 'HOME': '/Users/cltbld', 05:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:57 INFO - 'LOGNAME': 'cltbld', 05:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:57 INFO - 'MOZ_NO_REMOTE': '1', 05:59:57 INFO - 'NO_EM_RESTART': '1', 05:59:57 INFO - 'PAGER': '/bin/cat', 05:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:57 INFO - 'PWD': '/builds/slave/test', 05:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:57 INFO - 'SHELL': '/bin/bash', 05:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 05:59:57 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 05:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:57 INFO - 'USER': 'cltbld', 05:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:57 INFO - 'XPC_FLAGS': '0x0', 05:59:57 INFO - 'XPC_SERVICE_NAME': '0', 05:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:57 INFO - Downloading/unpacking psutil>=0.7.1 05:59:57 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 05:59:57 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 05:59:57 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 05:59:57 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 05:59:57 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 05:59:57 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:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:00 INFO - Installing collected packages: psutil 06:00:00 INFO - Running setup.py install for psutil 06:00:00 INFO - building 'psutil._psutil_osx' extension 06:00:00 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:00:01 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:00:01 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:00:01 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:00:01 INFO - building 'psutil._psutil_posix' extension 06:00:01 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:00:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:00:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:00:01 INFO - ^ 06:00:01 INFO - 1 warning generated. 06:00:01 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:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:01 INFO - Successfully installed psutil 06:00:01 INFO - Cleaning up... 06:00:01 INFO - Return code: 0 06:00:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:00:01 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:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:01 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:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:01 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 0x10335ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34159f1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, '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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:00:01 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:00:01 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:00:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 06:00:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:01 INFO - 'HOME': '/Users/cltbld', 06:00:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:01 INFO - 'LOGNAME': 'cltbld', 06:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:01 INFO - 'MOZ_NO_REMOTE': '1', 06:00:01 INFO - 'NO_EM_RESTART': '1', 06:00:01 INFO - 'PAGER': '/bin/cat', 06:00:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:01 INFO - 'PWD': '/builds/slave/test', 06:00:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:01 INFO - 'SHELL': '/bin/bash', 06:00:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 06:00:01 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:00:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:01 INFO - 'USER': 'cltbld', 06:00:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:01 INFO - 'XPC_FLAGS': '0x0', 06:00:01 INFO - 'XPC_SERVICE_NAME': '0', 06:00:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:00:01 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:00:01 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:00:01 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:00:01 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:00:01 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:00:01 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:00:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:04 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:00:04 INFO - Installing collected packages: mozsystemmonitor 06:00:04 INFO - Running setup.py install for mozsystemmonitor 06:00:04 INFO - Successfully installed mozsystemmonitor 06:00:04 INFO - Cleaning up... 06:00:04 INFO - Return code: 0 06:00:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:00:04 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:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:04 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:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:04 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 0x10335ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34159f1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, '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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:00:04 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:00:04 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:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 06:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:04 INFO - 'HOME': '/Users/cltbld', 06:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:04 INFO - 'LOGNAME': 'cltbld', 06:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:04 INFO - 'MOZ_NO_REMOTE': '1', 06:00:04 INFO - 'NO_EM_RESTART': '1', 06:00:04 INFO - 'PAGER': '/bin/cat', 06:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:04 INFO - 'PWD': '/builds/slave/test', 06:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:04 INFO - 'SHELL': '/bin/bash', 06:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 06:00:04 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:04 INFO - 'USER': 'cltbld', 06:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:04 INFO - 'XPC_FLAGS': '0x0', 06:00:04 INFO - 'XPC_SERVICE_NAME': '0', 06:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:04 INFO - Downloading/unpacking blobuploader==1.2.4 06:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:04 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:00:07 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00:07 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:00:07 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:00:07 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:00:07 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:00:07 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:00:07 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:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:00:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:08 INFO - Downloading docopt-0.6.1.tar.gz 06:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:08 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:08 INFO - Running setup.py install for blobuploader 06:00:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:00:08 INFO - Running setup.py install for requests 06:00:09 INFO - Running setup.py install for docopt 06:00:09 INFO - Successfully installed blobuploader requests docopt 06:00:09 INFO - Cleaning up... 06:00:09 INFO - Return code: 0 06:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00: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:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:09 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 0x10335ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34159f1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, '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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:00:09 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:00:09 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:00:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 06:00:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:09 INFO - 'HOME': '/Users/cltbld', 06:00:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:09 INFO - 'LOGNAME': 'cltbld', 06:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:09 INFO - 'MOZ_NO_REMOTE': '1', 06:00:09 INFO - 'NO_EM_RESTART': '1', 06:00:09 INFO - 'PAGER': '/bin/cat', 06:00:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:09 INFO - 'PWD': '/builds/slave/test', 06:00:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:09 INFO - 'SHELL': '/bin/bash', 06:00:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 06:00:09 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:00:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:09 INFO - 'USER': 'cltbld', 06:00:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:09 INFO - 'XPC_FLAGS': '0x0', 06:00:09 INFO - 'XPC_SERVICE_NAME': '0', 06:00:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:09 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-A2ZMcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:09 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Ks23Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:09 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Mimtlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:10 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-LpNLRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:10 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-nC4HVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:10 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-oL4m0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:10 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-g6fdWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:10 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-03B36q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:10 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-REJOmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:10 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-YbGhsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:10 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-KxnR7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:10 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-0fvItM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:11 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-OzFDPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:11 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-MJ7dh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:11 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-9BM49D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:11 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-te5sIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:11 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-x_dsLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:00:11 INFO - Running setup.py install for manifestparser 06:00:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:00:11 INFO - Running setup.py install for mozcrash 06:00:11 INFO - Running setup.py install for mozdebug 06:00:11 INFO - Running setup.py install for mozdevice 06:00:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:00:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:00:12 INFO - Running setup.py install for mozfile 06:00:12 INFO - Running setup.py install for mozhttpd 06:00:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:00:12 INFO - Running setup.py install for mozinfo 06:00:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:00:12 INFO - Running setup.py install for mozInstall 06:00:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:00:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:00:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:00:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:00:12 INFO - Running setup.py install for mozleak 06:00:12 INFO - Running setup.py install for mozlog 06:00:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:00:13 INFO - Running setup.py install for moznetwork 06:00:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:00:13 INFO - Running setup.py install for mozprocess 06:00:13 INFO - Running setup.py install for mozprofile 06:00:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:00:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:00:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:00:13 INFO - Running setup.py install for mozrunner 06:00:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:00:13 INFO - Running setup.py install for mozscreenshot 06:00:13 INFO - Running setup.py install for moztest 06:00:13 INFO - Running setup.py install for mozversion 06:00:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:00:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:00:14 INFO - Cleaning up... 06:00:14 INFO - Return code: 0 06:00:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:14 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:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:14 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:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:14 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 0x10335ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34159f1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, '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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:00:14 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:00:14 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:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 06:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:14 INFO - 'HOME': '/Users/cltbld', 06:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:14 INFO - 'LOGNAME': 'cltbld', 06:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:14 INFO - 'MOZ_NO_REMOTE': '1', 06:00:14 INFO - 'NO_EM_RESTART': '1', 06:00:14 INFO - 'PAGER': '/bin/cat', 06:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:14 INFO - 'PWD': '/builds/slave/test', 06:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:14 INFO - 'SHELL': '/bin/bash', 06:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 06:00:14 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:14 INFO - 'USER': 'cltbld', 06:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:14 INFO - 'XPC_FLAGS': '0x0', 06:00:14 INFO - 'XPC_SERVICE_NAME': '0', 06:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-VLwNsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:14 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:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-lP1mAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:14 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:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-yd_rqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:14 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:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-vIzAMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:14 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:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-cB6bRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:14 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:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:14 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-4xe2zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:15 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:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:15 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-2pneuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:15 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:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:15 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-EpMnwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:15 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:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:15 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-63O59n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:15 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:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:15 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-AX3l0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:15 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:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:15 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Gu5b0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:15 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:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:15 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-y4D8Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:15 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:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:15 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-ilFSN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:15 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:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:15 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-o2mx50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:15 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:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:15 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-sKwEjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:16 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:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:16 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-ge1CqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:16 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:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:16 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-msuBAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:16 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:00:16 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:00:16 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:00:16 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:00:16 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:00:16 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:00:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:00:16 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:00:16 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:00:16 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:00:16 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:00:16 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:00:16 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:00:18 INFO - Downloading blessings-1.6.tar.gz 06:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:00:18 INFO - Installing collected packages: blessings 06:00:18 INFO - Running setup.py install for blessings 06:00:18 INFO - Successfully installed blessings 06:00:18 INFO - Cleaning up... 06:00:19 INFO - Return code: 0 06:00:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:19 INFO - Reading from file tmpfile_stdout 06:00:19 INFO - Current package versions: 06:00:19 INFO - blessings == 1.6 06:00:19 INFO - blobuploader == 1.2.4 06:00:19 INFO - docopt == 0.6.1 06:00:19 INFO - manifestparser == 1.1 06:00:19 INFO - mozInstall == 1.12 06:00:19 INFO - mozcrash == 0.17 06:00:19 INFO - mozdebug == 0.1 06:00:19 INFO - mozdevice == 0.48 06:00:19 INFO - mozfile == 1.2 06:00:19 INFO - mozhttpd == 0.7 06:00:19 INFO - mozinfo == 0.9 06:00:19 INFO - mozleak == 0.1 06:00:19 INFO - mozlog == 3.1 06:00:19 INFO - moznetwork == 0.27 06:00:19 INFO - mozprocess == 0.22 06:00:19 INFO - mozprofile == 0.28 06:00:19 INFO - mozrunner == 6.11 06:00:19 INFO - mozscreenshot == 0.1 06:00:19 INFO - mozsystemmonitor == 0.0 06:00:19 INFO - moztest == 0.7 06:00:19 INFO - mozversion == 1.4 06:00:19 INFO - psutil == 3.1.1 06:00:19 INFO - requests == 1.2.3 06:00:19 INFO - wsgiref == 0.1.2 06:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:19 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 0x10335ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34159f1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, '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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:00:19 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:00:19 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:00:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 06:00:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:19 INFO - 'HOME': '/Users/cltbld', 06:00:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:19 INFO - 'LOGNAME': 'cltbld', 06:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:19 INFO - 'MOZ_NO_REMOTE': '1', 06:00:19 INFO - 'NO_EM_RESTART': '1', 06:00:19 INFO - 'PAGER': '/bin/cat', 06:00:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:19 INFO - 'PWD': '/builds/slave/test', 06:00:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:19 INFO - 'SHELL': '/bin/bash', 06:00:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 06:00:19 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:00:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:19 INFO - 'USER': 'cltbld', 06:00:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:19 INFO - 'XPC_FLAGS': '0x0', 06:00:19 INFO - 'XPC_SERVICE_NAME': '0', 06:00:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:19 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:00:19 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:00:19 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:00:19 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:00:19 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:00:19 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:00:19 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:00:19 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:00:19 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:00:19 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:00:19 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:00:19 INFO - Cleaning up... 06:00:19 INFO - Return code: 0 06:00:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:19 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 0x10335ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34159f1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, '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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:00:19 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:00:19 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:00:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 06:00:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:19 INFO - 'HOME': '/Users/cltbld', 06:00:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:19 INFO - 'LOGNAME': 'cltbld', 06:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:19 INFO - 'MOZ_NO_REMOTE': '1', 06:00:19 INFO - 'NO_EM_RESTART': '1', 06:00:19 INFO - 'PAGER': '/bin/cat', 06:00:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:19 INFO - 'PWD': '/builds/slave/test', 06:00:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:19 INFO - 'SHELL': '/bin/bash', 06:00:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 06:00:19 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:00:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:19 INFO - 'USER': 'cltbld', 06:00:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:19 INFO - 'XPC_FLAGS': '0x0', 06:00:19 INFO - 'XPC_SERVICE_NAME': '0', 06:00:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:20 INFO - Downloading/unpacking jsonschema 06:00:20 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:00:20 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:00:20 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:00:20 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:00:20 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:00:20 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:00:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:00:22 INFO - Downloading/unpacking functools32 (from jsonschema) 06:00:22 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:00:22 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:00:22 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:00:22 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:00:22 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:00:22 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:00:23 INFO - Downloading functools32-3.2.3-2.tar.gz 06:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:00:23 INFO - warning: no files found matching '*.txt' 06:00:23 INFO - no previously-included directories found matching 'build' 06:00:23 INFO - no previously-included directories found matching 'dist' 06:00:23 INFO - no previously-included directories found matching '.git*' 06:00:23 INFO - Installing collected packages: jsonschema, functools32 06:00:23 INFO - Running setup.py install for functools32 06:00:23 INFO - warning: no files found matching '*.txt' 06:00:23 INFO - no previously-included directories found matching 'build' 06:00:23 INFO - no previously-included directories found matching 'dist' 06:00:23 INFO - no previously-included directories found matching '.git*' 06:00:23 INFO - Successfully installed jsonschema functools32 06:00:23 INFO - Cleaning up... 06:00:23 INFO - Return code: 0 06:00:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:23 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 0x10335ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34159f1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, '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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:00:23 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:00:23 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:00:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 06:00:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:23 INFO - 'HOME': '/Users/cltbld', 06:00:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:23 INFO - 'LOGNAME': 'cltbld', 06:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:23 INFO - 'MOZ_NO_REMOTE': '1', 06:00:23 INFO - 'NO_EM_RESTART': '1', 06:00:23 INFO - 'PAGER': '/bin/cat', 06:00:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:23 INFO - 'PWD': '/builds/slave/test', 06:00:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:23 INFO - 'SHELL': '/bin/bash', 06:00:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 06:00:23 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:00:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:23 INFO - 'USER': 'cltbld', 06:00:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:23 INFO - 'XPC_FLAGS': '0x0', 06:00:23 INFO - 'XPC_SERVICE_NAME': '0', 06:00:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:23 INFO - Downloading/unpacking flake8 06:00:23 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:00:23 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:00:23 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:00:23 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:00:23 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:00:23 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:00:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:00:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:00:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:00: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:00: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:00: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:00: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:00: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:00: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:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:00:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:27 INFO - no previously-included directories found matching 'docs/_build' 06:00:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:00:27 INFO - Running setup.py install for pep8 06:00:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:27 INFO - no previously-included directories found matching 'docs/_build' 06:00:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:00:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:00:28 INFO - Cleaning up... 06:00:28 INFO - Return code: 0 06:00:28 INFO - Running post-action listener: _resource_record_post_action 06:00:28 INFO - Running post-action listener: _start_resource_monitoring 06:00:28 INFO - Starting resource monitoring. 06:00:28 INFO - ##### 06:00:28 INFO - ##### Running install step. 06:00:28 INFO - ##### 06:00:28 INFO - Running pre-action listener: _resource_record_pre_action 06:00:28 INFO - Running main action method: install 06:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:28 INFO - Reading from file tmpfile_stdout 06:00:28 INFO - Detecting whether we're running mozinstall >=1.0... 06:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:00:28 INFO - Reading from file tmpfile_stdout 06:00:28 INFO - Output received: 06:00:28 INFO - Usage: mozinstall [options] installer 06:00:28 INFO - Options: 06:00:28 INFO - -h, --help show this help message and exit 06:00:28 INFO - -d DEST, --destination=DEST 06:00:28 INFO - Directory to install application into. [default: 06:00:28 INFO - "/builds/slave/test"] 06:00:28 INFO - --app=APP Application being installed. [default: firefox] 06:00:28 INFO - mkdir: /builds/slave/test/build/application 06:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:01:01 INFO - Reading from file tmpfile_stdout 06:01:01 INFO - Output received: 06:01:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:01:01 INFO - Running post-action listener: _resource_record_post_action 06:01:01 INFO - ##### 06:01:01 INFO - ##### Running run-tests step. 06:01:01 INFO - ##### 06:01:01 INFO - Running pre-action listener: _resource_record_pre_action 06:01:01 INFO - Running main action method: run_tests 06:01:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:01:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:01:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:01:01 INFO - 2016-04-19 06:01:01.766 screenresolution[1639:7622] starting screenresolution argv=screenresolution get 06:01:01 INFO - 2016-04-19 06:01:01.769 screenresolution[1639:7622] Display 0: 1600x1200x32@60 06:01:01 INFO - 2016-04-19 06:01:01.774 screenresolution[1640:7624] starting screenresolution argv=screenresolution list 06:01:01 INFO - Available Modes on Display 0 06:01:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:01:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:01:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:01:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:01:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:01:02 INFO - Intel Iris: 06:01:02 INFO - Chipset Model: Intel Iris 06:01:02 INFO - Type: GPU 06:01:02 INFO - Bus: Built-In 06:01:02 INFO - VRAM (Dynamic, Max): 1536 MB 06:01:02 INFO - Vendor: Intel (0x8086) 06:01:02 INFO - Device ID: 0x0a2e 06:01:02 INFO - Revision ID: 0x0009 06:01:02 INFO - Displays: 06:01:02 INFO - Display: 06:01:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:01:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:01:02 INFO - Display Serial Number: 1600x1200 60 06:01:02 INFO - Main Display: Yes 06:01:02 INFO - Mirror: Off 06:01:02 INFO - Online: Yes 06:01:02 INFO - Rotation: Supported 06:01:02 INFO - Return code: 0 06:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:02 INFO - Python 2.7.3 06:01:02 INFO - Return code: 0 06:01:02 INFO - grabbing minidump binary from tooltool 06:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:02 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 0x1031fae00>, '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 0x103023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:02 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:01:02 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:01:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:02 INFO - Return code: 0 06:01:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:01:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:01:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:01:03 INFO - Return code: 0 06:01:03 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/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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:01:03 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/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --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:01:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4TKy8h4r6/Render', 06:01:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:03 INFO - 'HOME': '/Users/cltbld', 06:01:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:03 INFO - 'LOGNAME': 'cltbld', 06:01:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:03 INFO - 'MOZ_NO_REMOTE': '1', 06:01:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:03 INFO - 'NO_EM_RESTART': '1', 06:01:03 INFO - 'PAGER': '/bin/cat', 06:01:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:03 INFO - 'PWD': '/builds/slave/test', 06:01:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:03 INFO - 'SHELL': '/bin/bash', 06:01:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjnDOzbBkI/Listeners', 06:01:03 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 06:01:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:03 INFO - 'USER': 'cltbld', 06:01:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:03 INFO - 'XPC_FLAGS': '0x0', 06:01:03 INFO - 'XPC_SERVICE_NAME': '0', 06:01:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:03 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/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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:01:03 INFO - mozversion application_buildid: 20160419030056 06:01:03 INFO - mozversion application_changeset: 170eb8db5f8c99212b07756ce67ef86c45d7c229 06:01:03 INFO - mozversion application_display_name: Nightly 06:01:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:03 INFO - mozversion application_name: Firefox 06:01:03 INFO - mozversion application_remotingname: firefox 06:01:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:01:03 INFO - mozversion application_vendor: Mozilla 06:01:03 INFO - mozversion application_version: 48.0a1 06:01:03 INFO - mozversion platform_buildid: 20160419030056 06:01:03 INFO - mozversion platform_changeset: 170eb8db5f8c99212b07756ce67ef86c45d7c229 06:01:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:01:03 INFO - mozversion platform_version: 48.0a1 06:01:03 INFO - using testdate: 1461070863 06:01:03 INFO - actual date: 1461070863 06:01:03 INFO - starting webserver on 'localhost:49276' 06:01:03 INFO - SUITE-START | Running 2 tests 06:01:03 INFO - TEST-START | dromaeo_css 06:01:03 INFO - operating with platform_type : mac_ 06:01:03 INFO - Initialising browser for dromaeo_css test... 06:01:03 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmppLJm1T/profile http://localhost:49276/getInfo.html) 06:01:05 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 06:01:05 INFO - PROCESS | 1658 | colorDepth:24 06:01:05 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 06:01:05 INFO - PROCESS | 1658 | __metrics 06:01:05 INFO - PROCESS | 1658 | 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:01:05 ERROR - PROCESS | 1658 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:01:06 INFO - TEST-INFO | 1658: exit 0 06:01:06 INFO - Browser initialized. 06:01:06 INFO - Running cycle 1/1 for dromaeo_css test... 06:01:06 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmppLJm1T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:18 INFO - PROCESS | 1660 | RSS: Main: 237383680 06:01:18 INFO - PROCESS | 1660 | 06:02:09 INFO - PROCESS | 1660 | 1461070929885 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:04:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 06:04:21 INFO - PROCESS | 1660 | RSS: Main: 414187520 06:04:21 INFO - PROCESS | 1660 | 06:07:24 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 06:07:25 INFO - PROCESS | 1660 | RSS: Main: 376373248 06:07:25 INFO - PROCESS | 1660 | 06:10:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 06:10:27 INFO - PROCESS | 1660 | RSS: Main: 376913920 06:10:27 INFO - PROCESS | 1660 | 06:13:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 06:13:30 INFO - PROCESS | 1660 | RSS: Main: 376475648 06:13:30 INFO - PROCESS | 1660 | 06:16:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 06:16:34 INFO - PROCESS | 1660 | RSS: Main: 338513920 06:16:34 INFO - PROCESS | 1660 | 06:19:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 06:19:37 INFO - PROCESS | 1660 | RSS: Main: 409501696 06:19:37 INFO - PROCESS | 1660 | 06:19:37 INFO - PROCESS | 1660 | __start_tp_report 06:19:37 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 06:19:37 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 06:19:37 INFO - PROCESS | 1660 | |i|pagename|runs| 06:19:37 INFO - PROCESS | 1660 | |0;dojo.html;3440.9311813763725;3493.126718320418;3523.665251801078;3546.8472746357434;3559.377109005923;5689.971550142243;5764.020116580181;5810.273715785522;5836.737346819393;5858.443447872451;5785.27684039495;5825.533957283418;5852.034414321632;5971.432713892184;5975.9402405975925;5112.488751124895;5166.612504062192;5185.222216667511;5198.45416231296;5315.521603055724;5287.603429742785;5305.3898801637915;5332.14685650296;5347.25138480613;5382.381026181981;5141.30592370029;5164.612654050961;5178.533931946143;5229.241759944786;5288.709120998344;5223.608229382773;5225.190095535198;5243.9213411798855;5252.054630166568;5257.579393648499;5179.896402071938;5221.817236396708;5231.581473482112;5245.449227831099;5269.710165940872;5587.692676902769;5624;5670.659760414388;5692.886142277172;5797.73910174039;6108.511319094462;6127.84680382994;6138.47822935051;6147.077938309245;6170.105334726484;6164.4143806338325;6179.752809887599;6182.227221597301;6195.28754193269;6198.504119670415;5752.856178595569;5850.239468869105;5855.502282306009;5860.501857342131;5865.501432378295;6139.631622102688;6144.692765361714;6154.230721159855;6219.253689557282;6225.00399936008;6104.938950610526;6158.137860699506;6164.106204600397;6192;6207.6585787782105;6094.603850749687;6171.475424588871;6192.195014648067;6199.039148931923;6223.190985171898;6093.055576385667;6138.296437970319;6147.815565533041;6202.627842329474;6276.686165691697;6210.4410603045035;6222.502199824004;6235.251769787655;6243.188385509855;6250.531210159256;4899.265110233494;4948.307236986825;4963.379577552806;4973.726445045485;5005.89988200234;4297.419848320499;4315.8489452869;4490.169318676056;4498.482674492475;4523.185826551252;4744.572988431058;5705.914411283751;5737.655740655574;5784.132380142928;5803.100519419497;6211.409916057967;6218.19163508741;6225.62646241227;6236;6264.968675156595;5587.860303492445;5703.7148142592705;5707.3721890592005;5717.313922329347;5803.47768700819;5064.594832413398;5408.378036525771;5413.864653383697;5426.782928682808;5460.754266058037;6264.373562643699;6309.400606942333;6318.115463835067;6345.587536810277;6346.492280617539;6134.478569321479;6158.476529494864;6230.096635987847;6230.252369715663;6232.719527621177;4947;6162.044883043135;6308.779192728232;6312.7159277833525;6387.904181437375;6126.23422072241;6220.409061139185;6227.314995350598;6240.438360547572;6254.061890716429;6112.077967281481;6129.662868542095;6149.323574406722;6166.784162554289;6243.7814676486105;5934.109883517507;6132.294322189991;6143.631382117087;6148.3236843948025;6151.9384806151365;6125.509959203342;6142.938570614237;6144.938550614436;6150.723217455135;6163.8150855474405;5810.709464526842;5973.970130149321;6029.8191054268445;6031.336552979256;6033.818985430444;6047.365026672136;6091.543134265036;6093.146959425595;6101.572889897842;6105.145279660762;5960.97019514917;5968.612040217372;5972.970135149297;5977.731002104829;5978.491828194652 06:19:37 INFO - PROCESS | 1660 | |1;ext.html;526.8340472751083;535.189188379605;548.0819627124565;589.1780965553054;621.1769405537664;29238.853805730996;30730.692693073062;31347;31377.372452550935;38584;41305.38041929373;41825.7908710456;41826.95432614186;41994;42029.7898510507;9310.767230819216;9547.80904381912;9550.665726699566;9553.665621703241;9554.522273886312;8359.038710548304;8730.301575873946;9361.20429763471;11326.490307936163;11659;11192.608258710947;11310.717232069183;11316.264442811233;11321.377324247163;11337.659870203906;8381.03618083922;11327.433628318551;11420.885791142066;11427.48576314068;11439.714007149887;11187.944060279728;11521.48153333102;11528.76942461146;11539.538418463335;11555.711107222387;38175.42736858922;38838.805805971075;38920.41619375712;38998.61001390006;39053;3069.5856059432135;3122;3169.746420286395;3230.9983904989526;3405.9659403405894;27890.721092789016;28071.719282807117;28304.867805287762;28458.71541284602;28649.57025644617;2674.17100698784;2719.1298784388805;2727.3454370951026;2735.589661550783;2799.7900157488066;359226;359317;360290.1985490082;360646;361271;35085.64914350875;51552.74223628933;62335;62680.686596566724;62839;34978.65021349805;35160;35178.47232291518;35199.12002199965;35219.295614087576;14808.703825923421;15290.92963492545;15298.694026119638;15303.770443443358;15321.23393830304;11943.925046745835;12183.147179697513;12752.936235318764;12802.615921522369;12815;7901.249381308881;8045.678172873137;8073.798155046054;8133.959330203311;8140.511569305742;3380.594328680525;3409.3863104641405;3414.8634054637537;3422.401079811023;3446.190145315849;1012.2281933862583;1033.62495734442;1045.947702614866;1059.2214722179192;1070.2347821307646;27458.17625471239;29712.257193570334;29921.40157196844;30429;30574.08277751671;1084.7830433913248;1096.413418820943;1172.027217409548;1192.5587532612988;1192.6243233381458;15322.540323790305;15410.537683869501;15419.306131224123;15479.690406191814;15853.890227684182;646171;646348.2191068551;654354;655368;656156;50487;60511.69744151251;61153;61360.079598806056;61469;1335.5192130832893;1458.2635768936832;1505;1507.9472218472301;1513.28119143406;28568.0001199957;29399.412011760072;29588;29987;30277.697223027488;48918;49372.259416109504;49789.751051244515;49829.252561212335;49888.25167622561;406573;409322;409394;409566;409971;23155.884220578788;26108;26742.732572674024;26798.114273430634;27170.72829271761;43143.78428107839;43267.13465730731;43731.34402983894;44172.55827441684;44266.3360049606;34569;35876.28247435089;36330.636693632725;36637.717679882146;36642;35261.64738352686;35408.29183416266;35527.289454211284;36173.81913090418;36190.8190459046;36938.261234775695;37020.629793701715;37532.81233593814;37733;37932.81033594815;31389.372212556078;33212.335753284315;33280.33439331152;33366.332673346886;33392.833035834665;23985.640215396434;24209.152679656127;24459.38851528726;25002.499950001264;25021.874890626157 06:19:37 INFO - PROCESS | 1660 | |2;jquery.html;336.443186526299;394.71383247145815;400.0019950224191;407.9143379890223;419.05503090530846;18556.443306700803;20598.073086711098;21216.36350909475;21543.922803859805;21548.56902861942;19996.1001754921;20881.895590522065;20937.12663157313;21024.57950840982;21360.038798254078;5135.563477104451;5746.109353050273;5931.834880268692;5932.2584676915385;5949.137375080611;5724.885502289952;5847.122931560279;5857.092150716646;5896.616719913192;5907.556933230004;5689.772409103631;5846.64920104793;5849.9707501462435;5857.707114644272;5858.355580886099;5657.8585535361535;5704.1443783432815;5825.825225243249;5842.948269311522;5846.7076646167525;5049.671771334852;5088.389393272794;5095.3376061112185;5100.795968161269;5101.132807422747;12725.363731813371;13395.86604133956;13410.195388276734;13453.730925381535;25193.748062519324;1995.3561530971376;2019.2831544801531;2145.259885339571;2234.4637287051155;2563.9230823075336;9640.228781697517;9937.304388692794;10108.39349639024;10126.139278161365;10278.588856445733;1662.3599914033064;1728.6110625109375;1734.9763639452658;1775.7513948047283;1782.3049010885766;111244.44377778059;118552;121153.4904184101;121395;121622;9934.105930466292;10895.182861285435;11530.942345288388;11597.750414984053;11647;14966.850331496764;15085.924570377078;15086.396544138111;15092.320845561977;15114.244287785566;8464.30713857231;8667.219950204511;8675.696350627697;8751.299896008304;8808.427452215585;8467.618957146944;8476.067632560413;8508.829823403621;8592.785180370542;8602.741917742478;4442.888927776831;4565.931511027337;4610.815567377334;4621.6764826462495;4636.675432719677;1927.7686677598779;1965.15498335717;1981.0688976181173;1988.33390814076;2022.8645599321287;723.0094770164802;723.2532751091716;736.4660621049696;847.9448835825775;1061.8991195836384;19321.51696207606;20281;20339.288124915558;20579;20833.270835520987;904.3172404834439;919.9218066464292;944.7826999790087;957.5403806173076;1038.4184856480395;10349.430781307101;10542.632567922592;10887.668497254119;11000.332831602118;11091.83362249567;493499;511138;560723;582483;586489;136353.6364636341;140228;140534;141119;144456;1000.7248006798188;1037.968860934173;1053.2521909444226;1056.039004505896;1059.1209296284067;17303.480895573153;17532.737008945132;17590.38433654816;17641.911790440965;17866.374676886247;51050.23424648559;52295.738521308675;52414.737926310125;52892.73553632207;53099.46900530945;69804.30195697978;70115.64942175256;70597.64701176461;72079;75441.62279188569;6989.965050174716;7365.7790266292095;7404;7528.322450979438;7571.242875712384;10821;12106.939465302617;12610.05424593141;12686.99053477077;13197.34013299312;10981.670549883516;11025.546389490271;11187.80056312747;11206.831897521706;11230.775384492428;10902.400367979837;10994.28537145083;11074.612388566362;11234.101271898066;11441.913018263253;10807.135429165804;11253.66239012831;11577.536898523964;11590.536378544764;11613.825792612948;6116.5718399711595;7487.625618719151;7552.66013029404;7573.734919277799;7635.160132385544;10859.619913302997;11028.889711102785;11154.330740155292;11250;11440.542378304775 06:19:37 INFO - PROCESS | 1660 | |3;mootools.html;1395.0234835615058;1586.2306781211112;1594.4977332140375;1842.7604411426512;1979.237993372552;6987.266337034608;7919.643616037278;8396.83206335873;8890.155435233642;8904.332175086878;8475.364347673918;8742.606582703778;8742.737717868475;8744.91255087449;8757.43076700014;2187.3000639795273;2384.3443053160345;2471.4439251168524;2479.590867506859;2507.7868381187623;2514.006967247945;2537.2388283514965;2539.174768200333;2539.568273393518;2542.275451496324;2184.9235276765316;2216.911323547064;2504.9749502505015;2505.6366826810195;2505.799536037113;2156.795104465073;2242.383344580245;2388.6775285336603;2468.271859801363;2469.5060987802512;2410.5660981023407;2425.1511970810075;2434.0385547708556;2436.415260337524;2440.694913135858;8746.431481953716;8791.384603077788;8797.29621630268;8823.250023747989;8823.955880220621;4342.348647702838;5121.923171152435;5359.383670877821;5403.5136837684795;5449.209864569615;3523.312953973976;3557.3063252665743;3594.6764791168657;3623.4564815277654;3626.8911932642063;1036.2694300518192;1042.6611351310855;1044.3629386074488;1055.5566662001902;1058.222206678091;11639.476223569874;11671.1830171888;11713.180077394585;11714.004309633692;11757.529698812037;4686.984596623416;4832;4843.244100890963;4921.557059864558;4945.332380128709;8047.396445266629;8670.609822557873;10029.849552256723;10053.145482633912;10087.848682269772;5406.567474602022;5411.080116380225;5465.9726701366235;5472.890542189134;5479.123340265538;4436.223660859337;4597.885052873638;4826.58973987215;4969.428515720666;4971.65198436106;4010.3583426651594;4045.37296719009;4142.813573389144;4147.875563733093;4203.684723645678;1340.483913693235;1370.9040367174202;1371.5748118083427;1374.7456720506539;1382.4608402722947;790.8971833661587;813.3086876155221;827.3009307135461;904.3985749476656;956.53129966316;5357.892842143136;5559.221708960748;5786.681732504752;5805.129230615442;5912.113183022581;872.8516152254132;1002.4737013068197;1010.4139599032543;1036.1710631494775;1036.2797855490512;3703.666669999659;3790.7915064671156;3798.3542797724454;3869.2261547690014;3895.7857317847224;10492.317999330018;10746.785064298827;10859.674209773719;10879.782404351869;10922.453877306261;10805.729856753487;10827.566897324177;10855.945720271347;10857.51141198648;10997.285176463503;7761.185075567097;8129.065157506962;8134.186581341818;8174;8324;5661.85845353853;5793.0786588653;5857;5874.882502349844;5952.434518720715;7810.531368117704;9697.272704547046;9827.213822894008;9882.654107106217;9975.102240798364;9990.450525221182;10214.029667181605;10356.741081472723;10380.740481488023;10391.58433662645;6797.1163748714325;7255.746048888263;7462.589557574385;7545;7612.352949999312;8412.284955778583;8423.410361274651;8482.024567174854;8502.489850608736;8504.149585041447;7028.718851246097;7127.358537731629;7139.107611548557;7231.63841807918;7280.526765760209;7124.430045596444;7276.818079548054;7307.7807665770115;7331.816704582428;7460.813479663052;6767.729290828312;6850.691718872762;6861.4853885957755;6862.176538815374;6868.656567171522;4713.6936099153445;4793.304970779287;4822.156122678587;4881.804727810848;5010.599152067899;4779.856604301876;4817.325574419514;4836.685615434985;4950.430700469348;5040.16837221869 06:19:37 INFO - PROCESS | 1660 | |4;prototype.html;319.46330165322263;321.64940215165467;330.15480370252146;332.2408297041261;335.3293413173653;5990.311114221866;6085.482733967612;6085.634861908283;6105.816825495232;6125.264968203822;4940.51784464661;5974.283086029683;5984.3716409777;6012.188354572131;6024.789132380368;3757.380032294668;4123.917521649565;4409.735415875041;4425.579569940851;4464;4409.845655402061;4433.379326894237;4464;4482.327650852382;4497.482789479219;4247.25673007224;4491.820327186909;4497.550244975492;4500.234960056799;4508.143452743984;4193.728891464647;4201.4538110045805;4490.461144662661;4504.36938828561;4547.408836851221;3828.483154774098;3857.286402015608;3872.186840763443;3877.3408520551575;3899.3760998240145;5733.340665823442;5754.568407369422;5758.337791153987;5772.393898640625;5780.84383123377;4330.480342358906;4865.975670121662;5215.58275337972;5279.76241069149;5345.33183352081;5024.547790698854;5626.971865140648;5991.831592839398;6346.492280617539;6364.681765911686;3698.8890333290046;4320.65434765218;4343.956560434387;4347.956520434786;4359.346098085281;4960.950390496085;6280.937190628127;6568.0147977803235;6633.104530888365;6657.667116644148;3765.981170094187;4365.170617582713;4371.519132895379;4376.277914144131;4391.407160033418;4217.505042234924;4428.158649856517;4433.202023635777;4434.268345722984;4448.266036104072;5168.767405466763;5168.870778230499;5175.81884634036;5185.948140518622;5244.842654720364;6205.875882482325;6288.496920246369;6288.874222515524;6357.364263573698;6405.743770249231;1341.4567100324384;1473.992630036843;1549.7059954937529;1555.3234343060578;1564.5228205397236;888.4358432395346;954.5752140297501;971.2715463402449;1001.5643195209962;1016.506994107857;5106.540411362921;5481.588880833953;5510.194909287027;5827.7668893244645;5982;5170.974145129326;6561.507886908501;6644.202695676453;6657.73369065232;6688.933110668831;5683.772649094072;5938.524918006549;5982.40175982407;5998.870401007667;6007.909881351783;2996.7902246842514;3109.30040740836;3448.2069124101095;3494.8427320770625;3498.4985735199452;5762.971185144047;6513.446357059608;6866.656667166621;6918.437004942459;6935.549189302679;5770.855728606818;6791.626460544718;6798.320167983261;6817.659117044128;6827.726890924407;5123.6157288202785;6145.726081349929;6259.78090766821;6443.645599491979;6899.344562266577;6090.725917333819;6616.801495955129;6620.337966203341;6654.933450665431;6658.201015878126;6217.098520714561;6335.841603959938;6516.022596610546;6541.149650545399;6543.378379053982;5194.3766747990485;5779.682117483579;6410.423061924263;6680.866382672222;6911.447084233148;3862.6909847211596;4273.358996150602;4283.271843786626;4287.485501739811;4294.6564274858565;6403.903941440975;6570.277269500447;6665.800025999228;6666.633335166613;6692.59844409337;6414.93585064162;6460.3862633049785;6460.515461340325;6462.870742585216;6521.7065232065615;6353.205849268841;6378.3621637837705;6378.681065946591;6396.584222025554;6434.613923164625;5922.674252916131;5945.34601193877;6007.7596896125415;6016;6264.248290205022;5397.028534863763;5850.736716847837;6391.58454700443;6411.807645770635;6421.903671445026;5006.4743201963265;5432.755526001419;5945.751392207512;6260.906086408799;6268.185135932482 06:19:37 INFO - PROCESS | 1660 | |5;yui.html;656.8160914943816;668.91304130463;680.8876535371664;727.3453891497653;746.1605693594706;13645.044846860723;15112.244387780622;15126.470573529929;15164.696706065886;15189.54431367058;13726.794098088536;13737.58787236382;13802;13858.02993790435;14075.155490670568;931.1340453378373;948.5968463403061;951.3007939164709;952.7094236257939;953.5470651440579;916.3356566489308;931.3108299858123;933.6918816790477;934.700895713372;936.8688383626297;978.7063880835757;984.7341217871207;985.4087547471531;986.1666891476691;988.4316518002141;971.7424882406168;973.7614284500272;975.3075316525241;976.5507866381438;978.3787295067648;730.7223255163058;730.7296300368845;730.7807657702668;731.4002517935295;732.1068296678044;12545.372731363486;12603.117781755282;12663.683407914783;13162.802557961639;13857.722845543134;12097.274163550128;12160.695982600506;12250.571230006906;12473.688157796038;13028.153170043917;9596.856047159297;10030.99690030991;10090.142337901214;10162.18702503798;10312.89687103127;3414.709749671281;3434.639362866888;3473.3747925373423;3478.113081164312;3575.606683264839;73853.63073184654;75750.24249757487;76347;85934;87321.56339218326;9314.90685093154;9411.576479058458;9491.288153388523;9755.707328780149;9813.950930245303;20833.374998750063;20840.791592083886;20862.687059694115;20904.163833446797;20923.16307347689;7186.389156921616;7349.889751653729;7371.520851144658;7379.225181355988;7459.515131516542;3958.6437220649705;4023;4025.2754504188943;4127.731697439657;4136.73111247768;3414.214730611973;3517.876874309387;3518.1908161123083;3518.5601799775027;3522.277933023724;629.5813284165978;645.3417514135556;645.7546132469631;646.6217262901256;650.7494614573424;488.6481733152196;573.9569532285012;594.1859652276408;603.9909401358983;610.7923306075955;7782.186400091593;7877.660797664411;8104.554249516215;8152.2662960333855;8390.03514595817;544.4337888595895;564.5646242613741;586.7682265505101;597.9342272350038;598.790423351832;3796.7342286040266;3828.5405751310022;3832.156925476391;3833.5399752029375;3996.480457540501;80355.59822200969;84530.5773471141;84927;86942;90968;71810.9228361575;72477.2752272481;73431.2656873435;74196;75088.12279692943;64500.67749661222;65928.67035664791;66614.66692666506;66676;67938;7359.963200183965;7548;7564.167941526538;7742.38060955111;7971.960140199262;30217;35730.57077716862;37737.05657358588;38959.83120506389;41345;55340.72329638326;57323.14015289857;58628;59007.70496147664;63712.681436592524;10384.688459346231;10603.787924241318;10768.730781730519;10804.837927431252;11106.61126860556;11708.941455292668;11742.823857641972;11782.52869885195;12700.269442069999;12708;11223.214374993671;11306;11697.649070527897;11902.40487975615;12275.263484190977;11220.943895280472;11224.887751122711;11552.537898483966;11612.535498579962;11727.648170554898;11123.777524449304;11289.04043156308;11534.192606517463;11595.188336816342;11596.710082247673;8590.484570925764;8730.69039644033;9688.048226541574;9692.321537492307;9920.751981200528;9019.954900225457;9053.366264361432;9068.410553314014;9535.761605959906;9601.903980960102 06:19:37 INFO - PROCESS | 1660 | __end_tp_report 06:19:37 INFO - PROCESS | 1660 | __start_cc_report 06:19:37 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1668 06:19:37 INFO - PROCESS | 1660 | __end_cc_report 06:19:37 INFO - PROCESS | 1660 | __startTimestamp1461071977071__endTimestamp 06:19:37 INFO - PROCESS | 1660 | 06:19:37 INFO - PROCESS | 1660 | ------- Summary: start ------- 06:19:37 INFO - PROCESS | 1660 | Number of tests: 6 06:19:37 INFO - PROCESS | 1660 | 06:19:37 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5744.34 Median:5977.73 stddev:616.81 (10.3%) stddev-sans-first:591.64 06:19:37 INFO - PROCESS | 1660 | Values: 3440.9 3493.1 3523.7 3546.8 3559.4 5690.0 5764.0 5810.3 5836.7 5858.4 5785.3 5825.5 5852.0 5971.4 5975.9 5112.5 5166.6 5185.2 5198.5 5315.5 5287.6 5305.4 5332.1 5347.3 5382.4 5141.3 5164.6 5178.5 5229.2 5288.7 5223.6 5225.2 5243.9 5252.1 5257.6 5179.9 5221.8 5231.6 5245.4 5269.7 5587.7 5624.0 5670.7 5692.9 5797.7 6108.5 6127.8 6138.5 6147.1 6170.1 6164.4 6179.8 6182.2 6195.3 6198.5 5752.9 5850.2 5855.5 5860.5 5865.5 6139.6 6144.7 6154.2 6219.3 6225.0 6104.9 6158.1 6164.1 6192.0 6207.7 6094.6 6171.5 6192.2 6199.0 6223.2 6093.1 6138.3 6147.8 6202.6 6276.7 6210.4 6222.5 6235.3 6243.2 6250.5 4899.3 4948.3 4963.4 4973.7 5005.9 4297.4 4315.8 4490.2 4498.5 4523.2 4744.6 5705.9 5737.7 5784.1 5803.1 6211.4 6218.2 6225.6 6236.0 6265.0 5587.9 5703.7 5707.4 5717.3 5803.5 5064.6 5408.4 5413.9 5426.8 5460.8 6264.4 6309.4 6318.1 6345.6 6346.5 6134.5 6158.5 6230.1 6230.3 6232.7 4947.0 6162.0 6308.8 6312.7 6387.9 6126.2 6220.4 6227.3 6240.4 6254.1 6112.1 6129.7 6149.3 6166.8 6243.8 5934.1 6132.3 6143.6 6148.3 6151.9 6125.5 6142.9 6144.9 6150.7 6163.8 5810.7 5974.0 6029.8 6031.3 6033.8 6047.4 6091.5 6093.1 6101.6 6105.1 5961.0 5968.6 5973.0 5977.7 5978.5 06:19:37 INFO - PROCESS | 1660 | 06:19:37 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:60383.67 Median:3407.68 stddev:131294.27 (3852.9%) stddev-sans-first:131585.67 06:19:37 INFO - PROCESS | 1660 | Values: 526.8 535.2 548.1 589.2 621.2 29238.9 30730.7 31347.0 31377.4 38584.0 41305.4 41825.8 41827.0 41994.0 42029.8 9310.8 9547.8 9550.7 9553.7 9554.5 8359.0 8730.3 9361.2 11326.5 11659.0 11192.6 11310.7 11316.3 11321.4 11337.7 8381.0 11327.4 11420.9 11427.5 11439.7 11187.9 11521.5 11528.8 11539.5 11555.7 38175.4 38838.8 38920.4 38998.6 39053.0 3069.6 3122.0 3169.7 3231.0 3406.0 27890.7 28071.7 28304.9 28458.7 28649.6 2674.2 2719.1 2727.3 2735.6 2799.8 359226.0 359317.0 360290.2 360646.0 361271.0 35085.6 51552.7 62335.0 62680.7 62839.0 34978.7 35160.0 35178.5 35199.1 35219.3 14808.7 15290.9 15298.7 15303.8 15321.2 11943.9 12183.1 12752.9 12802.6 12815.0 7901.2 8045.7 8073.8 8134.0 8140.5 3380.6 3409.4 3414.9 3422.4 3446.2 1012.2 1033.6 1045.9 1059.2 1070.2 27458.2 29712.3 29921.4 30429.0 30574.1 1084.8 1096.4 1172.0 1192.6 1192.6 15322.5 15410.5 15419.3 15479.7 15853.9 646171.0 646348.2 654354.0 655368.0 656156.0 50487.0 60511.7 61153.0 61360.1 61469.0 1335.5 1458.3 1505.0 1507.9 1513.3 28568.0 29399.4 29588.0 29987.0 30277.7 48918.0 49372.3 49789.8 49829.3 49888.3 406573.0 409322.0 409394.0 409566.0 409971.0 23155.9 26108.0 26742.7 26798.1 27170.7 43143.8 43267.1 43731.3 44172.6 44266.3 34569.0 35876.3 36330.6 36637.7 36642.0 35261.6 35408.3 35527.3 36173.8 36190.8 36938.3 37020.6 37532.8 37733.0 37932.8 31389.4 33212.3 33280.3 33366.3 33392.8 23985.6 24209.2 24459.4 25002.5 25021.9 06:19:37 INFO - PROCESS | 1660 | 06:19:37 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:33417.31 Median:21120.47 stddev:92388.26 (437.4%) stddev-sans-first:92614.04 06:19:37 INFO - PROCESS | 1660 | Values: 336.4 394.7 400.0 407.9 419.1 18556.4 20598.1 21216.4 21543.9 21548.6 19996.1 20881.9 20937.1 21024.6 21360.0 5135.6 5746.1 5931.8 5932.3 5949.1 5724.9 5847.1 5857.1 5896.6 5907.6 5689.8 5846.6 5850.0 5857.7 5858.4 5657.9 5704.1 5825.8 5842.9 5846.7 5049.7 5088.4 5095.3 5100.8 5101.1 12725.4 13395.9 13410.2 13453.7 25193.7 1995.4 2019.3 2145.3 2234.5 2563.9 9640.2 9937.3 10108.4 10126.1 10278.6 1662.4 1728.6 1735.0 1775.8 1782.3 111244.4 118552.0 121153.5 121395.0 121622.0 9934.1 10895.2 11530.9 11597.8 11647.0 14966.9 15085.9 15086.4 15092.3 15114.2 8464.3 8667.2 8675.7 8751.3 8808.4 8467.6 8476.1 8508.8 8592.8 8602.7 4442.9 4565.9 4610.8 4621.7 4636.7 1927.8 1965.2 1981.1 1988.3 2022.9 723.0 723.3 736.5 847.9 1061.9 19321.5 20281.0 20339.3 20579.0 20833.3 904.3 919.9 944.8 957.5 1038.4 10349.4 10542.6 10887.7 11000.3 11091.8 493499.0 511138.0 560723.0 582483.0 586489.0 136353.6 140228.0 140534.0 141119.0 144456.0 1000.7 1038.0 1053.3 1056.0 1059.1 17303.5 17532.7 17590.4 17641.9 17866.4 51050.2 52295.7 52414.7 52892.7 53099.5 69804.3 70115.6 70597.6 72079.0 75441.6 6990.0 7365.8 7404.0 7528.3 7571.2 10821.0 12106.9 12610.1 12687.0 13197.3 10981.7 11025.5 11187.8 11206.8 11230.8 10902.4 10994.3 11074.6 11234.1 11441.9 10807.1 11253.7 11577.5 11590.5 11613.8 6116.6 7487.6 7552.7 7573.7 7635.2 10859.6 11028.9 11154.3 11250.0 11440.5 06:19:37 INFO - PROCESS | 1660 | 06:19:37 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5675.78 Median:4829.29 stddev:3154.99 (65.3%) stddev-sans-first:3147.44 06:19:37 INFO - PROCESS | 1660 | Values: 1395.0 1586.2 1594.5 1842.8 1979.2 6987.3 7919.6 8396.8 8890.2 8904.3 8475.4 8742.6 8742.7 8744.9 8757.4 2187.3 2384.3 2471.4 2479.6 2507.8 2514.0 2537.2 2539.2 2539.6 2542.3 2184.9 2216.9 2505.0 2505.6 2505.8 2156.8 2242.4 2388.7 2468.3 2469.5 2410.6 2425.2 2434.0 2436.4 2440.7 8746.4 8791.4 8797.3 8823.3 8824.0 4342.3 5121.9 5359.4 5403.5 5449.2 3523.3 3557.3 3594.7 3623.5 3626.9 1036.3 1042.7 1044.4 1055.6 1058.2 11639.5 11671.2 11713.2 11714.0 11757.5 4687.0 4832.0 4843.2 4921.6 4945.3 8047.4 8670.6 10029.8 10053.1 10087.8 5406.6 5411.1 5466.0 5472.9 5479.1 4436.2 4597.9 4826.6 4969.4 4971.7 4010.4 4045.4 4142.8 4147.9 4203.7 1340.5 1370.9 1371.6 1374.7 1382.5 790.9 813.3 827.3 904.4 956.5 5357.9 5559.2 5786.7 5805.1 5912.1 872.9 1002.5 1010.4 1036.2 1036.3 3703.7 3790.8 3798.4 3869.2 3895.8 10492.3 10746.8 10859.7 10879.8 10922.5 10805.7 10827.6 10855.9 10857.5 10997.3 7761.2 8129.1 8134.2 8174.0 8324.0 5661.9 5793.1 5857.0 5874.9 5952.4 7810.5 9697.3 9827.2 9882.7 9975.1 9990.5 10214.0 10356.7 10380.7 10391.6 6797.1 7255.7 7462.6 7545.0 7612.4 8412.3 8423.4 8482.0 8502.5 8504.1 7028.7 7127.4 7139.1 7231.6 7280.5 7124.4 7276.8 7307.8 7331.8 7460.8 6767.7 6850.7 6861.5 6862.2 6868.7 4713.7 4793.3 4822.2 4881.8 5010.6 4779.9 4817.3 4836.7 4950.4 5040.2 06:19:37 INFO - PROCESS | 1660 | 06:19:37 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5125.54 Median:5771.62 stddev:1605.18 (27.8%) stddev-sans-first:1568.62 06:19:37 INFO - PROCESS | 1660 | Values: 319.5 321.6 330.2 332.2 335.3 5990.3 6085.5 6085.6 6105.8 6125.3 4940.5 5974.3 5984.4 6012.2 6024.8 3757.4 4123.9 4409.7 4425.6 4464.0 4409.8 4433.4 4464.0 4482.3 4497.5 4247.3 4491.8 4497.6 4500.2 4508.1 4193.7 4201.5 4490.5 4504.4 4547.4 3828.5 3857.3 3872.2 3877.3 3899.4 5733.3 5754.6 5758.3 5772.4 5780.8 4330.5 4866.0 5215.6 5279.8 5345.3 5024.5 5627.0 5991.8 6346.5 6364.7 3698.9 4320.7 4344.0 4348.0 4359.3 4961.0 6280.9 6568.0 6633.1 6657.7 3766.0 4365.2 4371.5 4376.3 4391.4 4217.5 4428.2 4433.2 4434.3 4448.3 5168.8 5168.9 5175.8 5185.9 5244.8 6205.9 6288.5 6288.9 6357.4 6405.7 1341.5 1474.0 1549.7 1555.3 1564.5 888.4 954.6 971.3 1001.6 1016.5 5106.5 5481.6 5510.2 5827.8 5982.0 5171.0 6561.5 6644.2 6657.7 6688.9 5683.8 5938.5 5982.4 5998.9 6007.9 2996.8 3109.3 3448.2 3494.8 3498.5 5763.0 6513.4 6866.7 6918.4 6935.5 5770.9 6791.6 6798.3 6817.7 6827.7 5123.6 6145.7 6259.8 6443.6 6899.3 6090.7 6616.8 6620.3 6654.9 6658.2 6217.1 6335.8 6516.0 6541.1 6543.4 5194.4 5779.7 6410.4 6680.9 6911.4 3862.7 4273.4 4283.3 4287.5 4294.7 6403.9 6570.3 6665.8 6666.6 6692.6 6414.9 6460.4 6460.5 6462.9 6521.7 6353.2 6378.4 6378.7 6396.6 6434.6 5922.7 5945.3 6007.8 6016.0 6264.2 5397.0 5850.7 6391.6 6411.8 6421.9 5006.5 5432.8 5945.8 6260.9 6268.2 06:19:37 INFO - PROCESS | 1660 | 06:19:37 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:17118.26 Median:601.39 stddev:23781.10 (3954.4%) stddev-sans-first:23815.69 06:19:37 INFO - PROCESS | 1660 | Values: 656.8 668.9 680.9 727.3 746.2 13645.0 15112.2 15126.5 15164.7 15189.5 13726.8 13737.6 13802.0 13858.0 14075.2 931.1 948.6 951.3 952.7 953.5 916.3 931.3 933.7 934.7 936.9 978.7 984.7 985.4 986.2 988.4 971.7 973.8 975.3 976.6 978.4 730.7 730.7 730.8 731.4 732.1 12545.4 12603.1 12663.7 13162.8 13857.7 12097.3 12160.7 12250.6 12473.7 13028.2 9596.9 10031.0 10090.1 10162.2 10312.9 3414.7 3434.6 3473.4 3478.1 3575.6 73853.6 75750.2 76347.0 85934.0 87321.6 9314.9 9411.6 9491.3 9755.7 9814.0 20833.4 20840.8 20862.7 20904.2 20923.2 7186.4 7349.9 7371.5 7379.2 7459.5 3958.6 4023.0 4025.3 4127.7 4136.7 3414.2 3517.9 3518.2 3518.6 3522.3 629.6 645.3 645.8 646.6 650.7 488.6 574.0 594.2 604.0 610.8 7782.2 7877.7 8104.6 8152.3 8390.0 544.4 564.6 586.8 597.9 598.8 3796.7 3828.5 3832.2 3833.5 3996.5 80355.6 84530.6 84927.0 86942.0 90968.0 71810.9 72477.3 73431.3 74196.0 75088.1 64500.7 65928.7 66614.7 66676.0 67938.0 7360.0 7548.0 7564.2 7742.4 7972.0 30217.0 35730.6 37737.1 38959.8 41345.0 55340.7 57323.1 58628.0 59007.7 63712.7 10384.7 10603.8 10768.7 10804.8 11106.6 11708.9 11742.8 11782.5 12700.3 12708.0 11223.2 11306.0 11697.6 11902.4 12275.3 11220.9 11224.9 11552.5 11612.5 11727.6 11123.8 11289.0 11534.2 11595.2 11596.7 8590.5 8730.7 9688.0 9692.3 9920.8 9020.0 9053.4 9068.4 9535.8 9601.9 06:19:37 INFO - PROCESS | 1660 | -------- Summary: end -------- 06:19:37 INFO - PROCESS | 1660 | 06:19:37 INFO - TEST-INFO | 1660: exit 0 06:19:37 INFO - TEST-OK | dromaeo_css | took 1114253ms 06:19:37 INFO - TEST-START | kraken 06:19:37 INFO - operating with platform_type : mac_ 06:19:37 INFO - Initialising browser for kraken test... 06:19:37 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmptMYOug/profile http://localhost:49276/getInfo.html) 06:19:40 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 06:19:40 INFO - PROCESS | 1670 | colorDepth:24 06:19:40 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 06:19:40 INFO - PROCESS | 1670 | __metrics 06:19:40 INFO - PROCESS | 1670 | 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:19:40 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:19:40 INFO - TEST-INFO | 1670: exit 0 06:19:40 INFO - Browser initialized. 06:19:40 INFO - Running cycle 1/1 for kraken test... 06:19:40 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmptMYOug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:52 INFO - PROCESS | 1672 | RSS: Main: 237514752 06:19:52 INFO - PROCESS | 1672 | 06:19:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:56 INFO - PROCESS | 1672 | RSS: Main: 285708288 06:19:56 INFO - PROCESS | 1672 | 06:19:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 06:19:59 INFO - PROCESS | 1672 | RSS: Main: 299020288 06:19:59 INFO - PROCESS | 1672 | 06:20:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 06:20:03 INFO - PROCESS | 1672 | RSS: Main: 383983616 06:20:03 INFO - PROCESS | 1672 | 06:20:05 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 06:20:06 INFO - PROCESS | 1672 | RSS: Main: 286433280 06:20:06 INFO - PROCESS | 1672 | 06:20:08 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:09 INFO - PROCESS | 1672 | RSS: Main: 290631680 06:20:09 INFO - PROCESS | 1672 | 06:20:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:12 INFO - PROCESS | 1672 | RSS: Main: 328802304 06:20:12 INFO - PROCESS | 1672 | 06:20:15 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:15 INFO - PROCESS | 1672 | RSS: Main: 329584640 06:20:15 INFO - PROCESS | 1672 | 06:20:18 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 06:20:19 INFO - PROCESS | 1672 | RSS: Main: 326623232 06:20:19 INFO - PROCESS | 1672 | 06:20:20 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:21 INFO - PROCESS | 1672 | RSS: Main: 319901696 06:20:21 INFO - PROCESS | 1672 | 06:20:23 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:24 INFO - PROCESS | 1672 | RSS: Main: 326733824 06:20:24 INFO - PROCESS | 1672 | 06:20:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:26 INFO - PROCESS | 1672 | RSS: Main: 329605120 06:20:26 INFO - PROCESS | 1672 | 06:20:29 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:30 INFO - PROCESS | 1672 | RSS: Main: 334340096 06:20:30 INFO - PROCESS | 1672 | 06:20:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:33 INFO - PROCESS | 1672 | RSS: Main: 332046336 06:20:33 INFO - PROCESS | 1672 | 06:20:35 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 06:20:36 INFO - PROCESS | 1672 | RSS: Main: 396914688 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | __start_tp_report 06:20:36 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 06:20:36 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 06:20:36 INFO - PROCESS | 1672 | |i|pagename|runs| 06:20:36 INFO - PROCESS | 1672 | |0;ai-astar;112;109;111;114;112;113;118;112;111;112 06:20:36 INFO - PROCESS | 1672 | |1;audio-beat-detection;155;121;143;172;120;145;143;128;207;149 06:20:36 INFO - PROCESS | 1672 | |2;audio-dft;185;188;185;184;186;182;183;185;182;184 06:20:36 INFO - PROCESS | 1672 | |3;audio-fft;71;76;84;89;56;56;62;67;88;72 06:20:36 INFO - PROCESS | 1672 | |4;audio-oscillator;93;99;137;78;77;82;119;77;71;124 06:20:36 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;85;87;84;85;84;88;84;90;85 06:20:36 INFO - PROCESS | 1672 | |6;imaging-darkroom;92;92;98;92;92;92;127;93;125;147 06:20:36 INFO - PROCESS | 1672 | |7;imaging-desaturate;87;85;84;84;85;85;86;86;86;85 06:20:36 INFO - PROCESS | 1672 | |8;json-parse-financial;57;60;59;58;58;58;58;75;59;57 06:20:36 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;61;63;78;73;70;68;67;66;67;66 06:20:36 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;82;83;95;103;104;81;81;81;82;82 06:20:36 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;140;162;159;141;145;121;148;152;196;145 06:20:36 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;169;187;229;170;167;170;165;170;168;169 06:20:36 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;69;74;85;94;96;93;68;70;67;68 06:20:36 INFO - PROCESS | 1672 | __end_tp_report 06:20:36 INFO - PROCESS | 1672 | __start_cc_report 06:20:36 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,2033 06:20:36 INFO - PROCESS | 1672 | __end_cc_report 06:20:36 INFO - PROCESS | 1672 | __startTimestamp1461072036095__endTimestamp 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | ------- Summary: start ------- 06:20:36 INFO - PROCESS | 1672 | Number of tests: 14 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:2.37 (2.1%) stddev-sans-first:2.51 06:20:36 INFO - PROCESS | 1672 | Values: 112.0 109.0 111.0 114.0 112.0 113.0 118.0 112.0 111.0 112.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:147.00 stddev:25.99 (17.7%) stddev-sans-first:27.45 06:20:36 INFO - PROCESS | 1672 | Values: 155.0 121.0 143.0 172.0 120.0 145.0 143.0 128.0 207.0 149.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.84 (1.0%) stddev-sans-first:1.94 06:20:36 INFO - PROCESS | 1672 | Values: 185.0 188.0 185.0 184.0 186.0 182.0 183.0 185.0 182.0 184.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:72.10 Median:74.00 stddev:12.22 (16.5%) stddev-sans-first:12.95 06:20:36 INFO - PROCESS | 1672 | Values: 71.0 76.0 84.0 89.0 56.0 56.0 62.0 67.0 88.0 72.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:77.50 stddev:23.28 (30.0%) stddev-sans-first:24.67 06:20:36 INFO - PROCESS | 1672 | Values: 93.0 99.0 137.0 78.0 77.0 82.0 119.0 77.0 71.0 124.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.00 stddev:2.11 (2.5%) stddev-sans-first:2.11 06:20:36 INFO - PROCESS | 1672 | Values: 88.0 85.0 87.0 84.0 85.0 84.0 88.0 84.0 90.0 85.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:92.00 stddev:20.24 (22.0%) stddev-sans-first:20.91 06:20:36 INFO - PROCESS | 1672 | Values: 92.0 92.0 98.0 92.0 92.0 92.0 127.0 93.0 125.0 147.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:0.95 (1.1%) stddev-sans-first:0.78 06:20:36 INFO - PROCESS | 1672 | Values: 87.0 85.0 84.0 84.0 85.0 85.0 86.0 86.0 86.0 85.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:58.50 stddev:5.38 (9.2%) stddev-sans-first:5.61 06:20:36 INFO - PROCESS | 1672 | Values: 57.0 60.0 59.0 58.0 58.0 58.0 58.0 75.0 59.0 57.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.50 stddev:4.86 (7.2%) stddev-sans-first:4.47 06:20:36 INFO - PROCESS | 1672 | Values: 61.0 63.0 78.0 73.0 70.0 68.0 67.0 66.0 67.0 66.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:82.00 stddev:9.47 (11.5%) stddev-sans-first:9.84 06:20:36 INFO - PROCESS | 1672 | Values: 82.0 83.0 95.0 103.0 104.0 81.0 81.0 81.0 82.0 82.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:150.00 stddev:19.47 (13.0%) stddev-sans-first:20.25 06:20:36 INFO - PROCESS | 1672 | Values: 140.0 162.0 159.0 141.0 145.0 121.0 148.0 152.0 196.0 145.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:170.00 stddev:19.44 (11.4%) stddev-sans-first:20.43 06:20:36 INFO - PROCESS | 1672 | Values: 169.0 187.0 229.0 170.0 167.0 170.0 165.0 170.0 168.0 169.0 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.40 Median:79.50 stddev:12.18 (15.3%) stddev-sans-first:12.43 06:20:36 INFO - PROCESS | 1672 | Values: 69.0 74.0 85.0 94.0 96.0 93.0 68.0 70.0 67.0 68.0 06:20:36 INFO - PROCESS | 1672 | -------- Summary: end -------- 06:20:36 INFO - PROCESS | 1672 | 06:20:36 INFO - TEST-INFO | 1672: exit 0 06:20:36 INFO - TEST-OK | kraken | took 59103ms 06:20:36 INFO - SUITE-END | took 1173s 06:20:37 INFO - Completed test suite (00:19:33) 06:20:37 INFO - javascript benchmark 06:20:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3440.9311813763725, 3493.126718320418, 3523.665251801078, 3546.8472746357434, 3559.377109005923, 5689.971550142243, 5764.020116580181, 5810.273715785522, 5836.737346819393, 5858.443447872451, 5785.27684039495, 5825.533957283418, 5852.034414321632, 5971.432713892184, 5975.9402405975925, 5112.488751124895, 5166.612504062192, 5185.222216667511, 5198.45416231296, 5315.521603055724, 5287.603429742785, 5305.3898801637915, 5332.14685650296, 5347.25138480613, 5382.381026181981, 5141.30592370029, 5164.612654050961, 5178.533931946143, 5229.241759944786, 5288.709120998344, 5223.608229382773, 5225.190095535198, 5243.9213411798855, 5252.054630166568, 5257.579393648499, 5179.896402071938, 5221.817236396708, 5231.581473482112, 5245.449227831099, 5269.710165940872, 5587.692676902769, 5624.0, 5670.659760414388, 5692.886142277172, 5797.73910174039, 6108.511319094462, 6127.84680382994, 6138.47822935051, 6147.077938309245, 6170.105334726484, 6164.4143806338325, 6179.752809887599, 6182.227221597301, 6195.28754193269, 6198.504119670415, 5752.856178595569, 5850.239468869105, 5855.502282306009, 5860.501857342131, 5865.501432378295, 6139.631622102688, 6144.692765361714, 6154.230721159855, 6219.253689557282, 6225.00399936008, 6104.938950610526, 6158.137860699506, 6164.106204600397, 6192.0, 6207.6585787782105, 6094.603850749687, 6171.475424588871, 6192.195014648067, 6199.039148931923, 6223.190985171898, 6093.055576385667, 6138.296437970319, 6147.815565533041, 6202.627842329474, 6276.686165691697, 6210.4410603045035, 6222.502199824004, 6235.251769787655, 6243.188385509855, 6250.531210159256, 4899.265110233494, 4948.307236986825, 4963.379577552806, 4973.726445045485, 5005.89988200234, 4297.419848320499, 4315.8489452869, 4490.169318676056, 4498.482674492475, 4523.185826551252, 4744.572988431058, 5705.914411283751, 5737.655740655574, 5784.132380142928, 5803.100519419497, 6211.409916057967, 6218.19163508741, 6225.62646241227, 6236.0, 6264.968675156595, 5587.860303492445, 5703.7148142592705, 5707.3721890592005, 5717.313922329347, 5803.47768700819, 5064.594832413398, 5408.378036525771, 5413.864653383697, 5426.782928682808, 5460.754266058037, 6264.373562643699, 6309.400606942333, 6318.115463835067, 6345.587536810277, 6346.492280617539, 6134.478569321479, 6158.476529494864, 6230.096635987847, 6230.252369715663, 6232.719527621177, 4947.0, 6162.044883043135, 6308.779192728232, 6312.7159277833525, 6387.904181437375, 6126.23422072241, 6220.409061139185, 6227.314995350598, 6240.438360547572, 6254.061890716429, 6112.077967281481, 6129.662868542095, 6149.323574406722, 6166.784162554289, 6243.7814676486105, 5934.109883517507, 6132.294322189991, 6143.631382117087, 6148.3236843948025, 6151.9384806151365, 6125.509959203342, 6142.938570614237, 6144.938550614436, 6150.723217455135, 6163.8150855474405, 5810.709464526842, 5973.970130149321, 6029.8191054268445, 6031.336552979256, 6033.818985430444, 6047.365026672136, 6091.543134265036, 6093.146959425595, 6101.572889897842, 6105.145279660762, 5960.97019514917, 5968.612040217372, 5972.970135149297, 5977.731002104829, 5978.491828194652], "value": 5707.300730342618, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.8340472751083, 535.189188379605, 548.0819627124565, 589.1780965553054, 621.1769405537664, 29238.853805730996, 30730.692693073062, 31347.0, 31377.372452550935, 38584.0, 41305.38041929373, 41825.7908710456, 41826.95432614186, 41994.0, 42029.7898510507, 9310.767230819216, 9547.80904381912, 9550.665726699566, 9553.665621703241, 9554.522273886312, 8359.038710548304, 8730.301575873946, 9361.20429763471, 11326.490307936163, 11659.0, 11192.608258710947, 11310.717232069183, 11316.264442811233, 11321.377324247163, 11337.659870203906, 8381.03618083922, 11327.433628318551, 11420.885791142066, 11427.48576314068, 11439.714007149887, 11187.944060279728, 11521.48153333102, 11528.76942461146, 11539.538418463335, 11555.711107222387, 38175.42736858922, 38838.805805971075, 38920.41619375712, 38998.61001390006, 39053.0, 3069.5856059432135, 3122.0, 3169.746420286395, 3230.9983904989526, 3405.9659403405894, 27890.721092789016, 28071.719282807117, 28304.867805287762, 28458.71541284602, 28649.57025644617, 2674.17100698784, 2719.1298784388805, 2727.3454370951026, 2735.589661550783, 2799.7900157488066, 359226.0, 359317.0, 360290.1985490082, 360646.0, 361271.0, 35085.64914350875, 51552.74223628933, 62335.0, 62680.686596566724, 62839.0, 34978.65021349805, 35160.0, 35178.47232291518, 35199.12002199965, 35219.295614087576, 14808.703825923421, 15290.92963492545, 15298.694026119638, 15303.770443443358, 15321.23393830304, 11943.925046745835, 12183.147179697513, 12752.936235318764, 12802.615921522369, 12815.0, 7901.249381308881, 8045.678172873137, 8073.798155046054, 8133.959330203311, 8140.511569305742, 3380.594328680525, 3409.3863104641405, 3414.8634054637537, 3422.401079811023, 3446.190145315849, 1012.2281933862583, 1033.62495734442, 1045.947702614866, 1059.2214722179192, 1070.2347821307646, 27458.17625471239, 29712.257193570334, 29921.40157196844, 30429.0, 30574.08277751671, 1084.7830433913248, 1096.413418820943, 1172.027217409548, 1192.5587532612988, 1192.6243233381458, 15322.540323790305, 15410.537683869501, 15419.306131224123, 15479.690406191814, 15853.890227684182, 646171.0, 646348.2191068551, 654354.0, 655368.0, 656156.0, 50487.0, 60511.69744151251, 61153.0, 61360.079598806056, 61469.0, 1335.5192130832893, 1458.2635768936832, 1505.0, 1507.9472218472301, 1513.28119143406, 28568.0001199957, 29399.412011760072, 29588.0, 29987.0, 30277.697223027488, 48918.0, 49372.259416109504, 49789.751051244515, 49829.252561212335, 49888.25167622561, 406573.0, 409322.0, 409394.0, 409566.0, 409971.0, 23155.884220578788, 26108.0, 26742.732572674024, 26798.114273430634, 27170.72829271761, 43143.78428107839, 43267.13465730731, 43731.34402983894, 44172.55827441684, 44266.3360049606, 34569.0, 35876.28247435089, 36330.636693632725, 36637.717679882146, 36642.0, 35261.64738352686, 35408.29183416266, 35527.289454211284, 36173.81913090418, 36190.8190459046, 36938.261234775695, 37020.629793701715, 37532.81233593814, 37733.0, 37932.81033594815, 31389.372212556078, 33212.335753284315, 33280.33439331152, 33366.332673346886, 33392.833035834665, 23985.640215396434, 24209.152679656127, 24459.38851528726, 25002.499950001264, 25021.874890626157], "value": 18311.091346612135, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.443186526299, 394.71383247145815, 400.0019950224191, 407.9143379890223, 419.05503090530846, 18556.443306700803, 20598.073086711098, 21216.36350909475, 21543.922803859805, 21548.56902861942, 19996.1001754921, 20881.895590522065, 20937.12663157313, 21024.57950840982, 21360.038798254078, 5135.563477104451, 5746.109353050273, 5931.834880268692, 5932.2584676915385, 5949.137375080611, 5724.885502289952, 5847.122931560279, 5857.092150716646, 5896.616719913192, 5907.556933230004, 5689.772409103631, 5846.64920104793, 5849.9707501462435, 5857.707114644272, 5858.355580886099, 5657.8585535361535, 5704.1443783432815, 5825.825225243249, 5842.948269311522, 5846.7076646167525, 5049.671771334852, 5088.389393272794, 5095.3376061112185, 5100.795968161269, 5101.132807422747, 12725.363731813371, 13395.86604133956, 13410.195388276734, 13453.730925381535, 25193.748062519324, 1995.3561530971376, 2019.2831544801531, 2145.259885339571, 2234.4637287051155, 2563.9230823075336, 9640.228781697517, 9937.304388692794, 10108.39349639024, 10126.139278161365, 10278.588856445733, 1662.3599914033064, 1728.6110625109375, 1734.9763639452658, 1775.7513948047283, 1782.3049010885766, 111244.44377778059, 118552.0, 121153.4904184101, 121395.0, 121622.0, 9934.105930466292, 10895.182861285435, 11530.942345288388, 11597.750414984053, 11647.0, 14966.850331496764, 15085.924570377078, 15086.396544138111, 15092.320845561977, 15114.244287785566, 8464.30713857231, 8667.219950204511, 8675.696350627697, 8751.299896008304, 8808.427452215585, 8467.618957146944, 8476.067632560413, 8508.829823403621, 8592.785180370542, 8602.741917742478, 4442.888927776831, 4565.931511027337, 4610.815567377334, 4621.6764826462495, 4636.675432719677, 1927.7686677598779, 1965.15498335717, 1981.0688976181173, 1988.33390814076, 2022.8645599321287, 723.0094770164802, 723.2532751091716, 736.4660621049696, 847.9448835825775, 1061.8991195836384, 19321.51696207606, 20281.0, 20339.288124915558, 20579.0, 20833.270835520987, 904.3172404834439, 919.9218066464292, 944.7826999790087, 957.5403806173076, 1038.4184856480395, 10349.430781307101, 10542.632567922592, 10887.668497254119, 11000.332831602118, 11091.83362249567, 493499.0, 511138.0, 560723.0, 582483.0, 586489.0, 136353.6364636341, 140228.0, 140534.0, 141119.0, 144456.0, 1000.7248006798188, 1037.968860934173, 1053.2521909444226, 1056.039004505896, 1059.1209296284067, 17303.480895573153, 17532.737008945132, 17590.38433654816, 17641.911790440965, 17866.374676886247, 51050.23424648559, 52295.738521308675, 52414.737926310125, 52892.73553632207, 53099.46900530945, 69804.30195697978, 70115.64942175256, 70597.64701176461, 72079.0, 75441.62279188569, 6989.965050174716, 7365.7790266292095, 7404.0, 7528.322450979438, 7571.242875712384, 10821.0, 12106.939465302617, 12610.05424593141, 12686.99053477077, 13197.34013299312, 10981.670549883516, 11025.546389490271, 11187.80056312747, 11206.831897521706, 11230.775384492428, 10902.400367979837, 10994.28537145083, 11074.612388566362, 11234.101271898066, 11441.913018263253, 10807.135429165804, 11253.66239012831, 11577.536898523964, 11590.536378544764, 11613.825792612948, 6116.5718399711595, 7487.625618719151, 7552.66013029404, 7573.734919277799, 7635.160132385544, 10859.619913302997, 11028.889711102785, 11154.330740155292, 11250.0, 11440.542378304775], "value": 9295.10054822459, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.0234835615058, 1586.2306781211112, 1594.4977332140375, 1842.7604411426512, 1979.237993372552, 6987.266337034608, 7919.643616037278, 8396.83206335873, 8890.155435233642, 8904.332175086878, 8475.364347673918, 8742.606582703778, 8742.737717868475, 8744.91255087449, 8757.43076700014, 2187.3000639795273, 2384.3443053160345, 2471.4439251168524, 2479.590867506859, 2507.7868381187623, 2514.006967247945, 2537.2388283514965, 2539.174768200333, 2539.568273393518, 2542.275451496324, 2184.9235276765316, 2216.911323547064, 2504.9749502505015, 2505.6366826810195, 2505.799536037113, 2156.795104465073, 2242.383344580245, 2388.6775285336603, 2468.271859801363, 2469.5060987802512, 2410.5660981023407, 2425.1511970810075, 2434.0385547708556, 2436.415260337524, 2440.694913135858, 8746.431481953716, 8791.384603077788, 8797.29621630268, 8823.250023747989, 8823.955880220621, 4342.348647702838, 5121.923171152435, 5359.383670877821, 5403.5136837684795, 5449.209864569615, 3523.312953973976, 3557.3063252665743, 3594.6764791168657, 3623.4564815277654, 3626.8911932642063, 1036.2694300518192, 1042.6611351310855, 1044.3629386074488, 1055.5566662001902, 1058.222206678091, 11639.476223569874, 11671.1830171888, 11713.180077394585, 11714.004309633692, 11757.529698812037, 4686.984596623416, 4832.0, 4843.244100890963, 4921.557059864558, 4945.332380128709, 8047.396445266629, 8670.609822557873, 10029.849552256723, 10053.145482633912, 10087.848682269772, 5406.567474602022, 5411.080116380225, 5465.9726701366235, 5472.890542189134, 5479.123340265538, 4436.223660859337, 4597.885052873638, 4826.58973987215, 4969.428515720666, 4971.65198436106, 4010.3583426651594, 4045.37296719009, 4142.813573389144, 4147.875563733093, 4203.684723645678, 1340.483913693235, 1370.9040367174202, 1371.5748118083427, 1374.7456720506539, 1382.4608402722947, 790.8971833661587, 813.3086876155221, 827.3009307135461, 904.3985749476656, 956.53129966316, 5357.892842143136, 5559.221708960748, 5786.681732504752, 5805.129230615442, 5912.113183022581, 872.8516152254132, 1002.4737013068197, 1010.4139599032543, 1036.1710631494775, 1036.2797855490512, 3703.666669999659, 3790.7915064671156, 3798.3542797724454, 3869.2261547690014, 3895.7857317847224, 10492.317999330018, 10746.785064298827, 10859.674209773719, 10879.782404351869, 10922.453877306261, 10805.729856753487, 10827.566897324177, 10855.945720271347, 10857.51141198648, 10997.285176463503, 7761.185075567097, 8129.065157506962, 8134.186581341818, 8174.0, 8324.0, 5661.85845353853, 5793.0786588653, 5857.0, 5874.882502349844, 5952.434518720715, 7810.531368117704, 9697.272704547046, 9827.213822894008, 9882.654107106217, 9975.102240798364, 9990.450525221182, 10214.029667181605, 10356.741081472723, 10380.740481488023, 10391.58433662645, 6797.1163748714325, 7255.746048888263, 7462.589557574385, 7545.0, 7612.352949999312, 8412.284955778583, 8423.410361274651, 8482.024567174854, 8502.489850608736, 8504.149585041447, 7028.718851246097, 7127.358537731629, 7139.107611548557, 7231.63841807918, 7280.526765760209, 7124.430045596444, 7276.818079548054, 7307.7807665770115, 7331.816704582428, 7460.813479663052, 6767.729290828312, 6850.691718872762, 6861.4853885957755, 6862.176538815374, 6868.656567171522, 4713.6936099153445, 4793.304970779287, 4822.156122678587, 4881.804727810848, 5010.599152067899, 4779.856604301876, 4817.325574419514, 4836.685615434985, 4950.430700469348, 5040.16837221869], "value": 4592.335748405602, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.46330165322263, 321.64940215165467, 330.15480370252146, 332.2408297041261, 335.3293413173653, 5990.311114221866, 6085.482733967612, 6085.634861908283, 6105.816825495232, 6125.264968203822, 4940.51784464661, 5974.283086029683, 5984.3716409777, 6012.188354572131, 6024.789132380368, 3757.380032294668, 4123.917521649565, 4409.735415875041, 4425.579569940851, 4464.0, 4409.845655402061, 4433.379326894237, 4464.0, 4482.327650852382, 4497.482789479219, 4247.25673007224, 4491.820327186909, 4497.550244975492, 4500.234960056799, 4508.143452743984, 4193.728891464647, 4201.4538110045805, 4490.461144662661, 4504.36938828561, 4547.408836851221, 3828.483154774098, 3857.286402015608, 3872.186840763443, 3877.3408520551575, 3899.3760998240145, 5733.340665823442, 5754.568407369422, 5758.337791153987, 5772.393898640625, 5780.84383123377, 4330.480342358906, 4865.975670121662, 5215.58275337972, 5279.76241069149, 5345.33183352081, 5024.547790698854, 5626.971865140648, 5991.831592839398, 6346.492280617539, 6364.681765911686, 3698.8890333290046, 4320.65434765218, 4343.956560434387, 4347.956520434786, 4359.346098085281, 4960.950390496085, 6280.937190628127, 6568.0147977803235, 6633.104530888365, 6657.667116644148, 3765.981170094187, 4365.170617582713, 4371.519132895379, 4376.277914144131, 4391.407160033418, 4217.505042234924, 4428.158649856517, 4433.202023635777, 4434.268345722984, 4448.266036104072, 5168.767405466763, 5168.870778230499, 5175.81884634036, 5185.948140518622, 5244.842654720364, 6205.875882482325, 6288.496920246369, 6288.874222515524, 6357.364263573698, 6405.743770249231, 1341.4567100324384, 1473.992630036843, 1549.7059954937529, 1555.3234343060578, 1564.5228205397236, 888.4358432395346, 954.5752140297501, 971.2715463402449, 1001.5643195209962, 1016.506994107857, 5106.540411362921, 5481.588880833953, 5510.194909287027, 5827.7668893244645, 5982.0, 5170.974145129326, 6561.507886908501, 6644.202695676453, 6657.73369065232, 6688.933110668831, 5683.772649094072, 5938.524918006549, 5982.40175982407, 5998.870401007667, 6007.909881351783, 2996.7902246842514, 3109.30040740836, 3448.2069124101095, 3494.8427320770625, 3498.4985735199452, 5762.971185144047, 6513.446357059608, 6866.656667166621, 6918.437004942459, 6935.549189302679, 5770.855728606818, 6791.626460544718, 6798.320167983261, 6817.659117044128, 6827.726890924407, 5123.6157288202785, 6145.726081349929, 6259.78090766821, 6443.645599491979, 6899.344562266577, 6090.725917333819, 6616.801495955129, 6620.337966203341, 6654.933450665431, 6658.201015878126, 6217.098520714561, 6335.841603959938, 6516.022596610546, 6541.149650545399, 6543.378379053982, 5194.3766747990485, 5779.682117483579, 6410.423061924263, 6680.866382672222, 6911.447084233148, 3862.6909847211596, 4273.358996150602, 4283.271843786626, 4287.485501739811, 4294.6564274858565, 6403.903941440975, 6570.277269500447, 6665.800025999228, 6666.633335166613, 6692.59844409337, 6414.93585064162, 6460.3862633049785, 6460.515461340325, 6462.870742585216, 6521.7065232065615, 6353.205849268841, 6378.3621637837705, 6378.681065946591, 6396.584222025554, 6434.613923164625, 5922.674252916131, 5945.34601193877, 6007.7596896125415, 6016.0, 6264.248290205022, 5397.028534863763, 5850.736716847837, 6391.58454700443, 6411.807645770635, 6421.903671445026, 5006.4743201963265, 5432.755526001419, 5945.751392207512, 6260.906086408799, 6268.185135932482], "value": 4607.20772224683, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.8160914943816, 668.91304130463, 680.8876535371664, 727.3453891497653, 746.1605693594706, 13645.044846860723, 15112.244387780622, 15126.470573529929, 15164.696706065886, 15189.54431367058, 13726.794098088536, 13737.58787236382, 13802.0, 13858.02993790435, 14075.155490670568, 931.1340453378373, 948.5968463403061, 951.3007939164709, 952.7094236257939, 953.5470651440579, 916.3356566489308, 931.3108299858123, 933.6918816790477, 934.700895713372, 936.8688383626297, 978.7063880835757, 984.7341217871207, 985.4087547471531, 986.1666891476691, 988.4316518002141, 971.7424882406168, 973.7614284500272, 975.3075316525241, 976.5507866381438, 978.3787295067648, 730.7223255163058, 730.7296300368845, 730.7807657702668, 731.4002517935295, 732.1068296678044, 12545.372731363486, 12603.117781755282, 12663.683407914783, 13162.802557961639, 13857.722845543134, 12097.274163550128, 12160.695982600506, 12250.571230006906, 12473.688157796038, 13028.153170043917, 9596.856047159297, 10030.99690030991, 10090.142337901214, 10162.18702503798, 10312.89687103127, 3414.709749671281, 3434.639362866888, 3473.3747925373423, 3478.113081164312, 3575.606683264839, 73853.63073184654, 75750.24249757487, 76347.0, 85934.0, 87321.56339218326, 9314.90685093154, 9411.576479058458, 9491.288153388523, 9755.707328780149, 9813.950930245303, 20833.374998750063, 20840.791592083886, 20862.687059694115, 20904.163833446797, 20923.16307347689, 7186.389156921616, 7349.889751653729, 7371.520851144658, 7379.225181355988, 7459.515131516542, 3958.6437220649705, 4023.0, 4025.2754504188943, 4127.731697439657, 4136.73111247768, 3414.214730611973, 3517.876874309387, 3518.1908161123083, 3518.5601799775027, 3522.277933023724, 629.5813284165978, 645.3417514135556, 645.7546132469631, 646.6217262901256, 650.7494614573424, 488.6481733152196, 573.9569532285012, 594.1859652276408, 603.9909401358983, 610.7923306075955, 7782.186400091593, 7877.660797664411, 8104.554249516215, 8152.2662960333855, 8390.03514595817, 544.4337888595895, 564.5646242613741, 586.7682265505101, 597.9342272350038, 598.790423351832, 3796.7342286040266, 3828.5405751310022, 3832.156925476391, 3833.5399752029375, 3996.480457540501, 80355.59822200969, 84530.5773471141, 84927.0, 86942.0, 90968.0, 71810.9228361575, 72477.2752272481, 73431.2656873435, 74196.0, 75088.12279692943, 64500.67749661222, 65928.67035664791, 66614.66692666506, 66676.0, 67938.0, 7359.963200183965, 7548.0, 7564.167941526538, 7742.38060955111, 7971.960140199262, 30217.0, 35730.57077716862, 37737.05657358588, 38959.83120506389, 41345.0, 55340.72329638326, 57323.14015289857, 58628.0, 59007.70496147664, 63712.681436592524, 10384.688459346231, 10603.787924241318, 10768.730781730519, 10804.837927431252, 11106.61126860556, 11708.941455292668, 11742.823857641972, 11782.52869885195, 12700.269442069999, 12708.0, 11223.214374993671, 11306.0, 11697.649070527897, 11902.40487975615, 12275.263484190977, 11220.943895280472, 11224.887751122711, 11552.537898483966, 11612.535498579962, 11727.648170554898, 11123.777524449304, 11289.04043156308, 11534.192606517463, 11595.188336816342, 11596.710082247673, 8590.484570925764, 8730.69039644033, 9688.048226541574, 9692.321537492307, 9920.751981200528, 9019.954900225457, 9053.366264361432, 9068.410553314014, 9535.761605959906, 9601.903980960102], "value": 6733.386718222235, "unit": "score"}], "name": "dromaeo_css", "value": 7192.120167853371, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 111.0, 114.0, 112.0, 113.0, 118.0, 112.0, 111.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 143.0, 172.0, 120.0, 145.0, 143.0, 128.0, 207.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 188.0, 185.0, 184.0, 186.0, 182.0, 183.0, 185.0, 182.0, 184.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 84.0, 89.0, 56.0, 56.0, 62.0, 67.0, 88.0, 72.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 137.0, 78.0, 77.0, 82.0, 119.0, 77.0, 71.0, 124.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 84.0, 85.0, 84.0, 88.0, 84.0, 90.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 98.0, 92.0, 92.0, 92.0, 127.0, 93.0, 125.0, 147.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 84.0, 85.0, 85.0, 86.0, 86.0, 86.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 59.0, 58.0, 58.0, 58.0, 58.0, 75.0, 59.0, 57.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 78.0, 73.0, 70.0, 68.0, 67.0, 66.0, 67.0, 66.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 95.0, 103.0, 104.0, 81.0, 81.0, 81.0, 82.0, 82.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 162.0, 159.0, 141.0, 145.0, 121.0, 148.0, 152.0, 196.0, 145.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 187.0, 229.0, 170.0, 167.0, 170.0, 165.0, 170.0, 168.0, 169.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 85.0, 94.0, 96.0, 93.0, 68.0, 70.0, 67.0, 68.0], "value": 78.4, "unit": "score"}], "name": "kraken", "value": 1510.1000000000004, "alertThreshold": 2.0}]} 06:20:37 INFO - Return code: 0 06:20:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:20:37 ERROR - # TBPL SUCCESS # 06:20:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:20:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:20:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:20:37 INFO - 2016-04-19 06:20:37.399 screenresolution[1676:9990] starting screenresolution argv=screenresolution get 06:20:37 INFO - 2016-04-19 06:20:37.402 screenresolution[1676:9990] Display 0: 1600x1200x32@60 06:20:37 INFO - 2016-04-19 06:20:37.408 screenresolution[1677:9993] starting screenresolution argv=screenresolution list 06:20:37 INFO - Available Modes on Display 0 06:20:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:20:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:20:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:20:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:20:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:20:37 INFO - Intel Iris: 06:20:37 INFO - Chipset Model: Intel Iris 06:20:37 INFO - Type: GPU 06:20:37 INFO - Bus: Built-In 06:20:37 INFO - VRAM (Dynamic, Max): 1536 MB 06:20:37 INFO - Vendor: Intel (0x8086) 06:20:37 INFO - Device ID: 0x0a2e 06:20:37 INFO - Revision ID: 0x0009 06:20:37 INFO - Displays: 06:20:37 INFO - Display: 06:20:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:20:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:20:37 INFO - Display Serial Number: 1600x1200 60 06:20:37 INFO - Main Display: Yes 06:20:37 INFO - Mirror: Off 06:20:37 INFO - Online: Yes 06:20:37 INFO - Rotation: Supported 06:20:37 INFO - Return code: 0 06:20:37 INFO - Running post-action listener: _resource_record_post_action 06:20:37 INFO - Running post-run listener: _resource_record_post_run 06:20:38 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37574144; Write bytes: 694286336; Read time: 392; Write time: 1998 06:20:38 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 381770240; Write bytes: 375846400; Read time: 28339; Write time: 861 06:20:38 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 35780096; Write bytes: 296632832; Read time: 372; Write time: 1095 06:20:38 INFO - Running post-run listener: _upload_blobber_files 06:20:38 INFO - Blob upload gear active. 06:20:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:20:38 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:20:38 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:20:38 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:20:39 INFO - (blobuploader) - INFO - Open directory for files ... 06:20:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:20:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:40 INFO - (blobuploader) - INFO - Done attempting. 06:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:41 INFO - (blobuploader) - INFO - Done attempting. 06:20:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:20:41 INFO - Return code: 0 06:20:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:20:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:20:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dde3f284303f931c4f10f064bd2d89672059e0e7a9dab15606c27d371077efdf916ce473bb592d7c92af6542864926759fd962f0e53644817d553dec69236f30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/371bec365dca6d3510d9b3791a58dbc040b027907f8c215056e144b0aa65c7bf224bb5647b47dee1e12bce82c63d053d641d318a1a75c58f4336dde678dc5b3a"} 06:20:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:20:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:20:41 INFO - Contents: 06:20:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dde3f284303f931c4f10f064bd2d89672059e0e7a9dab15606c27d371077efdf916ce473bb592d7c92af6542864926759fd962f0e53644817d553dec69236f30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/371bec365dca6d3510d9b3791a58dbc040b027907f8c215056e144b0aa65c7bf224bb5647b47dee1e12bce82c63d053d641d318a1a75c58f4336dde678dc5b3a"} 06:20:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:20:41 INFO - Copying logs to upload dir... 06:20:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:20:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.714165 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-19 06:20:41.287157) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 06:20:41.291503) ========= 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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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/dde3f284303f931c4f10f064bd2d89672059e0e7a9dab15606c27d371077efdf916ce473bb592d7c92af6542864926759fd962f0e53644817d553dec69236f30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/371bec365dca6d3510d9b3791a58dbc040b027907f8c215056e144b0aa65c7bf224bb5647b47dee1e12bce82c63d053d641d318a1a75c58f4336dde678dc5b3a"} build_url:https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/WToLJtCOQXKvgbhvCkIl8g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dde3f284303f931c4f10f064bd2d89672059e0e7a9dab15606c27d371077efdf916ce473bb592d7c92af6542864926759fd962f0e53644817d553dec69236f30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/371bec365dca6d3510d9b3791a58dbc040b027907f8c215056e144b0aa65c7bf224bb5647b47dee1e12bce82c63d053d641d318a1a75c58f4336dde678dc5b3a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 06:20:41.321319) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:20:41.321676) ========= 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.F4TKy8h4r6/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.rjnDOzbBkI/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005106 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:20:41.372099) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 06:20:41.372437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 06:20:41.372825) ========= ========= Total master_lag: 0.67 =========