builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0117 starttime: 1467133376.23 results: success (0) buildid: 20160628075828 builduid: cc79df57ceac4240aee67e4232804bc3 revision: 39023f2bbf6e44d29165130cd5e19d35385f0b97 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:56.229513) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:56.229966) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:56.230248) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:56.255979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:56.256403) ========= 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.fXTgqMc28N/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.0KPU85dN2s/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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-06-28 10:02:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.0M=0.001s 2016-06-28 10:02:56 (15.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122426 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:56.401630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:56.401959) ========= 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.fXTgqMc28N/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.0KPU85dN2s/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.027985 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:56.451008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 10:02:56.451394) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39023f2bbf6e44d29165130cd5e19d35385f0b97 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39023f2bbf6e44d29165130cd5e19d35385f0b97 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fXTgqMc28N/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.0KPU85dN2s/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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-06-28 10:02:56,525 truncating revision to first 12 chars 2016-06-28 10:02:56,526 Setting DEBUG logging. 2016-06-28 10:02:56,526 attempt 1/10 2016-06-28 10:02:56,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/39023f2bbf6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 10:02:57,865 unpacking tar archive at: mozilla-beta-39023f2bbf6e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.596766 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 10:02:58.071044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:58.071431) ========= script_repo_revision: 39023f2bbf6e44d29165130cd5e19d35385f0b97 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:58.071865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:58.072154) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 10:02:58.091468) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-28 10:02:58.091886) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fXTgqMc28N/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.0KPU85dN2s/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:02:58 INFO - MultiFileLogger online at 20160628 10:02:58 in /builds/slave/test 10:02:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:02:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:02:58 INFO - {'append_to_log': False, 10:02:58 INFO - 'base_work_dir': '/builds/slave/test', 10:02:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:02:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:02:58 INFO - 'branch': 'Mozilla-Beta', 10:02:58 INFO - 'buildbot_json_path': 'buildprops.json', 10:02:58 INFO - 'config_files': ('talos/mac_config.py',), 10:02:58 INFO - 'default_actions': ('clobber', 10:02:58 INFO - 'read-buildbot-config', 10:02:58 INFO - 'download-and-extract', 10:02:58 INFO - 'populate-webroot', 10:02:58 INFO - 'create-virtualenv', 10:02:58 INFO - 'install', 10:02:58 INFO - 'run-tests'), 10:02:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:02:58 INFO - 'download_minidump_stackwalk': True, 10:02:58 INFO - 'download_symbols': 'ondemand', 10:02:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:02:58 INFO - 'tooltool.py': '/tools/tooltool.py', 10:02:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:02:58 INFO - '/tools/misc-python/virtualenv.py')}, 10:02:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:02:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:02:58 INFO - 'installer_path': 'installer.exe', 10:02:58 INFO - 'log_level': 'info', 10:02:58 INFO - 'log_name': 'talos', 10:02:58 INFO - 'log_to_console': True, 10:02:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:02:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:02:58 INFO - 'opt_config_files': (), 10:02:58 INFO - 'pip_index': False, 10:02:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:02:58 INFO - 'cmd': ('bash', 10:02:58 INFO - '-c', 10:02:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:02:58 INFO - 'enabled': True, 10:02:58 INFO - 'halt_on_failure': False, 10:02:58 INFO - 'name': 'check_screen_resolution'},), 10:02:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:02:58 INFO - 'cmd': ('bash', 10:02:58 INFO - '-c', 10:02:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:02:58 INFO - 'enabled': True, 10:02:58 INFO - 'halt_on_failure': False, 10:02:58 INFO - 'name': 'check_screen_resolution'},), 10:02:58 INFO - 'run_cmd_checks_enabled': True, 10:02:58 INFO - 'sps_profile': False, 10:02:58 INFO - 'sps_profile_interval': 0, 10:02:58 INFO - 'suite': 'dromaeojs', 10:02:58 INFO - 'system_bits': '32', 10:02:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:02:58 INFO - 'title': 't-yosemite-r7-0117', 10:02:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:02:58 INFO - 'use_talos_json': True, 10:02:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:02:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:02:58 INFO - 'work_dir': 'build'} 10:02:58 INFO - ##### 10:02:58 INFO - ##### Running clobber step. 10:02:58 INFO - ##### 10:02:58 INFO - Running pre-action listener: _resource_record_pre_action 10:02:58 INFO - Running main action method: clobber 10:02:58 INFO - rmtree: /builds/slave/test/build 10:02:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:03:00 INFO - Running post-action listener: _resource_record_post_action 10:03:00 INFO - ##### 10:03:00 INFO - ##### Running read-buildbot-config step. 10:03:00 INFO - ##### 10:03:00 INFO - Running pre-action listener: _resource_record_pre_action 10:03:00 INFO - Running main action method: read_buildbot_config 10:03:00 INFO - Using buildbot properties: 10:03:00 INFO - { 10:03:00 INFO - "project": "", 10:03:00 INFO - "product": "firefox", 10:03:00 INFO - "script_repo_revision": "production", 10:03:00 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:03:00 INFO - "repository": "", 10:03:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:03:00 INFO - "buildid": "20160628075828", 10:03:00 INFO - "pgo_build": "False", 10:03:00 INFO - "basedir": "/builds/slave/test", 10:03:00 INFO - "buildnumber": 3, 10:03:00 INFO - "slavename": "t-yosemite-r7-0117", 10:03:00 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:03:00 INFO - "platform": "yosemite_r7", 10:03:00 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:03:00 INFO - "branch": "mozilla-beta", 10:03:00 INFO - "repo_path": "releases/mozilla-beta", 10:03:00 INFO - "revision": "39023f2bbf6e44d29165130cd5e19d35385f0b97", 10:03:00 INFO - "stage_platform": "macosx64", 10:03:00 INFO - "builduid": "cc79df57ceac4240aee67e4232804bc3", 10:03:00 INFO - "slavebuilddir": "test" 10:03:00 INFO - } 10:03:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 10:03:00 INFO - Running post-action listener: _resource_record_post_action 10:03:00 INFO - ##### 10:03:00 INFO - ##### Running download-and-extract step. 10:03:00 INFO - ##### 10:03:00 INFO - Running pre-action listener: _resource_record_pre_action 10:03:00 INFO - Running main action method: download_and_extract 10:03:00 INFO - mkdir: /builds/slave/test/build/tests 10:03:00 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')]} 10:03:00 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:03:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:03:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:03:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 10:03:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 10:03:01 INFO - Downloaded 1165 bytes. 10:03:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 10:03:01 INFO - Using the following test package requirements: 10:03:01 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:03:01 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:03:01 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 10:03:01 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:03:01 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 10:03:01 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:03:01 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:03:01 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 10:03:01 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:03:01 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:03:01 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 10:03:01 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:03:01 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 10:03:01 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:03:01 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 10:03:01 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:03:01 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 10:03:01 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 10:03: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')]} 10:03:01 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:03:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:03:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:03:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 10:03:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 10:03:03 INFO - Downloaded 18350398 bytes. 10:03:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:03:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:03:06 INFO - Return code: 0 10:03:06 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:06 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:03:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:03:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:03:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 10:03:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 10:03:07 INFO - Downloaded 18350398 bytes. 10:03:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:03:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:03:11 INFO - Return code: 0 10:03:11 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')]} 10:03:11 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:03:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:03:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:03:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 10:03:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 10:03:12 INFO - Downloaded 10840145 bytes. 10:03:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:03:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:03:12 INFO - Return code: 0 10:03:12 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')]} 10:03:12 INFO - https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:03:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:03:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:03:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 10:03:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 10:03:15 INFO - Downloaded 86200745 bytes. 10:03:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:03:15 INFO - mkdir: /builds/slave/test/properties 10:03:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:03:15 INFO - Writing to file /builds/slave/test/properties/build_url 10:03:15 INFO - Contents: 10:03:15 INFO - build_url:https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:03:16 INFO - Running post-action listener: _resource_record_post_action 10:03:16 INFO - Running post-action listener: set_extra_try_arguments 10:03:16 INFO - ##### 10:03:16 INFO - ##### Running populate-webroot step. 10:03:16 INFO - ##### 10:03:16 INFO - Running pre-action listener: _resource_record_pre_action 10:03:16 INFO - Running main action method: populate_webroot 10:03:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:03:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:03:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:03:16 INFO - '--tppagecycles', 10:03:16 INFO - '7'], 10:03:16 INFO - 'tests': ['tsvgm']}}, 10:03:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:03:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:03:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:03:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:03:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:16 INFO - 'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:16 INFO - 'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['damp', 'tps']}, 10:03:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:16 INFO - 'tests': ['damp', 'tps']}, 10:03:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['dromaeo_dom']}, 10:03:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:03:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['a11yr', 10:03:16 INFO - 'ts_paint', 10:03:16 INFO - 'tpaint', 10:03:16 INFO - 'sessionrestore', 10:03:16 INFO - 'sessionrestore_no_auto_restore', 10:03:16 INFO - 'tabpaint']}, 10:03:16 INFO - 'other-e10s': {'tests': ['a11yr', 10:03:16 INFO - 'ts_paint', 10:03:16 INFO - 'tpaint', 10:03:16 INFO - 'sessionrestore', 10:03:16 INFO - 'sessionrestore_no_auto_restore', 10:03:16 INFO - 'tabpaint']}, 10:03:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:03:16 INFO - 'ts_paint', 10:03:16 INFO - 'tpaint', 10:03:16 INFO - 'sessionrestore', 10:03:16 INFO - 'sessionrestore_no_auto_restore', 10:03:16 INFO - 'tabpaint']}, 10:03:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:03:16 INFO - 'ts_paint', 10:03:16 INFO - 'tpaint', 10:03:16 INFO - 'sessionrestore', 10:03:16 INFO - 'sessionrestore_no_auto_restore', 10:03:16 INFO - 'tabpaint']}, 10:03:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['a11yr', 10:03:16 INFO - 'ts_paint', 10:03:16 INFO - 'tpaint', 10:03:16 INFO - 'sessionrestore', 10:03:16 INFO - 'sessionrestore_no_auto_restore', 10:03:16 INFO - 'tabpaint']}, 10:03:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['a11yr', 10:03:16 INFO - 'ts_paint', 10:03:16 INFO - 'tpaint', 10:03:16 INFO - 'sessionrestore', 10:03:16 INFO - 'sessionrestore_no_auto_restore', 10:03:16 INFO - 'tabpaint']}, 10:03:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['tsvgx', 10:03:16 INFO - 'tsvgr_opacity', 10:03:16 INFO - 'tart', 10:03:16 INFO - 'tscrollx', 10:03:16 INFO - 'cart']}, 10:03:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:03:16 INFO - 'tsvgr_opacity', 10:03:16 INFO - 'tart', 10:03:16 INFO - 'tscrollx', 10:03:16 INFO - 'cart']}, 10:03:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:16 INFO - 'talos_options': ['--disable-e10s'], 10:03:16 INFO - 'tests': ['tp5o']}, 10:03:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:16 INFO - 'tests': ['tp5o']}, 10:03:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:16 INFO - 'talos_options': ['--disable-e10s', 10:03:16 INFO - '--xperf_path', 10:03:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:16 INFO - 'tests': ['tp5n']}, 10:03:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:16 INFO - 'talos_options': ['--xperf_path', 10:03:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:16 INFO - 'tests': ['tp5n']}}, 10:03:16 INFO - 'talos.zip': {'path': '', 10:03:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:03:16 INFO - Running post-action listener: _resource_record_post_action 10:03:16 INFO - ##### 10:03:16 INFO - ##### Running create-virtualenv step. 10:03:16 INFO - ##### 10:03:16 INFO - Running pre-action listener: _resource_record_pre_action 10:03:16 INFO - Running main action method: create_virtualenv 10:03:16 INFO - Creating virtualenv /builds/slave/test/build/venv 10:03:16 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 10:03:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:03:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:03:16 INFO - Using real prefix '/tools/python27' 10:03:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:03:17 INFO - Installing distribute.............................................................................................................................................................................................done. 10:03:20 INFO - Installing pip.................done. 10:03:20 INFO - Return code: 0 10:03:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:20 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 0x104e8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1f3d76540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, '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.fXTgqMc28N/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.0KPU85dN2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:03:20 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 10:03:20 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 10:03:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:03:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:20 INFO - 'HOME': '/Users/cltbld', 10:03:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:20 INFO - 'LOGNAME': 'cltbld', 10:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:20 INFO - 'MOZ_NO_REMOTE': '1', 10:03:20 INFO - 'NO_EM_RESTART': '1', 10:03:20 INFO - 'PAGER': '/bin/cat', 10:03:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:20 INFO - 'PWD': '/builds/slave/test', 10:03:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:20 INFO - 'SHELL': '/bin/bash', 10:03:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:03:20 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:03:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:20 INFO - 'USER': 'cltbld', 10:03:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:20 INFO - 'XPC_FLAGS': '0x0', 10:03:20 INFO - 'XPC_SERVICE_NAME': '0', 10:03:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:20 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 10:03:20 INFO - Cleaning up... 10:03:20 INFO - Return code: 0 10:03:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:20 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 0x104e8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1f3d76540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, '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.fXTgqMc28N/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.0KPU85dN2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:03:20 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 10:03:20 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 10:03:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:03:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:20 INFO - 'HOME': '/Users/cltbld', 10:03:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:20 INFO - 'LOGNAME': 'cltbld', 10:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:20 INFO - 'MOZ_NO_REMOTE': '1', 10:03:20 INFO - 'NO_EM_RESTART': '1', 10:03:20 INFO - 'PAGER': '/bin/cat', 10:03:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:20 INFO - 'PWD': '/builds/slave/test', 10:03:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:20 INFO - 'SHELL': '/bin/bash', 10:03:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:03:20 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:03:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:20 INFO - 'USER': 'cltbld', 10:03:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:20 INFO - 'XPC_FLAGS': '0x0', 10:03:20 INFO - 'XPC_SERVICE_NAME': '0', 10:03:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:20 INFO - Downloading/unpacking psutil>=0.7.1 10:03: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 10:03: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 10:03: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 10:03: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 10:03: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 10:03: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 10:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:23 INFO - Installing collected packages: psutil 10:03:23 INFO - Running setup.py install for psutil 10:03:23 INFO - building 'psutil._psutil_osx' extension 10:03:23 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 10:03:23 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 10:03:23 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 10:03:24 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 10:03:24 INFO - building 'psutil._psutil_posix' extension 10:03:24 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 10:03:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:03:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:03:24 INFO - ^ 10:03:24 INFO - 1 warning generated. 10:03:24 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 10:03:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:24 INFO - Successfully installed psutil 10:03:24 INFO - Cleaning up... 10:03:24 INFO - Return code: 0 10:03:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104e8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1f3d76540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, '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.fXTgqMc28N/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.0KPU85dN2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:24 INFO - 'HOME': '/Users/cltbld', 10:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:24 INFO - 'LOGNAME': 'cltbld', 10:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:24 INFO - 'MOZ_NO_REMOTE': '1', 10:03:24 INFO - 'NO_EM_RESTART': '1', 10:03:24 INFO - 'PAGER': '/bin/cat', 10:03:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:24 INFO - 'PWD': '/builds/slave/test', 10:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:24 INFO - 'SHELL': '/bin/bash', 10:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:03:24 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:24 INFO - 'USER': 'cltbld', 10:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:24 INFO - 'XPC_FLAGS': '0x0', 10:03:24 INFO - 'XPC_SERVICE_NAME': '0', 10:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:03:27 INFO - Installing collected packages: mozsystemmonitor 10:03:27 INFO - Running setup.py install for mozsystemmonitor 10:03:27 INFO - Successfully installed mozsystemmonitor 10:03:27 INFO - Cleaning up... 10:03:27 INFO - Return code: 0 10:03:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:27 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 0x104e8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1f3d76540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, '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.fXTgqMc28N/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.0KPU85dN2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:03:27 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 10:03:27 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 10:03:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:03:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:27 INFO - 'HOME': '/Users/cltbld', 10:03:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:27 INFO - 'LOGNAME': 'cltbld', 10:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:27 INFO - 'MOZ_NO_REMOTE': '1', 10:03:27 INFO - 'NO_EM_RESTART': '1', 10:03:27 INFO - 'PAGER': '/bin/cat', 10:03:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:27 INFO - 'PWD': '/builds/slave/test', 10:03:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:27 INFO - 'SHELL': '/bin/bash', 10:03:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:03:27 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:03:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:27 INFO - 'USER': 'cltbld', 10:03:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:27 INFO - 'XPC_FLAGS': '0x0', 10:03:27 INFO - 'XPC_SERVICE_NAME': '0', 10:03:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:27 INFO - Downloading/unpacking blobuploader==1.2.4 10:03: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 10:03: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 10:03: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 10:03: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 10:03: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 10:03: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 10:03:30 INFO - Downloading blobuploader-1.2.4.tar.gz 10:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:03:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:03:30 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 10:03:30 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 10:03:30 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 10:03:30 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 10:03:30 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 10:03:30 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 10:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:03:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:03:30 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 10:03:30 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 10:03:30 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 10:03:30 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 10:03:30 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 10:03:30 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 10:03:31 INFO - Downloading docopt-0.6.1.tar.gz 10:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:03:31 INFO - Installing collected packages: blobuploader, requests, docopt 10:03:31 INFO - Running setup.py install for blobuploader 10:03:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:03:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:03:31 INFO - Running setup.py install for requests 10:03:32 INFO - Running setup.py install for docopt 10:03:32 INFO - Successfully installed blobuploader requests docopt 10:03:32 INFO - Cleaning up... 10:03:32 INFO - Return code: 0 10:03:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:32 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')]} 10:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:32 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')]} 10:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:32 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 0x104e8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1f3d76540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, '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.fXTgqMc28N/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.0KPU85dN2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:03:32 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 10:03:32 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 10:03:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:03:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:32 INFO - 'HOME': '/Users/cltbld', 10:03:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:32 INFO - 'LOGNAME': 'cltbld', 10:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:32 INFO - 'MOZ_NO_REMOTE': '1', 10:03:32 INFO - 'NO_EM_RESTART': '1', 10:03:32 INFO - 'PAGER': '/bin/cat', 10:03:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:32 INFO - 'PWD': '/builds/slave/test', 10:03:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:32 INFO - 'SHELL': '/bin/bash', 10:03:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:03:32 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:03:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:32 INFO - 'USER': 'cltbld', 10:03:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:32 INFO - 'XPC_FLAGS': '0x0', 10:03:32 INFO - 'XPC_SERVICE_NAME': '0', 10:03:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:32 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-FgtFYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:32 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-vodzQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:32 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-JdT7_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:32 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-wAxlnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:32 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-9uKX26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-B6t9Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-3pcCTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-gVXVp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-1jx3JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-dzoEN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-SLIVPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-nKmAWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-a0PgI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-eWVIwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:33 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-WElGnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:34 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-weXX3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:34 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-h8reMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:03:34 INFO - Running setup.py install for manifestparser 10:03:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:03:34 INFO - Running setup.py install for mozcrash 10:03:34 INFO - Running setup.py install for mozdebug 10:03:34 INFO - Running setup.py install for mozdevice 10:03:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:03:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:03:34 INFO - Running setup.py install for mozfile 10:03:35 INFO - Running setup.py install for mozhttpd 10:03:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:03:35 INFO - Running setup.py install for mozinfo 10:03:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:03:35 INFO - Running setup.py install for mozInstall 10:03:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:03:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:03:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:03:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:03:35 INFO - Running setup.py install for mozleak 10:03:35 INFO - Running setup.py install for mozlog 10:03:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:03:35 INFO - Running setup.py install for moznetwork 10:03:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:03:35 INFO - Running setup.py install for mozprocess 10:03:36 INFO - Running setup.py install for mozprofile 10:03:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:03:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:03:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:03:36 INFO - Running setup.py install for mozrunner 10:03:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:03:36 INFO - Running setup.py install for mozscreenshot 10:03:36 INFO - Running setup.py install for moztest 10:03:36 INFO - Running setup.py install for mozversion 10:03:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:03:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:03:36 INFO - Cleaning up... 10:03:36 INFO - Return code: 0 10:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:36 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 0x104e8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1f3d76540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, '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.fXTgqMc28N/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.0KPU85dN2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:03:36 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 10:03:36 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 10:03:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:03:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:36 INFO - 'HOME': '/Users/cltbld', 10:03:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:36 INFO - 'LOGNAME': 'cltbld', 10:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:36 INFO - 'MOZ_NO_REMOTE': '1', 10:03:36 INFO - 'NO_EM_RESTART': '1', 10:03:36 INFO - 'PAGER': '/bin/cat', 10:03:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:36 INFO - 'PWD': '/builds/slave/test', 10:03:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:36 INFO - 'SHELL': '/bin/bash', 10:03:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:03:36 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:03:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:36 INFO - 'USER': 'cltbld', 10:03:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:36 INFO - 'XPC_FLAGS': '0x0', 10:03:36 INFO - 'XPC_SERVICE_NAME': '0', 10:03:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:37 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-pQAJM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:37 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)) 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:37 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-drX1ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:37 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)) 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:37 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-06ESBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:37 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)) 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:37 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Hiw2v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:37 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)) 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:37 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-eLtLQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:37 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)) 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:37 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-AbDZG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:37 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)) 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:37 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-TXlxwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:37 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)) 10:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:37 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-HdTjC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:38 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)) 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:38 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-AGw6ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:38 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)) 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:38 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-I89NwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:38 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)) 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:38 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-TARxjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:38 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)) 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:38 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-GQjPKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:38 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)) 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:38 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-d_XqZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:38 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)) 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:38 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-gjBInh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:38 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)) 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:38 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-0mSKja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:38 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)) 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:38 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-S8Mrby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:38 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)) 10:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:38 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-prTl1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:38 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)) 10:03:38 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)) 10:03:38 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)) 10:03:38 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)) 10:03:38 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)) 10:03:38 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)) 10:03:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:41 INFO - Downloading blessings-1.6.tar.gz 10:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:03:41 INFO - Installing collected packages: blessings 10:03:41 INFO - Running setup.py install for blessings 10:03:41 INFO - Successfully installed blessings 10:03:41 INFO - Cleaning up... 10:03:41 INFO - Return code: 0 10:03:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:42 INFO - Reading from file tmpfile_stdout 10:03:42 INFO - Current package versions: 10:03:42 INFO - blessings == 1.6 10:03:42 INFO - blobuploader == 1.2.4 10:03:42 INFO - docopt == 0.6.1 10:03:42 INFO - manifestparser == 1.1 10:03:42 INFO - mozInstall == 1.12 10:03:42 INFO - mozcrash == 0.17 10:03:42 INFO - mozdebug == 0.1 10:03:42 INFO - mozdevice == 0.48 10:03:42 INFO - mozfile == 1.2 10:03:42 INFO - mozhttpd == 0.7 10:03:42 INFO - mozinfo == 0.9 10:03:42 INFO - mozleak == 0.1 10:03:42 INFO - mozlog == 3.1 10:03:42 INFO - moznetwork == 0.27 10:03:42 INFO - mozprocess == 0.22 10:03:42 INFO - mozprofile == 0.28 10:03:42 INFO - mozrunner == 6.11 10:03:42 INFO - mozscreenshot == 0.1 10:03:42 INFO - mozsystemmonitor == 0.0 10:03:42 INFO - moztest == 0.7 10:03:42 INFO - mozversion == 1.4 10:03:42 INFO - psutil == 3.1.1 10:03:42 INFO - requests == 1.2.3 10:03:42 INFO - wsgiref == 0.1.2 10:03:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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')]} 10:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:42 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 0x104e8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1f3d76540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, '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.fXTgqMc28N/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.0KPU85dN2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:03:42 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 10:03:42 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 10:03:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:03:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:42 INFO - 'HOME': '/Users/cltbld', 10:03:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:42 INFO - 'LOGNAME': 'cltbld', 10:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:42 INFO - 'MOZ_NO_REMOTE': '1', 10:03:42 INFO - 'NO_EM_RESTART': '1', 10:03:42 INFO - 'PAGER': '/bin/cat', 10:03:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:42 INFO - 'PWD': '/builds/slave/test', 10:03:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:42 INFO - 'SHELL': '/bin/bash', 10:03:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:03:42 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:03:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:42 INFO - 'USER': 'cltbld', 10:03:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:42 INFO - 'XPC_FLAGS': '0x0', 10:03:42 INFO - 'XPC_SERVICE_NAME': '0', 10:03:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 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)) 10:03:42 INFO - Cleaning up... 10:03:42 INFO - Return code: 0 10:03:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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')]} 10:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1f3d76540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, '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.fXTgqMc28N/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.0KPU85dN2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:03:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:03:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:42 INFO - 'HOME': '/Users/cltbld', 10:03:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:42 INFO - 'LOGNAME': 'cltbld', 10:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:42 INFO - 'MOZ_NO_REMOTE': '1', 10:03:42 INFO - 'NO_EM_RESTART': '1', 10:03:42 INFO - 'PAGER': '/bin/cat', 10:03:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:42 INFO - 'PWD': '/builds/slave/test', 10:03:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:42 INFO - 'SHELL': '/bin/bash', 10:03:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:03:42 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:03:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:42 INFO - 'USER': 'cltbld', 10:03:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:42 INFO - 'XPC_FLAGS': '0x0', 10:03:42 INFO - 'XPC_SERVICE_NAME': '0', 10:03:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:42 INFO - Downloading/unpacking jsonschema 10:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:03:45 INFO - Downloading/unpacking functools32 (from jsonschema) 10:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:45 INFO - Downloading functools32-3.2.3-2.tar.gz 10:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:03:45 INFO - warning: no files found matching '*.txt' 10:03:45 INFO - no previously-included directories found matching 'build' 10:03:45 INFO - no previously-included directories found matching 'dist' 10:03:45 INFO - no previously-included directories found matching '.git*' 10:03:45 INFO - Installing collected packages: jsonschema, functools32 10:03:45 INFO - Running setup.py install for functools32 10:03:45 INFO - warning: no files found matching '*.txt' 10:03:45 INFO - no previously-included directories found matching 'build' 10:03:45 INFO - no previously-included directories found matching 'dist' 10:03:45 INFO - no previously-included directories found matching '.git*' 10:03:45 INFO - Successfully installed jsonschema functools32 10:03:45 INFO - Cleaning up... 10:03:45 INFO - Return code: 0 10:03:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e9a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1f3d76540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, '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.fXTgqMc28N/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.0KPU85dN2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:45 INFO - 'HOME': '/Users/cltbld', 10:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:45 INFO - 'LOGNAME': 'cltbld', 10:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:45 INFO - 'MOZ_NO_REMOTE': '1', 10:03:45 INFO - 'NO_EM_RESTART': '1', 10:03:45 INFO - 'PAGER': '/bin/cat', 10:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:45 INFO - 'PWD': '/builds/slave/test', 10:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:45 INFO - 'SHELL': '/bin/bash', 10:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:03:45 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:45 INFO - 'USER': 'cltbld', 10:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:45 INFO - 'XPC_FLAGS': '0x0', 10:03:45 INFO - 'XPC_SERVICE_NAME': '0', 10:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:46 INFO - Downloading/unpacking flake8 10:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:03:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:03:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:03:49 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 10:03:49 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 10:03:49 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 10:03:49 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 10:03:49 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 10:03:49 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 10:03:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:03:49 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 10:03:49 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 10:03:49 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 10:03:49 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 10:03:49 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 10:03:49 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 10:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:03:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:03:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:03:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:03:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:03:49 INFO - no previously-included directories found matching 'docs/_build' 10:03:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:03:50 INFO - Running setup.py install for pep8 10:03:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:03:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:03:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:03:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:03:50 INFO - no previously-included directories found matching 'docs/_build' 10:03:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:03:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:03:50 INFO - Cleaning up... 10:03:50 INFO - Return code: 0 10:03:50 INFO - Running post-action listener: _resource_record_post_action 10:03:50 INFO - Running post-action listener: _start_resource_monitoring 10:03:50 INFO - Starting resource monitoring. 10:03:50 INFO - ##### 10:03:50 INFO - ##### Running install step. 10:03:50 INFO - ##### 10:03:50 INFO - Running pre-action listener: _resource_record_pre_action 10:03:50 INFO - Running main action method: install 10:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:50 INFO - Reading from file tmpfile_stdout 10:03:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:03:50 INFO - Reading from file tmpfile_stdout 10:03:50 INFO - Output received: 10:03:50 INFO - Usage: mozinstall [options] installer 10:03:50 INFO - Options: 10:03:50 INFO - -h, --help show this help message and exit 10:03:50 INFO - -d DEST, --destination=DEST 10:03:50 INFO - Directory to install application into. [default: 10:03:50 INFO - "/builds/slave/test"] 10:03:50 INFO - --app=APP Application being installed. [default: firefox] 10:03:50 INFO - mkdir: /builds/slave/test/build/application 10:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:04:12 INFO - Reading from file tmpfile_stdout 10:04:12 INFO - Output received: 10:04:12 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:04:12 INFO - Running post-action listener: _resource_record_post_action 10:04:12 INFO - ##### 10:04:12 INFO - ##### Running run-tests step. 10:04:12 INFO - ##### 10:04:12 INFO - Running pre-action listener: _resource_record_pre_action 10:04:12 INFO - Running main action method: run_tests 10:04:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:04:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:04:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:04:12 INFO - 2016-06-28 10:04:12.221 screenresolution[1637:7461] starting screenresolution argv=screenresolution get 10:04:12 INFO - 2016-06-28 10:04:12.224 screenresolution[1637:7461] Display 0: 1600x1200x32@60 10:04:12 INFO - 2016-06-28 10:04:12.229 screenresolution[1638:7464] starting screenresolution argv=screenresolution list 10:04:12 INFO - Available Modes on Display 0 10:04:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:04:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:04:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:04:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:04:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:04:12 INFO - Intel Iris: 10:04:12 INFO - Chipset Model: Intel Iris 10:04:12 INFO - Type: GPU 10:04:12 INFO - Bus: Built-In 10:04:12 INFO - VRAM (Dynamic, Max): 1536 MB 10:04:12 INFO - Vendor: Intel (0x8086) 10:04:12 INFO - Device ID: 0x0a2e 10:04:12 INFO - Revision ID: 0x0009 10:04:12 INFO - Displays: 10:04:12 INFO - Display: 10:04:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:04:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:04:12 INFO - Display Serial Number: 1600x1200 60 10:04:12 INFO - Main Display: Yes 10:04:12 INFO - Mirror: Off 10:04:12 INFO - Online: Yes 10:04:12 INFO - Rotation: Supported 10:04:12 INFO - Return code: 0 10:04:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:04:12 INFO - Python 2.7.3 10:04:12 INFO - Return code: 0 10:04:12 INFO - grabbing minidump binary from tooltool 10:04:12 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')]} 10:04:12 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 0x104d29e00>, '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 0x104b92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d24b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:04:12 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 10:04:12 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 10:04:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:04:12 INFO - Return code: 0 10:04:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:04:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:04:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:04:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:04:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:04:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:04:13 INFO - Return code: 0 10:04:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 10:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0117 --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 10:04:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXTgqMc28N/Render', 10:04:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:04:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:04:13 INFO - 'HOME': '/Users/cltbld', 10:04:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:04:13 INFO - 'LOGNAME': 'cltbld', 10:04:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:04:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:13 INFO - 'MOZ_NO_REMOTE': '1', 10:04:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:04:13 INFO - 'NO_EM_RESTART': '1', 10:04:13 INFO - 'PAGER': '/bin/cat', 10:04:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:13 INFO - 'PWD': '/builds/slave/test', 10:04:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:04:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:04:13 INFO - 'SHELL': '/bin/bash', 10:04:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0KPU85dN2s/Listeners', 10:04:13 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:04:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:04:13 INFO - 'USER': 'cltbld', 10:04:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:04:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:13 INFO - 'XPC_FLAGS': '0x0', 10:04:13 INFO - 'XPC_SERVICE_NAME': '0', 10:04:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:04:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 10:04:13 INFO - mozversion application_buildid: 20160628075828 10:04:13 INFO - mozversion application_changeset: 39023f2bbf6e44d29165130cd5e19d35385f0b97 10:04:13 INFO - mozversion application_display_name: Firefox 10:04:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:04:13 INFO - mozversion application_name: Firefox 10:04:13 INFO - mozversion application_remotingname: firefox 10:04:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:04:13 INFO - mozversion application_vendor: Mozilla 10:04:13 INFO - mozversion application_version: 48.0 10:04:13 INFO - mozversion platform_buildid: 20160628075828 10:04:13 INFO - mozversion platform_changeset: 39023f2bbf6e44d29165130cd5e19d35385f0b97 10:04:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:04:13 INFO - mozversion platform_version: 48.0 10:04:13 INFO - using testdate: 1467133453 10:04:13 INFO - actual date: 1467133453 10:04:13 INFO - starting webserver on 'localhost:49275' 10:04:13 INFO - SUITE-START | Running 2 tests 10:04:13 INFO - TEST-START | dromaeo_css 10:04:13 INFO - operating with platform_type : mac_ 10:04:13 INFO - Initialising browser for dromaeo_css test... 10:04:13 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpY8z_Bn/profile http://localhost:49275/getInfo.html) 10:04:16 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 10:04:16 INFO - PROCESS | 1656 | colorDepth:24 10:04:16 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 10:04:16 INFO - PROCESS | 1656 | __metrics 10:04:16 INFO - PROCESS | 1656 | 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" 10:04:16 ERROR - PROCESS | 1656 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:04:16 INFO - TEST-INFO | 1656: exit 0 10:04:16 INFO - Browser initialized. 10:04:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:04:16 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpY8z_Bn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:28 INFO - PROCESS | 1659 | RSS: Main: 161255424 10:04:28 INFO - PROCESS | 1659 | 10:05:19 INFO - PROCESS | 1659 | 1467133519850 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] 10:07:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 10:07:31 INFO - PROCESS | 1659 | RSS: Main: 304943104 10:07:31 INFO - PROCESS | 1659 | 10:10:33 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 10:10:34 INFO - PROCESS | 1659 | RSS: Main: 299384832 10:10:34 INFO - PROCESS | 1659 | 10:13:36 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 10:13:37 INFO - PROCESS | 1659 | RSS: Main: 306483200 10:13:37 INFO - PROCESS | 1659 | 10:16:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 10:16:39 INFO - PROCESS | 1659 | RSS: Main: 305991680 10:16:39 INFO - PROCESS | 1659 | 10:19:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 10:19:43 INFO - PROCESS | 1659 | RSS: Main: 278720512 10:19:43 INFO - PROCESS | 1659 | 10:22:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 10:22:46 INFO - PROCESS | 1659 | RSS: Main: 308699136 10:22:46 INFO - PROCESS | 1659 | 10:22:46 INFO - PROCESS | 1659 | __start_tp_report 10:22:46 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 10:22:46 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 10:22:46 INFO - PROCESS | 1659 | |i|pagename|runs| 10:22:46 INFO - PROCESS | 1659 | |0;dojo.html;3592.335417947679;3628.437592173214;3655.0679576707935;3659.5059666944953;3725.180460298733;5079.4412614612365;5331.893362132765;5842.0652695568715;5906.350301466835;5911.88176236475;5876.324222714389;5928.5553583481305;5932.169496270526;5940.3762604926505;5951.196588460556;5299.682019078858;5321.600879934001;5353.625246232766;5399.541039011689;5426;5409.053415652264;5441.809536666217;5444.863878403032;5448.128299472085;5451.400345961941;5330.946690533103;5401.27082843817;5412.134058550632;5416.404195538487;5426.647267927592;5422.376426710939;5442.91835622466;5470.425605311425;5483.698396588186;5525.005499010176;5185.222216667492;5260.105782017028;5358.758855851457;5380;5380.488853558905;5777.884442311172;5783.161441590988;5800.100984347433;5837.5913686041995;5872.442117998783;6337.746490140389;6366.299707032223;6369.5222858285815;6372.997197200222;6385.7764978226005;6220.968895155495;6262.499000079983;6317.273513545955;6331.145295385156;6340.841478963062;6011.428914253139;6019.624891317849;6081.604695694766;6085.269767627913;6089.208402907638;6359.20509936258;6374.07575901501;6374.617522948638;6377.426031657174;6381.744730210739;6193.628382297076;6239.937600624026;6341.556091073673;6348.873022539616;6358.650274234869;6320.968395157995;6334.619922804646;6335.303116657164;6349.936500634934;6360.268569114519;6349.0476428536085;6364.1408409865;6395.968020159869;6400.839979000469;6411.358864113645;6285.340039295899;6352.7141278642575;6377.3303803100935;6381.361863813581;6388.488920886318;5020.397552293675;5065.645404821627;5073.34046573943;5102.795888164506;5108.386993560796;4557.589816916494;4560.95439045612;4563.133004729091;4572.337011133367;4608.147492713859;5744.310682718101;5951.791687290924;5972.701364931736;5986.73059712314;5994.730237139339;6036.124761909498;6091.659834836329;6335.081413195061;6349;6370.140031095742;5982.551308651869;6002.219711437572;6011.152046201317;6016.639001659914;6026.819195424145;5463.918041229305;5572.888542229132;5578.944210557843;5584.96678114542;5596.160575913564;6425.068365087036;6469.54713170083;6527.934720652923;6538.215414150332;6538.967305163444;5341.572674185978;6299.685015749286;6309.211348581427;6333.334999824952;6338.461230795249;6377.681115944277;6553.639549824806;6581.276059633341;6594.637294948632;6596.967015164893;6287;6351.333110023381;6354.23749150105;6356.523260755369;6385.744570217139;5512.889742205213;6167.5682702210415;6227.906581401373;6300.779472718433;6339.683015849097;6190.721417536131;6209.472194863307;6274.6548939808745;6323.715432805627;6327.620342779448;6135.969320153371;6268.968655156695;6346.904796427965;6348.714307856065;6356.364363563606;6242.5942313749465;6246.875062498815;6249.781257656142;6252.937470625236;6261.998080307129;5254.65844720092;6159.938400616115;6208.565400422108;6325.778597749057;6350.7777227796805;6196.411340922605;6217.96891015542;6224.128621993015;6224.346443623354;6229.813105606839 10:22:46 INFO - PROCESS | 1659 | |1;ext.html;524.6170295684151;553.24758328673;556.579598075799;602.9306629737581;613.4662843326304;25884.61173082403;32719.018429447126;39430.81707548774;39763.40354894671;39790.801045994805;43522.347164792474;43852.56147438525;43938.56061439385;43948;43981.56018439815;8947.32895032875;9664.661736839213;9900.257480688977;9904.752381190456;9922.553485093153;8990.325725570576;11895.881041189565;12164.330961797097;12190.329531875743;12195.451204695766;11753;11805.23265987708;11855.466504007298;11861.110416718737;11885.168038237327;11754.235974661662;11799.410029498576;11859;11861.11041671878;11870.52517899283;9967.302288839785;12029.157958942878;12039;12051.216670916363;12059.819102713378;41714.58285417137;42207.57792422067;42263.57736422627;42269.57730422687;42331.15337693229;3353.8826141084946;3472.2881809229048;3520.1903562180587;3525.189206482498;3567.714582833367;28219.717802821913;29051.837926482916;29300.827966881512;29455;30110.84944575285;2777.4306267215175;2809.3959798643186;2811.325281932342;2815.0569559197693;2844.857757112157;391909;392688;392706.0364698158;393132.03433982935;394223;37333.25333493315;38028.809855950545;64009.03986440207;64467.67766161233;64595;36016.819915900254;36280.45579316312;36386.27227455489;36408.453873191924;36434;16071.517854464384;16238.10690412015;16239.59401014984;16267.18664066792;16274.511764647079;13026.47894084226;13036.739265214832;13042.282674452807;13043.869561304455;13698.45206191741;8447.66209351619;8587.828243435097;8625.13748625145;8631.223189912938;8714;3228.9505910579155;3400.064982129934;3441.380551500754;3518.7712798668003;3524.8942531724088;842.5450256861349;1044.3474321896088;1074.6453670288943;1086.3319058778952;1092.956281748721;25411.49177016449;25545.872270638527;30177.245568860955;30490;31097.844510777755;857.8713193021097;1093.6882988348282;1135.0919264588297;1187.857457105153;1221.8106193540016;13777.862221377658;15290;15332.540023799304;15639.530814075595;15741.763873541906;662195;662459;669310;669674;670547;62899.056514152326;63682.36317636857;63730.6813465939;63772.043419348745;63808.68095659492;1361.7889227169806;1579.6998570271612;1599.016604788047;1604.9839501605302;1605.4380966661809;29839.254018649706;30546.84726576353;30646.233844154074;30841.292893645215;32005;46491.3026304599;54708.63228419321;55018.89962200814;55206;55580.44419555915;292458;521671;524346;530243;536317;44421;44847;45225.32162017506;45429.77285113553;45993.31010034919;47996.760016199696;48178.75910620424;48331.275030875266;48702.75648621734;49919;32461.67538324681;38764.806175970065;39453.40819887647;39796.80101599474;40490.79754601208;37979;38905.61094389133;39033.80483097566;39726.404103937886;39769.20461590694;39142.217155657294;39164;39371.80314098411;40137.1972560553;40198.59801401949;31150.794642722944;32882.835585821915;32948.67051329456;32951.50572741459;32990.34019319648;24560;24669.259922202364;24687.629685554373;25055.624165637164;25188.874055629603 10:22:46 INFO - PROCESS | 1659 | |2;jquery.html;418.70899724691344;420.24146415719616;422.1788621131899;425.2324554179708;430.92027974824657;20743.066562004708;20751.06620202091;20788.376348709524;21372.931353432323;21390.89304553475;20849.374518764424;21135.471613209676;22120.446988825286;22124.55750884981;22139.557208855815;5959.284885813709;5999.100134979766;6187.690615469209;6213.25440947087;6216.129741836146;6047.455728984391;6148.262208534982;6156.38436156383;6156.984097623909;6162.983107787232;5831;6175.413335733098;6180.474659653913;6182.752689892399;6189.226346706661;5868.207791948075;6105.969470152643;6142;6178.443940045373;6188.84527886802;5322.760475778599;5358.169483730028;5368.516833485005;5376.516113549799;5378.139497680352;26828.329291767666;27541.449171016466;27706.584401234;27783.027594034313;27863;2079.906404211799;2234.6648002799548;2304.5275718477837;2525.861077640729;2832.4193540324186;10192.337498062601;10275.537600807982;10296.330738502049;10450.16398688103;10863.239573229877;1783.7591925090076;1796.4251439539353;1836.1737218251706;1863.57137858292;1880.4734674291221;83729.16270837336;94147.58778618326;101234.49382753113;108468;118476;10669.679909602724;11204.831927521094;12088.637340879788;12142.75714485723;12256.264624122581;15948.441804536786;16053.357865685475;16102.114383708775;16160.676786464204;16219.351225951066;9417.246620270362;9455.669051583161;9485;9492.003339649376;9622.13400793932;9542.33203675736;9560.426374417557;9582.233421326277;9616.471094089893;9633.133018028271;4798.67264376777;4878.780454879539;4912.656114072052;4944.98627781304;4945.975270123627;1746;2012.8362010838407;2048.8873111978687;2054.9691754623395;2059.7631272403564;924.242121460396;941.9136612403559;943.297243553557;1038.771470276538;1061.082163928212;21276.78723212779;21356.893215533823;21477.89261053685;21579.35261942113;21641.891790540947;1003.6186249225248;1008.3798463944621;1053.820850455409;1056.9418681972566;1065.8028264771042;9574.32979691415;9746.122848943629;11119.499622517005;11547.653570392902;11617.535298587962;660395;667856;668862;681259;685335;79600;79607;84674.72987905187;109708;121932.39033804952;1052.8368102944055;1061.2359101446946;1082.929609575375;1088.1240601315858;1090.0625462102585;15771.290291937119;18860;18883.622327553647;19238;19353.4193974181;54192.72903635457;55700.72149639388;56540.717296413255;56951.29146125623;57025.14462283152;75070;78767;78954.6052269735;80154;83511.5824420874;7247.347738703542;8152.307053900485;8516.233538981522;8530.445521041112;8927.821443571222;9332.533373331442;12336.198147120409;12836.358182091044;13289.867101328862;13297.86702133005;9814.705558833246;11246.100311975186;11287.887121128684;11626.953574178026;11851.288922664668;11281.266717663326;11336.376499292288;11391;11578.189526733384;11668.708282292671;10749.14006879432;11608.709782255512;11609.767804644029;11904.345261010727;11929.761404771682;7494;8296.419250652396;8555.743327700178;8571.871421928552;8664.220220180214;10248.64129755455;11343.432828358384;11466.598669046543;11649.825252621047;11658.18392712536 10:22:46 INFO - PROCESS | 1659 | |3;mootools.html;1437.3603746332885;1632;1662.2769095443482;1936.1093896807467;2008.9385364014704;8233;8744.956275218623;8939.821203575924;8953.149450802179;8974.820503589932;8517.488950662964;8805.075467075962;8819;8828.249598784096;8860.64557417704;2535.366158460385;2561.6157576363603;2562.4362640219124;2565;2565.9486810263784;2498.3504288884837;2561.923142305734;2564.76917077463;2565.1150353128232;2587.042794166161;2540.5808041673104;2555.9488810223784;2575.214559559334;2577.574700174469;2577.8324408913454;2529.178017144435;2554.3869471326934;2562.4106455515334;2565.8588777617224;2566.7561581649716;2517.2002018556636;2541.1487151804167;2553.846769193836;2561.6157576363507;2574.11193138367;8629.352798540072;8855.557222138867;8996.59515321812;9042.321825863086;9044.186023257873;5545.584081193927;5668.603197776158;5687.03320435527;5726.398728133528;5736.827895163152;3624.1483251435893;3688.778673279585;3699.186179040607;3747.362948298796;3749.268892565951;1035;1044.843273508972;1063.0910571461443;1069;1078.9028987391093;12321.938390308082;12358.567450139202;12404.007679385628;12439.253644781342;12444.315562644142;4704.5765881070865;4721.409823772028;4832.081904438145;4857.6842505237755;4865.367502224688;9599.232061435068;9599.47202903833;9608.375455595364;9609.135177833889;9657.9034209657;5507.7246137692955;5545.584081193927;5552.278203833475;5552.472515111058;5566.025945459528;4574.290984897346;4751.904961900812;4935.8025678972435;5112.079825631422;5181.4300426953005;3287;3369.4777309517062;3912.471816304819;3976.0855003349393;3995.001249687578;1209.7338585511172;1211.3156066822216;1219.536576101076;1222.1750318534953;1223.1193540650718;862.4480332587149;937.2782957122977;944.8582712593166;967.8403063494444;968.9467079310565;5998.25021872266;6091.908621370683;6127.877442451215;6149.938500615026;6175.073738939105;482.6500786929518;485.4732615112572;487.7244356938318;497.6392115716149;498.86780003299157;3919.627635374635;4058.6753059755147;4067.166230922713;4071.025986333495;4121.093359460914;10779.35323880554;11077.889221107847;11158.553657853758;11330.660080197607;11345.716357091138;11122.221444498808;11129.165312601588;11138.108951283877;11170.385628790495;11187.216894817284;8058.919410805935;8534.061253262136;8551;8667.869981950276;8669.349798765117;5897.734601942837;5971.684172690443;6049.334573196857;6112.877742445037;6152.16945712341;9470.668526601536;9607.711768646952;9932.453715045742;10024.097831195228;10115.59537618487;9994.150497207818;10183.796324073624;10332.380057196593;10364.637237696645;10378.42918639482;6260.561760676709;6995.4753393494675;7179.1026121734785;7725.5364678119495;7864.606769661608;8314.62584183701;8375.790605234917;8426.115257897833;8436.24073833358;8458.70394536213;7278.890816637861;7356.521826081287;7397.482176247611;7508.58702771331;7516.5114267572435;7339.559626422431;7400.48196626231;7414.295641914009;7460.626968651654;7473.663685134074;6920.965395173193;7102.3962963148715;7128.358447739728;7132;7155.24869888675;4833.299171620025;4933.555979961677;4967.925481117858;5005.649604527648;5087.898242035065;4927.630427718007;5003.509226029023;5023.572996295356;5068.138416469135;5251.737413129405 10:22:46 INFO - PROCESS | 1659 | |4;prototype.html;279.2961736424211;293.39560505358963;328.4793602140609;345.0545505315433;349.739444114135;6618.702158402872;6795.456363490921;6860.3482669146415;6864.416524595409;6930.757423490179;6629.270780214172;6791.694373753181;6825.897611535831;6835.248122706498;6840.692168852401;5134.2812006319145;5134.409542902567;5139.331886854704;5139.794408223666;5149.742512874342;4794.017226468583;4875.463698993126;5127.7948882044675;5142.768575414116;5157.097507936115;4383.364412160235;5067.797288108472;5068.037072956145;5072.2391641253735;5080.41575218849;5013.623978201631;5062.974685126587;5073;5084.389873215201;5088.491150884919;4331.198728235287;4334.869953901357;4344.283193273106;4350.15172041452;4351.999040220735;5348.358197016344;6526.543141980063;6575.408213260829;6596.901046484307;6606.471482281406;4885.413750349945;5628.859278518029;5996.700164991733;5998.490128339096;6000.519958403361;7216.67524961378;7242.637868106626;7257.45569082321;7266.709331626728;7293.963530182368;4712.858614241578;4717.575418212343;4718.174319494109;4728.621710263205;4735.621150307967;7480.326770590618;7691.077070751489;7713.460057795956;7715;7716.922830771677;4418.624416924533;4793.424789025269;4794.328793968847;4794.640401969867;4806.519348065165;4422.823087076481;4684.297355396718;4822.734749588736;4871.342368780241;4885.60915126789;5781.219535362757;5784.797532086357;5819.709014549256;5827.854303642358;5871.55963302754;7296.343329100407;7299.963500182571;7311.963440182872;7312.597807120659;7316.817079573053;1604.9679006419806;1641.9343226271055;1642.9507114786575;1643.1619873864176;1671.8244584318716;1001.5493028137367;1051.6003918510917;1072.126217133034;1075.9193060520493;1080.195254535376;6744.5616034957575;6756.493263005196;6828.6927088281145;6851.2121106072445;6851.931480685229;6091.604045737013;7491.587962662106;7494.100707915085;7520.323170914644;7520.473566850268;6796.864062718718;6812.216595091529;6814.386705196556;6820.31796820314;6836.931630683729;3881.6118388160958;3958.0698535844053;4027.7583344999393;4031.274370613259;4063.959360406358;7930.563818990011;8000.599970001476;8005.919940800517;8014.759557213293;8031.678732850737;7876.527408355517;7888.092869319987;7888.7633370998965;7891.644875980594;7891.842163156704;7668.769936901902;7876.684932602746;7962.7213047543055;7984.161663025415;7999.36005119589;7572.621368931421;7620.885686714814;7637.541747495168;7646.388288936983;7658.885116723365;7491.026166598307;7493.70025198986;7494.475386722877;7502.474826762074;7503.699852005859;7997.960010199912;8011.9584454020605;8012.519248844855;8043.075046369742;8045.034595848536;4640.095181439587;4780.091782561302;4805.471398146271;4822.590079843252;4832.540908613676;7465.962670186615;7514.1358743742985;7538.283863033003;7539.623018849145;7539.811504712206;7269.418446524372;7272.818179545554;7290.234525374759;7298.051253337032;7305.379042781211;7287.105352608466;7472;7480.326770590455;7486.850262994819;7489.363404110493;5743.4256574342235;7038.612876291853;7131.108611423572;7156.463265255023;7167.283271672791;5822.970885145547;7136.857262854817;7216.206217315986;7274.308940650842;7294;7082.645867706491;7134.60759658203;7154.964225178841;7166.605836678824;7212.3148300911325 10:22:46 INFO - PROCESS | 1659 | |5;yui.html;706.5831159615826;732.787491627428;772.942029347799;794.3962588432792;795.3835777272614;11965.461554230058;15344.309506072226;15667.981581197242;15710.92144539277;15724.213789310532;14453.421863125488;14526;14529.128252304869;14538.854611453882;14551.636209094751;768.0783060327615;789.7393860026207;940.4122423485321;982.9164521015687;984.478226539935;955.4171955107379;955.5556666150238;969.3166317745972;969.839976403896;970.7524581231776;806.6410447350931;870.4951128345544;1017.5726194998082;1031.742064483879;1032.4579595712273;989.579428742785;1010.8736407949007;1012.3065699995526;1013.2096964367805;1014.6043043213152;755.958422286774;756.9053868266467;761.1095018827984;762.1121393576477;762.9694812207505;15464.381424742996;15578.610534736608;15593.688126237525;15617.453389131439;15618.219089045617;13041.673958151026;13297.800532992012;13510.256935868523;13679.316034198251;13753.862461375358;10334.948325258325;10409.115225205867;10475.79048419035;10731.517081731263;10818.891811081867;3539.876104336336;3568.2149927016017;3586.677199052098;3608.9278214435562;3655.250673611903;67191.99212011824;85761;86713.56643216807;87806.56096719476;88283;9299.581518831668;9711.174550163174;9879.506024698736;10407.895921040845;10467.633632822815;22917.823982223923;23204.3038708839;24028.51942961131;24068.51862962731;24133.276001719976;7857.017872765904;7938.364930805522;7969.282764551102;7988.520688758576;8051.51690898548;4214.789260536961;4232.640225580799;4251.6598672106775;4270.807813648331;4444;3832.3485007548784;3892.1242720387686;3893.805309734502;3896.4155376693725;3904.00447885793;584.9502792262621;656.7176114270814;681.6080753566719;704.1936982155403;731.5464412064554;542.5876333986199;594.5986459140149;606.5875204860737;617.8486270863577;647.8153726188013;8233.629486673113;8398.034226063959;8413.368997325226;8490.320774338039;8604;600.2856600645218;611.6819253987901;618.11300783376;620.0791824141147;624.7282432141942;3753.0992561784974;3916.3146449371247;3966.2464131814863;3968.900777480528;3972.781497017634;93966;95349.04650953402;95393.60055907669;96252;96818;85679.25966900332;86095.13904860997;86144.56927715322;86407;87447.25105497855;65827.67086164538;66661.66676666537;67003.66498167576;70026.99999999898;70739.64630176817;7879.172686867796;7921.32668723142;7949.443538952218;7969.880451793344;7990.960045199737;36806.63193368032;49567.51297461082;50354.244686329;51151;53191;65049.67475162594;68478.65760671165;70635.29364706288;70931;71664;10429.843552346569;10555.788884222426;10974;11369;11635.069194464591;11962.401879905796;12098.758024839279;12247.877521224673;12285.38573071325;12570.308633024906;8450.005211150978;11447.771044579229;11645.126615503701;12098.879011210127;12382.133250672727;11649.59226427071;11727;11768.646940591796;11880.643580692593;12122.818157727464;9316;11562.190646654653;11800.780708185588;11814.527418903492;11826.82259766087;8362.623681934449;9272.350935434455;9570.234381249622;9666.323357364918;9763.072508111718;9518.190953769008;9658.565364558752;9705.417674939526;9873.605055797687;9943.900560994587 10:22:46 INFO - PROCESS | 1659 | __end_tp_report 10:22:46 INFO - PROCESS | 1659 | __start_cc_report 10:22:46 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1292 10:22:46 INFO - PROCESS | 1659 | __end_cc_report 10:22:46 INFO - PROCESS | 1659 | __startTimestamp1467134566308__endTimestamp 10:22:46 INFO - PROCESS | 1659 | 10:22:46 INFO - PROCESS | 1659 | ------- Summary: start ------- 10:22:46 INFO - PROCESS | 1659 | Number of tests: 6 10:22:46 INFO - PROCESS | 1659 | 10:22:46 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5895.24 Median:6167.57 stddev:623.31 (10.1%) stddev-sans-first:598.47 10:22:46 INFO - PROCESS | 1659 | Values: 3592.3 3628.4 3655.1 3659.5 3725.2 5079.4 5331.9 5842.1 5906.4 5911.9 5876.3 5928.6 5932.2 5940.4 5951.2 5299.7 5321.6 5353.6 5399.5 5426.0 5409.1 5441.8 5444.9 5448.1 5451.4 5330.9 5401.3 5412.1 5416.4 5426.6 5422.4 5442.9 5470.4 5483.7 5525.0 5185.2 5260.1 5358.8 5380.0 5380.5 5777.9 5783.2 5800.1 5837.6 5872.4 6337.7 6366.3 6369.5 6373.0 6385.8 6221.0 6262.5 6317.3 6331.1 6340.8 6011.4 6019.6 6081.6 6085.3 6089.2 6359.2 6374.1 6374.6 6377.4 6381.7 6193.6 6239.9 6341.6 6348.9 6358.7 6321.0 6334.6 6335.3 6349.9 6360.3 6349.0 6364.1 6396.0 6400.8 6411.4 6285.3 6352.7 6377.3 6381.4 6388.5 5020.4 5065.6 5073.3 5102.8 5108.4 4557.6 4561.0 4563.1 4572.3 4608.1 5744.3 5951.8 5972.7 5986.7 5994.7 6036.1 6091.7 6335.1 6349.0 6370.1 5982.6 6002.2 6011.2 6016.6 6026.8 5463.9 5572.9 5578.9 5585.0 5596.2 6425.1 6469.5 6527.9 6538.2 6539.0 5341.6 6299.7 6309.2 6333.3 6338.5 6377.7 6553.6 6581.3 6594.6 6597.0 6287.0 6351.3 6354.2 6356.5 6385.7 5512.9 6167.6 6227.9 6300.8 6339.7 6190.7 6209.5 6274.7 6323.7 6327.6 6136.0 6269.0 6346.9 6348.7 6356.4 6242.6 6246.9 6249.8 6252.9 6262.0 5254.7 6159.9 6208.6 6325.8 6350.8 6196.4 6218.0 6224.1 6224.3 6229.8 10:22:46 INFO - PROCESS | 1659 | 10:22:46 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:65263.46 Median:36148.64 stddev:141519.02 (391.5%) stddev-sans-first:141832.55 10:22:46 INFO - PROCESS | 1659 | Values: 524.6 553.2 556.6 602.9 613.5 25884.6 32719.0 39430.8 39763.4 39790.8 43522.3 43852.6 43938.6 43948.0 43981.6 8947.3 9664.7 9900.3 9904.8 9922.6 8990.3 11895.9 12164.3 12190.3 12195.5 11753.0 11805.2 11855.5 11861.1 11885.2 11754.2 11799.4 11859.0 11861.1 11870.5 9967.3 12029.2 12039.0 12051.2 12059.8 41714.6 42207.6 42263.6 42269.6 42331.2 3353.9 3472.3 3520.2 3525.2 3567.7 28219.7 29051.8 29300.8 29455.0 30110.8 2777.4 2809.4 2811.3 2815.1 2844.9 391909.0 392688.0 392706.0 393132.0 394223.0 37333.3 38028.8 64009.0 64467.7 64595.0 36016.8 36280.5 36386.3 36408.5 36434.0 16071.5 16238.1 16239.6 16267.2 16274.5 13026.5 13036.7 13042.3 13043.9 13698.5 8447.7 8587.8 8625.1 8631.2 8714.0 3229.0 3400.1 3441.4 3518.8 3524.9 842.5 1044.3 1074.6 1086.3 1093.0 25411.5 25545.9 30177.2 30490.0 31097.8 857.9 1093.7 1135.1 1187.9 1221.8 13777.9 15290.0 15332.5 15639.5 15741.8 662195.0 662459.0 669310.0 669674.0 670547.0 62899.1 63682.4 63730.7 63772.0 63808.7 1361.8 1579.7 1599.0 1605.0 1605.4 29839.3 30546.8 30646.2 30841.3 32005.0 46491.3 54708.6 55018.9 55206.0 55580.4 292458.0 521671.0 524346.0 530243.0 536317.0 44421.0 44847.0 45225.3 45429.8 45993.3 47996.8 48178.8 48331.3 48702.8 49919.0 32461.7 38764.8 39453.4 39796.8 40490.8 37979.0 38905.6 39033.8 39726.4 39769.2 39142.2 39164.0 39371.8 40137.2 40198.6 31150.8 32882.8 32948.7 32951.5 32990.3 24560.0 24669.3 24687.6 25055.6 25188.9 10:22:46 INFO - PROCESS | 1659 | 10:22:46 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:36145.50 Median:2415.19 stddev:110749.99 (4585.6%) stddev-sans-first:111028.18 10:22:46 INFO - PROCESS | 1659 | Values: 418.7 420.2 422.2 425.2 430.9 20743.1 20751.1 20788.4 21372.9 21390.9 20849.4 21135.5 22120.4 22124.6 22139.6 5959.3 5999.1 6187.7 6213.3 6216.1 6047.5 6148.3 6156.4 6157.0 6163.0 5831.0 6175.4 6180.5 6182.8 6189.2 5868.2 6106.0 6142.0 6178.4 6188.8 5322.8 5358.2 5368.5 5376.5 5378.1 26828.3 27541.4 27706.6 27783.0 27863.0 2079.9 2234.7 2304.5 2525.9 2832.4 10192.3 10275.5 10296.3 10450.2 10863.2 1783.8 1796.4 1836.2 1863.6 1880.5 83729.2 94147.6 101234.5 108468.0 118476.0 10669.7 11204.8 12088.6 12142.8 12256.3 15948.4 16053.4 16102.1 16160.7 16219.4 9417.2 9455.7 9485.0 9492.0 9622.1 9542.3 9560.4 9582.2 9616.5 9633.1 4798.7 4878.8 4912.7 4945.0 4946.0 1746.0 2012.8 2048.9 2055.0 2059.8 924.2 941.9 943.3 1038.8 1061.1 21276.8 21356.9 21477.9 21579.4 21641.9 1003.6 1008.4 1053.8 1056.9 1065.8 9574.3 9746.1 11119.5 11547.7 11617.5 660395.0 667856.0 668862.0 681259.0 685335.0 79600.0 79607.0 84674.7 109708.0 121932.4 1052.8 1061.2 1082.9 1088.1 1090.1 15771.3 18860.0 18883.6 19238.0 19353.4 54192.7 55700.7 56540.7 56951.3 57025.1 75070.0 78767.0 78954.6 80154.0 83511.6 7247.3 8152.3 8516.2 8530.4 8927.8 9332.5 12336.2 12836.4 13289.9 13297.9 9814.7 11246.1 11287.9 11627.0 11851.3 11281.3 11336.4 11391.0 11578.2 11668.7 10749.1 11608.7 11609.8 11904.3 11929.8 7494.0 8296.4 8555.7 8571.9 8664.2 10248.6 11343.4 11466.6 11649.8 11658.2 10:22:46 INFO - PROCESS | 1659 | 10:22:46 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5822.68 Median:2732.78 stddev:3265.88 (119.5%) stddev-sans-first:3258.41 10:22:46 INFO - PROCESS | 1659 | Values: 1437.4 1632.0 1662.3 1936.1 2008.9 8233.0 8745.0 8939.8 8953.1 8974.8 8517.5 8805.1 8819.0 8828.2 8860.6 2535.4 2561.6 2562.4 2565.0 2565.9 2498.4 2561.9 2564.8 2565.1 2587.0 2540.6 2555.9 2575.2 2577.6 2577.8 2529.2 2554.4 2562.4 2565.9 2566.8 2517.2 2541.1 2553.8 2561.6 2574.1 8629.4 8855.6 8996.6 9042.3 9044.2 5545.6 5668.6 5687.0 5726.4 5736.8 3624.1 3688.8 3699.2 3747.4 3749.3 1035.0 1044.8 1063.1 1069.0 1078.9 12321.9 12358.6 12404.0 12439.3 12444.3 4704.6 4721.4 4832.1 4857.7 4865.4 9599.2 9599.5 9608.4 9609.1 9657.9 5507.7 5545.6 5552.3 5552.5 5566.0 4574.3 4751.9 4935.8 5112.1 5181.4 3287.0 3369.5 3912.5 3976.1 3995.0 1209.7 1211.3 1219.5 1222.2 1223.1 862.4 937.3 944.9 967.8 968.9 5998.3 6091.9 6127.9 6149.9 6175.1 482.7 485.5 487.7 497.6 498.9 3919.6 4058.7 4067.2 4071.0 4121.1 10779.4 11077.9 11158.6 11330.7 11345.7 11122.2 11129.2 11138.1 11170.4 11187.2 8058.9 8534.1 8551.0 8667.9 8669.3 5897.7 5971.7 6049.3 6112.9 6152.2 9470.7 9607.7 9932.5 10024.1 10115.6 9994.2 10183.8 10332.4 10364.6 10378.4 6260.6 6995.5 7179.1 7725.5 7864.6 8314.6 8375.8 8426.1 8436.2 8458.7 7278.9 7356.5 7397.5 7508.6 7516.5 7339.6 7400.5 7414.3 7460.6 7473.7 6921.0 7102.4 7128.4 7132.0 7155.2 4833.3 4933.6 4967.9 5005.6 5087.9 4927.6 5003.5 5023.6 5068.1 5251.7 10:22:46 INFO - PROCESS | 1659 | 10:22:46 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:5975.36 Median:6813.30 stddev:1932.04 (28.4%) stddev-sans-first:1889.57 10:22:46 INFO - PROCESS | 1659 | Values: 279.3 293.4 328.5 345.1 349.7 6618.7 6795.5 6860.3 6864.4 6930.8 6629.3 6791.7 6825.9 6835.2 6840.7 5134.3 5134.4 5139.3 5139.8 5149.7 4794.0 4875.5 5127.8 5142.8 5157.1 4383.4 5067.8 5068.0 5072.2 5080.4 5013.6 5063.0 5073.0 5084.4 5088.5 4331.2 4334.9 4344.3 4350.2 4352.0 5348.4 6526.5 6575.4 6596.9 6606.5 4885.4 5628.9 5996.7 5998.5 6000.5 7216.7 7242.6 7257.5 7266.7 7294.0 4712.9 4717.6 4718.2 4728.6 4735.6 7480.3 7691.1 7713.5 7715.0 7716.9 4418.6 4793.4 4794.3 4794.6 4806.5 4422.8 4684.3 4822.7 4871.3 4885.6 5781.2 5784.8 5819.7 5827.9 5871.6 7296.3 7300.0 7312.0 7312.6 7316.8 1605.0 1641.9 1643.0 1643.2 1671.8 1001.5 1051.6 1072.1 1075.9 1080.2 6744.6 6756.5 6828.7 6851.2 6851.9 6091.6 7491.6 7494.1 7520.3 7520.5 6796.9 6812.2 6814.4 6820.3 6836.9 3881.6 3958.1 4027.8 4031.3 4064.0 7930.6 8000.6 8005.9 8014.8 8031.7 7876.5 7888.1 7888.8 7891.6 7891.8 7668.8 7876.7 7962.7 7984.2 7999.4 7572.6 7620.9 7637.5 7646.4 7658.9 7491.0 7493.7 7494.5 7502.5 7503.7 7998.0 8012.0 8012.5 8043.1 8045.0 4640.1 4780.1 4805.5 4822.6 4832.5 7466.0 7514.1 7538.3 7539.6 7539.8 7269.4 7272.8 7290.2 7298.1 7305.4 7287.1 7472.0 7480.3 7486.9 7489.4 5743.4 7038.6 7131.1 7156.5 7167.3 5823.0 7136.9 7216.2 7274.3 7294.0 7082.6 7134.6 7155.0 7166.6 7212.3 10:22:46 INFO - PROCESS | 1659 | 10:22:46 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:18808.68 Median:603.44 stddev:26628.01 (4412.7%) stddev-sans-first:26668.01 10:22:46 INFO - PROCESS | 1659 | Values: 706.6 732.8 772.9 794.4 795.4 11965.5 15344.3 15668.0 15710.9 15724.2 14453.4 14526.0 14529.1 14538.9 14551.6 768.1 789.7 940.4 982.9 984.5 955.4 955.6 969.3 969.8 970.8 806.6 870.5 1017.6 1031.7 1032.5 989.6 1010.9 1012.3 1013.2 1014.6 756.0 756.9 761.1 762.1 763.0 15464.4 15578.6 15593.7 15617.5 15618.2 13041.7 13297.8 13510.3 13679.3 13753.9 10334.9 10409.1 10475.8 10731.5 10818.9 3539.9 3568.2 3586.7 3608.9 3655.3 67192.0 85761.0 86713.6 87806.6 88283.0 9299.6 9711.2 9879.5 10407.9 10467.6 22917.8 23204.3 24028.5 24068.5 24133.3 7857.0 7938.4 7969.3 7988.5 8051.5 4214.8 4232.6 4251.7 4270.8 4444.0 3832.3 3892.1 3893.8 3896.4 3904.0 585.0 656.7 681.6 704.2 731.5 542.6 594.6 606.6 617.8 647.8 8233.6 8398.0 8413.4 8490.3 8604.0 600.3 611.7 618.1 620.1 624.7 3753.1 3916.3 3966.2 3968.9 3972.8 93966.0 95349.0 95393.6 96252.0 96818.0 85679.3 86095.1 86144.6 86407.0 87447.3 65827.7 66661.7 67003.7 70027.0 70739.6 7879.2 7921.3 7949.4 7969.9 7991.0 36806.6 49567.5 50354.2 51151.0 53191.0 65049.7 68478.7 70635.3 70931.0 71664.0 10429.8 10555.8 10974.0 11369.0 11635.1 11962.4 12098.8 12247.9 12285.4 12570.3 8450.0 11447.8 11645.1 12098.9 12382.1 11649.6 11727.0 11768.6 11880.6 12122.8 9316.0 11562.2 11800.8 11814.5 11826.8 8362.6 9272.4 9570.2 9666.3 9763.1 9518.2 9658.6 9705.4 9873.6 9943.9 10:22:46 INFO - PROCESS | 1659 | -------- Summary: end -------- 10:22:46 INFO - PROCESS | 1659 | 10:22:46 INFO - TEST-INFO | 1659: exit 0 10:22:46 INFO - TEST-OK | dromaeo_css | took 1112966ms 10:22:46 INFO - TEST-START | kraken 10:22:46 INFO - operating with platform_type : mac_ 10:22:46 INFO - Initialising browser for kraken test... 10:22:46 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpSa65ba/profile http://localhost:49275/getInfo.html) 10:22:48 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 10:22:48 INFO - PROCESS | 1668 | colorDepth:24 10:22:48 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 10:22:48 INFO - PROCESS | 1668 | __metrics 10:22:49 INFO - PROCESS | 1668 | 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" 10:22:49 ERROR - PROCESS | 1668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:22:49 INFO - TEST-INFO | 1668: exit 0 10:22:49 INFO - Browser initialized. 10:22:49 INFO - Running cycle 1/1 for kraken test... 10:22:49 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpSa65ba/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:01 INFO - PROCESS | 1671 | RSS: Main: 161824768 10:23:01 INFO - PROCESS | 1671 | 10:23:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 10:23:04 INFO - PROCESS | 1671 | RSS: Main: 224374784 10:23:04 INFO - PROCESS | 1671 | 10:23:07 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 10:23:08 INFO - PROCESS | 1671 | RSS: Main: 239595520 10:23:08 INFO - PROCESS | 1671 | 10:23:11 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 10:23:12 INFO - PROCESS | 1671 | RSS: Main: 327835648 10:23:12 INFO - PROCESS | 1671 | 10:23:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 10:23:14 INFO - PROCESS | 1671 | RSS: Main: 232779776 10:23:14 INFO - PROCESS | 1671 | 10:23:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:17 INFO - PROCESS | 1671 | RSS: Main: 233963520 10:23:17 INFO - PROCESS | 1671 | 10:23:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:20 INFO - PROCESS | 1671 | RSS: Main: 271917056 10:23:20 INFO - PROCESS | 1671 | 10:23:23 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:24 INFO - PROCESS | 1671 | RSS: Main: 272793600 10:23:24 INFO - PROCESS | 1671 | 10:23:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 10:23:27 INFO - PROCESS | 1671 | RSS: Main: 269737984 10:23:27 INFO - PROCESS | 1671 | 10:23:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:23:29 INFO - PROCESS | 1671 | RSS: Main: 261001216 10:23:29 INFO - PROCESS | 1671 | 10:23:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:23:32 INFO - PROCESS | 1671 | RSS: Main: 267714560 10:23:32 INFO - PROCESS | 1671 | 10:23:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:23:34 INFO - PROCESS | 1671 | RSS: Main: 271462400 10:23:34 INFO - PROCESS | 1671 | 10:23:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:23:38 INFO - PROCESS | 1671 | RSS: Main: 278466560 10:23:38 INFO - PROCESS | 1671 | 10:23:41 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:23:41 INFO - PROCESS | 1671 | RSS: Main: 275607552 10:23:41 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 10:23:43 INFO - PROCESS | 1671 | RSS: Main: 336535552 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | __start_tp_report 10:23:43 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 10:23:43 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 10:23:43 INFO - PROCESS | 1671 | |i|pagename|runs| 10:23:43 INFO - PROCESS | 1671 | |0;ai-astar;114;113;119;111;111;113;113;113;112;133 10:23:43 INFO - PROCESS | 1671 | |1;audio-beat-detection;158;125;128;184;145;166;124;136;197;141 10:23:43 INFO - PROCESS | 1671 | |2;audio-dft;258;256;218;184;185;185;184;186;184;186 10:23:43 INFO - PROCESS | 1671 | |3;audio-fft;70;75;74;152;55;55;59;64;131;56 10:23:43 INFO - PROCESS | 1671 | |4;audio-oscillator;88;89;141;79;82;90;123;80;80;124 10:23:43 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;87;84;87;84;87;83;87;84;86;83 10:23:43 INFO - PROCESS | 1671 | |6;imaging-darkroom;94;95;94;95;116;126;94;95;94;92 10:23:43 INFO - PROCESS | 1671 | |7;imaging-desaturate;82;83;86;86;83;83;85;84;95;124 10:23:43 INFO - PROCESS | 1671 | |8;json-parse-financial;60;63;63;63;63;61;63;77;60;56 10:23:43 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;60;64;69;76;70;68;64;64;65;64 10:23:43 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;78;78;79;78;78;79;79;78;79;83 10:23:43 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;138;143;128;127;123;124;121;126;145;138 10:23:43 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;195;213;172;162;162;161;161;162;158;161 10:23:43 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;66;65;67;66;67;66;65;69;68;66 10:23:43 INFO - PROCESS | 1671 | __end_tp_report 10:23:43 INFO - PROCESS | 1671 | __start_cc_report 10:23:43 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1877 10:23:43 INFO - PROCESS | 1671 | __end_cc_report 10:23:43 INFO - PROCESS | 1671 | __startTimestamp1467134623587__endTimestamp 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | ------- Summary: start ------- 10:23:43 INFO - PROCESS | 1671 | Number of tests: 14 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:115.20 Median:113.00 stddev:6.65 (5.9%) stddev-sans-first:7.04 10:23:43 INFO - PROCESS | 1671 | Values: 114.0 113.0 119.0 111.0 111.0 113.0 113.0 113.0 112.0 133.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:151.50 stddev:25.32 (16.7%) stddev-sans-first:26.71 10:23:43 INFO - PROCESS | 1671 | Values: 158.0 125.0 128.0 184.0 145.0 166.0 124.0 136.0 197.0 141.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:202.60 Median:186.00 stddev:30.49 (16.4%) stddev-sans-first:24.89 10:23:43 INFO - PROCESS | 1671 | Values: 258.0 256.0 218.0 184.0 185.0 185.0 184.0 186.0 184.0 186.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:79.10 Median:61.50 stddev:34.09 (55.4%) stddev-sans-first:36.00 10:23:43 INFO - PROCESS | 1671 | Values: 70.0 75.0 74.0 152.0 55.0 55.0 59.0 64.0 131.0 56.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:81.00 stddev:22.75 (28.1%) stddev-sans-first:23.86 10:23:43 INFO - PROCESS | 1671 | Values: 88.0 89.0 141.0 79.0 82.0 90.0 123.0 80.0 80.0 124.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.50 stddev:1.75 (2.0%) stddev-sans-first:1.73 10:23:43 INFO - PROCESS | 1671 | Values: 87.0 84.0 87.0 84.0 87.0 83.0 87.0 84.0 86.0 83.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:94.00 stddev:11.61 (12.3%) stddev-sans-first:12.14 10:23:43 INFO - PROCESS | 1671 | Values: 94.0 95.0 94.0 95.0 116.0 126.0 94.0 95.0 94.0 92.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:89.10 Median:84.50 stddev:12.81 (15.2%) stddev-sans-first:13.33 10:23:43 INFO - PROCESS | 1671 | Values: 82.0 83.0 86.0 86.0 83.0 83.0 85.0 84.0 95.0 124.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:5.45 (8.6%) stddev-sans-first:5.67 10:23:43 INFO - PROCESS | 1671 | Values: 60.0 63.0 63.0 63.0 63.0 61.0 63.0 77.0 60.0 56.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:4.48 (6.7%) stddev-sans-first:4.11 10:23:43 INFO - PROCESS | 1671 | Values: 60.0 64.0 69.0 76.0 70.0 68.0 64.0 64.0 65.0 64.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:1.52 (1.9%) stddev-sans-first:1.58 10:23:43 INFO - PROCESS | 1671 | Values: 78.0 78.0 79.0 78.0 78.0 79.0 79.0 78.0 79.0 83.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:133.00 stddev:8.82 (6.6%) stddev-sans-first:9.02 10:23:43 INFO - PROCESS | 1671 | Values: 138.0 143.0 128.0 127.0 123.0 124.0 121.0 126.0 145.0 138.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:162.00 stddev:18.42 (11.4%) stddev-sans-first:17.31 10:23:43 INFO - PROCESS | 1671 | Values: 195.0 213.0 172.0 162.0 162.0 161.0 161.0 162.0 158.0 161.0 10:23:43 INFO - PROCESS | 1671 | 10:23:43 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.27 (1.9%) stddev-sans-first:1.33 10:23:43 INFO - PROCESS | 1671 | Values: 66.0 65.0 67.0 66.0 67.0 66.0 65.0 69.0 68.0 66.0 10:23:43 INFO - PROCESS | 1671 | -------- Summary: end -------- 10:23:43 INFO - PROCESS | 1671 | 10:23:44 INFO - TEST-INFO | 1671: exit 0 10:23:44 INFO - TEST-OK | kraken | took 57453ms 10:23:44 INFO - SUITE-END | took 1170s 10:23:44 INFO - Completed test suite (00:19:30) 10:23:44 INFO - javascript benchmark 10:23:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3592.335417947679, 3628.437592173214, 3655.0679576707935, 3659.5059666944953, 3725.180460298733, 5079.4412614612365, 5331.893362132765, 5842.0652695568715, 5906.350301466835, 5911.88176236475, 5876.324222714389, 5928.5553583481305, 5932.169496270526, 5940.3762604926505, 5951.196588460556, 5299.682019078858, 5321.600879934001, 5353.625246232766, 5399.541039011689, 5426.0, 5409.053415652264, 5441.809536666217, 5444.863878403032, 5448.128299472085, 5451.400345961941, 5330.946690533103, 5401.27082843817, 5412.134058550632, 5416.404195538487, 5426.647267927592, 5422.376426710939, 5442.91835622466, 5470.425605311425, 5483.698396588186, 5525.005499010176, 5185.222216667492, 5260.105782017028, 5358.758855851457, 5380.0, 5380.488853558905, 5777.884442311172, 5783.161441590988, 5800.100984347433, 5837.5913686041995, 5872.442117998783, 6337.746490140389, 6366.299707032223, 6369.5222858285815, 6372.997197200222, 6385.7764978226005, 6220.968895155495, 6262.499000079983, 6317.273513545955, 6331.145295385156, 6340.841478963062, 6011.428914253139, 6019.624891317849, 6081.604695694766, 6085.269767627913, 6089.208402907638, 6359.20509936258, 6374.07575901501, 6374.617522948638, 6377.426031657174, 6381.744730210739, 6193.628382297076, 6239.937600624026, 6341.556091073673, 6348.873022539616, 6358.650274234869, 6320.968395157995, 6334.619922804646, 6335.303116657164, 6349.936500634934, 6360.268569114519, 6349.0476428536085, 6364.1408409865, 6395.968020159869, 6400.839979000469, 6411.358864113645, 6285.340039295899, 6352.7141278642575, 6377.3303803100935, 6381.361863813581, 6388.488920886318, 5020.397552293675, 5065.645404821627, 5073.34046573943, 5102.795888164506, 5108.386993560796, 4557.589816916494, 4560.95439045612, 4563.133004729091, 4572.337011133367, 4608.147492713859, 5744.310682718101, 5951.791687290924, 5972.701364931736, 5986.73059712314, 5994.730237139339, 6036.124761909498, 6091.659834836329, 6335.081413195061, 6349.0, 6370.140031095742, 5982.551308651869, 6002.219711437572, 6011.152046201317, 6016.639001659914, 6026.819195424145, 5463.918041229305, 5572.888542229132, 5578.944210557843, 5584.96678114542, 5596.160575913564, 6425.068365087036, 6469.54713170083, 6527.934720652923, 6538.215414150332, 6538.967305163444, 5341.572674185978, 6299.685015749286, 6309.211348581427, 6333.334999824952, 6338.461230795249, 6377.681115944277, 6553.639549824806, 6581.276059633341, 6594.637294948632, 6596.967015164893, 6287.0, 6351.333110023381, 6354.23749150105, 6356.523260755369, 6385.744570217139, 5512.889742205213, 6167.5682702210415, 6227.906581401373, 6300.779472718433, 6339.683015849097, 6190.721417536131, 6209.472194863307, 6274.6548939808745, 6323.715432805627, 6327.620342779448, 6135.969320153371, 6268.968655156695, 6346.904796427965, 6348.714307856065, 6356.364363563606, 6242.5942313749465, 6246.875062498815, 6249.781257656142, 6252.937470625236, 6261.998080307129, 5254.65844720092, 6159.938400616115, 6208.565400422108, 6325.778597749057, 6350.7777227796805, 6196.411340922605, 6217.96891015542, 6224.128621993015, 6224.346443623354, 6229.813105606839], "value": 5858.737690209141, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.6170295684151, 553.24758328673, 556.579598075799, 602.9306629737581, 613.4662843326304, 25884.61173082403, 32719.018429447126, 39430.81707548774, 39763.40354894671, 39790.801045994805, 43522.347164792474, 43852.56147438525, 43938.56061439385, 43948.0, 43981.56018439815, 8947.32895032875, 9664.661736839213, 9900.257480688977, 9904.752381190456, 9922.553485093153, 8990.325725570576, 11895.881041189565, 12164.330961797097, 12190.329531875743, 12195.451204695766, 11753.0, 11805.23265987708, 11855.466504007298, 11861.110416718737, 11885.168038237327, 11754.235974661662, 11799.410029498576, 11859.0, 11861.11041671878, 11870.52517899283, 9967.302288839785, 12029.157958942878, 12039.0, 12051.216670916363, 12059.819102713378, 41714.58285417137, 42207.57792422067, 42263.57736422627, 42269.57730422687, 42331.15337693229, 3353.8826141084946, 3472.2881809229048, 3520.1903562180587, 3525.189206482498, 3567.714582833367, 28219.717802821913, 29051.837926482916, 29300.827966881512, 29455.0, 30110.84944575285, 2777.4306267215175, 2809.3959798643186, 2811.325281932342, 2815.0569559197693, 2844.857757112157, 391909.0, 392688.0, 392706.0364698158, 393132.03433982935, 394223.0, 37333.25333493315, 38028.809855950545, 64009.03986440207, 64467.67766161233, 64595.0, 36016.819915900254, 36280.45579316312, 36386.27227455489, 36408.453873191924, 36434.0, 16071.517854464384, 16238.10690412015, 16239.59401014984, 16267.18664066792, 16274.511764647079, 13026.47894084226, 13036.739265214832, 13042.282674452807, 13043.869561304455, 13698.45206191741, 8447.66209351619, 8587.828243435097, 8625.13748625145, 8631.223189912938, 8714.0, 3228.9505910579155, 3400.064982129934, 3441.380551500754, 3518.7712798668003, 3524.8942531724088, 842.5450256861349, 1044.3474321896088, 1074.6453670288943, 1086.3319058778952, 1092.956281748721, 25411.49177016449, 25545.872270638527, 30177.245568860955, 30490.0, 31097.844510777755, 857.8713193021097, 1093.6882988348282, 1135.0919264588297, 1187.857457105153, 1221.8106193540016, 13777.862221377658, 15290.0, 15332.540023799304, 15639.530814075595, 15741.763873541906, 662195.0, 662459.0, 669310.0, 669674.0, 670547.0, 62899.056514152326, 63682.36317636857, 63730.6813465939, 63772.043419348745, 63808.68095659492, 1361.7889227169806, 1579.6998570271612, 1599.016604788047, 1604.9839501605302, 1605.4380966661809, 29839.254018649706, 30546.84726576353, 30646.233844154074, 30841.292893645215, 32005.0, 46491.3026304599, 54708.63228419321, 55018.89962200814, 55206.0, 55580.44419555915, 292458.0, 521671.0, 524346.0, 530243.0, 536317.0, 44421.0, 44847.0, 45225.32162017506, 45429.77285113553, 45993.31010034919, 47996.760016199696, 48178.75910620424, 48331.275030875266, 48702.75648621734, 49919.0, 32461.67538324681, 38764.806175970065, 39453.40819887647, 39796.80101599474, 40490.79754601208, 37979.0, 38905.61094389133, 39033.80483097566, 39726.404103937886, 39769.20461590694, 39142.217155657294, 39164.0, 39371.80314098411, 40137.1972560553, 40198.59801401949, 31150.794642722944, 32882.835585821915, 32948.67051329456, 32951.50572741459, 32990.34019319648, 24560.0, 24669.259922202364, 24687.629685554373, 25055.624165637164, 25188.874055629603], "value": 19447.164193656754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.70899724691344, 420.24146415719616, 422.1788621131899, 425.2324554179708, 430.92027974824657, 20743.066562004708, 20751.06620202091, 20788.376348709524, 21372.931353432323, 21390.89304553475, 20849.374518764424, 21135.471613209676, 22120.446988825286, 22124.55750884981, 22139.557208855815, 5959.284885813709, 5999.100134979766, 6187.690615469209, 6213.25440947087, 6216.129741836146, 6047.455728984391, 6148.262208534982, 6156.38436156383, 6156.984097623909, 6162.983107787232, 5831.0, 6175.413335733098, 6180.474659653913, 6182.752689892399, 6189.226346706661, 5868.207791948075, 6105.969470152643, 6142.0, 6178.443940045373, 6188.84527886802, 5322.760475778599, 5358.169483730028, 5368.516833485005, 5376.516113549799, 5378.139497680352, 26828.329291767666, 27541.449171016466, 27706.584401234, 27783.027594034313, 27863.0, 2079.906404211799, 2234.6648002799548, 2304.5275718477837, 2525.861077640729, 2832.4193540324186, 10192.337498062601, 10275.537600807982, 10296.330738502049, 10450.16398688103, 10863.239573229877, 1783.7591925090076, 1796.4251439539353, 1836.1737218251706, 1863.57137858292, 1880.4734674291221, 83729.16270837336, 94147.58778618326, 101234.49382753113, 108468.0, 118476.0, 10669.679909602724, 11204.831927521094, 12088.637340879788, 12142.75714485723, 12256.264624122581, 15948.441804536786, 16053.357865685475, 16102.114383708775, 16160.676786464204, 16219.351225951066, 9417.246620270362, 9455.669051583161, 9485.0, 9492.003339649376, 9622.13400793932, 9542.33203675736, 9560.426374417557, 9582.233421326277, 9616.471094089893, 9633.133018028271, 4798.67264376777, 4878.780454879539, 4912.656114072052, 4944.98627781304, 4945.975270123627, 1746.0, 2012.8362010838407, 2048.8873111978687, 2054.9691754623395, 2059.7631272403564, 924.242121460396, 941.9136612403559, 943.297243553557, 1038.771470276538, 1061.082163928212, 21276.78723212779, 21356.893215533823, 21477.89261053685, 21579.35261942113, 21641.891790540947, 1003.6186249225248, 1008.3798463944621, 1053.820850455409, 1056.9418681972566, 1065.8028264771042, 9574.32979691415, 9746.122848943629, 11119.499622517005, 11547.653570392902, 11617.535298587962, 660395.0, 667856.0, 668862.0, 681259.0, 685335.0, 79600.0, 79607.0, 84674.72987905187, 109708.0, 121932.39033804952, 1052.8368102944055, 1061.2359101446946, 1082.929609575375, 1088.1240601315858, 1090.0625462102585, 15771.290291937119, 18860.0, 18883.622327553647, 19238.0, 19353.4193974181, 54192.72903635457, 55700.72149639388, 56540.717296413255, 56951.29146125623, 57025.14462283152, 75070.0, 78767.0, 78954.6052269735, 80154.0, 83511.5824420874, 7247.347738703542, 8152.307053900485, 8516.233538981522, 8530.445521041112, 8927.821443571222, 9332.533373331442, 12336.198147120409, 12836.358182091044, 13289.867101328862, 13297.86702133005, 9814.705558833246, 11246.100311975186, 11287.887121128684, 11626.953574178026, 11851.288922664668, 11281.266717663326, 11336.376499292288, 11391.0, 11578.189526733384, 11668.708282292671, 10749.14006879432, 11608.709782255512, 11609.767804644029, 11904.345261010727, 11929.761404771682, 7494.0, 8296.419250652396, 8555.743327700178, 8571.871421928552, 8664.220220180214, 10248.64129755455, 11343.432828358384, 11466.598669046543, 11649.825252621047, 11658.18392712536], "value": 9844.856722055425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.3603746332885, 1632.0, 1662.2769095443482, 1936.1093896807467, 2008.9385364014704, 8233.0, 8744.956275218623, 8939.821203575924, 8953.149450802179, 8974.820503589932, 8517.488950662964, 8805.075467075962, 8819.0, 8828.249598784096, 8860.64557417704, 2535.366158460385, 2561.6157576363603, 2562.4362640219124, 2565.0, 2565.9486810263784, 2498.3504288884837, 2561.923142305734, 2564.76917077463, 2565.1150353128232, 2587.042794166161, 2540.5808041673104, 2555.9488810223784, 2575.214559559334, 2577.574700174469, 2577.8324408913454, 2529.178017144435, 2554.3869471326934, 2562.4106455515334, 2565.8588777617224, 2566.7561581649716, 2517.2002018556636, 2541.1487151804167, 2553.846769193836, 2561.6157576363507, 2574.11193138367, 8629.352798540072, 8855.557222138867, 8996.59515321812, 9042.321825863086, 9044.186023257873, 5545.584081193927, 5668.603197776158, 5687.03320435527, 5726.398728133528, 5736.827895163152, 3624.1483251435893, 3688.778673279585, 3699.186179040607, 3747.362948298796, 3749.268892565951, 1035.0, 1044.843273508972, 1063.0910571461443, 1069.0, 1078.9028987391093, 12321.938390308082, 12358.567450139202, 12404.007679385628, 12439.253644781342, 12444.315562644142, 4704.5765881070865, 4721.409823772028, 4832.081904438145, 4857.6842505237755, 4865.367502224688, 9599.232061435068, 9599.47202903833, 9608.375455595364, 9609.135177833889, 9657.9034209657, 5507.7246137692955, 5545.584081193927, 5552.278203833475, 5552.472515111058, 5566.025945459528, 4574.290984897346, 4751.904961900812, 4935.8025678972435, 5112.079825631422, 5181.4300426953005, 3287.0, 3369.4777309517062, 3912.471816304819, 3976.0855003349393, 3995.001249687578, 1209.7338585511172, 1211.3156066822216, 1219.536576101076, 1222.1750318534953, 1223.1193540650718, 862.4480332587149, 937.2782957122977, 944.8582712593166, 967.8403063494444, 968.9467079310565, 5998.25021872266, 6091.908621370683, 6127.877442451215, 6149.938500615026, 6175.073738939105, 482.6500786929518, 485.4732615112572, 487.7244356938318, 497.6392115716149, 498.86780003299157, 3919.627635374635, 4058.6753059755147, 4067.166230922713, 4071.025986333495, 4121.093359460914, 10779.35323880554, 11077.889221107847, 11158.553657853758, 11330.660080197607, 11345.716357091138, 11122.221444498808, 11129.165312601588, 11138.108951283877, 11170.385628790495, 11187.216894817284, 8058.919410805935, 8534.061253262136, 8551.0, 8667.869981950276, 8669.349798765117, 5897.734601942837, 5971.684172690443, 6049.334573196857, 6112.877742445037, 6152.16945712341, 9470.668526601536, 9607.711768646952, 9932.453715045742, 10024.097831195228, 10115.59537618487, 9994.150497207818, 10183.796324073624, 10332.380057196593, 10364.637237696645, 10378.42918639482, 6260.561760676709, 6995.4753393494675, 7179.1026121734785, 7725.5364678119495, 7864.606769661608, 8314.62584183701, 8375.790605234917, 8426.115257897833, 8436.24073833358, 8458.70394536213, 7278.890816637861, 7356.521826081287, 7397.482176247611, 7508.58702771331, 7516.5114267572435, 7339.559626422431, 7400.48196626231, 7414.295641914009, 7460.626968651654, 7473.663685134074, 6920.965395173193, 7102.3962963148715, 7128.358447739728, 7132.0, 7155.24869888675, 4833.299171620025, 4933.555979961677, 4967.925481117858, 5005.649604527648, 5087.898242035065, 4927.630427718007, 5003.509226029023, 5023.572996295356, 5068.138416469135, 5251.737413129405], "value": 4624.884680855625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.2961736424211, 293.39560505358963, 328.4793602140609, 345.0545505315433, 349.739444114135, 6618.702158402872, 6795.456363490921, 6860.3482669146415, 6864.416524595409, 6930.757423490179, 6629.270780214172, 6791.694373753181, 6825.897611535831, 6835.248122706498, 6840.692168852401, 5134.2812006319145, 5134.409542902567, 5139.331886854704, 5139.794408223666, 5149.742512874342, 4794.017226468583, 4875.463698993126, 5127.7948882044675, 5142.768575414116, 5157.097507936115, 4383.364412160235, 5067.797288108472, 5068.037072956145, 5072.2391641253735, 5080.41575218849, 5013.623978201631, 5062.974685126587, 5073.0, 5084.389873215201, 5088.491150884919, 4331.198728235287, 4334.869953901357, 4344.283193273106, 4350.15172041452, 4351.999040220735, 5348.358197016344, 6526.543141980063, 6575.408213260829, 6596.901046484307, 6606.471482281406, 4885.413750349945, 5628.859278518029, 5996.700164991733, 5998.490128339096, 6000.519958403361, 7216.67524961378, 7242.637868106626, 7257.45569082321, 7266.709331626728, 7293.963530182368, 4712.858614241578, 4717.575418212343, 4718.174319494109, 4728.621710263205, 4735.621150307967, 7480.326770590618, 7691.077070751489, 7713.460057795956, 7715.0, 7716.922830771677, 4418.624416924533, 4793.424789025269, 4794.328793968847, 4794.640401969867, 4806.519348065165, 4422.823087076481, 4684.297355396718, 4822.734749588736, 4871.342368780241, 4885.60915126789, 5781.219535362757, 5784.797532086357, 5819.709014549256, 5827.854303642358, 5871.55963302754, 7296.343329100407, 7299.963500182571, 7311.963440182872, 7312.597807120659, 7316.817079573053, 1604.9679006419806, 1641.9343226271055, 1642.9507114786575, 1643.1619873864176, 1671.8244584318716, 1001.5493028137367, 1051.6003918510917, 1072.126217133034, 1075.9193060520493, 1080.195254535376, 6744.5616034957575, 6756.493263005196, 6828.6927088281145, 6851.2121106072445, 6851.931480685229, 6091.604045737013, 7491.587962662106, 7494.100707915085, 7520.323170914644, 7520.473566850268, 6796.864062718718, 6812.216595091529, 6814.386705196556, 6820.31796820314, 6836.931630683729, 3881.6118388160958, 3958.0698535844053, 4027.7583344999393, 4031.274370613259, 4063.959360406358, 7930.563818990011, 8000.599970001476, 8005.919940800517, 8014.759557213293, 8031.678732850737, 7876.527408355517, 7888.092869319987, 7888.7633370998965, 7891.644875980594, 7891.842163156704, 7668.769936901902, 7876.684932602746, 7962.7213047543055, 7984.161663025415, 7999.36005119589, 7572.621368931421, 7620.885686714814, 7637.541747495168, 7646.388288936983, 7658.885116723365, 7491.026166598307, 7493.70025198986, 7494.475386722877, 7502.474826762074, 7503.699852005859, 7997.960010199912, 8011.9584454020605, 8012.519248844855, 8043.075046369742, 8045.034595848536, 4640.095181439587, 4780.091782561302, 4805.471398146271, 4822.590079843252, 4832.540908613676, 7465.962670186615, 7514.1358743742985, 7538.283863033003, 7539.623018849145, 7539.811504712206, 7269.418446524372, 7272.818179545554, 7290.234525374759, 7298.051253337032, 7305.379042781211, 7287.105352608466, 7472.0, 7480.326770590455, 7486.850262994819, 7489.363404110493, 5743.4256574342235, 7038.612876291853, 7131.108611423572, 7156.463265255023, 7167.283271672791, 5822.970885145547, 7136.857262854817, 7216.206217315986, 7274.308940650842, 7294.0, 7082.645867706491, 7134.60759658203, 7154.964225178841, 7166.605836678824, 7212.3148300911325], "value": 5314.937431794193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.5831159615826, 732.787491627428, 772.942029347799, 794.3962588432792, 795.3835777272614, 11965.461554230058, 15344.309506072226, 15667.981581197242, 15710.92144539277, 15724.213789310532, 14453.421863125488, 14526.0, 14529.128252304869, 14538.854611453882, 14551.636209094751, 768.0783060327615, 789.7393860026207, 940.4122423485321, 982.9164521015687, 984.478226539935, 955.4171955107379, 955.5556666150238, 969.3166317745972, 969.839976403896, 970.7524581231776, 806.6410447350931, 870.4951128345544, 1017.5726194998082, 1031.742064483879, 1032.4579595712273, 989.579428742785, 1010.8736407949007, 1012.3065699995526, 1013.2096964367805, 1014.6043043213152, 755.958422286774, 756.9053868266467, 761.1095018827984, 762.1121393576477, 762.9694812207505, 15464.381424742996, 15578.610534736608, 15593.688126237525, 15617.453389131439, 15618.219089045617, 13041.673958151026, 13297.800532992012, 13510.256935868523, 13679.316034198251, 13753.862461375358, 10334.948325258325, 10409.115225205867, 10475.79048419035, 10731.517081731263, 10818.891811081867, 3539.876104336336, 3568.2149927016017, 3586.677199052098, 3608.9278214435562, 3655.250673611903, 67191.99212011824, 85761.0, 86713.56643216807, 87806.56096719476, 88283.0, 9299.581518831668, 9711.174550163174, 9879.506024698736, 10407.895921040845, 10467.633632822815, 22917.823982223923, 23204.3038708839, 24028.51942961131, 24068.51862962731, 24133.276001719976, 7857.017872765904, 7938.364930805522, 7969.282764551102, 7988.520688758576, 8051.51690898548, 4214.789260536961, 4232.640225580799, 4251.6598672106775, 4270.807813648331, 4444.0, 3832.3485007548784, 3892.1242720387686, 3893.805309734502, 3896.4155376693725, 3904.00447885793, 584.9502792262621, 656.7176114270814, 681.6080753566719, 704.1936982155403, 731.5464412064554, 542.5876333986199, 594.5986459140149, 606.5875204860737, 617.8486270863577, 647.8153726188013, 8233.629486673113, 8398.034226063959, 8413.368997325226, 8490.320774338039, 8604.0, 600.2856600645218, 611.6819253987901, 618.11300783376, 620.0791824141147, 624.7282432141942, 3753.0992561784974, 3916.3146449371247, 3966.2464131814863, 3968.900777480528, 3972.781497017634, 93966.0, 95349.04650953402, 95393.60055907669, 96252.0, 96818.0, 85679.25966900332, 86095.13904860997, 86144.56927715322, 86407.0, 87447.25105497855, 65827.67086164538, 66661.66676666537, 67003.66498167576, 70026.99999999898, 70739.64630176817, 7879.172686867796, 7921.32668723142, 7949.443538952218, 7969.880451793344, 7990.960045199737, 36806.63193368032, 49567.51297461082, 50354.244686329, 51151.0, 53191.0, 65049.67475162594, 68478.65760671165, 70635.29364706288, 70931.0, 71664.0, 10429.843552346569, 10555.788884222426, 10974.0, 11369.0, 11635.069194464591, 11962.401879905796, 12098.758024839279, 12247.877521224673, 12285.38573071325, 12570.308633024906, 8450.005211150978, 11447.771044579229, 11645.126615503701, 12098.879011210127, 12382.133250672727, 11649.59226427071, 11727.0, 11768.646940591796, 11880.643580692593, 12122.818157727464, 9316.0, 11562.190646654653, 11800.780708185588, 11814.527418903492, 11826.82259766087, 8362.623681934449, 9272.350935434455, 9570.234381249622, 9666.323357364918, 9763.072508111718, 9518.190953769008, 9658.565364558752, 9705.417674939526, 9873.605055797687, 9943.900560994587], "value": 7115.87973872508, "unit": "score"}], "name": "dromaeo_css", "value": 7622.933477288571, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 119.0, 111.0, 111.0, 113.0, 113.0, 113.0, 112.0, 133.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 128.0, 184.0, 145.0, 166.0, 124.0, 136.0, 197.0, 141.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [258.0, 256.0, 218.0, 184.0, 185.0, 185.0, 184.0, 186.0, 184.0, 186.0], "value": 202.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 74.0, 152.0, 55.0, 55.0, 59.0, 64.0, 131.0, 56.0], "value": 79.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 141.0, 79.0, 82.0, 90.0, 123.0, 80.0, 80.0, 124.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 86.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 116.0, 126.0, 94.0, 95.0, 94.0, 92.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 86.0, 86.0, 83.0, 83.0, 85.0, 84.0, 95.0, 124.0], "value": 89.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 63.0, 63.0, 63.0, 61.0, 63.0, 77.0, 60.0, 56.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 69.0, 76.0, 70.0, 68.0, 64.0, 64.0, 65.0, 64.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 78.0, 78.0, 79.0, 79.0, 78.0, 79.0, 83.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 143.0, 128.0, 127.0, 123.0, 124.0, 121.0, 126.0, 145.0, 138.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 213.0, 172.0, 162.0, 162.0, 161.0, 161.0, 162.0, 158.0, 161.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 67.0, 66.0, 65.0, 69.0, 68.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1495.4000000000003, "alertThreshold": 2.0}]} 10:23:44 INFO - Return code: 0 10:23:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:23:44 ERROR - # TBPL SUCCESS # 10:23:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:23:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:23:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:23:44 INFO - 2016-06-28 10:23:44.903 screenresolution[1675:9749] starting screenresolution argv=screenresolution get 10:23:44 INFO - 2016-06-28 10:23:44.906 screenresolution[1675:9749] Display 0: 1600x1200x32@60 10:23:44 INFO - 2016-06-28 10:23:44.912 screenresolution[1676:9753] starting screenresolution argv=screenresolution list 10:23:44 INFO - Available Modes on Display 0 10:23:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:23:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:23:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:23:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:23:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:23:45 INFO - Intel Iris: 10:23:45 INFO - Chipset Model: Intel Iris 10:23:45 INFO - Type: GPU 10:23:45 INFO - Bus: Built-In 10:23:45 INFO - VRAM (Dynamic, Max): 1536 MB 10:23:45 INFO - Vendor: Intel (0x8086) 10:23:45 INFO - Device ID: 0x0a2e 10:23:45 INFO - Revision ID: 0x0009 10:23:45 INFO - Displays: 10:23:45 INFO - Display: 10:23:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:23:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:23:45 INFO - Display Serial Number: 1600x1200 60 10:23:45 INFO - Main Display: Yes 10:23:45 INFO - Mirror: Off 10:23:45 INFO - Online: Yes 10:23:45 INFO - Rotation: Supported 10:23:45 INFO - Return code: 0 10:23:45 INFO - Running post-action listener: _resource_record_post_action 10:23:45 INFO - Running post-run listener: _resource_record_post_run 10:23:46 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 37889536; Write bytes: 493261312; Read time: 391; Write time: 1810 10:23:46 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 182977024; Write bytes: 178624000; Read time: 16575; Write time: 370 10:23:46 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 36967936; Write bytes: 296320000; Read time: 378; Write time: 1387 10:23:46 INFO - Running post-run listener: _upload_blobber_files 10:23:46 INFO - Blob upload gear active. 10:23:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:23:46 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 10:23:46 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:23:46 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:23:46 INFO - (blobuploader) - INFO - Open directory for files ... 10:23:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:23:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:23:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:47 INFO - (blobuploader) - INFO - Done attempting. 10:23:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:23:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:23:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:48 INFO - (blobuploader) - INFO - Done attempting. 10:23:48 INFO - (blobuploader) - INFO - Iteration through files over. 10:23:48 INFO - Return code: 0 10:23:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:23:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:23:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8b90a124aceffb48f832e01bf5b2941255f9491666a6d6600eae982a3c2667a8a96a5d379b6760de7a5ad8474f0c18a81abc8a79a230740b89e9a6afcd795500", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3bdb83637f9c145677c3293407e155d1b750a92e3ac889fd266158fd254ad3d3093e30fde5ced6fa5577bacb37104312fa2fca9c3133dc14f4570900508d61b"} 10:23:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:23:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:23:48 INFO - Contents: 10:23:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8b90a124aceffb48f832e01bf5b2941255f9491666a6d6600eae982a3c2667a8a96a5d379b6760de7a5ad8474f0c18a81abc8a79a230740b89e9a6afcd795500", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3bdb83637f9c145677c3293407e155d1b750a92e3ac889fd266158fd254ad3d3093e30fde5ced6fa5577bacb37104312fa2fca9c3133dc14f4570900508d61b"} 10:23:48 INFO - Running post-run listener: copy_logs_to_upload_dir 10:23:48 INFO - Copying logs to upload dir... 10:23:48 INFO - mkdir: /builds/slave/test/build/upload/logs 10:23:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.257045 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-28 10:23:48.387034) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:23:48.390825) ========= 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.fXTgqMc28N/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.0KPU85dN2s/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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/Mozilla-Beta/sha512/8b90a124aceffb48f832e01bf5b2941255f9491666a6d6600eae982a3c2667a8a96a5d379b6760de7a5ad8474f0c18a81abc8a79a230740b89e9a6afcd795500", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3bdb83637f9c145677c3293407e155d1b750a92e3ac889fd266158fd254ad3d3093e30fde5ced6fa5577bacb37104312fa2fca9c3133dc14f4570900508d61b"} build_url:https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009859 build_url: 'https://queue.taskcluster.net/v1/task/OVEL36guReawWAukG4YWtA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8b90a124aceffb48f832e01bf5b2941255f9491666a6d6600eae982a3c2667a8a96a5d379b6760de7a5ad8474f0c18a81abc8a79a230740b89e9a6afcd795500", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3bdb83637f9c145677c3293407e155d1b750a92e3ac889fd266158fd254ad3d3093e30fde5ced6fa5577bacb37104312fa2fca9c3133dc14f4570900508d61b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:23:48.420472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:23:48.420818) ========= 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.fXTgqMc28N/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.0KPU85dN2s/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.004708 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:23:48.469280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:23:48.469614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:23:48.469955) ========= ========= Total master_lag: 0.17 =========