builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0233 starttime: 1470879720.53 results: success (0) buildid: 20160810163021 builduid: 451c5c7ac5df4d0e9749fc5842865b1e revision: dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:00.525514) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:00.525934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:00.526274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:00.550566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:00.550841) ========= 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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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-08-10 18:42:00-- 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% 19.1M=0.001s 2016-08-10 18:42:00 (19.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098463 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:00.671215) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:00.671519) ========= 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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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.025265 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:00.719110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 18:42:00.719427) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SO1OPib5O8/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.mtzDcpKhbJ/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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-08-10 18:42:00,761 truncating revision to first 12 chars 2016-08-10 18:42:00,762 Setting DEBUG logging. 2016-08-10 18:42:00,762 attempt 1/10 2016-08-10 18:42:00,762 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dc8f8117d67b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 18:42:01,818 unpacking tar archive at: mozilla-central-dc8f8117d67b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.335233 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 18:42:02.076068) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:02.076388) ========= script_repo_revision: dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:02.076799) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:02.077064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 18:42:02.095341) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 18 secs) (at 2016-08-10 18:42:02.095607) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SO1OPib5O8/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.mtzDcpKhbJ/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42:02 INFO - MultiFileLogger online at 20160810 18:42:02 in /builds/slave/test 18:42:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:42:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:42:02 INFO - {'append_to_log': False, 18:42:02 INFO - 'base_work_dir': '/builds/slave/test', 18:42:02 INFO - 'blob_upload_branch': 'Firefox', 18:42:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:42:02 INFO - 'branch': 'Firefox', 18:42:02 INFO - 'buildbot_json_path': 'buildprops.json', 18:42:02 INFO - 'config_files': ('talos/mac_config.py',), 18:42:02 INFO - 'default_actions': ('clobber', 18:42:02 INFO - 'read-buildbot-config', 18:42:02 INFO - 'download-and-extract', 18:42:02 INFO - 'populate-webroot', 18:42:02 INFO - 'create-virtualenv', 18:42:02 INFO - 'install', 18:42:02 INFO - 'run-tests'), 18:42:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:42:02 INFO - 'download_minidump_stackwalk': True, 18:42:02 INFO - 'download_symbols': 'ondemand', 18:42:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:42:02 INFO - 'tooltool.py': '/tools/tooltool.py', 18:42:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:42:02 INFO - '/tools/misc-python/virtualenv.py')}, 18:42:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:42:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:42:02 INFO - 'installer_path': 'installer.exe', 18:42:02 INFO - 'log_level': 'info', 18:42:02 INFO - 'log_name': 'talos', 18:42:02 INFO - 'log_to_console': True, 18:42:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:42:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:42:02 INFO - 'opt_config_files': (), 18:42:02 INFO - 'pip_index': False, 18:42:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:42:02 INFO - 'cmd': ('bash', 18:42:02 INFO - '-c', 18:42:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:42:02 INFO - 'enabled': True, 18:42:02 INFO - 'halt_on_failure': False, 18:42:02 INFO - 'name': 'check_screen_resolution'},), 18:42:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:42:02 INFO - 'cmd': ('bash', 18:42:02 INFO - '-c', 18:42:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:42:02 INFO - 'enabled': True, 18:42:02 INFO - 'halt_on_failure': False, 18:42:02 INFO - 'name': 'check_screen_resolution'},), 18:42:02 INFO - 'run_cmd_checks_enabled': True, 18:42:02 INFO - 'sps_profile': False, 18:42:02 INFO - 'sps_profile_interval': 0, 18:42:02 INFO - 'suite': 'dromaeojs', 18:42:02 INFO - 'system_bits': '32', 18:42:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:42:02 INFO - 'title': 't-yosemite-r7-0233', 18:42:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:42:02 INFO - 'use_talos_json': True, 18:42:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:42:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:42:02 INFO - 'work_dir': 'build'} 18:42:02 INFO - [mozharness: 2016-08-11 01:42:02.245650Z] Running clobber step. 18:42:02 INFO - Running pre-action listener: _resource_record_pre_action 18:42:02 INFO - Running main action method: clobber 18:42:02 INFO - rmtree: /builds/slave/test/build 18:42:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:42:04 INFO - Running post-action listener: _resource_record_post_action 18:42:04 INFO - [mozharness: 2016-08-11 01:42:04.224590Z] Finished clobber step (success) 18:42:04 INFO - [mozharness: 2016-08-11 01:42:04.224763Z] Running read-buildbot-config step. 18:42:04 INFO - Running pre-action listener: _resource_record_pre_action 18:42:04 INFO - Running main action method: read_buildbot_config 18:42:04 INFO - Using buildbot properties: 18:42:04 INFO - { 18:42:04 INFO - "project": "", 18:42:04 INFO - "product": "firefox", 18:42:04 INFO - "script_repo_revision": "production", 18:42:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:42:04 INFO - "repository": "", 18:42:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:42:04 INFO - "buildid": "20160810163021", 18:42:04 INFO - "pgo_build": "False", 18:42:04 INFO - "basedir": "/builds/slave/test", 18:42:04 INFO - "buildnumber": 41, 18:42:04 INFO - "slavename": "t-yosemite-r7-0233", 18:42:04 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:42:04 INFO - "platform": "yosemite_r7", 18:42:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:42:04 INFO - "branch": "mozilla-central", 18:42:04 INFO - "repo_path": "mozilla-central", 18:42:04 INFO - "revision": "dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa", 18:42:04 INFO - "stage_platform": "macosx64", 18:42:04 INFO - "builduid": "451c5c7ac5df4d0e9749fc5842865b1e", 18:42:04 INFO - "slavebuilddir": "test" 18:42:04 INFO - } 18:42:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 18:42:04 INFO - Running post-action listener: _resource_record_post_action 18:42:04 INFO - [mozharness: 2016-08-11 01:42:04.228282Z] Finished read-buildbot-config step (success) 18:42:04 INFO - [mozharness: 2016-08-11 01:42:04.228392Z] Running download-and-extract step. 18:42:04 INFO - Running pre-action listener: _resource_record_pre_action 18:42:04 INFO - Running main action method: download_and_extract 18:42:04 INFO - mkdir: /builds/slave/test/build/tests 18:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:04 INFO - trying https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 18:42:04 INFO - Downloading https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 18:42:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 18:42:05 INFO - Downloaded 1199 bytes. 18:42:05 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 18:42:05 INFO - Using the following test package requirements: 18:42:05 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:42:05 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:42:05 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 18:42:05 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:42:05 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 18:42:05 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:42:05 INFO - u'jsshell-mac.zip'], 18:42:05 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:42:05 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 18:42:05 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:42:05 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:42:05 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 18:42:05 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:42:05 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 18:42:05 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:42:05 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 18:42:05 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:42:05 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 18:42:05 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:42:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:05 INFO - trying https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:42:06 INFO - Downloaded 16328335 bytes. 18:42:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:42:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:42:09 INFO - Return code: 0 18:42:09 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:09 INFO - trying https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:42:09 INFO - Downloading https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:42:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:42:10 INFO - Downloaded 16328335 bytes. 18:42:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:42:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:42:13 INFO - Return code: 0 18:42:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:13 INFO - trying https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 18:42:13 INFO - Downloading https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 18:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:42:14 INFO - Downloaded 14413719 bytes. 18:42:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:42:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:42:14 INFO - Return code: 0 18:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:14 INFO - trying https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:42:14 INFO - Downloading https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 18:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 18:42:17 INFO - Downloaded 110866587 bytes. 18:42:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:42:17 INFO - mkdir: /builds/slave/test/properties 18:42:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:42:17 INFO - Writing to file /builds/slave/test/properties/build_url 18:42:17 INFO - Contents: 18:42:17 INFO - build_url:https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:42:20 INFO - Running post-action listener: _resource_record_post_action 18:42:20 INFO - Running post-action listener: set_extra_try_arguments 18:42:20 INFO - [mozharness: 2016-08-11 01:42:20.839718Z] Finished download-and-extract step (success) 18:42:20 INFO - [mozharness: 2016-08-11 01:42:20.839865Z] Running populate-webroot step. 18:42:20 INFO - Running pre-action listener: _resource_record_pre_action 18:42:20 INFO - Running main action method: populate_webroot 18:42:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:42:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:42:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:42:20 INFO - '--tppagecycles', 18:42:20 INFO - '7'], 18:42:20 INFO - 'tests': ['tsvgm']}}, 18:42:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:42:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:42:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:42:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:42:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:20 INFO - 'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:20 INFO - 'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['damp', 'tps']}, 18:42:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:20 INFO - 'tests': ['damp', 'tps']}, 18:42:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['dromaeo_dom']}, 18:42:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:42:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['basic_compositor_video']}, 18:42:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:42:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['a11yr', 18:42:20 INFO - 'ts_paint', 18:42:20 INFO - 'tpaint', 18:42:20 INFO - 'sessionrestore', 18:42:20 INFO - 'sessionrestore_no_auto_restore', 18:42:20 INFO - 'tabpaint']}, 18:42:20 INFO - 'other-e10s': {'tests': ['a11yr', 18:42:20 INFO - 'ts_paint', 18:42:20 INFO - 'tpaint', 18:42:20 INFO - 'sessionrestore', 18:42:20 INFO - 'sessionrestore_no_auto_restore', 18:42:20 INFO - 'tabpaint']}, 18:42:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:42:20 INFO - 'ts_paint', 18:42:20 INFO - 'tpaint', 18:42:20 INFO - 'sessionrestore', 18:42:20 INFO - 'sessionrestore_no_auto_restore', 18:42:20 INFO - 'tabpaint']}, 18:42:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:42:20 INFO - 'ts_paint', 18:42:20 INFO - 'tpaint', 18:42:20 INFO - 'sessionrestore', 18:42:20 INFO - 'sessionrestore_no_auto_restore', 18:42:20 INFO - 'tabpaint']}, 18:42:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['a11yr', 18:42:20 INFO - 'ts_paint', 18:42:20 INFO - 'tpaint', 18:42:20 INFO - 'sessionrestore', 18:42:20 INFO - 'sessionrestore_no_auto_restore', 18:42:20 INFO - 'tabpaint']}, 18:42:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['a11yr', 18:42:20 INFO - 'ts_paint', 18:42:20 INFO - 'tpaint', 18:42:20 INFO - 'sessionrestore', 18:42:20 INFO - 'sessionrestore_no_auto_restore', 18:42:20 INFO - 'tabpaint']}, 18:42:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['tsvgx', 18:42:20 INFO - 'tsvgr_opacity', 18:42:20 INFO - 'tart', 18:42:20 INFO - 'tscrollx', 18:42:20 INFO - 'cart']}, 18:42:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:42:20 INFO - 'tsvgr_opacity', 18:42:20 INFO - 'tart', 18:42:20 INFO - 'tscrollx', 18:42:20 INFO - 'cart']}, 18:42:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:20 INFO - 'talos_options': ['--disable-e10s'], 18:42:20 INFO - 'tests': ['tp5o']}, 18:42:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:20 INFO - 'tests': ['tp5o']}, 18:42:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:20 INFO - 'talos_options': ['--disable-e10s', 18:42:20 INFO - '--xperf_path', 18:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:20 INFO - 'tests': ['tp5n']}, 18:42:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:20 INFO - 'talos_options': ['--xperf_path', 18:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:20 INFO - 'tests': ['tp5n']}}, 18:42:20 INFO - 'talos.zip': {'path': '', 18:42:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:42:20 INFO - Running post-action listener: _resource_record_post_action 18:42:20 INFO - [mozharness: 2016-08-11 01:42:20.858579Z] Finished populate-webroot step (success) 18:42:20 INFO - [mozharness: 2016-08-11 01:42:20.858711Z] Running create-virtualenv step. 18:42:20 INFO - Running pre-action listener: _resource_record_pre_action 18:42:20 INFO - Running main action method: create_virtualenv 18:42:20 INFO - Creating virtualenv /builds/slave/test/build/venv 18:42:20 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 18:42:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:42:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:42:20 INFO - Using real prefix '/tools/python27' 18:42:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:42:21 INFO - Installing distribute.............................................................................................................................................................................................done. 18:42:24 INFO - Installing pip.................done. 18:42:24 INFO - Return code: 0 18:42:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42: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', 'pip>=1.5'] in /builds/slave/test/build 18:42: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 pip>=1.5 18:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:24 INFO - 'HOME': '/Users/cltbld', 18:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:24 INFO - 'LOGNAME': 'cltbld', 18:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:24 INFO - 'MOZ_NO_REMOTE': '1', 18:42:24 INFO - 'NO_EM_RESTART': '1', 18:42:24 INFO - 'PAGER': '/bin/cat', 18:42:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:24 INFO - 'PWD': '/builds/slave/test', 18:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:24 INFO - 'SHELL': '/bin/bash', 18:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:24 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:24 INFO - 'USER': 'cltbld', 18:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:24 INFO - 'XPC_FLAGS': '0x0', 18:42:24 INFO - 'XPC_SERVICE_NAME': '0', 18:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:24 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 18:42:24 INFO - Cleaning up... 18:42:24 INFO - Return code: 0 18:42:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:42: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 psutil>=3.1.1 18:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:24 INFO - 'HOME': '/Users/cltbld', 18:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:24 INFO - 'LOGNAME': 'cltbld', 18:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:24 INFO - 'MOZ_NO_REMOTE': '1', 18:42:24 INFO - 'NO_EM_RESTART': '1', 18:42:24 INFO - 'PAGER': '/bin/cat', 18:42:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:24 INFO - 'PWD': '/builds/slave/test', 18:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:24 INFO - 'SHELL': '/bin/bash', 18:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:24 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:24 INFO - 'USER': 'cltbld', 18:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:24 INFO - 'XPC_FLAGS': '0x0', 18:42:24 INFO - 'XPC_SERVICE_NAME': '0', 18:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:25 INFO - Downloading/unpacking psutil>=3.1.1 18:42:25 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 18:42:25 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 18:42:25 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 18:42:25 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 18:42:25 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 18:42:25 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 18:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:42:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:28 INFO - Installing collected packages: psutil 18:42:28 INFO - Running setup.py install for psutil 18:42:28 INFO - building 'psutil._psutil_osx' extension 18:42:28 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 18:42:29 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 18:42:29 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 18:42:29 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 18:42:29 INFO - building 'psutil._psutil_posix' extension 18:42:29 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 18:42:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:42:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:42:29 INFO - ^ 18:42:29 INFO - 1 warning generated. 18:42:29 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 18:42:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:29 INFO - Successfully installed psutil 18:42:29 INFO - Cleaning up... 18:42:29 INFO - Return code: 0 18:42:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:29 INFO - 'HOME': '/Users/cltbld', 18:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:29 INFO - 'LOGNAME': 'cltbld', 18:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:29 INFO - 'MOZ_NO_REMOTE': '1', 18:42:29 INFO - 'NO_EM_RESTART': '1', 18:42:29 INFO - 'PAGER': '/bin/cat', 18:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:29 INFO - 'PWD': '/builds/slave/test', 18:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:29 INFO - 'SHELL': '/bin/bash', 18:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:29 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:29 INFO - 'USER': 'cltbld', 18:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:29 INFO - 'XPC_FLAGS': '0x0', 18:42:29 INFO - 'XPC_SERVICE_NAME': '0', 18:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:42:29 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 18:42:29 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 18:42:29 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 18:42:29 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 18:42:29 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 18:42:29 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 18:42:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:42:32 INFO - Installing collected packages: mozsystemmonitor 18:42:32 INFO - Running setup.py install for mozsystemmonitor 18:42:32 INFO - Successfully installed mozsystemmonitor 18:42:32 INFO - Cleaning up... 18:42:32 INFO - Return code: 0 18:42:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:32 INFO - 'HOME': '/Users/cltbld', 18:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:32 INFO - 'LOGNAME': 'cltbld', 18:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:32 INFO - 'MOZ_NO_REMOTE': '1', 18:42:32 INFO - 'NO_EM_RESTART': '1', 18:42:32 INFO - 'PAGER': '/bin/cat', 18:42:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:32 INFO - 'PWD': '/builds/slave/test', 18:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:32 INFO - 'SHELL': '/bin/bash', 18:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:32 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:32 INFO - 'USER': 'cltbld', 18:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:32 INFO - 'XPC_FLAGS': '0x0', 18:42:32 INFO - 'XPC_SERVICE_NAME': '0', 18:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:32 INFO - Downloading/unpacking jsonschema==2.5.1 18:42:32 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 18:42:32 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 18:42:32 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 18:42:32 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 18:42:32 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 18:42:32 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 18:42:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:42:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:42:35 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 18:42:35 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 18:42:35 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 18:42:35 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 18:42:35 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 18:42:35 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 18:42:35 INFO - Downloading functools32-3.2.3-2.tar.gz 18:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:42:36 INFO - warning: no files found matching '*.txt' 18:42:36 INFO - no previously-included directories found matching 'build' 18:42:36 INFO - no previously-included directories found matching 'dist' 18:42:36 INFO - no previously-included directories found matching '.git*' 18:42:36 INFO - Installing collected packages: jsonschema, functools32 18:42:36 INFO - Running setup.py install for functools32 18:42:36 INFO - warning: no files found matching '*.txt' 18:42:36 INFO - no previously-included directories found matching 'build' 18:42:36 INFO - no previously-included directories found matching 'dist' 18:42:36 INFO - no previously-included directories found matching '.git*' 18:42:36 INFO - Successfully installed jsonschema functools32 18:42:36 INFO - Cleaning up... 18:42:36 INFO - Return code: 0 18:42:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:36 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42:36 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:42:36 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 functools32==3.2.3-2 18:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:36 INFO - 'HOME': '/Users/cltbld', 18:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:36 INFO - 'LOGNAME': 'cltbld', 18:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:36 INFO - 'MOZ_NO_REMOTE': '1', 18:42:36 INFO - 'NO_EM_RESTART': '1', 18:42:36 INFO - 'PAGER': '/bin/cat', 18:42:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:36 INFO - 'PWD': '/builds/slave/test', 18:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:36 INFO - 'SHELL': '/bin/bash', 18:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:36 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:36 INFO - 'USER': 'cltbld', 18:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:36 INFO - 'XPC_FLAGS': '0x0', 18:42:36 INFO - 'XPC_SERVICE_NAME': '0', 18:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:42:36 INFO - Cleaning up... 18:42:36 INFO - Return code: 0 18:42:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:36 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 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42:36 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 18:42:36 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 18:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:36 INFO - 'HOME': '/Users/cltbld', 18:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:36 INFO - 'LOGNAME': 'cltbld', 18:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:36 INFO - 'MOZ_NO_REMOTE': '1', 18:42:36 INFO - 'NO_EM_RESTART': '1', 18:42:36 INFO - 'PAGER': '/bin/cat', 18:42:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:36 INFO - 'PWD': '/builds/slave/test', 18:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:36 INFO - 'SHELL': '/bin/bash', 18:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:36 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:36 INFO - 'USER': 'cltbld', 18:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:36 INFO - 'XPC_FLAGS': '0x0', 18:42:36 INFO - 'XPC_SERVICE_NAME': '0', 18:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:36 INFO - Downloading/unpacking blobuploader==1.2.4 18:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:39 INFO - Downloading blobuploader-1.2.4.tar.gz 18:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:42:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:42:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42:40 INFO - Downloading docopt-0.6.1.tar.gz 18:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:42:40 INFO - Installing collected packages: blobuploader, requests, docopt 18:42:40 INFO - Running setup.py install for blobuploader 18:42:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:42:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:42:40 INFO - Running setup.py install for requests 18:42:41 INFO - Running setup.py install for docopt 18:42:41 INFO - Successfully installed blobuploader requests docopt 18:42:41 INFO - Cleaning up... 18:42:41 INFO - Return code: 0 18:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:41 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 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42:41 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 18:42:41 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 18:42:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:41 INFO - 'HOME': '/Users/cltbld', 18:42:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:41 INFO - 'LOGNAME': 'cltbld', 18:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:41 INFO - 'MOZ_NO_REMOTE': '1', 18:42:41 INFO - 'NO_EM_RESTART': '1', 18:42:41 INFO - 'PAGER': '/bin/cat', 18:42:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:41 INFO - 'PWD': '/builds/slave/test', 18:42:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:41 INFO - 'SHELL': '/bin/bash', 18:42:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:41 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:41 INFO - 'USER': 'cltbld', 18:42:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:41 INFO - 'XPC_FLAGS': '0x0', 18:42:41 INFO - 'XPC_SERVICE_NAME': '0', 18:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:42:41 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-8W4Lgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:42:41 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-zFW2Ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:42:41 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-coAzCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-QHazuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-WVZ0if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-eFamWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-1hRU1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-TA6_XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-tjCewP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-cGKQ8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-PZEuQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-5YumMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:42:42 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-hEL07d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:42:43 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-1WESGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:43 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-bAn1Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:43 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-hq7jt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:43 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-pRT2yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:42:43 INFO - Running setup.py install for manifestparser 18:42:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:42:43 INFO - Running setup.py install for mozcrash 18:42:43 INFO - Running setup.py install for mozdebug 18:42:43 INFO - Running setup.py install for mozdevice 18:42:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:42:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:42:44 INFO - Running setup.py install for mozfile 18:42:44 INFO - Running setup.py install for mozhttpd 18:42:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:42:44 INFO - Running setup.py install for mozinfo 18:42:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:42:44 INFO - Running setup.py install for mozInstall 18:42:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:42:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:42:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:42:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:42:44 INFO - Running setup.py install for mozleak 18:42:44 INFO - Running setup.py install for mozlog 18:42:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:42:44 INFO - Running setup.py install for moznetwork 18:42:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:42:45 INFO - Running setup.py install for mozprocess 18:42:45 INFO - Running setup.py install for mozprofile 18:42:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:42:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:42:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:42:45 INFO - Running setup.py install for mozrunner 18:42:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:42:45 INFO - Running setup.py install for mozscreenshot 18:42:45 INFO - Running setup.py install for moztest 18:42:45 INFO - Running setup.py install for mozversion 18:42:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:42:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:42:46 INFO - Cleaning up... 18:42:46 INFO - Return code: 0 18:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:46 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 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42:46 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 18:42:46 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 18:42:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:46 INFO - 'HOME': '/Users/cltbld', 18:42:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:46 INFO - 'LOGNAME': 'cltbld', 18:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:46 INFO - 'MOZ_NO_REMOTE': '1', 18:42:46 INFO - 'NO_EM_RESTART': '1', 18:42:46 INFO - 'PAGER': '/bin/cat', 18:42:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:46 INFO - 'PWD': '/builds/slave/test', 18:42:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:46 INFO - 'SHELL': '/bin/bash', 18:42:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:46 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:46 INFO - 'USER': 'cltbld', 18:42:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:46 INFO - 'XPC_FLAGS': '0x0', 18:42:46 INFO - 'XPC_SERVICE_NAME': '0', 18:42:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:42:46 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-tfvYun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:42:46 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)) 18:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:42:46 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-s3Uk6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:42:46 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)) 18:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:42:46 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-2zVQjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:42:46 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)) 18:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:42:46 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-1coHrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:42:46 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)) 18:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:42:46 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-Rip5rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:42:46 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)) 18:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:42:46 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-0mZ3n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:42:46 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)) 18:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:42:46 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-NFqeZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:42:47 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)) 18:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:42:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-rwvXz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:42:47 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)) 18:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:42:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-MzgY6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:42:47 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)) 18:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:42:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-19pOOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 18:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:42:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-Mqpulb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:42:47 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)) 18:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:42:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-TIE3_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:42:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-EVMR9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:42:47 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)) 18:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:42:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-FNFjWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-XpeP6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:47 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)) 18:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-F1DCz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:48 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)) 18:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-DDeYkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:48 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)) 18:42:48 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)) 18:42:48 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)) 18:42:48 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)) 18:42:48 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)) 18:42:48 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)) 18:42:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42: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 18:42:50 INFO - Downloading blessings-1.6.tar.gz 18:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:42:50 INFO - Installing collected packages: blessings 18:42:50 INFO - Running setup.py install for blessings 18:42:50 INFO - Successfully installed blessings 18:42:50 INFO - Cleaning up... 18:42:50 INFO - Return code: 0 18:42:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:51 INFO - Reading from file tmpfile_stdout 18:42:51 INFO - Current package versions: 18:42:51 INFO - blessings == 1.6 18:42:51 INFO - blobuploader == 1.2.4 18:42:51 INFO - docopt == 0.6.1 18:42:51 INFO - functools32 == 3.2.3-2 18:42:51 INFO - jsonschema == 2.5.1 18:42:51 INFO - manifestparser == 1.1 18:42:51 INFO - mozInstall == 1.12 18:42:51 INFO - mozcrash == 0.17 18:42:51 INFO - mozdebug == 0.1 18:42:51 INFO - mozdevice == 0.48 18:42:51 INFO - mozfile == 1.2 18:42:51 INFO - mozhttpd == 0.7 18:42:51 INFO - mozinfo == 0.9 18:42:51 INFO - mozleak == 0.1 18:42:51 INFO - mozlog == 3.3 18:42:51 INFO - moznetwork == 0.27 18:42:51 INFO - mozprocess == 0.23 18:42:51 INFO - mozprofile == 0.28 18:42:51 INFO - mozrunner == 6.12 18:42:51 INFO - mozscreenshot == 0.1 18:42:51 INFO - mozsystemmonitor == 0.3 18:42:51 INFO - moztest == 0.7 18:42:51 INFO - mozversion == 1.4 18:42:51 INFO - psutil == 3.1.1 18:42:51 INFO - requests == 1.2.3 18:42:51 INFO - wsgiref == 0.1.2 18:42:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:51 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 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42:51 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 18:42:51 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 18:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:51 INFO - 'HOME': '/Users/cltbld', 18:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:51 INFO - 'LOGNAME': 'cltbld', 18:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:51 INFO - 'MOZ_NO_REMOTE': '1', 18:42:51 INFO - 'NO_EM_RESTART': '1', 18:42:51 INFO - 'PAGER': '/bin/cat', 18:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:51 INFO - 'PWD': '/builds/slave/test', 18:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:51 INFO - 'SHELL': '/bin/bash', 18:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:51 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:51 INFO - 'USER': 'cltbld', 18:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:51 INFO - 'XPC_FLAGS': '0x0', 18:42:51 INFO - 'XPC_SERVICE_NAME': '0', 18:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:51 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)) 18:42:51 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)) 18:42:51 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)) 18:42:51 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)) 18:42:51 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)) 18:42:51 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)) 18:42:51 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)) 18:42:51 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)) 18:42:51 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)) 18:42:51 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)) 18:42:51 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)) 18:42:51 INFO - Cleaning up... 18:42:51 INFO - Return code: 0 18:42:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:42:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:51 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 0x10f703a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f798618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8d8d51f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, '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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 18:42:51 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 18:42:51 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 18:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:51 INFO - 'HOME': '/Users/cltbld', 18:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:51 INFO - 'LOGNAME': 'cltbld', 18:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:51 INFO - 'MOZ_NO_REMOTE': '1', 18:42:51 INFO - 'NO_EM_RESTART': '1', 18:42:51 INFO - 'PAGER': '/bin/cat', 18:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:51 INFO - 'PWD': '/builds/slave/test', 18:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:51 INFO - 'SHELL': '/bin/bash', 18:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:42:51 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:51 INFO - 'USER': 'cltbld', 18:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:51 INFO - 'XPC_FLAGS': '0x0', 18:42:51 INFO - 'XPC_SERVICE_NAME': '0', 18:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:42:51 INFO - Cleaning up... 18:42:51 INFO - Return code: 0 18:42:51 INFO - Running post-action listener: _resource_record_post_action 18:42:51 INFO - Running post-action listener: _start_resource_monitoring 18:42:51 INFO - Starting resource monitoring. 18:42:51 INFO - [mozharness: 2016-08-11 01:42:51.738087Z] Finished create-virtualenv step (success) 18:42:51 INFO - [mozharness: 2016-08-11 01:42:51.739048Z] Running install step. 18:42:51 INFO - Running pre-action listener: _resource_record_pre_action 18:42:51 INFO - Running main action method: install 18:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:51 INFO - Reading from file tmpfile_stdout 18:42:51 INFO - Detecting whether we're running mozinstall >=1.0... 18:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:42:52 INFO - Reading from file tmpfile_stdout 18:42:52 INFO - Output received: 18:42:52 INFO - Usage: mozinstall [options] installer 18:42:52 INFO - Options: 18:42:52 INFO - -h, --help show this help message and exit 18:42:52 INFO - -d DEST, --destination=DEST 18:42:52 INFO - Directory to install application into. [default: 18:42:52 INFO - "/builds/slave/test"] 18:42:52 INFO - --app=APP Application being installed. [default: firefox] 18:42:52 INFO - mkdir: /builds/slave/test/build/application 18:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:43:26 INFO - Reading from file tmpfile_stdout 18:43:26 INFO - Output received: 18:43:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:43:26 INFO - Running post-action listener: _resource_record_post_action 18:43:26 INFO - [mozharness: 2016-08-11 01:43:26.466918Z] Finished install step (success) 18:43:26 INFO - [mozharness: 2016-08-11 01:43:26.467054Z] Running run-tests step. 18:43:26 INFO - Running pre-action listener: _resource_record_pre_action 18:43:26 INFO - Running main action method: run_tests 18:43:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:43:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:43:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:43:26 INFO - 2016-08-10 18:43:26.481 screenresolution[1640:7349] starting screenresolution argv=screenresolution get 18:43:26 INFO - 2016-08-10 18:43:26.484 screenresolution[1640:7349] Display 0: 1600x1200x32@60 18:43:26 INFO - 2016-08-10 18:43:26.490 screenresolution[1641:7351] starting screenresolution argv=screenresolution list 18:43:26 INFO - Available Modes on Display 0 18:43:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:43:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:43:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:43:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:43:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:43:26 INFO - Intel Iris: 18:43:26 INFO - Chipset Model: Intel Iris 18:43:26 INFO - Type: GPU 18:43:26 INFO - Bus: Built-In 18:43:26 INFO - VRAM (Dynamic, Max): 1536 MB 18:43:26 INFO - Vendor: Intel (0x8086) 18:43:26 INFO - Device ID: 0x0a2e 18:43:26 INFO - Revision ID: 0x0009 18:43:26 INFO - Displays: 18:43:26 INFO - Display: 18:43:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:43:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:43:26 INFO - Display Serial Number: 1600x1200 60 18:43:26 INFO - Main Display: Yes 18:43:26 INFO - Mirror: Off 18:43:26 INFO - Online: Yes 18:43:26 INFO - Rotation: Supported 18:43:26 INFO - Return code: 0 18:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:43:26 INFO - Python 2.7.3 18:43:26 INFO - Return code: 0 18:43:26 INFO - grabbing minidump binary from tooltool 18:43:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:43:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f667d30>, '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 0x10f3ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:43:26 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 18:43:26 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 18:43:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:43:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:43:26 INFO - Return code: 0 18:43:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:43:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:43:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:43:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:43:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0233', '--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 18:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0233 --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 18:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SO1OPib5O8/Render', 18:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:26 INFO - 'HOME': '/Users/cltbld', 18:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:26 INFO - 'LOGNAME': 'cltbld', 18:43:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:43:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:26 INFO - 'MOZ_NO_REMOTE': '1', 18:43:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:43:26 INFO - 'NO_EM_RESTART': '1', 18:43:26 INFO - 'PAGER': '/bin/cat', 18:43:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:26 INFO - 'PWD': '/builds/slave/test', 18:43:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:26 INFO - 'SHELL': '/bin/bash', 18:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mtzDcpKhbJ/Listeners', 18:43:26 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 18:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:26 INFO - 'USER': 'cltbld', 18:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:26 INFO - 'XPC_FLAGS': '0x0', 18:43:26 INFO - 'XPC_SERVICE_NAME': '0', 18:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:43:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0233', '--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 18:43:27 INFO - mozversion application_buildid: 20160810163021 18:43:27 INFO - mozversion application_changeset: dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa 18:43:27 INFO - mozversion application_display_name: Nightly 18:43:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:43:27 INFO - mozversion application_name: Firefox 18:43:27 INFO - mozversion application_remotingname: firefox 18:43:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:43:27 INFO - mozversion application_vendor: Mozilla 18:43:27 INFO - mozversion application_version: 51.0a1 18:43:27 INFO - mozversion platform_buildid: 20160810163021 18:43:27 INFO - mozversion platform_changeset: dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa 18:43:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:43:27 INFO - mozversion platform_version: 51.0a1 18:43:27 INFO - using testdate: 1470879807 18:43:27 INFO - actual date: 1470879807 18:43:27 INFO - starting webserver on 'localhost:49280' 18:43:27 INFO - SUITE-START | Running 2 tests 18:43:27 INFO - TEST-START | dromaeo_css 18:43:27 INFO - operating with platform_type : mac_ 18:43:27 INFO - Initialising browser for dromaeo_css test... 18:43:27 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpDOfm7d/profile http://localhost:49280/getInfo.html) 18:43:29 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 18:43:29 INFO - PROCESS | 1651 | colorDepth:24 18:43:29 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 18:43:29 INFO - PROCESS | 1651 | __metrics 18:43:29 INFO - PROCESS | 1651 | 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" 18:43:29 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:43:30 INFO - TEST-INFO | 1651: exit 0 18:43:30 INFO - Browser initialized. 18:43:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:43:30 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpDOfm7d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:43:42 INFO - PROCESS | 1653 | RSS: Main: 243798016 18:43:42 INFO - PROCESS | 1653 | 18:44:33 INFO - PROCESS | 1653 | 1470879873976 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] 18:46:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 18:46:46 INFO - PROCESS | 1653 | RSS: Main: 350777344 18:46:46 INFO - PROCESS | 1653 | 18:49:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 18:49:50 INFO - PROCESS | 1653 | RSS: Main: 382234624 18:49:50 INFO - PROCESS | 1653 | 18:52:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 18:52:53 INFO - PROCESS | 1653 | RSS: Main: 371228672 18:52:53 INFO - PROCESS | 1653 | 18:55:55 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 18:55:56 INFO - PROCESS | 1653 | RSS: Main: 341790720 18:55:56 INFO - PROCESS | 1653 | 18:58:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 18:59:00 INFO - PROCESS | 1653 | RSS: Main: 336973824 18:59:00 INFO - PROCESS | 1653 | 19:02:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 19:02:04 INFO - PROCESS | 1653 | RSS: Main: 388378624 19:02:04 INFO - PROCESS | 1653 | 19:02:04 INFO - PROCESS | 1653 | __start_tp_report 19:02:04 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 19:02:04 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 19:02:04 INFO - PROCESS | 1653 | |i|pagename|runs| 19:02:04 INFO - PROCESS | 1653 | |0;dojo.html;3376.4428869236576;3390.271091715282;3402.489626556017;3404.7616666833333;3456.291460250647;5411.431799661028;5523.7790488380415;5728.484436400723;5810.331811841639;5819.825405237839;5707.600467967233;5775.884482310362;5806.187133801272;5825.417458254173;5865.560082993782;5163.096458119833;5230.7646155922885;5245.527902488775;5283.577313814885;5370.409254981969;5337.893242135155;5339.466053394649;5353.7590808413715;5367.275417818603;5399.946000540003;4310.78446077698;5142.74286285688;5183.611229157828;5246.50158234969;5278.445763194886;5036.194208926554;5144.768485418165;5240.895182096337;5241.528262456359;5255.290535777659;5169.870753231162;5194.740262986836;5212.713300768456;5219.5041471060185;5227.503387178212;5652.547796176296;5654.660720356792;5668.348139963916;5724.112762521816;5755.424457554211;6181.629102253879;6205.193324867739;6211.3167551569295;6232.688365581703;6250.468710159642;6152.984757515004;6165.075238714184;6183.041628547582;6216.689165541705;6227.96886015567;5661.66030038199;5708.514776243983;5813.912791308134;5856.092305692625;5886.8822623547285;6293.402126797947;6298.433141017331;6298.685065746694;6302.243730752248;6327.4938004959495;6190.721417536221;6212;6219.502439804804;6224.626522408579;6235.781747638811;6093.725782339805;6100.8779824404155;6103.375170450573;6160.9383906161265;6168.722407491674;4640.698354607007;6106.460667180062;6124.441964285778;6183.690815459209;6198.256209254918;6166.445019948226;6212.285587157535;6235;6237.5009999200865;6255.343188965184;4844.346013288232;4886.633502487328;4887.511248875084;4899.951000490021;4921.680090794087;4375.212461756851;4386.670999675037;4408.493023302297;4442.022754993896;4454.26504626733;5792.957267691771;5804.390538993429;5837.9124313135335;5848.327442344185;5857.560682948796;6118.174046503754;6194.34959329273;6196.442320191204;6215.440610345;6228.937710622927;5599.608027438122;5748.482636562646;5780.132980053026;5782.392848750905;5792.1311803229855;5473.534749546333;5481.506664400223;5483;5494.862628434321;5528.778848846082;5382.273393092039;6391.201099862517;6397.168368112116;6402.327755585783;6405.391487808558;6121.574916084701;6165.630062196283;6166.105914642441;6233.657148856856;6302.842428939313;5386.676799392049;6322.589031712924;6323.936760632335;6328.050792381179;6329.367063293634;6154.907676384768;6166.784162554289;6215.96892015537;6222.346653601488;6231.532635052298;5389.434109418455;5942.376050514634;6104.004449388181;6187.102870083902;6216.844578885564;5070.797168113234;6098.40197260387;6117.827404800828;6121.910283036266;6142.621558143092;6108.918862504554;6122.764110201706;6133.1510485532735;6139.492138333381;6159.630422174684;5892.469677729025;6001;6017.428344307459;6056.84857878539;6076.8784624308155;6135.171751813448;6138.848241798255;6156.630602163885;6170.629762214281;6185.134081228722;6010.338862725184;6045.2098175002575;6056.182415373868;6061.1514387984835;6109.75560977556 19:02:04 INFO - PROCESS | 1653 | |1;ext.html;516.4216077992648;522.3366324767545;525.0758664750041;531.5534950641463;551.627651335349;31723.048308550722;40773;41805.58194418055;41845.37231941523;43839.56160438403;42199.94500137498;42279.78860105695;42345.7882710586;42373.57626423735;42457.7877110614;9610.471424071691;9794.265430092772;9795;9795.461249631267;9815.018498150164;8717.259032982203;8815.77960550988;8825.117488251188;9014.819703605925;9015.774605634879;11621.302721836675;11650.184487085908;11707;11875.881241187608;12006.879931200663;11708.941455292712;11799.410029498491;11804.527818887234;11806.291622502677;11832.822507662435;11579.30524168544;11648.184627076109;11657.417129143509;11659.00898423635;11713.238639488405;40282.597174028175;40529.392059119135;40608.18783624311;40618.79690601528;40676.796616017025;3433.759636825423;3464.185916309665;3613.8012409317475;3657.158853463718;3906.58980807014;28444.715552844413;28469.715302847122;28535.28661783472;28590.571141432894;28610.85694571514;3231.3698828728407;3297.4394352960053;3385.5768028996376;3408.5739282589675;3414.334204830059;488673;490233.54883225355;493007;493958;495069.52465237805;59837.40162598405;60027.39972600218;60107.699461502416;60123;60140.398596014355;61677.38322616806;61685.69157154186;61764;61816;61920;16408.425705100504;16573.50279491617;16581.25384357707;16588.58528536772;16594.921330113502;12863.935680321538;12873.163244389085;12883;12917.741645167232;12926.41831117602;12510.874891251153;13671.658208544666;13826.792598111037;15891.920540397456;16168.67662646764;5872.765089396462;5972.134040564094;6414.711337989708;6479.838004049842;6481.546291759531;800.2677550041763;928.4058202750246;989.559645957542;1062.1715062251455;1151.250099848226;28370;29558.852205739262;29841.701582984326;30553.69446305553;30731.385372292876;1027.6197806811529;1058.296233005043;1070.743021674808;1072.6781965410346;1075.3386667199616;12445.62663120108;12768.80846787299;15234.238288085551;15322.85078619108;15362.462313818962;634710;640724;641099.3285436431;641462;642278;51127.23309150366;51313.48686513162;51603;58731.412685872594;58778;1139.8518192634904;1276.7510335484676;1305.9738805224033;1377.8622137786342;1394.8674875886775;30240;30476.84761576178;31006.689933101283;31197.220069498446;31934.52098218575;49795.751021244665;56505.71747141238;56907.43092569021;57030.429695702514;61117.38882611295;512282;590746;597433;597684;598273;22733.545329092995;25913.481730365664;26122.738772612032;26286.60570091412;26583.33541661474;46826.76586617045;47101.528984709716;47552.762236188595;47655.046899062516;48135;39136.60863391444;39239.41140882832;39815.20369592534;40524;40837.38743918903;39088;40247.1950560993;40311.246972885085;40387.798061009504;40550.78347649575;37818.81090594529;38127.618723812404;38816;38924.41613375858;38928.22143557169;32108.839455802572;33426.665733343325;33532;33853;34589.308213836084;24715;25507.36231594225;25837.612435813855;25853.729152834876;26350.472990540464 19:02:04 INFO - PROCESS | 1653 | |2;jquery.html;313.80700868965585;355.92525569630374;374.51874341471216;378.15482396843043;407.0596921112231;14565.761910237628;15585.22073896305;20379.79620203801;20512.589748205046;21666.674999874976;20297.39107826764;20482.48793780156;20974.89512552439;21128.683069753966;21285;5805.680687562182;6158.784442544512;6162;6163.137160797492;6168.414000669929;3922.627350401707;5564.888702225973;6034.547408944325;6759.222689390734;6775.830604234884;6728.091707619457;6749.831254218635;6752.594844309333;6753.054572359873;6761.763338283161;6416.935830641681;6665.33346665332;6667.199936007686;6706.396424321786;6712.697928593225;5574.386817450078;5598;5832.970835145839;5836.182934389189;5856.15085812559;26012;26215.606765898527;26294.474110517873;26568.202953911412;26586.601200981808;2220.433789383713;2250.437390652337;2472.4807790364043;2525.595904655265;3133.6709645487354;14269.00116991811;15048.774268385983;15208.958208358263;16208.918955405265;16635.334586616522;1878.3063541439672;1961.5586493038952;1963.1264087481077;1964.2437661500283;1964.3615824856836;125999;130919;131564.34217828946;131967;132092;11494.942525287488;11709.063274937984;11718.414079296;11773.587924422603;11895.226810257305;12992.545260915822;13533.796993045113;13638.590842274747;14330.785038224434;14336.49822256216;8468.957655211685;8531.317494600416;8647.697330593399;8771.649134034695;8780.165884240987;8608.225259726654;8608.827823443497;8625.568721563897;8806.691765788166;8859.512726800089;4211.010412553048;4479.006841955299;4602.838900638461;4666.65000124992;4678.485366609671;1888.3202047262973;1926.7591551056119;1935.7773856006459;1938.8463864000896;1951.3170390363543;827.8468483330603;888;942.5625920471336;943.1464524605243;956.5408603870181;21219.78780212209;21986.568393068108;22075.33773986783;22113.336599902028;22131.24587607234;764.4610549562545;916.5234078279258;939.699296225215;958.7411398922392;1024.2164743970868;9280;11361.602343918088;11469.910358515928;11490.023348015346;11527.884721152848;577565;583839;586023;593668;593687;129302.70697293094;132847;136143;136423.27153456875;138470;951.5480146930153;973.5618971462728;989.7624570103123;991.980160396788;993.9155171810477;17683.20425580826;19242.807571924663;19299.8070019298;19318;19326.806731932502;41481;53781;56214;56275.71862140663;56554;59653.70173149106;72778.90831637423;79912.60043699744;80079.59960200162;80265.394692107;7248.855022899618;8051.436399451982;8364;8486.40595158333;8631.56842157877;12337.814932775836;13233.007524435514;13251.933740331237;13681.247531385869;13742.381592828147;11453.942730286295;11627.127965402799;11717.238379505305;11725.241213817995;11828.467718952495;11229.49467273991;11337.26307789991;11346;11637.709057273636;11664.533418663497;9207.861882071908;11459.656210313704;11615.186936914335;11738.58914937973;11878;6882.8967565485555;8013.639386227517;8147.10381858007;8364.749057528285;8660.826783464421;8386.958065209636;10711.357318560911;11016.283941543774;11569.826452603049;11730.296182229093 19:02:04 INFO - PROCESS | 1653 | |3;mootools.html;1352.4860552989874;1511.3350125944587;1526.3894442223109;1732.4542769027755;1881.670707626165;7721.343685786708;8602;8702.216800487962;8842.469451832878;8961.507117108556;8749.168828961254;8832.823343533142;8841.292696584274;8854.557272136384;8868.24619907307;2160.945976350588;2203.900824462903;2315.976840231597;2345.9178928737497;2350.9412264693347;1960.4412742368427;2292.32376448948;2350.5533948549805;2352.5765362234793;2353.6940197774265;1975.5950030243766;2301.873396963166;2324.3840382298704;2329.7087864017;2332.926853647324;2268.3761965459466;2288.702468679069;2294.9885250573807;2300.1719381022817;2302.2172461363048;2035.216441669953;2225.154441312307;2309.307207837659;2315.9305220843403;2316.455632926261;8721.956390218073;8795.208431241219;8811.911880881238;8837.072107428756;8867;4704.435467743859;5096.974515127401;5223.425423203445;5342.171963345649;5363.383210930715;3104.1929098434343;3428.9657103428895;3584.534010578634;3647.927041459156;3650.762700424464;1049.4175732468477;1081.4376524207446;1085.7014321061692;1105.1214284643647;1111.5664890692635;11476.942615286871;11552.711182220512;11591;11594.652160435116;11632.953034226875;4351.26028575143;4393;4578.2903649934315;4584.266517357207;4607.562281583244;7864.174261702553;9202.723918282461;9208.171264586219;9215.124563166488;9217.078292170729;5195.818146364859;5221.451747566527;5227.477252274742;5227.738613069331;5230.34620672416;4124.381342798604;4293.785310734451;4378.43080399546;4872.9512704873205;4875.049365373789;3136.43544162053;3771.6039815819495;3835.67396771272;3844.4233364995475;3852.711046671455;978.3054031637474;1123.3989815448697;1136.3863513702508;1137.1357768096307;1162.0297051961538;800.8438354520813;820.5856042698518;836.2599099796723;923.6997975657938;976.9218462522981;5869.941300586939;6003.969980150071;6039.63762174271;6215.751369945242;6250.843728906722;944.7213072143734;945.5792172483317;955.4219697083304;966.3332300712486;992.5384696116196;3864.729468937204;3956.9010774730864;4078.938815917764;4088.386741988666;4160.54234034256;10621.787564248672;10819.350838949531;10896.400697961688;10903.182261330432;10920.617778377718;10297.639582614573;10714.303570267908;10725.678229653124;10882.347059176474;10947.56209751617;7101;8105.1489593593005;8290.8341833163;8296.377771667148;8307.750767476986;5702.914456283076;5948.256467941507;6025.8192254232445;6196.256449226122;6203.131561581473;9984.400935943866;10243.795124097625;10253.025962533547;10261.486925653538;10262.897371026194;9360.297977651839;9777.657781977596;10154.54304556282;10274.075333220046;10392.896071039193;7120.359167674934;7474;7569.394448444222;7655.846883062419;7794.259545343183;8248.83502329962;8328.3337333012;8362.87455688153;8420.789480263042;8443.535605541509;7529.510581812165;7530.729579698522;7535.472516923982;7600.391968642606;7633.0458692663415;7376.409887209118;7388.261173882569;7435.144958329862;7455.4035677146785;7554.886676699744;7031.1211098612675;7034.753783617549;7055.717771289091;7106.6446677666945;7112.644367781487;4921.926171107508;4929.16204245272;5009.398872135222;5056.6713163644245;5211.557017653542;4965.354503914468;5019.297298378303;5041.941192349647;5072.188449848007;5254.763535640982 19:02:04 INFO - PROCESS | 1653 | |4;prototype.html;286.2414601306538;295.95708622249776;310.6520696819561;310.97978631388946;315.38814699483004;4500.582316570286;4922.729249891255;5296.549793267572;5302.151655735079;5376.462353764621;4998.350214472122;5122.846314610568;5142.3287431584695;5223.608229382802;5242.606804489659;3247.967520324802;3814.1775086436114;4047.3726572381256;4051.5616955980645;4068.5417395214126;3375.5611770469927;3821.61783821617;4060.593940605945;4081.5918408159246;4092.6494256895153;3763.209725957552;3966.8214930328204;3973.284808734427;3998.7800670963084;4026.3557830747086;3960.6633436157963;3984.442178095069;3984.860529881469;3985.903876433975;3989.4614227079264;2992.640883094021;3383.983080084584;3478.721702263813;3500.4049311617086;3517.4699005932503;4506.7070640408265;4826.686265392738;5111.798727299119;5181.326427564431;5203.635745497817;3919.8432062717457;4170.645495132887;4502.41468609082;4528;4537.4328208973875;4760.952390476085;4765.309030190603;4973.477784832577;5483.435766751603;5494.835154945358;3316.6351701312838;3506.5967413747235;3751.868684596026;3760.7555508891833;3768.321702093622;5455.918161227585;5703.486686198221;5782.335031471351;5801.3618501965175;5826.329972053226;3280.2947366316357;3380.9323813523592;3852.3065848147603;3879.941800872989;3888.6694630956686;3086.305581244202;3404.5403870477166;3910.865848903786;3929.25344184604;3930.8624198153498;4251.00101476159;4531.3882625845745;4550.3824459554735;4553.225951588238;4581.725096494221;5351.812686555952;5556.555475561945;5565.413857050721;5587.832365029056;5601.439856014366;1239.7768401687601;1277.1800184736712;1282.5895713371817;1288.7100402409383;1330.4545136493991;735.0701362776092;782.945193836426;797.57728403946;799.7800604833717;828.4863384701404;3831.9307573910332;4271.487421509377;4309.461317335333;4336.76147811867;4352.760598167068;3979.965209045611;4767.642426818003;4793.904121917542;4833.9214137921035;4867.1969125093965;4757.857264282077;5071.442141364447;5179.928028788515;5197.271432497969;5226.817061402832;3003.5344521599186;3007.5338322560037;3023.727864492206;3030.7423868970945;3044.3606842562867;5452.427495113036;5589.692566908859;5919.822405327847;5967.492763115184;5982.790602328898;4696.976515117402;5915.231019967463;5939.910901336483;5942.138389933435;5956.880862382728;5301.54936830366;5562.745793710725;6002.339742628395;6015.548833837567;6068.514518838482;5604.355499117653;5675;5745.166950792195;5749.770009199585;5760;4959;5590.496855283044;5687.5449964001955;5699.202111704281;5823.970880145572;4338.913221735611;5242.921356179737;5588.608797384307;5823.854403639773;5944.821655350346;3770.3967365221433;3835.9041023974623;3860.285847118292;3862.729608927348;3879.254335548958;5236.795537026582;5612.382637909908;5734.483896449339;5768.067697321444;5816.47651711348;4725.487843889922;4888.120138375127;5293.206019097166;5419.132938729785;5656.3495198051105;5309.089092589416;5547.44525547442;5547.585365731874;5564.610477266552;5586.748596313095;4641.419822522184;5057.342545469065;5168.71572063525;5311.362636483646;5337.946620533745;4620.607248383925;5290.285811415563;5583.972080139573;5595.418931883679;5615.6630602164005;4519.389882365838;4919.262110683426;5143.177091665316;5459.781608735606;5462.890742185214 19:02:04 INFO - PROCESS | 1653 | |5;yui.html;717.5120917775912;720.6720941971407;770.722539885641;810.8175660476397;828.9626966786494;15116.546503604883;16752.832471675294;16765.7485137723;16772.329106835743;16773;14923.328450219766;15115.84884151158;15121.16833574153;15136.772948405784;15142.848571514282;689.8344397344651;711.9145702515706;845.0873057098349;850.391969741633;871.1332224436694;843.9282660973824;863.2791618998144;863.7451951674271;863.9308855291562;866.7529754020105;912.7079334612927;916.1754421021068;918.1874041473311;918.8897332320131;920.8894932608063;727.0657205490919;893.3835653399134;907.1744712311764;913.2328843771231;913.2921985461287;689.7585844954276;689.941354984827;690.1855810144028;690.9516333856632;693.3240090911321;15015.624609384744;15075.5477335679;15102.244887755569;15148.924255378763;15177.317020733983;12238.837310455492;14136;14420;14559.272036398137;14621.195834229113;10540.525676344583;11608.593699220572;11875.821862672066;12146;12364.44360003802;3384.4754063120254;4049.3925911113274;4088.4276201331836;4127.979360103211;4145.461090058273;87838.12161878427;102319;108525;112727;120123.99999999913;11525.135614828921;11540.192186546861;11666.183367164216;11826.52693892252;12179.695507612203;24104.87947560251;24799.876000619883;24846.627300590506;24851.751482485306;24895.5020899581;8197.180281971756;8365.58172091393;8393.580320983927;8691.913080869237;8700.956495217484;4324.394584758136;4467.754273514923;4468.530804265571;4725.787339569728;4729.432468103781;3684.2815650948346;3802.524684414448;3805.0487378155462;3807.3717836556657;3808.5810560838286;677.3531277629852;683.1870074611197;692.2108795972596;705.7212401101536;714.2393351081082;584.5878655547829;634.8730253949228;666.7199776094052;684.7706018483764;695.8747425463364;8988.191062804248;9122.042185570419;9421.811563768822;9508.239340852715;9698.175655069399;570.4010788671878;644.239797039498;676.5433332500543;678.5860625018735;692.5533031194851;4566.086782643418;4602.907941841145;4683.220376257069;4714.528547145258;4765.9523404766205;130258.69741302465;134719;159720;167084;169053;139930;143259;144405;146238;149550;87806;98695.0260994776;99784.50323245158;101542;104907;9387.812243755223;9743.902560974582;10039.74900627461;10093.545790439595;10114.544845481823;50814;60081.09878351741;62962;64501.35498645141;65427;93437.06562934283;97559.51220243853;97703;97721.53417698882;100754.4962275184;13113.409896554487;13287.40206690682;13303;13382.996275279198;13857.099288546213;11908.940455297668;14554.053986490844;14888;14986.6084120121;15472.767908481157;13741.969352298418;13964.4414223434;14271.357788899317;14411.567652970427;14575.125492470486;13662.658433539242;14033.017688761689;14090.929545352208;14102.224377658917;14472.975936521541;13712.451501939811;13722.725545489235;13836.37736301889;14008.929955350159;14024.439022438988;11200;11224.158188136085;11410.600628977945;11432.08543316516;11965.940170299093;11246.775064498828;11448.885511144781;11546.364949927834;11551.133664974992;11595.420228988349 19:02:04 INFO - PROCESS | 1653 | __end_tp_report 19:02:04 INFO - PROCESS | 1653 | __start_cc_report 19:02:04 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1161 19:02:04 INFO - PROCESS | 1653 | __end_cc_report 19:02:04 INFO - PROCESS | 1653 | __startTimestamp1470880924299__endTimestamp 19:02:04 INFO - PROCESS | 1653 | 19:02:04 INFO - PROCESS | 1653 | ------- Summary: start ------- 19:02:04 INFO - PROCESS | 1653 | Number of tests: 6 19:02:04 INFO - PROCESS | 1653 | 19:02:04 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5727.80 Median:6001.00 stddev:643.28 (10.7%) stddev-sans-first:618.24 19:02:04 INFO - PROCESS | 1653 | Values: 3376.4 3390.3 3402.5 3404.8 3456.3 5411.4 5523.8 5728.5 5810.3 5819.8 5707.6 5775.9 5806.2 5825.4 5865.6 5163.1 5230.8 5245.5 5283.6 5370.4 5337.9 5339.5 5353.8 5367.3 5399.9 4310.8 5142.7 5183.6 5246.5 5278.4 5036.2 5144.8 5240.9 5241.5 5255.3 5169.9 5194.7 5212.7 5219.5 5227.5 5652.5 5654.7 5668.3 5724.1 5755.4 6181.6 6205.2 6211.3 6232.7 6250.5 6153.0 6165.1 6183.0 6216.7 6228.0 5661.7 5708.5 5813.9 5856.1 5886.9 6293.4 6298.4 6298.7 6302.2 6327.5 6190.7 6212.0 6219.5 6224.6 6235.8 6093.7 6100.9 6103.4 6160.9 6168.7 4640.7 6106.5 6124.4 6183.7 6198.3 6166.4 6212.3 6235.0 6237.5 6255.3 4844.3 4886.6 4887.5 4900.0 4921.7 4375.2 4386.7 4408.5 4442.0 4454.3 5793.0 5804.4 5837.9 5848.3 5857.6 6118.2 6194.3 6196.4 6215.4 6228.9 5599.6 5748.5 5780.1 5782.4 5792.1 5473.5 5481.5 5483.0 5494.9 5528.8 5382.3 6391.2 6397.2 6402.3 6405.4 6121.6 6165.6 6166.1 6233.7 6302.8 5386.7 6322.6 6323.9 6328.1 6329.4 6154.9 6166.8 6216.0 6222.3 6231.5 5389.4 5942.4 6104.0 6187.1 6216.8 5070.8 6098.4 6117.8 6121.9 6142.6 6108.9 6122.8 6133.2 6139.5 6159.6 5892.5 6001.0 6017.4 6056.8 6076.9 6135.2 6138.8 6156.6 6170.6 6185.1 6010.3 6045.2 6056.2 6061.2 6109.8 19:02:04 INFO - PROCESS | 1653 | 19:02:04 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:70439.43 Median:38926.32 stddev:153376.70 (394.0%) stddev-sans-first:153717.11 19:02:04 INFO - PROCESS | 1653 | Values: 516.4 522.3 525.1 531.6 551.6 31723.0 40773.0 41805.6 41845.4 43839.6 42199.9 42279.8 42345.8 42373.6 42457.8 9610.5 9794.3 9795.0 9795.5 9815.0 8717.3 8815.8 8825.1 9014.8 9015.8 11621.3 11650.2 11707.0 11875.9 12006.9 11708.9 11799.4 11804.5 11806.3 11832.8 11579.3 11648.2 11657.4 11659.0 11713.2 40282.6 40529.4 40608.2 40618.8 40676.8 3433.8 3464.2 3613.8 3657.2 3906.6 28444.7 28469.7 28535.3 28590.6 28610.9 3231.4 3297.4 3385.6 3408.6 3414.3 488673.0 490233.5 493007.0 493958.0 495069.5 59837.4 60027.4 60107.7 60123.0 60140.4 61677.4 61685.7 61764.0 61816.0 61920.0 16408.4 16573.5 16581.3 16588.6 16594.9 12863.9 12873.2 12883.0 12917.7 12926.4 12510.9 13671.7 13826.8 15891.9 16168.7 5872.8 5972.1 6414.7 6479.8 6481.5 800.3 928.4 989.6 1062.2 1151.3 28370.0 29558.9 29841.7 30553.7 30731.4 1027.6 1058.3 1070.7 1072.7 1075.3 12445.6 12768.8 15234.2 15322.9 15362.5 634710.0 640724.0 641099.3 641462.0 642278.0 51127.2 51313.5 51603.0 58731.4 58778.0 1139.9 1276.8 1306.0 1377.9 1394.9 30240.0 30476.8 31006.7 31197.2 31934.5 49795.8 56505.7 56907.4 57030.4 61117.4 512282.0 590746.0 597433.0 597684.0 598273.0 22733.5 25913.5 26122.7 26286.6 26583.3 46826.8 47101.5 47552.8 47655.0 48135.0 39136.6 39239.4 39815.2 40524.0 40837.4 39088.0 40247.2 40311.2 40387.8 40550.8 37818.8 38127.6 38816.0 38924.4 38928.2 32108.8 33426.7 33532.0 33853.0 34589.3 24715.0 25507.4 25837.6 25853.7 26350.5 19:02:04 INFO - PROCESS | 1653 | 19:02:04 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35415.00 Median:26577.40 stddev:98484.87 (370.6%) stddev-sans-first:98725.88 19:02:04 INFO - PROCESS | 1653 | Values: 313.8 355.9 374.5 378.2 407.1 14565.8 15585.2 20379.8 20512.6 21666.7 20297.4 20482.5 20974.9 21128.7 21285.0 5805.7 6158.8 6162.0 6163.1 6168.4 3922.6 5564.9 6034.5 6759.2 6775.8 6728.1 6749.8 6752.6 6753.1 6761.8 6416.9 6665.3 6667.2 6706.4 6712.7 5574.4 5598.0 5833.0 5836.2 5856.2 26012.0 26215.6 26294.5 26568.2 26586.6 2220.4 2250.4 2472.5 2525.6 3133.7 14269.0 15048.8 15209.0 16208.9 16635.3 1878.3 1961.6 1963.1 1964.2 1964.4 125999.0 130919.0 131564.3 131967.0 132092.0 11494.9 11709.1 11718.4 11773.6 11895.2 12992.5 13533.8 13638.6 14330.8 14336.5 8469.0 8531.3 8647.7 8771.6 8780.2 8608.2 8608.8 8625.6 8806.7 8859.5 4211.0 4479.0 4602.8 4666.7 4678.5 1888.3 1926.8 1935.8 1938.8 1951.3 827.8 888.0 942.6 943.1 956.5 21219.8 21986.6 22075.3 22113.3 22131.2 764.5 916.5 939.7 958.7 1024.2 9280.0 11361.6 11469.9 11490.0 11527.9 577565.0 583839.0 586023.0 593668.0 593687.0 129302.7 132847.0 136143.0 136423.3 138470.0 951.5 973.6 989.8 992.0 993.9 17683.2 19242.8 19299.8 19318.0 19326.8 41481.0 53781.0 56214.0 56275.7 56554.0 59653.7 72778.9 79912.6 80079.6 80265.4 7248.9 8051.4 8364.0 8486.4 8631.6 12337.8 13233.0 13251.9 13681.2 13742.4 11453.9 11627.1 11717.2 11725.2 11828.5 11229.5 11337.3 11346.0 11637.7 11664.5 9207.9 11459.7 11615.2 11738.6 11878.0 6882.9 8013.6 8147.1 8364.7 8660.8 8387.0 10711.4 11016.3 11569.8 11730.3 19:02:04 INFO - PROCESS | 1653 | 19:02:04 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5670.79 Median:5014.35 stddev:3208.66 (64.0%) stddev-sans-first:3201.25 19:02:04 INFO - PROCESS | 1653 | Values: 1352.5 1511.3 1526.4 1732.5 1881.7 7721.3 8602.0 8702.2 8842.5 8961.5 8749.2 8832.8 8841.3 8854.6 8868.2 2160.9 2203.9 2316.0 2345.9 2350.9 1960.4 2292.3 2350.6 2352.6 2353.7 1975.6 2301.9 2324.4 2329.7 2332.9 2268.4 2288.7 2295.0 2300.2 2302.2 2035.2 2225.2 2309.3 2315.9 2316.5 8722.0 8795.2 8811.9 8837.1 8867.0 4704.4 5097.0 5223.4 5342.2 5363.4 3104.2 3429.0 3584.5 3647.9 3650.8 1049.4 1081.4 1085.7 1105.1 1111.6 11476.9 11552.7 11591.0 11594.7 11633.0 4351.3 4393.0 4578.3 4584.3 4607.6 7864.2 9202.7 9208.2 9215.1 9217.1 5195.8 5221.5 5227.5 5227.7 5230.3 4124.4 4293.8 4378.4 4873.0 4875.0 3136.4 3771.6 3835.7 3844.4 3852.7 978.3 1123.4 1136.4 1137.1 1162.0 800.8 820.6 836.3 923.7 976.9 5869.9 6004.0 6039.6 6215.8 6250.8 944.7 945.6 955.4 966.3 992.5 3864.7 3956.9 4078.9 4088.4 4160.5 10621.8 10819.4 10896.4 10903.2 10920.6 10297.6 10714.3 10725.7 10882.3 10947.6 7101.0 8105.1 8290.8 8296.4 8307.8 5702.9 5948.3 6025.8 6196.3 6203.1 9984.4 10243.8 10253.0 10261.5 10262.9 9360.3 9777.7 10154.5 10274.1 10392.9 7120.4 7474.0 7569.4 7655.8 7794.3 8248.8 8328.3 8362.9 8420.8 8443.5 7529.5 7530.7 7535.5 7600.4 7633.0 7376.4 7388.3 7435.1 7455.4 7554.9 7031.1 7034.8 7055.7 7106.6 7112.6 4921.9 4929.2 5009.4 5056.7 5211.6 4965.4 5019.3 5041.9 5072.2 5254.8 19:02:04 INFO - PROCESS | 1653 | 19:02:04 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4425.40 Median:4850.56 stddev:1378.07 (28.4%) stddev-sans-first:1346.46 19:02:04 INFO - PROCESS | 1653 | Values: 286.2 296.0 310.7 311.0 315.4 4500.6 4922.7 5296.5 5302.2 5376.5 4998.4 5122.8 5142.3 5223.6 5242.6 3248.0 3814.2 4047.4 4051.6 4068.5 3375.6 3821.6 4060.6 4081.6 4092.6 3763.2 3966.8 3973.3 3998.8 4026.4 3960.7 3984.4 3984.9 3985.9 3989.5 2992.6 3384.0 3478.7 3500.4 3517.5 4506.7 4826.7 5111.8 5181.3 5203.6 3919.8 4170.6 4502.4 4528.0 4537.4 4761.0 4765.3 4973.5 5483.4 5494.8 3316.6 3506.6 3751.9 3760.8 3768.3 5455.9 5703.5 5782.3 5801.4 5826.3 3280.3 3380.9 3852.3 3879.9 3888.7 3086.3 3404.5 3910.9 3929.3 3930.9 4251.0 4531.4 4550.4 4553.2 4581.7 5351.8 5556.6 5565.4 5587.8 5601.4 1239.8 1277.2 1282.6 1288.7 1330.5 735.1 782.9 797.6 799.8 828.5 3831.9 4271.5 4309.5 4336.8 4352.8 3980.0 4767.6 4793.9 4833.9 4867.2 4757.9 5071.4 5179.9 5197.3 5226.8 3003.5 3007.5 3023.7 3030.7 3044.4 5452.4 5589.7 5919.8 5967.5 5982.8 4697.0 5915.2 5939.9 5942.1 5956.9 5301.5 5562.7 6002.3 6015.5 6068.5 5604.4 5675.0 5745.2 5749.8 5760.0 4959.0 5590.5 5687.5 5699.2 5824.0 4338.9 5242.9 5588.6 5823.9 5944.8 3770.4 3835.9 3860.3 3862.7 3879.3 5236.8 5612.4 5734.5 5768.1 5816.5 4725.5 4888.1 5293.2 5419.1 5656.3 5309.1 5547.4 5547.6 5564.6 5586.7 4641.4 5057.3 5168.7 5311.4 5337.9 4620.6 5290.3 5584.0 5595.4 5615.7 4519.4 4919.3 5143.2 5459.8 5462.9 19:02:04 INFO - PROCESS | 1653 | 19:02:04 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25361.52 Median:3534.38 stddev:40588.88 (1148.4%) stddev-sans-first:40660.56 19:02:04 INFO - PROCESS | 1653 | Values: 717.5 720.7 770.7 810.8 829.0 15116.5 16752.8 16765.7 16772.3 16773.0 14923.3 15115.8 15121.2 15136.8 15142.8 689.8 711.9 845.1 850.4 871.1 843.9 863.3 863.7 863.9 866.8 912.7 916.2 918.2 918.9 920.9 727.1 893.4 907.2 913.2 913.3 689.8 689.9 690.2 691.0 693.3 15015.6 15075.5 15102.2 15148.9 15177.3 12238.8 14136.0 14420.0 14559.3 14621.2 10540.5 11608.6 11875.8 12146.0 12364.4 3384.5 4049.4 4088.4 4128.0 4145.5 87838.1 102319.0 108525.0 112727.0 120124.0 11525.1 11540.2 11666.2 11826.5 12179.7 24104.9 24799.9 24846.6 24851.8 24895.5 8197.2 8365.6 8393.6 8691.9 8701.0 4324.4 4467.8 4468.5 4725.8 4729.4 3684.3 3802.5 3805.0 3807.4 3808.6 677.4 683.2 692.2 705.7 714.2 584.6 634.9 666.7 684.8 695.9 8988.2 9122.0 9421.8 9508.2 9698.2 570.4 644.2 676.5 678.6 692.6 4566.1 4602.9 4683.2 4714.5 4766.0 130258.7 134719.0 159720.0 167084.0 169053.0 139930.0 143259.0 144405.0 146238.0 149550.0 87806.0 98695.0 99784.5 101542.0 104907.0 9387.8 9743.9 10039.7 10093.5 10114.5 50814.0 60081.1 62962.0 64501.4 65427.0 93437.1 97559.5 97703.0 97721.5 100754.5 13113.4 13287.4 13303.0 13383.0 13857.1 11908.9 14554.1 14888.0 14986.6 15472.8 13742.0 13964.4 14271.4 14411.6 14575.1 13662.7 14033.0 14090.9 14102.2 14473.0 13712.5 13722.7 13836.4 14008.9 14024.4 11200.0 11224.2 11410.6 11432.1 11965.9 11246.8 11448.9 11546.4 11551.1 11595.4 19:02:04 INFO - PROCESS | 1653 | -------- Summary: end -------- 19:02:04 INFO - PROCESS | 1653 | 19:02:04 INFO - TEST-INFO | 1653: exit 0 19:02:04 INFO - TEST-OK | dromaeo_css | took 1117886ms 19:02:04 INFO - TEST-START | kraken 19:02:04 INFO - operating with platform_type : mac_ 19:02:04 INFO - Initialising browser for kraken test... 19:02:04 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpfHGHfT/profile http://localhost:49280/getInfo.html) 19:02:07 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 19:02:07 INFO - PROCESS | 1662 | colorDepth:24 19:02:07 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 19:02:07 INFO - PROCESS | 1662 | __metrics 19:02:07 INFO - PROCESS | 1662 | 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" 19:02:07 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:02:08 INFO - TEST-INFO | 1662: exit 0 19:02:08 INFO - Browser initialized. 19:02:08 INFO - Running cycle 1/1 for kraken test... 19:02:08 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpfHGHfT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:20 INFO - PROCESS | 1663 | RSS: Main: 243642368 19:02:20 INFO - PROCESS | 1663 | 19:02:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 19:02:23 INFO - PROCESS | 1663 | RSS: Main: 293171200 19:02:23 INFO - PROCESS | 1663 | 19:02:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 19:02:26 INFO - PROCESS | 1663 | RSS: Main: 298913792 19:02:26 INFO - PROCESS | 1663 | 19:02:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 19:02:31 INFO - PROCESS | 1663 | RSS: Main: 392351744 19:02:31 INFO - PROCESS | 1663 | 19:02:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 19:02:33 INFO - PROCESS | 1663 | RSS: Main: 296312832 19:02:33 INFO - PROCESS | 1663 | 19:02:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:02:36 INFO - PROCESS | 1663 | RSS: Main: 300724224 19:02:36 INFO - PROCESS | 1663 | 19:02:39 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 19:02:39 INFO - PROCESS | 1663 | RSS: Main: 337739776 19:02:39 INFO - PROCESS | 1663 | 19:02:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 19:02:43 INFO - PROCESS | 1663 | RSS: Main: 338944000 19:02:43 INFO - PROCESS | 1663 | 19:02:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 19:02:46 INFO - PROCESS | 1663 | RSS: Main: 338034688 19:02:46 INFO - PROCESS | 1663 | 19:02:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:02:48 INFO - PROCESS | 1663 | RSS: Main: 314531840 19:02:48 INFO - PROCESS | 1663 | 19:02:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:02:51 INFO - PROCESS | 1663 | RSS: Main: 320421888 19:02:51 INFO - PROCESS | 1663 | 19:02:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:02:54 INFO - PROCESS | 1663 | RSS: Main: 328237056 19:02:54 INFO - PROCESS | 1663 | 19:02:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:02:58 INFO - PROCESS | 1663 | RSS: Main: 331374592 19:02:58 INFO - PROCESS | 1663 | 19:03:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:03:01 INFO - PROCESS | 1663 | RSS: Main: 332722176 19:03:01 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 19:03:03 INFO - PROCESS | 1663 | RSS: Main: 375566336 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | __start_tp_report 19:03:03 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 19:03:03 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 19:03:03 INFO - PROCESS | 1663 | |i|pagename|runs| 19:03:03 INFO - PROCESS | 1663 | |0;ai-astar;102;113;113;113;113;113;114;113;113;113 19:03:03 INFO - PROCESS | 1663 | |1;audio-beat-detection;143;109;118;203;138;107;128;101;142;108 19:03:03 INFO - PROCESS | 1663 | |2;audio-dft;198;212;183;185;184;184;184;184;182;184 19:03:03 INFO - PROCESS | 1663 | |3;audio-fft;81;61;67;111;79;68;62;61;82;56 19:03:03 INFO - PROCESS | 1663 | |4;audio-oscillator;91;70;101;69;73;68;97;73;67;104 19:03:03 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;90;85;90;87;89;87;90;88;90;86 19:03:03 INFO - PROCESS | 1663 | |6;imaging-darkroom;93;95;94;95;95;95;94;94;94;93 19:03:03 INFO - PROCESS | 1663 | |7;imaging-desaturate;84;86;84;85;84;85;96;132;85;86 19:03:03 INFO - PROCESS | 1663 | |8;json-parse-financial;55;54;54;55;53;55;52;53;53;52 19:03:03 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;68;74;73;77;78;96;98;59;98;98 19:03:03 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;87;84;85;85;85;86;82;85;86;126 19:03:03 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;140;136;138;143;134;136;134;133;150;139 19:03:03 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;211;184;165;168;165;167;166;166;168;163 19:03:03 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;66;66;68;68;77;84;83;82;71;66 19:03:03 INFO - PROCESS | 1663 | __end_tp_report 19:03:03 INFO - PROCESS | 1663 | __start_cc_report 19:03:03 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2011 19:03:03 INFO - PROCESS | 1663 | __end_cc_report 19:03:03 INFO - PROCESS | 1663 | __startTimestamp1470880983586__endTimestamp 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | ------- Summary: start ------- 19:03:03 INFO - PROCESS | 1663 | Number of tests: 14 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.53 (3.1%) stddev-sans-first:0.33 19:03:03 INFO - PROCESS | 1663 | Values: 102.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:133.00 stddev:30.09 (22.6%) stddev-sans-first:31.53 19:03:03 INFO - PROCESS | 1663 | Values: 143.0 109.0 118.0 203.0 138.0 107.0 128.0 101.0 142.0 108.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:188.00 Median:184.00 stddev:9.58 (5.2%) stddev-sans-first:9.45 19:03:03 INFO - PROCESS | 1663 | Values: 198.0 212.0 183.0 185.0 184.0 184.0 184.0 184.0 182.0 184.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:72.80 Median:67.50 stddev:16.27 (24.1%) stddev-sans-first:16.99 19:03:03 INFO - PROCESS | 1663 | Values: 81.0 61.0 67.0 111.0 79.0 68.0 62.0 61.0 82.0 56.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:71.50 stddev:15.06 (21.1%) stddev-sans-first:15.56 19:03:03 INFO - PROCESS | 1663 | Values: 91.0 70.0 101.0 69.0 73.0 68.0 97.0 73.0 67.0 104.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.50 stddev:1.87 (2.1%) stddev-sans-first:1.87 19:03:03 INFO - PROCESS | 1663 | Values: 90.0 85.0 90.0 87.0 89.0 87.0 90.0 88.0 90.0 86.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 19:03:03 INFO - PROCESS | 1663 | Values: 93.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 93.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:90.70 Median:85.00 stddev:14.94 (17.6%) stddev-sans-first:15.65 19:03:03 INFO - PROCESS | 1663 | Values: 84.0 86.0 84.0 85.0 84.0 85.0 96.0 132.0 85.0 86.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.17 (2.2%) stddev-sans-first:1.13 19:03:03 INFO - PROCESS | 1663 | Values: 55.0 54.0 54.0 55.0 53.0 55.0 52.0 53.0 53.0 52.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:81.90 Median:87.00 stddev:14.43 (16.6%) stddev-sans-first:14.41 19:03:03 INFO - PROCESS | 1663 | Values: 68.0 74.0 73.0 77.0 78.0 96.0 98.0 59.0 98.0 98.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:85.00 stddev:13.03 (15.3%) stddev-sans-first:13.80 19:03:03 INFO - PROCESS | 1663 | Values: 87.0 84.0 85.0 85.0 85.0 86.0 82.0 85.0 86.0 126.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:138.50 stddev:5.14 (3.7%) stddev-sans-first:5.42 19:03:03 INFO - PROCESS | 1663 | Values: 140.0 136.0 138.0 143.0 134.0 136.0 134.0 133.0 150.0 139.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:167.50 stddev:14.80 (8.8%) stddev-sans-first:6.20 19:03:03 INFO - PROCESS | 1663 | Values: 211.0 184.0 165.0 168.0 165.0 167.0 166.0 166.0 168.0 163.0 19:03:03 INFO - PROCESS | 1663 | 19:03:03 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:74.00 stddev:7.59 (10.3%) stddev-sans-first:7.61 19:03:03 INFO - PROCESS | 1663 | Values: 66.0 66.0 68.0 68.0 77.0 84.0 83.0 82.0 71.0 66.0 19:03:03 INFO - PROCESS | 1663 | -------- Summary: end -------- 19:03:03 INFO - PROCESS | 1663 | 19:03:04 INFO - TEST-INFO | 1663: exit 0 19:03:04 INFO - TEST-OK | kraken | took 59481ms 19:03:04 INFO - SUITE-END | took 1177s 19:03:04 INFO - Completed test suite (00:19:37) 19:03:04 INFO - javascript benchmark 19:03:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.4428869236576, 3390.271091715282, 3402.489626556017, 3404.7616666833333, 3456.291460250647, 5411.431799661028, 5523.7790488380415, 5728.484436400723, 5810.331811841639, 5819.825405237839, 5707.600467967233, 5775.884482310362, 5806.187133801272, 5825.417458254173, 5865.560082993782, 5163.096458119833, 5230.7646155922885, 5245.527902488775, 5283.577313814885, 5370.409254981969, 5337.893242135155, 5339.466053394649, 5353.7590808413715, 5367.275417818603, 5399.946000540003, 4310.78446077698, 5142.74286285688, 5183.611229157828, 5246.50158234969, 5278.445763194886, 5036.194208926554, 5144.768485418165, 5240.895182096337, 5241.528262456359, 5255.290535777659, 5169.870753231162, 5194.740262986836, 5212.713300768456, 5219.5041471060185, 5227.503387178212, 5652.547796176296, 5654.660720356792, 5668.348139963916, 5724.112762521816, 5755.424457554211, 6181.629102253879, 6205.193324867739, 6211.3167551569295, 6232.688365581703, 6250.468710159642, 6152.984757515004, 6165.075238714184, 6183.041628547582, 6216.689165541705, 6227.96886015567, 5661.66030038199, 5708.514776243983, 5813.912791308134, 5856.092305692625, 5886.8822623547285, 6293.402126797947, 6298.433141017331, 6298.685065746694, 6302.243730752248, 6327.4938004959495, 6190.721417536221, 6212.0, 6219.502439804804, 6224.626522408579, 6235.781747638811, 6093.725782339805, 6100.8779824404155, 6103.375170450573, 6160.9383906161265, 6168.722407491674, 4640.698354607007, 6106.460667180062, 6124.441964285778, 6183.690815459209, 6198.256209254918, 6166.445019948226, 6212.285587157535, 6235.0, 6237.5009999200865, 6255.343188965184, 4844.346013288232, 4886.633502487328, 4887.511248875084, 4899.951000490021, 4921.680090794087, 4375.212461756851, 4386.670999675037, 4408.493023302297, 4442.022754993896, 4454.26504626733, 5792.957267691771, 5804.390538993429, 5837.9124313135335, 5848.327442344185, 5857.560682948796, 6118.174046503754, 6194.34959329273, 6196.442320191204, 6215.440610345, 6228.937710622927, 5599.608027438122, 5748.482636562646, 5780.132980053026, 5782.392848750905, 5792.1311803229855, 5473.534749546333, 5481.506664400223, 5483.0, 5494.862628434321, 5528.778848846082, 5382.273393092039, 6391.201099862517, 6397.168368112116, 6402.327755585783, 6405.391487808558, 6121.574916084701, 6165.630062196283, 6166.105914642441, 6233.657148856856, 6302.842428939313, 5386.676799392049, 6322.589031712924, 6323.936760632335, 6328.050792381179, 6329.367063293634, 6154.907676384768, 6166.784162554289, 6215.96892015537, 6222.346653601488, 6231.532635052298, 5389.434109418455, 5942.376050514634, 6104.004449388181, 6187.102870083902, 6216.844578885564, 5070.797168113234, 6098.40197260387, 6117.827404800828, 6121.910283036266, 6142.621558143092, 6108.918862504554, 6122.764110201706, 6133.1510485532735, 6139.492138333381, 6159.630422174684, 5892.469677729025, 6001.0, 6017.428344307459, 6056.84857878539, 6076.8784624308155, 6135.171751813448, 6138.848241798255, 6156.630602163885, 6170.629762214281, 6185.134081228722, 6010.338862725184, 6045.2098175002575, 6056.182415373868, 6061.1514387984835, 6109.75560977556], "value": 5688.567764135468, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.4216077992648, 522.3366324767545, 525.0758664750041, 531.5534950641463, 551.627651335349, 31723.048308550722, 40773.0, 41805.58194418055, 41845.37231941523, 43839.56160438403, 42199.94500137498, 42279.78860105695, 42345.7882710586, 42373.57626423735, 42457.7877110614, 9610.471424071691, 9794.265430092772, 9795.0, 9795.461249631267, 9815.018498150164, 8717.259032982203, 8815.77960550988, 8825.117488251188, 9014.819703605925, 9015.774605634879, 11621.302721836675, 11650.184487085908, 11707.0, 11875.881241187608, 12006.879931200663, 11708.941455292712, 11799.410029498491, 11804.527818887234, 11806.291622502677, 11832.822507662435, 11579.30524168544, 11648.184627076109, 11657.417129143509, 11659.00898423635, 11713.238639488405, 40282.597174028175, 40529.392059119135, 40608.18783624311, 40618.79690601528, 40676.796616017025, 3433.759636825423, 3464.185916309665, 3613.8012409317475, 3657.158853463718, 3906.58980807014, 28444.715552844413, 28469.715302847122, 28535.28661783472, 28590.571141432894, 28610.85694571514, 3231.3698828728407, 3297.4394352960053, 3385.5768028996376, 3408.5739282589675, 3414.334204830059, 488673.0, 490233.54883225355, 493007.0, 493958.0, 495069.52465237805, 59837.40162598405, 60027.39972600218, 60107.699461502416, 60123.0, 60140.398596014355, 61677.38322616806, 61685.69157154186, 61764.0, 61816.0, 61920.0, 16408.425705100504, 16573.50279491617, 16581.25384357707, 16588.58528536772, 16594.921330113502, 12863.935680321538, 12873.163244389085, 12883.0, 12917.741645167232, 12926.41831117602, 12510.874891251153, 13671.658208544666, 13826.792598111037, 15891.920540397456, 16168.67662646764, 5872.765089396462, 5972.134040564094, 6414.711337989708, 6479.838004049842, 6481.546291759531, 800.2677550041763, 928.4058202750246, 989.559645957542, 1062.1715062251455, 1151.250099848226, 28370.0, 29558.852205739262, 29841.701582984326, 30553.69446305553, 30731.385372292876, 1027.6197806811529, 1058.296233005043, 1070.743021674808, 1072.6781965410346, 1075.3386667199616, 12445.62663120108, 12768.80846787299, 15234.238288085551, 15322.85078619108, 15362.462313818962, 634710.0, 640724.0, 641099.3285436431, 641462.0, 642278.0, 51127.23309150366, 51313.48686513162, 51603.0, 58731.412685872594, 58778.0, 1139.8518192634904, 1276.7510335484676, 1305.9738805224033, 1377.8622137786342, 1394.8674875886775, 30240.0, 30476.84761576178, 31006.689933101283, 31197.220069498446, 31934.52098218575, 49795.751021244665, 56505.71747141238, 56907.43092569021, 57030.429695702514, 61117.38882611295, 512282.0, 590746.0, 597433.0, 597684.0, 598273.0, 22733.545329092995, 25913.481730365664, 26122.738772612032, 26286.60570091412, 26583.33541661474, 46826.76586617045, 47101.528984709716, 47552.762236188595, 47655.046899062516, 48135.0, 39136.60863391444, 39239.41140882832, 39815.20369592534, 40524.0, 40837.38743918903, 39088.0, 40247.1950560993, 40311.246972885085, 40387.798061009504, 40550.78347649575, 37818.81090594529, 38127.618723812404, 38816.0, 38924.41613375858, 38928.22143557169, 32108.839455802572, 33426.665733343325, 33532.0, 33853.0, 34589.308213836084, 24715.0, 25507.36231594225, 25837.612435813855, 25853.729152834876, 26350.472990540464], "value": 20087.999173644657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.80700868965585, 355.92525569630374, 374.51874341471216, 378.15482396843043, 407.0596921112231, 14565.761910237628, 15585.22073896305, 20379.79620203801, 20512.589748205046, 21666.674999874976, 20297.39107826764, 20482.48793780156, 20974.89512552439, 21128.683069753966, 21285.0, 5805.680687562182, 6158.784442544512, 6162.0, 6163.137160797492, 6168.414000669929, 3922.627350401707, 5564.888702225973, 6034.547408944325, 6759.222689390734, 6775.830604234884, 6728.091707619457, 6749.831254218635, 6752.594844309333, 6753.054572359873, 6761.763338283161, 6416.935830641681, 6665.33346665332, 6667.199936007686, 6706.396424321786, 6712.697928593225, 5574.386817450078, 5598.0, 5832.970835145839, 5836.182934389189, 5856.15085812559, 26012.0, 26215.606765898527, 26294.474110517873, 26568.202953911412, 26586.601200981808, 2220.433789383713, 2250.437390652337, 2472.4807790364043, 2525.595904655265, 3133.6709645487354, 14269.00116991811, 15048.774268385983, 15208.958208358263, 16208.918955405265, 16635.334586616522, 1878.3063541439672, 1961.5586493038952, 1963.1264087481077, 1964.2437661500283, 1964.3615824856836, 125999.0, 130919.0, 131564.34217828946, 131967.0, 132092.0, 11494.942525287488, 11709.063274937984, 11718.414079296, 11773.587924422603, 11895.226810257305, 12992.545260915822, 13533.796993045113, 13638.590842274747, 14330.785038224434, 14336.49822256216, 8468.957655211685, 8531.317494600416, 8647.697330593399, 8771.649134034695, 8780.165884240987, 8608.225259726654, 8608.827823443497, 8625.568721563897, 8806.691765788166, 8859.512726800089, 4211.010412553048, 4479.006841955299, 4602.838900638461, 4666.65000124992, 4678.485366609671, 1888.3202047262973, 1926.7591551056119, 1935.7773856006459, 1938.8463864000896, 1951.3170390363543, 827.8468483330603, 888.0, 942.5625920471336, 943.1464524605243, 956.5408603870181, 21219.78780212209, 21986.568393068108, 22075.33773986783, 22113.336599902028, 22131.24587607234, 764.4610549562545, 916.5234078279258, 939.699296225215, 958.7411398922392, 1024.2164743970868, 9280.0, 11361.602343918088, 11469.910358515928, 11490.023348015346, 11527.884721152848, 577565.0, 583839.0, 586023.0, 593668.0, 593687.0, 129302.70697293094, 132847.0, 136143.0, 136423.27153456875, 138470.0, 951.5480146930153, 973.5618971462728, 989.7624570103123, 991.980160396788, 993.9155171810477, 17683.20425580826, 19242.807571924663, 19299.8070019298, 19318.0, 19326.806731932502, 41481.0, 53781.0, 56214.0, 56275.71862140663, 56554.0, 59653.70173149106, 72778.90831637423, 79912.60043699744, 80079.59960200162, 80265.394692107, 7248.855022899618, 8051.436399451982, 8364.0, 8486.40595158333, 8631.56842157877, 12337.814932775836, 13233.007524435514, 13251.933740331237, 13681.247531385869, 13742.381592828147, 11453.942730286295, 11627.127965402799, 11717.238379505305, 11725.241213817995, 11828.467718952495, 11229.49467273991, 11337.26307789991, 11346.0, 11637.709057273636, 11664.533418663497, 9207.861882071908, 11459.656210313704, 11615.186936914335, 11738.58914937973, 11878.0, 6882.8967565485555, 8013.639386227517, 8147.10381858007, 8364.749057528285, 8660.826783464421, 8386.958065209636, 10711.357318560911, 11016.283941543774, 11569.826452603049, 11730.296182229093], "value": 9849.639078492079, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.4860552989874, 1511.3350125944587, 1526.3894442223109, 1732.4542769027755, 1881.670707626165, 7721.343685786708, 8602.0, 8702.216800487962, 8842.469451832878, 8961.507117108556, 8749.168828961254, 8832.823343533142, 8841.292696584274, 8854.557272136384, 8868.24619907307, 2160.945976350588, 2203.900824462903, 2315.976840231597, 2345.9178928737497, 2350.9412264693347, 1960.4412742368427, 2292.32376448948, 2350.5533948549805, 2352.5765362234793, 2353.6940197774265, 1975.5950030243766, 2301.873396963166, 2324.3840382298704, 2329.7087864017, 2332.926853647324, 2268.3761965459466, 2288.702468679069, 2294.9885250573807, 2300.1719381022817, 2302.2172461363048, 2035.216441669953, 2225.154441312307, 2309.307207837659, 2315.9305220843403, 2316.455632926261, 8721.956390218073, 8795.208431241219, 8811.911880881238, 8837.072107428756, 8867.0, 4704.435467743859, 5096.974515127401, 5223.425423203445, 5342.171963345649, 5363.383210930715, 3104.1929098434343, 3428.9657103428895, 3584.534010578634, 3647.927041459156, 3650.762700424464, 1049.4175732468477, 1081.4376524207446, 1085.7014321061692, 1105.1214284643647, 1111.5664890692635, 11476.942615286871, 11552.711182220512, 11591.0, 11594.652160435116, 11632.953034226875, 4351.26028575143, 4393.0, 4578.2903649934315, 4584.266517357207, 4607.562281583244, 7864.174261702553, 9202.723918282461, 9208.171264586219, 9215.124563166488, 9217.078292170729, 5195.818146364859, 5221.451747566527, 5227.477252274742, 5227.738613069331, 5230.34620672416, 4124.381342798604, 4293.785310734451, 4378.43080399546, 4872.9512704873205, 4875.049365373789, 3136.43544162053, 3771.6039815819495, 3835.67396771272, 3844.4233364995475, 3852.711046671455, 978.3054031637474, 1123.3989815448697, 1136.3863513702508, 1137.1357768096307, 1162.0297051961538, 800.8438354520813, 820.5856042698518, 836.2599099796723, 923.6997975657938, 976.9218462522981, 5869.941300586939, 6003.969980150071, 6039.63762174271, 6215.751369945242, 6250.843728906722, 944.7213072143734, 945.5792172483317, 955.4219697083304, 966.3332300712486, 992.5384696116196, 3864.729468937204, 3956.9010774730864, 4078.938815917764, 4088.386741988666, 4160.54234034256, 10621.787564248672, 10819.350838949531, 10896.400697961688, 10903.182261330432, 10920.617778377718, 10297.639582614573, 10714.303570267908, 10725.678229653124, 10882.347059176474, 10947.56209751617, 7101.0, 8105.1489593593005, 8290.8341833163, 8296.377771667148, 8307.750767476986, 5702.914456283076, 5948.256467941507, 6025.8192254232445, 6196.256449226122, 6203.131561581473, 9984.400935943866, 10243.795124097625, 10253.025962533547, 10261.486925653538, 10262.897371026194, 9360.297977651839, 9777.657781977596, 10154.54304556282, 10274.075333220046, 10392.896071039193, 7120.359167674934, 7474.0, 7569.394448444222, 7655.846883062419, 7794.259545343183, 8248.83502329962, 8328.3337333012, 8362.87455688153, 8420.789480263042, 8443.535605541509, 7529.510581812165, 7530.729579698522, 7535.472516923982, 7600.391968642606, 7633.0458692663415, 7376.409887209118, 7388.261173882569, 7435.144958329862, 7455.4035677146785, 7554.886676699744, 7031.1211098612675, 7034.753783617549, 7055.717771289091, 7106.6446677666945, 7112.644367781487, 4921.926171107508, 4929.16204245272, 5009.398872135222, 5056.6713163644245, 5211.557017653542, 4965.354503914468, 5019.297298378303, 5041.941192349647, 5072.188449848007, 5254.763535640982], "value": 4529.431433048243, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.2414601306538, 295.95708622249776, 310.6520696819561, 310.97978631388946, 315.38814699483004, 4500.582316570286, 4922.729249891255, 5296.549793267572, 5302.151655735079, 5376.462353764621, 4998.350214472122, 5122.846314610568, 5142.3287431584695, 5223.608229382802, 5242.606804489659, 3247.967520324802, 3814.1775086436114, 4047.3726572381256, 4051.5616955980645, 4068.5417395214126, 3375.5611770469927, 3821.61783821617, 4060.593940605945, 4081.5918408159246, 4092.6494256895153, 3763.209725957552, 3966.8214930328204, 3973.284808734427, 3998.7800670963084, 4026.3557830747086, 3960.6633436157963, 3984.442178095069, 3984.860529881469, 3985.903876433975, 3989.4614227079264, 2992.640883094021, 3383.983080084584, 3478.721702263813, 3500.4049311617086, 3517.4699005932503, 4506.7070640408265, 4826.686265392738, 5111.798727299119, 5181.326427564431, 5203.635745497817, 3919.8432062717457, 4170.645495132887, 4502.41468609082, 4528.0, 4537.4328208973875, 4760.952390476085, 4765.309030190603, 4973.477784832577, 5483.435766751603, 5494.835154945358, 3316.6351701312838, 3506.5967413747235, 3751.868684596026, 3760.7555508891833, 3768.321702093622, 5455.918161227585, 5703.486686198221, 5782.335031471351, 5801.3618501965175, 5826.329972053226, 3280.2947366316357, 3380.9323813523592, 3852.3065848147603, 3879.941800872989, 3888.6694630956686, 3086.305581244202, 3404.5403870477166, 3910.865848903786, 3929.25344184604, 3930.8624198153498, 4251.00101476159, 4531.3882625845745, 4550.3824459554735, 4553.225951588238, 4581.725096494221, 5351.812686555952, 5556.555475561945, 5565.413857050721, 5587.832365029056, 5601.439856014366, 1239.7768401687601, 1277.1800184736712, 1282.5895713371817, 1288.7100402409383, 1330.4545136493991, 735.0701362776092, 782.945193836426, 797.57728403946, 799.7800604833717, 828.4863384701404, 3831.9307573910332, 4271.487421509377, 4309.461317335333, 4336.76147811867, 4352.760598167068, 3979.965209045611, 4767.642426818003, 4793.904121917542, 4833.9214137921035, 4867.1969125093965, 4757.857264282077, 5071.442141364447, 5179.928028788515, 5197.271432497969, 5226.817061402832, 3003.5344521599186, 3007.5338322560037, 3023.727864492206, 3030.7423868970945, 3044.3606842562867, 5452.427495113036, 5589.692566908859, 5919.822405327847, 5967.492763115184, 5982.790602328898, 4696.976515117402, 5915.231019967463, 5939.910901336483, 5942.138389933435, 5956.880862382728, 5301.54936830366, 5562.745793710725, 6002.339742628395, 6015.548833837567, 6068.514518838482, 5604.355499117653, 5675.0, 5745.166950792195, 5749.770009199585, 5760.0, 4959.0, 5590.496855283044, 5687.5449964001955, 5699.202111704281, 5823.970880145572, 4338.913221735611, 5242.921356179737, 5588.608797384307, 5823.854403639773, 5944.821655350346, 3770.3967365221433, 3835.9041023974623, 3860.285847118292, 3862.729608927348, 3879.254335548958, 5236.795537026582, 5612.382637909908, 5734.483896449339, 5768.067697321444, 5816.47651711348, 4725.487843889922, 4888.120138375127, 5293.206019097166, 5419.132938729785, 5656.3495198051105, 5309.089092589416, 5547.44525547442, 5547.585365731874, 5564.610477266552, 5586.748596313095, 4641.419822522184, 5057.342545469065, 5168.71572063525, 5311.362636483646, 5337.946620533745, 4620.607248383925, 5290.285811415563, 5583.972080139573, 5595.418931883679, 5615.6630602164005, 4519.389882365838, 4919.262110683426, 5143.177091665316, 5459.781608735606, 5462.890742185214], "value": 3983.5000533461803, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.5120917775912, 720.6720941971407, 770.722539885641, 810.8175660476397, 828.9626966786494, 15116.546503604883, 16752.832471675294, 16765.7485137723, 16772.329106835743, 16773.0, 14923.328450219766, 15115.84884151158, 15121.16833574153, 15136.772948405784, 15142.848571514282, 689.8344397344651, 711.9145702515706, 845.0873057098349, 850.391969741633, 871.1332224436694, 843.9282660973824, 863.2791618998144, 863.7451951674271, 863.9308855291562, 866.7529754020105, 912.7079334612927, 916.1754421021068, 918.1874041473311, 918.8897332320131, 920.8894932608063, 727.0657205490919, 893.3835653399134, 907.1744712311764, 913.2328843771231, 913.2921985461287, 689.7585844954276, 689.941354984827, 690.1855810144028, 690.9516333856632, 693.3240090911321, 15015.624609384744, 15075.5477335679, 15102.244887755569, 15148.924255378763, 15177.317020733983, 12238.837310455492, 14136.0, 14420.0, 14559.272036398137, 14621.195834229113, 10540.525676344583, 11608.593699220572, 11875.821862672066, 12146.0, 12364.44360003802, 3384.4754063120254, 4049.3925911113274, 4088.4276201331836, 4127.979360103211, 4145.461090058273, 87838.12161878427, 102319.0, 108525.0, 112727.0, 120123.99999999913, 11525.135614828921, 11540.192186546861, 11666.183367164216, 11826.52693892252, 12179.695507612203, 24104.87947560251, 24799.876000619883, 24846.627300590506, 24851.751482485306, 24895.5020899581, 8197.180281971756, 8365.58172091393, 8393.580320983927, 8691.913080869237, 8700.956495217484, 4324.394584758136, 4467.754273514923, 4468.530804265571, 4725.787339569728, 4729.432468103781, 3684.2815650948346, 3802.524684414448, 3805.0487378155462, 3807.3717836556657, 3808.5810560838286, 677.3531277629852, 683.1870074611197, 692.2108795972596, 705.7212401101536, 714.2393351081082, 584.5878655547829, 634.8730253949228, 666.7199776094052, 684.7706018483764, 695.8747425463364, 8988.191062804248, 9122.042185570419, 9421.811563768822, 9508.239340852715, 9698.175655069399, 570.4010788671878, 644.239797039498, 676.5433332500543, 678.5860625018735, 692.5533031194851, 4566.086782643418, 4602.907941841145, 4683.220376257069, 4714.528547145258, 4765.9523404766205, 130258.69741302465, 134719.0, 159720.0, 167084.0, 169053.0, 139930.0, 143259.0, 144405.0, 146238.0, 149550.0, 87806.0, 98695.0260994776, 99784.50323245158, 101542.0, 104907.0, 9387.812243755223, 9743.902560974582, 10039.74900627461, 10093.545790439595, 10114.544845481823, 50814.0, 60081.09878351741, 62962.0, 64501.35498645141, 65427.0, 93437.06562934283, 97559.51220243853, 97703.0, 97721.53417698882, 100754.4962275184, 13113.409896554487, 13287.40206690682, 13303.0, 13382.996275279198, 13857.099288546213, 11908.940455297668, 14554.053986490844, 14888.0, 14986.6084120121, 15472.767908481157, 13741.969352298418, 13964.4414223434, 14271.357788899317, 14411.567652970427, 14575.125492470486, 13662.658433539242, 14033.017688761689, 14090.929545352208, 14102.224377658917, 14472.975936521541, 13712.451501939811, 13722.725545489235, 13836.37736301889, 14008.929955350159, 14024.439022438988, 11200.0, 11224.158188136085, 11410.600628977945, 11432.08543316516, 11965.940170299093, 11246.775064498828, 11448.885511144781, 11546.364949927834, 11551.133664974992, 11595.420228988349], "value": 8026.77097278447, "unit": "score"}], "name": "dromaeo_css", "value": 7391.109516919768, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 118.0, 203.0, 138.0, 107.0, 128.0, 101.0, 142.0, 108.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 212.0, 183.0, 185.0, 184.0, 184.0, 184.0, 184.0, 182.0, 184.0], "value": 188.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 67.0, 111.0, 79.0, 68.0, 62.0, 61.0, 82.0, 56.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 101.0, 69.0, 73.0, 68.0, 97.0, 73.0, 67.0, 104.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 90.0, 87.0, 89.0, 87.0, 90.0, 88.0, 90.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 85.0, 84.0, 85.0, 96.0, 132.0, 85.0, 86.0], "value": 90.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 53.0, 55.0, 52.0, 53.0, 53.0, 52.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 73.0, 77.0, 78.0, 96.0, 98.0, 59.0, 98.0, 98.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 85.0, 85.0, 86.0, 82.0, 85.0, 86.0, 126.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 138.0, 143.0, 134.0, 136.0, 134.0, 133.0, 150.0, 139.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 184.0, 165.0, 168.0, 165.0, 167.0, 166.0, 166.0, 168.0, 163.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 68.0, 77.0, 84.0, 83.0, 82.0, 71.0, 66.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1465.1999999999998, "alertThreshold": 2.0}]} 19:03:04 INFO - Return code: 0 19:03:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:03:04 INFO - # TBPL SUCCESS # 19:03:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:03:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:03:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:03:04 INFO - 2016-08-10 19:03:04.885 screenresolution[1667:9614] starting screenresolution argv=screenresolution get 19:03:04 INFO - 2016-08-10 19:03:04.888 screenresolution[1667:9614] Display 0: 1600x1200x32@60 19:03:04 INFO - 2016-08-10 19:03:04.894 screenresolution[1668:9617] starting screenresolution argv=screenresolution list 19:03:04 INFO - Available Modes on Display 0 19:03:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:03:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:03:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:03:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:03:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:03:05 INFO - Intel Iris: 19:03:05 INFO - Chipset Model: Intel Iris 19:03:05 INFO - Type: GPU 19:03:05 INFO - Bus: Built-In 19:03:05 INFO - VRAM (Dynamic, Max): 1536 MB 19:03:05 INFO - Vendor: Intel (0x8086) 19:03:05 INFO - Device ID: 0x0a2e 19:03:05 INFO - Revision ID: 0x0009 19:03:05 INFO - Displays: 19:03:05 INFO - Display: 19:03:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:03:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:03:05 INFO - Display Serial Number: 1600x1200 60 19:03:05 INFO - Main Display: Yes 19:03:05 INFO - Mirror: Off 19:03:05 INFO - Online: Yes 19:03:05 INFO - Rotation: Supported 19:03:05 INFO - Return code: 0 19:03:05 INFO - Running post-action listener: _resource_record_post_action 19:03:05 INFO - [mozharness: 2016-08-11 02:03:05.130563Z] Finished run-tests step (success) 19:03:05 INFO - Running post-run listener: _resource_record_post_run 19:03:05 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37164032; Write bytes: 701213696; Read time: 239; Write time: 1974 19:03:05 INFO - TinderboxPrint: CPU usage
53.6% 19:03:05 INFO - TinderboxPrint: I/O read bytes / time
37,164,032 / 239 19:03:05 INFO - TinderboxPrint: I/O write bytes / time
701,213,696 / 1,974 19:03:05 INFO - TinderboxPrint: CPU idle
2,248.1 (46.4%) 19:03:05 INFO - TinderboxPrint: CPU system
972.6 (20.1%) 19:03:05 INFO - TinderboxPrint: CPU user
1,629.0 (33.6%) 19:03:05 INFO - TinderboxPrint: Swap in / out
440,463,360 / 0 19:03:05 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388805120; Write bytes: 384136704; Read time: 29405; Write time: 811 19:03:05 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36209664; Write bytes: 293766656; Read time: 227; Write time: 1104 19:03:05 INFO - Running post-run listener: _upload_blobber_files 19:03:05 INFO - Blob upload gear active. 19:03:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:03:05 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 19:03:05 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:03:05 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:03:06 INFO - (blobuploader) - INFO - Open directory for files ... 19:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:07 INFO - (blobuploader) - INFO - Done attempting. 19:03:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:03:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:03:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:08 INFO - (blobuploader) - INFO - Done attempting. 19:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:03:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:11 INFO - (blobuploader) - INFO - Done attempting. 19:03:11 INFO - (blobuploader) - INFO - Iteration through files over. 19:03:11 INFO - Return code: 0 19:03:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:03:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:03:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adc5487567619be9e3334ea87286f8114f36d104effafdcec141c3105d6a247919c76a2199fb2df79efe05a8fd49f9ed7997f464418170bb9759a8bab8ae6e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c2effb3c602bc1ba37fa8b970706b7716ee483baf34b8510576fe1297f951210ff2995a4fa46e9f5d9034acceedbfc5e3e06b817b0ba8d47dae2afb9bfac65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/547204eec68b18c3afaa03ac4cdf0882cdcc7a80bd34c6c12cfc7a437304fbd54bd57059ed06b3cebe91e170b228d618f4449bbb0af450b2a8db160e5c04dd6e"} 19:03:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:03:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:03:11 INFO - Contents: 19:03:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adc5487567619be9e3334ea87286f8114f36d104effafdcec141c3105d6a247919c76a2199fb2df79efe05a8fd49f9ed7997f464418170bb9759a8bab8ae6e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c2effb3c602bc1ba37fa8b970706b7716ee483baf34b8510576fe1297f951210ff2995a4fa46e9f5d9034acceedbfc5e3e06b817b0ba8d47dae2afb9bfac65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/547204eec68b18c3afaa03ac4cdf0882cdcc7a80bd34c6c12cfc7a437304fbd54bd57059ed06b3cebe91e170b228d618f4449bbb0af450b2a8db160e5c04dd6e"} 19:03:11 INFO - Running post-run listener: copy_logs_to_upload_dir 19:03:11 INFO - Copying logs to upload dir... 19:03:11 INFO - mkdir: /builds/slave/test/build/upload/logs 19:03:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.188544 ========= master_lag: 129.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 18 secs) (at 2016-08-10 19:05:20.284410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-08-10 19:05:20.288051) ========= 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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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/Firefox/sha512/adc5487567619be9e3334ea87286f8114f36d104effafdcec141c3105d6a247919c76a2199fb2df79efe05a8fd49f9ed7997f464418170bb9759a8bab8ae6e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c2effb3c602bc1ba37fa8b970706b7716ee483baf34b8510576fe1297f951210ff2995a4fa46e9f5d9034acceedbfc5e3e06b817b0ba8d47dae2afb9bfac65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/547204eec68b18c3afaa03ac4cdf0882cdcc7a80bd34c6c12cfc7a437304fbd54bd57059ed06b3cebe91e170b228d618f4449bbb0af450b2a8db160e5c04dd6e"} build_url:https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011575 build_url: 'https://queue.taskcluster.net/v1/task/GDKorFEhTcWYK6E3p_K-CQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adc5487567619be9e3334ea87286f8114f36d104effafdcec141c3105d6a247919c76a2199fb2df79efe05a8fd49f9ed7997f464418170bb9759a8bab8ae6e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c2effb3c602bc1ba37fa8b970706b7716ee483baf34b8510576fe1297f951210ff2995a4fa46e9f5d9034acceedbfc5e3e06b817b0ba8d47dae2afb9bfac65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/547204eec68b18c3afaa03ac4cdf0882cdcc7a80bd34c6c12cfc7a437304fbd54bd57059ed06b3cebe91e170b228d618f4449bbb0af450b2a8db160e5c04dd6e"}' ========= master_lag: 3.36 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-08-10 19:05:23.655595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-08-10 19:05:23.655969) ========= 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.SO1OPib5O8/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.mtzDcpKhbJ/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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.005271 ========= master_lag: 2.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-08-10 19:05:26.275830) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-08-10 19:05:26.276099) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-08-10 19:05:27.357792) ========= ========= Total master_lag: 135.04 =========