builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0021 starttime: 1478893046.0 results: success (0) buildid: 20161111102820 builduid: f621d39968b349188994d9888be94f4c revision: 0116b93b47e9db13d3da4575676202db72a65e54 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:25.998875) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:25.999401) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:25.999719) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:26.024549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:26.024945) ========= 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.etJUfG2usB/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.7AcKxluLdU/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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-11-11 11:37:26-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 63.8M=0s 2016-11-11 11:37:26 (63.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115640 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:26.162978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:26.163532) ========= 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.etJUfG2usB/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.7AcKxluLdU/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.019563 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:26.211899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 11:37:26.212307) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0116b93b47e9db13d3da4575676202db72a65e54 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0116b93b47e9db13d3da4575676202db72a65e54 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.etJUfG2usB/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.7AcKxluLdU/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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-11-11 11:37:26,298 truncating revision to first 12 chars 2016-11-11 11:37:26,298 Setting DEBUG logging. 2016-11-11 11:37:26,298 attempt 1/10 2016-11-11 11:37:26,298 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0116b93b47e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 11:37:27,587 unpacking tar archive at: mozilla-aurora-0116b93b47e9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581348 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 11:37:27.815955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:27.816347) ========= script_repo_revision: 0116b93b47e9db13d3da4575676202db72a65e54 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:27.816769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:27.817038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 11:37:27.835476) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-11 11:37:27.835772) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.etJUfG2usB/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.7AcKxluLdU/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:37:28 INFO - MultiFileLogger online at 20161111 11:37:28 in /builds/slave/test 11:37:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:37:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:37:28 INFO - {'append_to_log': False, 11:37:28 INFO - 'base_work_dir': '/builds/slave/test', 11:37:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:37:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:37:28 INFO - 'branch': 'Mozilla-Aurora', 11:37:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:37:28 INFO - 'config_files': ('talos/mac_config.py',), 11:37:28 INFO - 'default_actions': ('clobber', 11:37:28 INFO - 'read-buildbot-config', 11:37:28 INFO - 'download-and-extract', 11:37:28 INFO - 'populate-webroot', 11:37:28 INFO - 'create-virtualenv', 11:37:28 INFO - 'install', 11:37:28 INFO - 'run-tests'), 11:37:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:37:28 INFO - 'download_minidump_stackwalk': True, 11:37:28 INFO - 'download_symbols': 'ondemand', 11:37:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:37:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:37:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:37:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:37:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:37:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:37:28 INFO - 'installer_path': 'installer.exe', 11:37:28 INFO - 'log_level': 'info', 11:37:28 INFO - 'log_name': 'talos', 11:37:28 INFO - 'log_to_console': True, 11:37:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:37:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:37:28 INFO - 'opt_config_files': (), 11:37:28 INFO - 'pip_index': False, 11:37:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:37:28 INFO - 'cmd': ('bash', 11:37:28 INFO - '-c', 11:37:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:37:28 INFO - 'enabled': True, 11:37:28 INFO - 'halt_on_failure': False, 11:37:28 INFO - 'name': 'check_screen_resolution'},), 11:37:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:37:28 INFO - 'cmd': ('bash', 11:37:28 INFO - '-c', 11:37:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:37:28 INFO - 'enabled': True, 11:37:28 INFO - 'halt_on_failure': False, 11:37:28 INFO - 'name': 'check_screen_resolution'},), 11:37:28 INFO - 'run_cmd_checks_enabled': True, 11:37:28 INFO - 'sps_profile': False, 11:37:28 INFO - 'sps_profile_interval': 0, 11:37:28 INFO - 'suite': 'dromaeojs', 11:37:28 INFO - 'system_bits': '32', 11:37:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:37:28 INFO - 'title': 't-yosemite-r7-0021', 11:37:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:37:28 INFO - 'use_talos_json': True, 11:37:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:37:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:37:28 INFO - 'work_dir': 'build'} 11:37:28 INFO - [mozharness: 2016-11-11 19:37:28.029814Z] Running clobber step. 11:37:28 INFO - Running pre-action listener: _resource_record_pre_action 11:37:28 INFO - Running main action method: clobber 11:37:28 INFO - rmtree: /builds/slave/test/build 11:37:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:37:28 INFO - Running post-action listener: _resource_record_post_action 11:37:28 INFO - [mozharness: 2016-11-11 19:37:28.985039Z] Finished clobber step (success) 11:37:28 INFO - [mozharness: 2016-11-11 19:37:28.985149Z] Running read-buildbot-config step. 11:37:28 INFO - Running pre-action listener: _resource_record_pre_action 11:37:28 INFO - Running main action method: read_buildbot_config 11:37:28 INFO - Using buildbot properties: 11:37:28 INFO - { 11:37:28 INFO - "project": "", 11:37:28 INFO - "product": "firefox", 11:37:28 INFO - "script_repo_revision": "production", 11:37:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:37:28 INFO - "repository": "", 11:37:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:37:28 INFO - "buildid": "20161111102820", 11:37:28 INFO - "pgo_build": "False", 11:37:28 INFO - "basedir": "/builds/slave/test", 11:37:28 INFO - "buildnumber": 20, 11:37:28 INFO - "slavename": "t-yosemite-r7-0021", 11:37:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:37:28 INFO - "platform": "yosemite_r7", 11:37:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:37:28 INFO - "branch": "mozilla-aurora", 11:37:28 INFO - "repo_path": "releases/mozilla-aurora", 11:37:28 INFO - "revision": "0116b93b47e9db13d3da4575676202db72a65e54", 11:37:28 INFO - "stage_platform": "macosx64", 11:37:28 INFO - "builduid": "f621d39968b349188994d9888be94f4c", 11:37:28 INFO - "slavebuilddir": "test" 11:37:28 INFO - } 11:37:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 11:37:28 INFO - Running post-action listener: _resource_record_post_action 11:37:28 INFO - [mozharness: 2016-11-11 19:37:28.988520Z] Finished read-buildbot-config step (success) 11:37:28 INFO - [mozharness: 2016-11-11 19:37:28.988632Z] Running download-and-extract step. 11:37:28 INFO - Running pre-action listener: _resource_record_pre_action 11:37:28 INFO - Running main action method: download_and_extract 11:37:28 INFO - mkdir: /builds/slave/test/build/tests 11:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:28 INFO - trying https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 11:37:28 INFO - Downloading https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 11:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 11:37:29 INFO - Downloaded 1199 bytes. 11:37:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 11:37:29 INFO - Using the following test package requirements: 11:37:29 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 11:37:29 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 11:37:29 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 11:37:29 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 11:37:29 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 11:37:29 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 11:37:29 INFO - u'jsshell-mac.zip'], 11:37:29 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 11:37:29 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 11:37:29 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 11:37:29 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 11:37:29 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 11:37:29 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 11:37:29 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 11:37:29 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 11:37:29 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 11:37:29 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 11:37:29 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 11:37:29 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:37:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 11:37:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:37:29 INFO - Fetch https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 11:37:30 INFO - Expected file size: 16423750 11:37:37 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:37:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 11:37:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:37:37 INFO - Fetch https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 11:37:38 INFO - Expected file size: 16423750 11:37:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 11:37:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:37:45 INFO - Fetch https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 11:37:45 INFO - Expected file size: 14414089 11:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:47 INFO - trying https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 11:37:47 INFO - Downloading https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 11:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 11:37:49 INFO - Downloaded 115562459 bytes. 11:37:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 11:37:49 INFO - mkdir: /builds/slave/test/properties 11:37:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:37:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:37:49 INFO - Contents: 11:37:49 INFO - build_url:https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 11:37:50 INFO - Running post-action listener: _resource_record_post_action 11:37:50 INFO - Running post-action listener: set_extra_try_arguments 11:37:50 INFO - [mozharness: 2016-11-11 19:37:50.615107Z] Finished download-and-extract step (success) 11:37:50 INFO - [mozharness: 2016-11-11 19:37:50.615258Z] Running populate-webroot step. 11:37:50 INFO - Running pre-action listener: _resource_record_pre_action 11:37:50 INFO - Running main action method: populate_webroot 11:37:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:37:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:37:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:37:50 INFO - '--tppagecycles', 11:37:50 INFO - '7'], 11:37:50 INFO - 'tests': ['tsvgm']}}, 11:37:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:37:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:37:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:37:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:37:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:50 INFO - 'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:50 INFO - 'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['damp', 'tps']}, 11:37:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:50 INFO - 'tests': ['damp', 'tps']}, 11:37:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['dromaeo_dom']}, 11:37:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['basic_compositor_video']}, 11:37:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:37:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['a11yr', 11:37:50 INFO - 'ts_paint', 11:37:50 INFO - 'tpaint', 11:37:50 INFO - 'sessionrestore', 11:37:50 INFO - 'sessionrestore_no_auto_restore', 11:37:50 INFO - 'tabpaint']}, 11:37:50 INFO - 'other-e10s': {'tests': ['a11yr', 11:37:50 INFO - 'ts_paint', 11:37:50 INFO - 'tpaint', 11:37:50 INFO - 'sessionrestore', 11:37:50 INFO - 'sessionrestore_no_auto_restore', 11:37:50 INFO - 'tabpaint']}, 11:37:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:37:50 INFO - 'ts_paint', 11:37:50 INFO - 'tpaint', 11:37:50 INFO - 'sessionrestore', 11:37:50 INFO - 'sessionrestore_no_auto_restore', 11:37:50 INFO - 'tabpaint']}, 11:37:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:37:50 INFO - 'ts_paint', 11:37:50 INFO - 'tpaint', 11:37:50 INFO - 'sessionrestore', 11:37:50 INFO - 'sessionrestore_no_auto_restore', 11:37:50 INFO - 'tabpaint']}, 11:37:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['a11yr', 11:37:50 INFO - 'ts_paint', 11:37:50 INFO - 'tpaint', 11:37:50 INFO - 'sessionrestore', 11:37:50 INFO - 'sessionrestore_no_auto_restore', 11:37:50 INFO - 'tabpaint']}, 11:37:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['a11yr', 11:37:50 INFO - 'ts_paint', 11:37:50 INFO - 'tpaint', 11:37:50 INFO - 'sessionrestore', 11:37:50 INFO - 'sessionrestore_no_auto_restore', 11:37:50 INFO - 'tabpaint']}, 11:37:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['tsvgx', 11:37:50 INFO - 'tsvgr_opacity', 11:37:50 INFO - 'tart', 11:37:50 INFO - 'tscrollx', 11:37:50 INFO - 'cart']}, 11:37:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:37:50 INFO - 'tsvgr_opacity', 11:37:50 INFO - 'tart', 11:37:50 INFO - 'tscrollx', 11:37:50 INFO - 'cart']}, 11:37:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:50 INFO - 'talos_options': ['--disable-e10s'], 11:37:50 INFO - 'tests': ['tp5o']}, 11:37:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:50 INFO - 'tests': ['tp5o']}, 11:37:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:50 INFO - 'talos_options': ['--disable-e10s', 11:37:50 INFO - '--xperf_path', 11:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:50 INFO - 'tests': ['tp5n']}, 11:37:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:50 INFO - 'talos_options': ['--xperf_path', 11:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:50 INFO - 'tests': ['tp5n']}}, 11:37:50 INFO - 'talos.zip': {'path': '', 11:37:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:37:50 INFO - Running post-action listener: _resource_record_post_action 11:37:50 INFO - [mozharness: 2016-11-11 19:37:50.634916Z] Finished populate-webroot step (success) 11:37:50 INFO - [mozharness: 2016-11-11 19:37:50.635052Z] Running create-virtualenv step. 11:37:50 INFO - Running pre-action listener: _resource_record_pre_action 11:37:50 INFO - Running main action method: create_virtualenv 11:37:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:37:50 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 11:37:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:37:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:50 INFO - Using real prefix '/tools/python27' 11:37:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:37:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:54 INFO - Installing pip.................done. 11:37:54 INFO - Return code: 0 11:37:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:37:54 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')]} 11:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:54 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')]} 11:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:54 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 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:37:54 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 11:37:54 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 11:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:54 INFO - 'HOME': '/Users/cltbld', 11:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:54 INFO - 'LOGNAME': 'cltbld', 11:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:54 INFO - 'MOZ_NO_REMOTE': '1', 11:37:54 INFO - 'NO_EM_RESTART': '1', 11:37:54 INFO - 'PAGER': '/bin/cat', 11:37:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:54 INFO - 'PWD': '/builds/slave/test', 11:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:54 INFO - 'SHELL': '/bin/bash', 11:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:37:54 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:54 INFO - 'USER': 'cltbld', 11:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:54 INFO - 'XPC_FLAGS': '0x0', 11:37:54 INFO - 'XPC_SERVICE_NAME': '0', 11:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:54 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 11:37:54 INFO - Cleaning up... 11:37:54 INFO - Return code: 0 11:37:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:37:54 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')]} 11:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:54 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')]} 11:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:54 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 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:37:54 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 11:37:54 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 11:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:54 INFO - 'HOME': '/Users/cltbld', 11:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:54 INFO - 'LOGNAME': 'cltbld', 11:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:54 INFO - 'MOZ_NO_REMOTE': '1', 11:37:54 INFO - 'NO_EM_RESTART': '1', 11:37:54 INFO - 'PAGER': '/bin/cat', 11:37:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:54 INFO - 'PWD': '/builds/slave/test', 11:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:54 INFO - 'SHELL': '/bin/bash', 11:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:37:54 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:54 INFO - 'USER': 'cltbld', 11:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:54 INFO - 'XPC_FLAGS': '0x0', 11:37:54 INFO - 'XPC_SERVICE_NAME': '0', 11:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:54 INFO - Downloading/unpacking psutil>=3.1.1 11:37:54 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 11:37:54 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 11:37:54 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 11:37:54 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 11:37:54 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 11:37:54 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 11:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:57 INFO - Installing collected packages: psutil 11:37:57 INFO - Running setup.py install for psutil 11:37:57 INFO - building 'psutil._psutil_osx' extension 11:37:57 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 11:37:57 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 11:37:57 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 11:37:58 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 11:37:58 INFO - building 'psutil._psutil_posix' extension 11:37:58 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 11:37:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:37:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:37:58 INFO - ^ 11:37:58 INFO - 1 warning generated. 11:37:58 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 11:37:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:58 INFO - Successfully installed psutil 11:37:58 INFO - Cleaning up... 11:37:58 INFO - Return code: 0 11:37:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:37:58 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')]} 11:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:58 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')]} 11:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:58 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 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:37:58 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 11:37:58 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 11:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:58 INFO - 'HOME': '/Users/cltbld', 11:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:58 INFO - 'LOGNAME': 'cltbld', 11:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:58 INFO - 'MOZ_NO_REMOTE': '1', 11:37:58 INFO - 'NO_EM_RESTART': '1', 11:37:58 INFO - 'PAGER': '/bin/cat', 11:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:58 INFO - 'PWD': '/builds/slave/test', 11:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:58 INFO - 'SHELL': '/bin/bash', 11:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:37:58 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:58 INFO - 'USER': 'cltbld', 11:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:58 INFO - 'XPC_FLAGS': '0x0', 11:37:58 INFO - 'XPC_SERVICE_NAME': '0', 11:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:37:58 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 11:37:58 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 11:37:58 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 11:37:58 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 11:37:58 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 11:37:58 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 11:38:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:38:01 INFO - Installing collected packages: mozsystemmonitor 11:38:01 INFO - Running setup.py install for mozsystemmonitor 11:38:01 INFO - Successfully installed mozsystemmonitor 11:38:01 INFO - Cleaning up... 11:38:01 INFO - Return code: 0 11:38:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:01 INFO - 'HOME': '/Users/cltbld', 11:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:01 INFO - 'LOGNAME': 'cltbld', 11:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:01 INFO - 'MOZ_NO_REMOTE': '1', 11:38:01 INFO - 'NO_EM_RESTART': '1', 11:38:01 INFO - 'PAGER': '/bin/cat', 11:38:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:01 INFO - 'PWD': '/builds/slave/test', 11:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:01 INFO - 'SHELL': '/bin/bash', 11:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:38:01 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:01 INFO - 'USER': 'cltbld', 11:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:01 INFO - 'XPC_FLAGS': '0x0', 11:38:01 INFO - 'XPC_SERVICE_NAME': '0', 11:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:01 INFO - Downloading/unpacking jsonschema==2.5.1 11:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:38:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:38:04 INFO - warning: no files found matching '*.txt' 11:38:04 INFO - no previously-included directories found matching 'build' 11:38:04 INFO - no previously-included directories found matching 'dist' 11:38:04 INFO - no previously-included directories found matching '.git*' 11:38:04 INFO - Installing collected packages: jsonschema, functools32 11:38:04 INFO - Running setup.py install for functools32 11:38:04 INFO - warning: no files found matching '*.txt' 11:38:04 INFO - no previously-included directories found matching 'build' 11:38:04 INFO - no previously-included directories found matching 'dist' 11:38:04 INFO - no previously-included directories found matching '.git*' 11:38:04 INFO - Successfully installed jsonschema functools32 11:38:04 INFO - Cleaning up... 11:38:04 INFO - Return code: 0 11:38:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:38: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')]} 11:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38: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')]} 11:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:04 INFO - 'HOME': '/Users/cltbld', 11:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:04 INFO - 'LOGNAME': 'cltbld', 11:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:04 INFO - 'MOZ_NO_REMOTE': '1', 11:38:04 INFO - 'NO_EM_RESTART': '1', 11:38:04 INFO - 'PAGER': '/bin/cat', 11:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:04 INFO - 'PWD': '/builds/slave/test', 11:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:04 INFO - 'SHELL': '/bin/bash', 11:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:38:04 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:04 INFO - 'USER': 'cltbld', 11:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:04 INFO - 'XPC_FLAGS': '0x0', 11:38:04 INFO - 'XPC_SERVICE_NAME': '0', 11:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:38:05 INFO - Cleaning up... 11:38:05 INFO - Return code: 0 11:38:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:38: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')]} 11:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38: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')]} 11:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:05 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 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:38:05 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 11:38:05 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 11:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:05 INFO - 'HOME': '/Users/cltbld', 11:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:05 INFO - 'LOGNAME': 'cltbld', 11:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:05 INFO - 'MOZ_NO_REMOTE': '1', 11:38:05 INFO - 'NO_EM_RESTART': '1', 11:38:05 INFO - 'PAGER': '/bin/cat', 11:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:05 INFO - 'PWD': '/builds/slave/test', 11:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:05 INFO - 'SHELL': '/bin/bash', 11:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:38:05 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:05 INFO - 'USER': 'cltbld', 11:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:05 INFO - 'XPC_FLAGS': '0x0', 11:38:05 INFO - 'XPC_SERVICE_NAME': '0', 11:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:38:05 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 11:38:05 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 11:38:05 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 11:38:05 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 11:38:05 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 11:38:05 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 11:38:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:38:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:38:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:09 INFO - Downloading docopt-0.6.1.tar.gz 11:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:38:09 INFO - Installing collected packages: blobuploader, requests, docopt 11:38:09 INFO - Running setup.py install for blobuploader 11:38:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:38:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:38:09 INFO - Running setup.py install for requests 11:38:09 INFO - Running setup.py install for docopt 11:38:09 INFO - Successfully installed blobuploader requests docopt 11:38:09 INFO - Cleaning up... 11:38:10 INFO - Return code: 0 11:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:10 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')]} 11:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:10 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')]} 11:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:10 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 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:38:10 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 11:38:10 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 11:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:10 INFO - 'HOME': '/Users/cltbld', 11:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:10 INFO - 'LOGNAME': 'cltbld', 11:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:10 INFO - 'MOZ_NO_REMOTE': '1', 11:38:10 INFO - 'NO_EM_RESTART': '1', 11:38:10 INFO - 'PAGER': '/bin/cat', 11:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:10 INFO - 'PWD': '/builds/slave/test', 11:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:10 INFO - 'SHELL': '/bin/bash', 11:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:38:10 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:10 INFO - 'USER': 'cltbld', 11:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:10 INFO - 'XPC_FLAGS': '0x0', 11:38:10 INFO - 'XPC_SERVICE_NAME': '0', 11:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:38:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-8TGzfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:38:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-1VVxez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:38:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-c6e3DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:38:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-4P8PfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:38:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-8QnXz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:38:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-KU4low-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:38:10 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-qUyCq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-SPPRlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-XIaO30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-FsHKmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-bbBSVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-7AYMIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-bh1lJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-eR7YuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Qu0aQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-aD0Cn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:38:11 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-zj8Rjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:38:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:38:12 INFO - Running setup.py install for manifestparser 11:38:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Running setup.py install for mozcrash 11:38:12 INFO - Running setup.py install for mozdebug 11:38:12 INFO - Running setup.py install for mozdevice 11:38:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Running setup.py install for mozfile 11:38:12 INFO - Running setup.py install for mozhttpd 11:38:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:38:12 INFO - Running setup.py install for mozinfo 11:38:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:38:13 INFO - Running setup.py install for mozInstall 11:38:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:38:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:38:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:38:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:38:13 INFO - Running setup.py install for mozleak 11:38:13 INFO - Running setup.py install for mozlog 11:38:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:38:13 INFO - Running setup.py install for moznetwork 11:38:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:38:13 INFO - Running setup.py install for mozprocess 11:38:13 INFO - Running setup.py install for mozprofile 11:38:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:38:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:38:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:38:14 INFO - Running setup.py install for mozrunner 11:38:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:38:14 INFO - Running setup.py install for mozscreenshot 11:38:14 INFO - Running setup.py install for moztest 11:38:14 INFO - Running setup.py install for mozversion 11:38:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:38:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:38:14 INFO - Cleaning up... 11:38:14 INFO - Return code: 0 11:38:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38: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')]} 11:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38: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')]} 11:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:38:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:38:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:14 INFO - 'HOME': '/Users/cltbld', 11:38:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:14 INFO - 'LOGNAME': 'cltbld', 11:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:14 INFO - 'MOZ_NO_REMOTE': '1', 11:38:14 INFO - 'NO_EM_RESTART': '1', 11:38:14 INFO - 'PAGER': '/bin/cat', 11:38:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:14 INFO - 'PWD': '/builds/slave/test', 11:38:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:14 INFO - 'SHELL': '/bin/bash', 11:38:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:38:14 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:38:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:14 INFO - 'USER': 'cltbld', 11:38:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:14 INFO - 'XPC_FLAGS': '0x0', 11:38:14 INFO - 'XPC_SERVICE_NAME': '0', 11:38:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:38:14 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-HM3vZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:38:15 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)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-zcBZtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:38:15 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)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-ol7Lo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:38:15 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)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-ls6KP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:38:15 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)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Vu_MDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:38:15 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)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-1VBKsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-3jrrB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-6Kkz95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-WL2wSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-qBQo6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 11:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:38:15 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Tr68ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:38:16 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)) 11:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:38:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-k8H6ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:38:16 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)) 11:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:38:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-GdgTEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:38:16 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)) 11:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:38:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-T4eirT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:38:16 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)) 11:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-w_6Cj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:38:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-1y_1Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:38:16 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-fio2BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:38:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:19 INFO - Downloading blessings-1.6.tar.gz 11:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:38:19 INFO - Installing collected packages: blessings 11:38:19 INFO - Running setup.py install for blessings 11:38:19 INFO - Successfully installed blessings 11:38:19 INFO - Cleaning up... 11:38:19 INFO - Return code: 0 11:38:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:38:19 INFO - Reading from file tmpfile_stdout 11:38:19 INFO - Current package versions: 11:38:19 INFO - blessings == 1.6 11:38:19 INFO - blobuploader == 1.2.4 11:38:19 INFO - docopt == 0.6.1 11:38:19 INFO - functools32 == 3.2.3-2 11:38:19 INFO - jsonschema == 2.5.1 11:38:19 INFO - manifestparser == 1.1 11:38:19 INFO - mozInstall == 1.12 11:38:19 INFO - mozcrash == 0.17 11:38:19 INFO - mozdebug == 0.1 11:38:19 INFO - mozdevice == 0.48 11:38:19 INFO - mozfile == 1.2 11:38:19 INFO - mozhttpd == 0.7 11:38:19 INFO - mozinfo == 0.9 11:38:19 INFO - mozleak == 0.1 11:38:19 INFO - mozlog == 3.4 11:38:19 INFO - moznetwork == 0.27 11:38:19 INFO - mozprocess == 0.23 11:38:19 INFO - mozprofile == 0.28 11:38:19 INFO - mozrunner == 6.12 11:38:19 INFO - mozscreenshot == 0.1 11:38:19 INFO - mozsystemmonitor == 0.3 11:38:19 INFO - moztest == 0.7 11:38:19 INFO - mozversion == 1.4 11:38:19 INFO - psutil == 3.1.1 11:38:19 INFO - requests == 1.2.3 11:38:19 INFO - wsgiref == 0.1.2 11:38:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:20 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 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:38:20 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 11:38:20 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 11:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:20 INFO - 'HOME': '/Users/cltbld', 11:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:20 INFO - 'LOGNAME': 'cltbld', 11:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:20 INFO - 'MOZ_NO_REMOTE': '1', 11:38:20 INFO - 'NO_EM_RESTART': '1', 11:38:20 INFO - 'PAGER': '/bin/cat', 11:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:20 INFO - 'PWD': '/builds/slave/test', 11:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:20 INFO - 'SHELL': '/bin/bash', 11:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:38:20 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:20 INFO - 'USER': 'cltbld', 11:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:20 INFO - 'XPC_FLAGS': '0x0', 11:38:20 INFO - 'XPC_SERVICE_NAME': '0', 11:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:20 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)) 11:38:20 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)) 11:38:20 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)) 11:38:20 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)) 11:38:20 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)) 11:38:20 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)) 11:38:20 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)) 11:38:20 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)) 11:38:20 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)) 11:38:20 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)) 11:38:20 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)) 11:38:20 INFO - Cleaning up... 11:38:20 INFO - Return code: 0 11:38:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea72490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed84b1f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, '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.etJUfG2usB/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.7AcKxluLdU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 11:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:20 INFO - 'HOME': '/Users/cltbld', 11:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:20 INFO - 'LOGNAME': 'cltbld', 11:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:20 INFO - 'MOZ_NO_REMOTE': '1', 11:38:20 INFO - 'NO_EM_RESTART': '1', 11:38:20 INFO - 'PAGER': '/bin/cat', 11:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:20 INFO - 'PWD': '/builds/slave/test', 11:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:20 INFO - 'SHELL': '/bin/bash', 11:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:38:20 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:20 INFO - 'USER': 'cltbld', 11:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:20 INFO - 'XPC_FLAGS': '0x0', 11:38:20 INFO - 'XPC_SERVICE_NAME': '0', 11:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:38:21 INFO - Cleaning up... 11:38:21 INFO - Return code: 0 11:38:21 INFO - Running post-action listener: _resource_record_post_action 11:38:21 INFO - Running post-action listener: _start_resource_monitoring 11:38:21 INFO - Starting resource monitoring. 11:38:21 INFO - [mozharness: 2016-11-11 19:38:21.124118Z] Finished create-virtualenv step (success) 11:38:21 INFO - [mozharness: 2016-11-11 19:38:21.125086Z] Running install step. 11:38:21 INFO - Running pre-action listener: _resource_record_pre_action 11:38:21 INFO - Running main action method: install 11:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:38:21 INFO - Reading from file tmpfile_stdout 11:38:21 INFO - Detecting whether we're running mozinstall >=1.0... 11:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:38:21 INFO - Reading from file tmpfile_stdout 11:38:21 INFO - Output received: 11:38:21 INFO - Usage: mozinstall [options] installer 11:38:21 INFO - Options: 11:38:21 INFO - -h, --help show this help message and exit 11:38:21 INFO - -d DEST, --destination=DEST 11:38:21 INFO - Directory to install application into. [default: 11:38:21 INFO - "/builds/slave/test"] 11:38:21 INFO - --app=APP Application being installed. [default: firefox] 11:38:21 INFO - mkdir: /builds/slave/test/build/application 11:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:38:54 INFO - Reading from file tmpfile_stdout 11:38:54 INFO - Output received: 11:38:54 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:38:54 INFO - Running post-action listener: _resource_record_post_action 11:38:54 INFO - [mozharness: 2016-11-11 19:38:54.109545Z] Finished install step (success) 11:38:54 INFO - [mozharness: 2016-11-11 19:38:54.109702Z] Running run-tests step. 11:38:54 INFO - Running pre-action listener: _resource_record_pre_action 11:38:54 INFO - Running main action method: run_tests 11:38:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:38:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:38:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:38:54 INFO - 2016-11-11 11:38:54.122 screenresolution[2062:10718] starting screenresolution argv=screenresolution get 11:38:54 INFO - 2016-11-11 11:38:54.125 screenresolution[2062:10718] Display 0: 1600x1200x32@60 11:38:54 INFO - 2016-11-11 11:38:54.130 screenresolution[2063:10720] starting screenresolution argv=screenresolution list 11:38:54 INFO - Available Modes on Display 0 11:38:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:38:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:38:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:38:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:38:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:38:54 INFO - Intel Iris: 11:38:54 INFO - Chipset Model: Intel Iris 11:38:54 INFO - Type: GPU 11:38:54 INFO - Bus: Built-In 11:38:54 INFO - VRAM (Dynamic, Max): 1536 MB 11:38:54 INFO - Vendor: Intel (0x8086) 11:38:54 INFO - Device ID: 0x0a2e 11:38:54 INFO - Revision ID: 0x0009 11:38:54 INFO - Displays: 11:38:54 INFO - Display: 11:38:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:38:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:38:54 INFO - Display Serial Number: 1600x1200 60 11:38:54 INFO - Main Display: Yes 11:38:54 INFO - Mirror: Off 11:38:54 INFO - Online: Yes 11:38:54 INFO - Rotation: Supported 11:38:54 INFO - Return code: 0 11:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:38:54 INFO - Python 2.7.3 11:38:54 INFO - Return code: 0 11:38:54 INFO - grabbing minidump binary from tooltool 11:38:54 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')]} 11:38:54 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 0x10e886d30>, '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 0x10e6ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e87eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:38:54 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 11:38:54 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 11:38:54 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 11:38:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:38:54 INFO - Return code: 0 11:38:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:38:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:38:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:38:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:38:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--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 11:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0021 --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 11:38:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.etJUfG2usB/Render', 11:38:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:54 INFO - 'HOME': '/Users/cltbld', 11:38:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:54 INFO - 'LOGNAME': 'cltbld', 11:38:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:38:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:54 INFO - 'MOZ_NO_REMOTE': '1', 11:38:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:38:54 INFO - 'NO_EM_RESTART': '1', 11:38:54 INFO - 'PAGER': '/bin/cat', 11:38:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:54 INFO - 'PWD': '/builds/slave/test', 11:38:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:38:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:54 INFO - 'SHELL': '/bin/bash', 11:38:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7AcKxluLdU/Listeners', 11:38:54 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 11:38:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:54 INFO - 'USER': 'cltbld', 11:38:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:54 INFO - 'XPC_FLAGS': '0x0', 11:38:54 INFO - 'XPC_SERVICE_NAME': '0', 11:38:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--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 11:38:54 INFO - mozversion application_buildid: 20161111102820 11:38:54 INFO - mozversion application_changeset: 0116b93b47e9db13d3da4575676202db72a65e54 11:38:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:38:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:38:54 INFO - mozversion application_name: Firefox 11:38:54 INFO - mozversion application_remotingname: firefox-dev 11:38:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:38:54 INFO - mozversion application_vendor: Mozilla 11:38:54 INFO - mozversion application_version: 51.0a2 11:38:54 INFO - mozversion platform_buildid: 20161111102820 11:38:54 INFO - mozversion platform_changeset: 0116b93b47e9db13d3da4575676202db72a65e54 11:38:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:38:54 INFO - mozversion platform_version: 51.0a2 11:38:54 INFO - using testdate: 1478893134 11:38:54 INFO - actual date: 1478893134 11:38:54 INFO - starting webserver on 'localhost:49775' 11:38:54 INFO - SUITE-START | Running 2 tests 11:38:54 INFO - TEST-START | dromaeo_css 11:38:54 INFO - operating with platform_type : mac_ 11:38:54 INFO - Initialising browser for dromaeo_css test... 11:38:54 INFO - TEST-INFO | started process 2073 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpPAvPDY/profile http://localhost:49775/getInfo.html) 11:38:57 INFO - PROCESS | 2073 | __metrics Screen width/height:1600/1200 11:38:57 INFO - PROCESS | 2073 | colorDepth:24 11:38:57 INFO - PROCESS | 2073 | Browser inner width/height: 1024/689 11:38:57 INFO - PROCESS | 2073 | __metrics 11:38:57 INFO - PROCESS | 2073 | 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" 11:38:57 INFO - PROCESS | 2073 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:38:57 INFO - TEST-INFO | 2073: exit 0 11:38:57 INFO - Browser initialized. 11:38:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:38:57 INFO - TEST-INFO | started process 2075 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpPAvPDY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:10 INFO - PROCESS | 2075 | RSS: Main: 220000256 11:39:10 INFO - PROCESS | 2075 | 11:40:01 INFO - PROCESS | 2075 | 1478893201365 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] 11:42:13 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:49775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49775/tests/dromaeo/cssquery-ext.html) 11:42:14 INFO - PROCESS | 2075 | RSS: Main: 353656832 11:42:14 INFO - PROCESS | 2075 | 11:45:17 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:49775/tests/dromaeo/cssquery-ext.html (next: http://localhost:49775/tests/dromaeo/cssquery-jquery.html) 11:45:18 INFO - PROCESS | 2075 | RSS: Main: 352845824 11:45:18 INFO - PROCESS | 2075 | 11:48:20 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:49775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49775/tests/dromaeo/cssquery-mootools.html) 11:48:21 INFO - PROCESS | 2075 | RSS: Main: 333398016 11:48:21 INFO - PROCESS | 2075 | 11:51:23 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:49775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49775/tests/dromaeo/cssquery-prototype.html) 11:51:24 INFO - PROCESS | 2075 | RSS: Main: 330379264 11:51:24 INFO - PROCESS | 2075 | 11:54:27 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:49775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49775/tests/dromaeo/cssquery-yui.html) 11:54:28 INFO - PROCESS | 2075 | RSS: Main: 313196544 11:54:28 INFO - PROCESS | 2075 | 11:57:30 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:49775/tests/dromaeo/cssquery-yui.html (next: http://localhost:49775/tests/dromaeo/cssquery-dojo.html) 11:57:31 INFO - PROCESS | 2075 | RSS: Main: 365060096 11:57:31 INFO - PROCESS | 2075 | 11:57:31 INFO - PROCESS | 2075 | __start_tp_report 11:57:31 INFO - PROCESS | 2075 | _x_x_mozilla_page_load 11:57:31 INFO - PROCESS | 2075 | _x_x_mozilla_page_load_details 11:57:31 INFO - PROCESS | 2075 | |i|pagename|runs| 11:57:31 INFO - PROCESS | 2075 | |0;dojo.html;3250.4961730931705;3251.6423193448722;3284.1953721338277;3294.2917272786344;3335.2662414268866;5531.917021244684;5586.525145362649;5589.916151257735;5601.7199140042985;5602.047651899176;5512.255845460862;5599.63602365846;5608.6073974821775;5618.2415373924505;5657.462541058603;5093.567046801017;5096.719680417576;5101.744912754366;5162.199859021857;5185.611079169059;5088.745562721849;5095.745212739367;5099.184130539096;5183.611229157809;5194.688318700871;5097.617678674096;5155.922661160085;5169.793208271683;5181.792728290883;5190.299309593194;5127.564157046637;5159.045576568347;5161.148410512261;5169.224616307546;5206.687598744087;5067.6452648314635;5139.537441630234;5142.280080788692;5159.22611608258;5178;5466.480684334982;5516.724163791794;5530;5603.411641777636;5610.270664813589;5961.8807623847715;5995.37048609894;6035.8792824143275;6078.483328917047;6084.178635884187;6124.35694252106;6150.415710507495;6155.045967874942;6173.135760993465;6174.259088909314;5532.944670553324;5579.6652200868075;5637.267155269788;5643.492085712305;5649.152627105926;6130.612163469634;6206;6215;6231.283402408691;6274.968625156845;5945.821625351246;5956.195913551615;5960.761569537257;5963.016102343152;5963.0459126539545;6098.664573448415;6104.664243466652;6139.4781443577795;6156;6176.197094377702;4854.441739200037;5858.033424484912;5888.087346461305;5896.351401345849;6003.7898673546215;6028.306744724325;6033.637981721111;6043.365446628129;6046.788362407295;6088.4215999479975;4751;4759.785809638505;4760.238361862154;4780.282957556395;4825.9758701206265;4194.958050419517;4245.957540424618;4262.360645903139;4298.828046878152;4311.719738217006;4895.339129217581;5571.60998730085;5620.016497112989;5635.915461268084;5696.202531645573;6125.9693701531205;6142.673046761843;6148.44663980235;6150.907736383958;6159.076138579249;5618.438156184349;5642.26650535436;5647.068233741469;5649.6327738696855;5666.376698563155;5109.8722531936255;5182.404023537266;5215.061288968022;5225.399079105876;5262.394824595144;6269.435750782361;6330.3986121317475;6349.174607301022;6351.9047214290895;6355.300916899045;6109.327973922954;6129.693515324305;6132.325444201224;6150.630962142286;6159.5688301818445;6161.322254551906;6233.719482623384;6299.6535190564955;6308.148399965946;6350.714217860115;5812.157237200667;5859.472647461749;5867.119932010232;5928.466438020599;5963.224780778471;6029.306629737461;6054.455099041107;6054.8183554493435;6060.6969651516365;6060.787872424444;5647;5742.397048309867;5839.737211825393;5850.765969361178;5855.94144058554;5777.537796976148;5802.854928626818;5824.242848429677;5836.562257830765;5849.532037436909;5482.5613950884635;5763.452472015152;5771.192033115283;5781.82654520365;5804.506616937439;5836.562257830595;5869.882602348014;5880.235569376125;5886.264216972879;5900.173975643327;4845.6123510118405;5605.971970140124;5616.66300022;5674.4892959633835;5698.2592263005545 11:57:31 INFO - PROCESS | 2075 | |1;ext.html;465.9207934651111;473.1577791531076;473.7347085632046;490.2939766735899;519.3170980161088;30496.39007219857;40460.1907961841;41337.37993930093;41458;41492.37761433581;42713.78643106788;42952.57047429525;43013.35479967803;43058.56941430585;43285.56714432855;8762.25520830727;9919.950400247988;10090.798184036315;10092.990700929922;10106.191504679644;8724.956375218115;12055.276683399024;12335.25988440692;12357.629271121881;12549.686257843581;12274.631761047183;12308.076894232969;12330;12340.753184936297;12344.691382715459;10336.948315258376;12210.023198144127;12259.264444133381;12271.815922761165;12287.754244915097;11912.761744765055;12071.456784444634;12128.332941688204;12141.271523708605;12157.574484893075;39958;40261.59738402608;40280;40306.193876122314;40350.39474407886;3210.7431405487505;3399.082247793107;3783.148791521913;3895.2599006189016;3903.609639036102;30603.23491912698;31232.90684826043;31239.843800781076;31553.684463155303;32233.1941701457;3131.3424180922034;3297.7032067113837;3298.65364136767;3334;3379.4086034943784;396177;500946.49526752497;501747.4912625413;501823;503481;31082.844585776926;33494.49758253628;62413.06380404298;62927.74144517084;62949;34663.306733865684;34898.47652285218;34980.125496862274;35076.64923350785;35080.47379289313;14926.776098358316;15033.248337583078;15063.924680376527;15070.924645376703;15087.773683394758;11516.02113820318;11762.647120586225;11779.52881884715;12764.80852787209;12817.807732884014;7665.8850117248285;7842.137364889858;7842.725504607425;7843.333316668033;7913.208679132041;3163.2408222027007;3202.8878989235263;3209.812369423282;3246.334501427249;3247.7888937219004;917.312015988009;925.5048549026238;950.695777351241;1040.3133931605105;1057.2704833664748;23951.16170934009;28987;30136.547951780303;30353.544696829566;30842.53736193959;1052.4053909541237;1087.5106202209038;1102.2614848051664;1154.49202350967;1172.8358029875824;11752.632785023237;15388.769168462259;15509.5347139586;15510;15863.444779432664;641359;644780;646026;646154;646980;56397.43602564004;56857;56961.71519142378;57066.14400783992;57180.42819571751;1210.6912737251944;1244.887960083597;1325.9469621215428;1347.3263368315843;1369.3084992079137;29295.974640887467;30665.648643021035;31238.531422029144;31289.530657040617;31905.521417178297;49202.015959681325;49744.75127624483;49774.25338619996;49777.25334120064;49889.75055124701;537628;540094;540989;541939;542682;26486.735132648428;27254.72745272522;27332.726672733814;27987.160385188476;28115.71884281131;45954.31068534042;46212.53787462082;46516;46870.76564617155;47109.52890471051;38305;38346;39124.217515650096;39156.608433915295;40411.393829092;38210.2357952845;38416.6158338413;38834.80582597069;39943.80028099841;39962.2007559853;36555.268894621426;38343;38404.23191536098;38651.42022869603;38797.41803872888;32895.67104329022;33799;34173.76728593347;34652.82673586616;34707.30585388227;23988;25486.490270194863;25534.48931021332;25619.74380256248;26065.218043457968 11:57:31 INFO - PROCESS | 2075 | |2;jquery.html;327.2440662070617;357.31930672069717;380.90477380654835;387.0826142043357;408.8814243869278;11774.587889423872;12184.81722774159;14494.782578261334;15403.383864645415;20696.586068278626;22127.889360553214;22655.98048087836;22940.31179064631;23131.653025204592;23326.883365583148;6750.156230471179;7044.894326585106;7106.609136497491;7120.287971202864;7123.78628641139;6333.904991425133;6749.616328652614;6934.583924964493;7001.964990175042;7096.325849044332;6704.899426508607;7061.152661680606;7067.045948796924;7083.397911177556;7088.220295767487;5997.37027612101;6844.828879278008;6882.69027893741;6936.791896243096;7001;6455.160829092188;6717.6977036033495;6773.593584384953;6778.186617605918;6784.864302713968;28613;29271.829126835113;29340.559891601642;29361.70638293611;29365.853170734223;2377.2868139558063;2460.507898420305;2515.295717199187;2597.71425143236;3207.716913234725;16421;17171.399001034904;17220.225089870986;17264.74102888458;17464.301427942868;1984.3550845974971;2112.904919278636;2115.8730476171477;2117.3118736410574;2163.718716566852;137130.6286937128;137593.999999999;143311;150175.24912375477;152865.23567382203;17541.64916701659;20742.688859667116;21181.046852891657;21441.78558214429;21478.24826131078;24679.753202467746;29358.266043349086;29510.704892951224;30668.846655767025;30952.380952381278;9300.255979521622;10339.327943683636;10513.632022879163;11188.384638844778;11207.887921120684;9198.632054717737;9204.355695101278;9213.631454741735;9360.506956660842;9412.529373531295;9481.668141615148;9722.076402741728;9742.123208911233;9837.950810245902;9962.701118966443;3728.217074414349;3821.464994900716;3823.9044023899623;3827.928180109574;3828.3584326814407;837.5644664774284;903.8327909336793;933.7152168588646;942.40157499988;992.1467537917385;20714.689279660815;21585.67621485679;21617.78382216158;21673.566528669337;21811.454713632287;894.7360528644066;936.7704912296394;937.3719607862748;962.8363178259713;974.8927617962019;10515.684529464128;10889.564417423215;11187.272827266203;11222.831657525143;11278.943605281922;586183;594013;599855;611311;613923;79694.60152699199;88735.55632221798;100931.49534252282;123744.38127809303;125264;940.1350757303297;964.6816550538306;997.2769741937037;997.6109317366233;998.236349192868;19054.809451905858;19738.50653733668;19827.30604428838;19858.404247872586;19933.903635300197;45589;56363;57496.42503575078;58111.12833307419;58958.41041589701;70320.29679703138;74089.88865166919;76685.61657191678;78870;79468.20531794608;7874.803129921569;8012;8206.83586328282;8309.6676132954;8325.500469971821;10553.63062292816;12714.936425317814;12864.678383040498;12926.93536532349;13160.868391316348;10945.781084378108;11015.669529914116;11032.227744057838;11304.152188585724;11406.942965285121;10978.670639880816;11006.889931100906;11128.666140015812;11198.944005279922;11335.829962550733;11158.776824463628;11532;11554.826677599674;11561.075113991028;11764.411779411166;7946.125926148235;8017.759467215993;8042.517448953082;8152.225538573826;8197.918020819716;8161.469504482189;11018.559257629606;11031.944840275748;11087.279326843729;11196.38419886914 11:57:31 INFO - PROCESS | 2075 | |3;mootools.html;1293.9805902911457;1483.5845963130323;1639.8934069285497;1821.107657247949;1870.7568016157907;8062.153473885245;8318.70884519042;8362.289205417539;8917.821643567126;8932.419392739468;8218.835623287545;8305.83388332233;8321.500709957392;8559.743207703763;8755.1682590154;2380.119355838338;2410.192585483865;2416.359664688859;2417.371483414316;2419.1653879411574;2060.7527096748413;2396.209250947192;2434.732179460258;2441.2554170977933;2442.5237078769646;2400.639904014403;2418.51629674065;2427.8786060696984;2434.3670645632174;2436.378723425533;2390.4621460171497;2411.8191135664806;2414.0464516516054;2417.395651087228;2422.87885605719;2010.4873257319437;2174.2716190076344;2238.697775800262;2404.2426635609727;2413.3845869303213;8853.380263381501;9056.637734490612;9069.138431848964;9072.818543629157;9089.27285817133;5225.372955245357;5386.218998245233;5403.864903377408;5419.729013549307;5424.159255315432;3599.6760291573883;3624.4200927851416;3663.139162296858;3687.4100143976834;3709.2952339055764;1083.7128161037253;1084.5228099636136;1092.1317552545745;1099.2854644481072;1106.2090605217227;11813.877681620232;11909.464074116686;11913.94043029788;11933.641990740292;11944.641660750278;4001.3397789365013;4162.708610397243;4735.431748190171;4788.254095085911;4949.7772600233075;10160.4919754012;10175.84736228957;10183.032611901857;10191.133753630877;10199.796004080024;5468.863278418072;5471.5896307777075;5472.699001554873;5489.505944465017;5504.80733174345;4480.820767169342;4572.542745725401;4612.953870461252;4959.578435832923;5003.2745251938995;4005.7396269242404;4029.8388064477094;4130.091379896418;4133.689973251958;4143.37849322598;1310.9410076546578;1330.2949436798513;1331.227887825059;1335.1988806715892;1341.2958196946681;818.4802650317091;909.1590278992038;914.1087439746194;922.3497434308796;925.893522244937;5122.769475373542;5606.383297837235;5820.301563812285;5855.268091488564;5900.675462849585;383.5014481174462;430.26424813568525;452.988675283114;456.07872098361787;462.39657247292604;3886.358750806142;3937.330653788863;3952.8023598819946;3981.3629819229363;4053.1488387438967;9912.801743965081;10789.136869050457;10827;10889.346639201514;11075.05862001739;10747.623833165802;10752.892471075345;10954.726131846768;11011.61459348919;11017.1186305097;8067.878981815277;8247.257746802816;8293.585320733939;8453.746387608382;8469.11074337198;5641.971790141023;5765.077587585966;5807.651540907559;5833.4749872511675;5944.702764861653;10172.08451239392;10211.948940255548;10354.016368444985;10359;10377.533011014371;10008.799824003625;10269.589216431259;10284.434356110485;10361.84457233127;10403.42781147014;6981.930180698128;7180.5691658500655;7446.664900079401;7636.770896873103;7792.493487923267;8204.220599043081;8321.459105158145;8415;8417.326613870999;8424.241818236389;7418.740344087931;7501.062367204099;7653.57905315213;7706.922930770845;7736.7678969631;7279.199288078413;7451.5901625411125;7476.289752473506;7485.70057197706;7625.351845093007;6671.232808227116;7078.301207710216;7168.56988580666;7174.461915356474;7177.031100801325;4279.893002674958;4870.561649451566;4945.876353091202;4978.979309241525;5014.598832093351;4698.130845793539;4711.293306004127;4823.059503396944;4896.510348965075;4921.778519966539 11:57:31 INFO - PROCESS | 2075 | |4;prototype.html;251.75202425610775;301.5491839699651;307.1017274472169;311.9064280715786;316.20947630922694;5301.549368303694;5348.224507446418;5355.848492574096;5369.389183245031;5435.2551961259605;4291.978540107303;4570.040291538781;5170.138750049979;5197.714125723083;5203.869903252421;3322.5846769153854;3398.0485464069975;4013.418054382113;4029.2747305485;4080.979595102035;3871.903202419948;4010.9972506873282;4086.3053280942313;4107.630313271805;4152.356384760367;3424.366492198951;3920.7255492115564;4042.4946881639794;4049.412835138903;4070.308047631895;4026.6376026157495;4072.7149099563044;4074.6129117733767;4091.6931230157707;4108.301588729923;2846.985765071182;3556.270964452281;3559.519464872235;3564.8395822188063;3570.2505772171708;4889.119958407486;5062.2406639004075;5201.843944681666;5231.2937753403185;5260.947390526084;4075.32757095079;4678.555537223959;4705.282826567008;4718.245080787057;4733.479317275097;4499.437570303712;5628.493435590775;5669.971650141764;5689.573282003867;5699.487046165865;3803.5435747710453;3966.6628336591425;3972.8609498667406;3986.4817573715522;3987.4218238355274;4883.804647814119;5130.589552835801;5918.674472904032;5985.25184351956;5993.340732519463;3365.6466071062678;4000.259951908848;4005;4028.267844826694;4058.3303754880703;3619.7466177367332;4087.162131763041;4092.836286548564;4106.967051309561;4109.486314210723;3858.7877666728036;4513.345564893072;4555.496686093581;4684.789184486638;4693.812247510062;4980;5152.819651312186;5366.838994830161;5613.438656134435;5640.379558248589;1136.9488373023069;1365.283226306197;1386.654944703636;1396.8672976067257;1400.1948879394185;715.1418298042266;797.2505844506146;862.9611667474978;879.0198928195144;913.9124441914101;4372.759498227564;5357.330333708286;5360.624756267024;5371.435999220103;5410.864728381822;4556.243472699036;5735.541156707537;5759.308882934075;5789.45000224978;5792.478676919098;4520.751358675305;5151.278820965068;5281.102212623863;5282.577393808486;5355.705436201047;2428.3807629054477;2926.6488021437563;3003.819770813758;3007.7593792496546;3010.71398217169;4838;5254.737263136904;5459.890802183934;5672.688002159921;5937.228160339128;5814.767409303665;5818.563607729353;5823.883522329615;5827.475527202488;5840.1531777892815;5847.2869727722355;5864.501517371071;5918.3489816121055;5919.260092488439;5938.732757025944;4743.9525604744895;5433.239346491573;5658.20785090096;5703.861052105461;5720.8283751487525;4899.877503062309;4908.386451693538;5500.4499550044675;5575.4424557543925;5575.832725018256;5147;5527.364353099445;5832.970835145967;5856.970715146397;5861.912071319019;3908.065507573769;3919.2749341371937;3927.8821635350987;3956.327424337812;3965.4250133731025;4992.700437973734;5146.24324243312;5331.333583302087;5635.351934527582;5656.446560518822;4374.834456943706;4885;5559.388467268678;5559.749811258423;5579.74891129892;5137.919142747193;5463.890722185613;5512.669239845462;5521.337439507124;5537.916931246115;4888.804447822047;5015.993602559006;5149.356330458692;5395.271638328933;5445.646033007842;5094.821681241138;5189.714565698923;5410.296661433988;5672.432756724294;5672.858178545569;4461.442319710036;5516.503514683698;5530.806421775219;5534.754680197085;5535.667859928256 11:57:31 INFO - PROCESS | 2075 | |5;yui.html;708.9649112296045;754.8905408715734;763.2710761223033;772.7140957845598;780.2743448592806;13641.317934103292;16607.66784664306;16614.833851661464;16620.418285360014;16689.33242670295;14673.972821902471;14856.925715371435;14999.100053996768;15148.924255378708;15179.241037948113;665.3213722003553;684.3737979748524;686.9793906182822;818.3575892924056;821.137805304428;740.6111791309552;840.0675250471971;854.9957250213771;855.2601999270648;858.3262139220712;860.9698660546882;904.0688091266006;905.4386280506062;906.8549032154857;908.4095338030301;695.4123765418213;715.8460930899881;901.9007909130023;904.430208968349;905.3255324783013;553.510143522981;640.6444423345042;652.282489261813;654.9738010479575;663.0683889135772;15456.768148477782;15551.30019149141;15551.766723499157;15563.299651515708;15589.220538973006;13993.230372329517;14215.786763198457;14233.217173055478;14293.57119286423;14304.356303966346;12507.312097834616;13051.347432628425;13096.86903130966;13106.148100373444;13523.932380338134;4481.484629267611;4496.3705081288645;4553.817847286105;4555.339475775994;4653;111874.44062779716;114138.28792568119;114411.42794286058;114910;123255.3837230817;11253.549858005752;11313.83029254562;11385.886141138648;11883.702907427383;11884.584039558575;22706.659400109012;22877.656835147485;22923;22935.655965160535;22938.885305573367;7966.888774474769;8001.519908805491;8038.557879316577;8131.79670508242;8147.348212143014;4129.236091323115;4174.165166966619;4383.189110014658;4457.175422546839;4458.130664520388;3501.142220156078;3701.3892707702926;3712.461693054492;3713.3872910969926;3718.3307004738867;656.967151642416;661.9304972977768;665.2216906219638;666.7732970789955;673.2190658835727;587.9706014699248;609.2049874913192;617.8949578571653;624.725120946782;641.8908785506475;8923.910760892439;9007.549622518847;9095.363324567217;9231.123043310874;9407.717768466957;481.1891962043967;549.6235078970918;587.6885250817073;609.2719200555382;623.7754408412968;3208.903732888017;4292.699511034198;4541.931871021938;4574.45106587205;4579.95420045802;98696.50651746696;104525;156799;164560.17719911324;172594;96484;121336.78663213432;133597.33201334125;138686;147614.52385476007;115345.26982095276;122093;124323.37838310751;125099.74900251062;130263.34868325788;9781.710679553622;10021.949890250502;10087.949560252151;10201.948990255001;10378.636747714096;48454.757726212556;53611.46388536221;57464.42535574758;58787.987736065894;61453;90778.57263337575;95533.52233238789;101619.49190254002;102139;102826.48586757018;12923.547675831302;13051.934740326238;13238.205707657571;13370.799438008244;13513.729725405634;15227;15268.847311526742;15289.923550382176;15314.387424502895;15340.232988350761;13759;13765;13891.305434728425;14213.218272995084;14835.629109272355;14155.716885662436;14264.928675356558;14265.358058887168;14265.358058887168;14371.353289101806;13515.256660883353;13595.32023398846;13704.10923289983;13922.443102275796;14501.129932204101;11494.94252528732;11504.389385486205;11593.768124637629;11725.88274117248;12193;11488.368139752394;11630.76738465209;11694.356810375511;11717.589884354347;11814.232074915102 11:57:31 INFO - PROCESS | 2075 | __end_tp_report 11:57:31 INFO - PROCESS | 2075 | __start_cc_report 11:57:31 INFO - PROCESS | 2075 | _x_x_mozilla_cycle_collect,1335 11:57:31 INFO - PROCESS | 2075 | __end_cc_report 11:57:31 INFO - PROCESS | 2075 | __startTimestamp1478894251196__endTimestamp 11:57:31 INFO - PROCESS | 2075 | 11:57:31 INFO - PROCESS | 2075 | ------- Summary: start ------- 11:57:31 INFO - PROCESS | 2075 | Number of tests: 6 11:57:31 INFO - PROCESS | 2075 | 11:57:31 INFO - PROCESS | 2075 | [#0] dojo.html Cycles:165 Average:5589.57 Median:5698.26 stddev:629.98 (11.1%) stddev-sans-first:604.60 11:57:31 INFO - PROCESS | 2075 | Values: 3250.5 3251.6 3284.2 3294.3 3335.3 5531.9 5586.5 5589.9 5601.7 5602.0 5512.3 5599.6 5608.6 5618.2 5657.5 5093.6 5096.7 5101.7 5162.2 5185.6 5088.7 5095.7 5099.2 5183.6 5194.7 5097.6 5155.9 5169.8 5181.8 5190.3 5127.6 5159.0 5161.1 5169.2 5206.7 5067.6 5139.5 5142.3 5159.2 5178.0 5466.5 5516.7 5530.0 5603.4 5610.3 5961.9 5995.4 6035.9 6078.5 6084.2 6124.4 6150.4 6155.0 6173.1 6174.3 5532.9 5579.7 5637.3 5643.5 5649.2 6130.6 6206.0 6215.0 6231.3 6275.0 5945.8 5956.2 5960.8 5963.0 5963.0 6098.7 6104.7 6139.5 6156.0 6176.2 4854.4 5858.0 5888.1 5896.4 6003.8 6028.3 6033.6 6043.4 6046.8 6088.4 4751.0 4759.8 4760.2 4780.3 4826.0 4195.0 4246.0 4262.4 4298.8 4311.7 4895.3 5571.6 5620.0 5635.9 5696.2 6126.0 6142.7 6148.4 6150.9 6159.1 5618.4 5642.3 5647.1 5649.6 5666.4 5109.9 5182.4 5215.1 5225.4 5262.4 6269.4 6330.4 6349.2 6351.9 6355.3 6109.3 6129.7 6132.3 6150.6 6159.6 6161.3 6233.7 6299.7 6308.1 6350.7 5812.2 5859.5 5867.1 5928.5 5963.2 6029.3 6054.5 6054.8 6060.7 6060.8 5647.0 5742.4 5839.7 5850.8 5855.9 5777.5 5802.9 5824.2 5836.6 5849.5 5482.6 5763.5 5771.2 5781.8 5804.5 5836.6 5869.9 5880.2 5886.3 5900.2 4845.6 5606.0 5616.7 5674.5 5698.3 11:57:31 INFO - PROCESS | 2075 | 11:57:31 INFO - PROCESS | 2075 | [#1] ext.html Cycles:180 Average:67865.62 Median:18786.42 stddev:149833.35 (797.6%) stddev-sans-first:150168.21 11:57:31 INFO - PROCESS | 2075 | Values: 465.9 473.2 473.7 490.3 519.3 30496.4 40460.2 41337.4 41458.0 41492.4 42713.8 42952.6 43013.4 43058.6 43285.6 8762.3 9920.0 10090.8 10093.0 10106.2 8725.0 12055.3 12335.3 12357.6 12549.7 12274.6 12308.1 12330.0 12340.8 12344.7 10336.9 12210.0 12259.3 12271.8 12287.8 11912.8 12071.5 12128.3 12141.3 12157.6 39958.0 40261.6 40280.0 40306.2 40350.4 3210.7 3399.1 3783.1 3895.3 3903.6 30603.2 31232.9 31239.8 31553.7 32233.2 3131.3 3297.7 3298.7 3334.0 3379.4 396177.0 500946.5 501747.5 501823.0 503481.0 31082.8 33494.5 62413.1 62927.7 62949.0 34663.3 34898.5 34980.1 35076.6 35080.5 14926.8 15033.2 15063.9 15070.9 15087.8 11516.0 11762.6 11779.5 12764.8 12817.8 7665.9 7842.1 7842.7 7843.3 7913.2 3163.2 3202.9 3209.8 3246.3 3247.8 917.3 925.5 950.7 1040.3 1057.3 23951.2 28987.0 30136.5 30353.5 30842.5 1052.4 1087.5 1102.3 1154.5 1172.8 11752.6 15388.8 15509.5 15510.0 15863.4 641359.0 644780.0 646026.0 646154.0 646980.0 56397.4 56857.0 56961.7 57066.1 57180.4 1210.7 1244.9 1325.9 1347.3 1369.3 29296.0 30665.6 31238.5 31289.5 31905.5 49202.0 49744.8 49774.3 49777.3 49889.8 537628.0 540094.0 540989.0 541939.0 542682.0 26486.7 27254.7 27332.7 27987.2 28115.7 45954.3 46212.5 46516.0 46870.8 47109.5 38305.0 38346.0 39124.2 39156.6 40411.4 38210.2 38416.6 38834.8 39943.8 39962.2 36555.3 38343.0 38404.2 38651.4 38797.4 32895.7 33799.0 34173.8 34652.8 34707.3 23988.0 25486.5 25534.5 25619.7 26065.2 11:57:31 INFO - PROCESS | 2075 | 11:57:31 INFO - PROCESS | 2075 | [#2] jquery.html Cycles:180 Average:36511.06 Median:1767.48 stddev:100228.60 (5670.7%) stddev-sans-first:100472.94 11:57:31 INFO - PROCESS | 2075 | Values: 327.2 357.3 380.9 387.1 408.9 11774.6 12184.8 14494.8 15403.4 20696.6 22127.9 22656.0 22940.3 23131.7 23326.9 6750.2 7044.9 7106.6 7120.3 7123.8 6333.9 6749.6 6934.6 7002.0 7096.3 6704.9 7061.2 7067.0 7083.4 7088.2 5997.4 6844.8 6882.7 6936.8 7001.0 6455.2 6717.7 6773.6 6778.2 6784.9 28613.0 29271.8 29340.6 29361.7 29365.9 2377.3 2460.5 2515.3 2597.7 3207.7 16421.0 17171.4 17220.2 17264.7 17464.3 1984.4 2112.9 2115.9 2117.3 2163.7 137130.6 137594.0 143311.0 150175.2 152865.2 17541.6 20742.7 21181.0 21441.8 21478.2 24679.8 29358.3 29510.7 30668.8 30952.4 9300.3 10339.3 10513.6 11188.4 11207.9 9198.6 9204.4 9213.6 9360.5 9412.5 9481.7 9722.1 9742.1 9838.0 9962.7 3728.2 3821.5 3823.9 3827.9 3828.4 837.6 903.8 933.7 942.4 992.1 20714.7 21585.7 21617.8 21673.6 21811.5 894.7 936.8 937.4 962.8 974.9 10515.7 10889.6 11187.3 11222.8 11278.9 586183.0 594013.0 599855.0 611311.0 613923.0 79694.6 88735.6 100931.5 123744.4 125264.0 940.1 964.7 997.3 997.6 998.2 19054.8 19738.5 19827.3 19858.4 19933.9 45589.0 56363.0 57496.4 58111.1 58958.4 70320.3 74089.9 76685.6 78870.0 79468.2 7874.8 8012.0 8206.8 8309.7 8325.5 10553.6 12714.9 12864.7 12926.9 13160.9 10945.8 11015.7 11032.2 11304.2 11406.9 10978.7 11006.9 11128.7 11198.9 11335.8 11158.8 11532.0 11554.8 11561.1 11764.4 7946.1 8017.8 8042.5 8152.2 8197.9 8161.5 11018.6 11031.9 11087.3 11196.4 11:57:31 INFO - PROCESS | 2075 | 11:57:31 INFO - PROCESS | 2075 | [#3] mootools.html Cycles:180 Average:5737.23 Median:454.53 stddev:3268.10 (719.0%) stddev-sans-first:3260.21 11:57:31 INFO - PROCESS | 2075 | Values: 1294.0 1483.6 1639.9 1821.1 1870.8 8062.2 8318.7 8362.3 8917.8 8932.4 8218.8 8305.8 8321.5 8559.7 8755.2 2380.1 2410.2 2416.4 2417.4 2419.2 2060.8 2396.2 2434.7 2441.3 2442.5 2400.6 2418.5 2427.9 2434.4 2436.4 2390.5 2411.8 2414.0 2417.4 2422.9 2010.5 2174.3 2238.7 2404.2 2413.4 8853.4 9056.6 9069.1 9072.8 9089.3 5225.4 5386.2 5403.9 5419.7 5424.2 3599.7 3624.4 3663.1 3687.4 3709.3 1083.7 1084.5 1092.1 1099.3 1106.2 11813.9 11909.5 11913.9 11933.6 11944.6 4001.3 4162.7 4735.4 4788.3 4949.8 10160.5 10175.8 10183.0 10191.1 10199.8 5468.9 5471.6 5472.7 5489.5 5504.8 4480.8 4572.5 4613.0 4959.6 5003.3 4005.7 4029.8 4130.1 4133.7 4143.4 1310.9 1330.3 1331.2 1335.2 1341.3 818.5 909.2 914.1 922.3 925.9 5122.8 5606.4 5820.3 5855.3 5900.7 383.5 430.3 453.0 456.1 462.4 3886.4 3937.3 3952.8 3981.4 4053.1 9912.8 10789.1 10827.0 10889.3 11075.1 10747.6 10752.9 10954.7 11011.6 11017.1 8067.9 8247.3 8293.6 8453.7 8469.1 5642.0 5765.1 5807.7 5833.5 5944.7 10172.1 10211.9 10354.0 10359.0 10377.5 10008.8 10269.6 10284.4 10361.8 10403.4 6981.9 7180.6 7446.7 7636.8 7792.5 8204.2 8321.5 8415.0 8417.3 8424.2 7418.7 7501.1 7653.6 7706.9 7736.8 7279.2 7451.6 7476.3 7485.7 7625.4 6671.2 7078.3 7168.6 7174.5 7177.0 4279.9 4870.6 4945.9 4979.0 5014.6 4698.1 4711.3 4823.1 4896.5 4921.8 11:57:31 INFO - PROCESS | 2075 | 11:57:31 INFO - PROCESS | 2075 | [#4] prototype.html Cycles:180 Average:4510.15 Median:5112.71 stddev:1375.08 (26.9%) stddev-sans-first:1341.28 11:57:31 INFO - PROCESS | 2075 | Values: 251.8 301.5 307.1 311.9 316.2 5301.5 5348.2 5355.8 5369.4 5435.3 4292.0 4570.0 5170.1 5197.7 5203.9 3322.6 3398.0 4013.4 4029.3 4081.0 3871.9 4011.0 4086.3 4107.6 4152.4 3424.4 3920.7 4042.5 4049.4 4070.3 4026.6 4072.7 4074.6 4091.7 4108.3 2847.0 3556.3 3559.5 3564.8 3570.3 4889.1 5062.2 5201.8 5231.3 5260.9 4075.3 4678.6 4705.3 4718.2 4733.5 4499.4 5628.5 5670.0 5689.6 5699.5 3803.5 3966.7 3972.9 3986.5 3987.4 4883.8 5130.6 5918.7 5985.3 5993.3 3365.6 4000.3 4005.0 4028.3 4058.3 3619.7 4087.2 4092.8 4107.0 4109.5 3858.8 4513.3 4555.5 4684.8 4693.8 4980.0 5152.8 5366.8 5613.4 5640.4 1136.9 1365.3 1386.7 1396.9 1400.2 715.1 797.3 863.0 879.0 913.9 4372.8 5357.3 5360.6 5371.4 5410.9 4556.2 5735.5 5759.3 5789.5 5792.5 4520.8 5151.3 5281.1 5282.6 5355.7 2428.4 2926.6 3003.8 3007.8 3010.7 4838.0 5254.7 5459.9 5672.7 5937.2 5814.8 5818.6 5823.9 5827.5 5840.2 5847.3 5864.5 5918.3 5919.3 5938.7 4744.0 5433.2 5658.2 5703.9 5720.8 4899.9 4908.4 5500.4 5575.4 5575.8 5147.0 5527.4 5833.0 5857.0 5861.9 3908.1 3919.3 3927.9 3956.3 3965.4 4992.7 5146.2 5331.3 5635.4 5656.4 4374.8 4885.0 5559.4 5559.7 5579.7 5137.9 5463.9 5512.7 5521.3 5537.9 4888.8 5016.0 5149.4 5395.3 5445.6 5094.8 5189.7 5410.3 5672.4 5672.9 4461.4 5516.5 5530.8 5534.8 5535.7 11:57:31 INFO - PROCESS | 2075 | 11:57:31 INFO - PROCESS | 2075 | [#5] yui.html Cycles:180 Average:25376.76 Median:22792.16 stddev:40503.70 (177.7%) stddev-sans-first:40574.98 11:57:31 INFO - PROCESS | 2075 | Values: 709.0 754.9 763.3 772.7 780.3 13641.3 16607.7 16614.8 16620.4 16689.3 14674.0 14856.9 14999.1 15148.9 15179.2 665.3 684.4 687.0 818.4 821.1 740.6 840.1 855.0 855.3 858.3 861.0 904.1 905.4 906.9 908.4 695.4 715.8 901.9 904.4 905.3 553.5 640.6 652.3 655.0 663.1 15456.8 15551.3 15551.8 15563.3 15589.2 13993.2 14215.8 14233.2 14293.6 14304.4 12507.3 13051.3 13096.9 13106.1 13523.9 4481.5 4496.4 4553.8 4555.3 4653.0 111874.4 114138.3 114411.4 114910.0 123255.4 11253.5 11313.8 11385.9 11883.7 11884.6 22706.7 22877.7 22923.0 22935.7 22938.9 7966.9 8001.5 8038.6 8131.8 8147.3 4129.2 4174.2 4383.2 4457.2 4458.1 3501.1 3701.4 3712.5 3713.4 3718.3 657.0 661.9 665.2 666.8 673.2 588.0 609.2 617.9 624.7 641.9 8923.9 9007.5 9095.4 9231.1 9407.7 481.2 549.6 587.7 609.3 623.8 3208.9 4292.7 4541.9 4574.5 4580.0 98696.5 104525.0 156799.0 164560.2 172594.0 96484.0 121336.8 133597.3 138686.0 147614.5 115345.3 122093.0 124323.4 125099.7 130263.3 9781.7 10021.9 10087.9 10201.9 10378.6 48454.8 53611.5 57464.4 58788.0 61453.0 90778.6 95533.5 101619.5 102139.0 102826.5 12923.5 13051.9 13238.2 13370.8 13513.7 15227.0 15268.8 15289.9 15314.4 15340.2 13759.0 13765.0 13891.3 14213.2 14835.6 14155.7 14264.9 14265.4 14265.4 14371.4 13515.3 13595.3 13704.1 13922.4 14501.1 11494.9 11504.4 11593.8 11725.9 12193.0 11488.4 11630.8 11694.4 11717.6 11814.2 11:57:31 INFO - PROCESS | 2075 | -------- Summary: end -------- 11:57:31 INFO - PROCESS | 2075 | 11:57:31 INFO - TEST-INFO | 2075: exit 0 11:57:31 INFO - TEST-OK | dromaeo_css | took 1117111ms 11:57:31 INFO - TEST-START | kraken 11:57:31 INFO - operating with platform_type : mac_ 11:57:31 INFO - Initialising browser for kraken test... 11:57:31 INFO - TEST-INFO | started process 2190 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpPT_6Pg/profile http://localhost:49775/getInfo.html) 11:57:34 INFO - PROCESS | 2190 | __metrics Screen width/height:1600/1200 11:57:34 INFO - PROCESS | 2190 | colorDepth:24 11:57:34 INFO - PROCESS | 2190 | Browser inner width/height: 1024/689 11:57:34 INFO - PROCESS | 2190 | __metrics 11:57:34 INFO - PROCESS | 2190 | 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" 11:57:34 INFO - PROCESS | 2190 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:57:34 INFO - TEST-INFO | 2190: exit 0 11:57:34 INFO - Browser initialized. 11:57:34 INFO - Running cycle 1/1 for kraken test... 11:57:34 INFO - TEST-INFO | started process 2191 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpPT_6Pg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:57:46 INFO - PROCESS | 2191 | RSS: Main: 220127232 11:57:46 INFO - PROCESS | 2191 | 11:57:49 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49775/tests/kraken/driver.html?testName=audio-beat-detection) 11:57:50 INFO - PROCESS | 2191 | RSS: Main: 270954496 11:57:50 INFO - PROCESS | 2191 | 11:57:53 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49775/tests/kraken/driver.html?testName=audio-dft) 11:57:53 INFO - PROCESS | 2191 | RSS: Main: 281186304 11:57:53 INFO - PROCESS | 2191 | 11:57:56 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49775/tests/kraken/driver.html?testName=audio-fft) 11:57:57 INFO - PROCESS | 2191 | RSS: Main: 379535360 11:57:57 INFO - PROCESS | 2191 | 11:57:59 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49775/tests/kraken/driver.html?testName=audio-oscillator) 11:57:59 INFO - PROCESS | 2191 | RSS: Main: 281415680 11:57:59 INFO - PROCESS | 2191 | 11:58:01 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:58:02 INFO - PROCESS | 2191 | RSS: Main: 282439680 11:58:02 INFO - PROCESS | 2191 | 11:58:05 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49775/tests/kraken/driver.html?testName=imaging-darkroom) 11:58:05 INFO - PROCESS | 2191 | RSS: Main: 320110592 11:58:05 INFO - PROCESS | 2191 | 11:58:08 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49775/tests/kraken/driver.html?testName=imaging-desaturate) 11:58:09 INFO - PROCESS | 2191 | RSS: Main: 319193088 11:58:09 INFO - PROCESS | 2191 | 11:58:12 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49775/tests/kraken/driver.html?testName=json-parse-financial) 11:58:13 INFO - PROCESS | 2191 | RSS: Main: 315363328 11:58:13 INFO - PROCESS | 2191 | 11:58:14 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:58:15 INFO - PROCESS | 2191 | RSS: Main: 292302848 11:58:15 INFO - PROCESS | 2191 | 11:58:17 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49775/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:58:17 INFO - PROCESS | 2191 | RSS: Main: 295428096 11:58:17 INFO - PROCESS | 2191 | 11:58:20 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:58:20 INFO - PROCESS | 2191 | RSS: Main: 305688576 11:58:20 INFO - PROCESS | 2191 | 11:58:23 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:58:24 INFO - PROCESS | 2191 | RSS: Main: 311631872 11:58:24 INFO - PROCESS | 2191 | 11:58:27 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:58:27 INFO - PROCESS | 2191 | RSS: Main: 311328768 11:58:27 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49775/tests/kraken/driver.html?testName=ai-astar) 11:58:29 INFO - PROCESS | 2191 | RSS: Main: 355598336 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | __start_tp_report 11:58:29 INFO - PROCESS | 2191 | _x_x_mozilla_page_load 11:58:29 INFO - PROCESS | 2191 | _x_x_mozilla_page_load_details 11:58:29 INFO - PROCESS | 2191 | |i|pagename|runs| 11:58:29 INFO - PROCESS | 2191 | |0;ai-astar;116;112;115;114;114;114;113;113;113;112 11:58:29 INFO - PROCESS | 2191 | |1;audio-beat-detection;146;112;109;142;109;107;114;133;174;109 11:58:29 INFO - PROCESS | 2191 | |2;audio-dft;183;183;187;185;183;183;186;185;183;182 11:58:29 INFO - PROCESS | 2191 | |3;audio-fft;82;57;59;90;63;62;58;58;82;57 11:58:29 INFO - PROCESS | 2191 | |4;audio-oscillator;88;72;94;69;68;68;92;67;69;88 11:58:29 INFO - PROCESS | 2191 | |5;imaging-gaussian-blur;87;85;91;126;88;84;88;86;88;87 11:58:29 INFO - PROCESS | 2191 | |6;imaging-darkroom;95;95;95;103;97;95;95;95;95;94 11:58:29 INFO - PROCESS | 2191 | |7;imaging-desaturate;86;113;132;71;139;131;133;77;136;131 11:58:29 INFO - PROCESS | 2191 | |8;json-parse-financial;55;54;53;53;56;57;58;57;56;57 11:58:29 INFO - PROCESS | 2191 | |9;json-stringify-tinderbox;68;77;65;74;73;69;71;69;70;70 11:58:29 INFO - PROCESS | 2191 | |10;stanford-crypto-aes;89;100;100;100;76;84;85;86;87;84 11:58:29 INFO - PROCESS | 2191 | |11;stanford-crypto-ccm;138;157;148;148;157;148;148;141;171;138 11:58:29 INFO - PROCESS | 2191 | |12;stanford-crypto-pbkdf2;162;218;226;166;163;162;163;164;162;164 11:58:29 INFO - PROCESS | 2191 | |13;stanford-crypto-sha256-iterative;67;66;66;66;66;66;66;66;64;67 11:58:29 INFO - PROCESS | 2191 | __end_tp_report 11:58:29 INFO - PROCESS | 2191 | __start_cc_report 11:58:29 INFO - PROCESS | 2191 | _x_x_mozilla_cycle_collect,1971 11:58:29 INFO - PROCESS | 2191 | __end_cc_report 11:58:29 INFO - PROCESS | 2191 | __startTimestamp1478894309850__endTimestamp 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | ------- Summary: start ------- 11:58:29 INFO - PROCESS | 2191 | Number of tests: 14 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.00 11:58:29 INFO - PROCESS | 2191 | Values: 116.0 112.0 115.0 114.0 114.0 114.0 113.0 113.0 113.0 112.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:123.50 stddev:22.55 (18.3%) stddev-sans-first:22.66 11:58:29 INFO - PROCESS | 2191 | Values: 146.0 112.0 109.0 142.0 109.0 107.0 114.0 133.0 174.0 109.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.63 (0.9%) stddev-sans-first:1.69 11:58:29 INFO - PROCESS | 2191 | Values: 183.0 183.0 187.0 185.0 183.0 183.0 186.0 185.0 183.0 182.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#3] audio-fft Cycles:10 Average:66.80 Median:62.50 stddev:12.67 (20.3%) stddev-sans-first:12.19 11:58:29 INFO - PROCESS | 2191 | Values: 82.0 57.0 59.0 90.0 63.0 62.0 58.0 58.0 82.0 57.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:80.00 stddev:11.39 (14.2%) stddev-sans-first:11.43 11:58:29 INFO - PROCESS | 2191 | Values: 88.0 72.0 94.0 69.0 68.0 68.0 92.0 67.0 69.0 88.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:87.50 stddev:12.45 (14.2%) stddev-sans-first:13.12 11:58:29 INFO - PROCESS | 2191 | Values: 87.0 85.0 91.0 126.0 88.0 84.0 88.0 86.0 88.0 87.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:95.00 stddev:2.60 (2.7%) stddev-sans-first:2.74 11:58:29 INFO - PROCESS | 2191 | Values: 95.0 95.0 95.0 103.0 97.0 95.0 95.0 95.0 95.0 94.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#7] imaging-desaturate Cycles:10 Average:114.90 Median:137.50 stddev:26.60 (19.3%) stddev-sans-first:26.07 11:58:29 INFO - PROCESS | 2191 | Values: 86.0 113.0 132.0 71.0 139.0 131.0 133.0 77.0 136.0 131.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.50 stddev:1.78 (3.1%) stddev-sans-first:1.87 11:58:29 INFO - PROCESS | 2191 | Values: 55.0 54.0 53.0 53.0 56.0 57.0 58.0 57.0 56.0 57.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.50 stddev:3.37 (4.8%) stddev-sans-first:3.44 11:58:29 INFO - PROCESS | 2191 | Values: 68.0 77.0 65.0 74.0 73.0 69.0 71.0 69.0 70.0 70.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:84.50 stddev:8.24 (9.8%) stddev-sans-first:8.74 11:58:29 INFO - PROCESS | 2191 | Values: 89.0 100.0 100.0 100.0 76.0 84.0 85.0 86.0 87.0 84.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:148.00 stddev:10.11 (6.8%) stddev-sans-first:9.85 11:58:29 INFO - PROCESS | 2191 | Values: 138.0 157.0 148.0 148.0 157.0 148.0 148.0 141.0 171.0 138.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:164.00 stddev:24.87 (15.2%) stddev-sans-first:25.93 11:58:29 INFO - PROCESS | 2191 | Values: 162.0 218.0 226.0 166.0 163.0 162.0 163.0 164.0 162.0 164.0 11:58:29 INFO - PROCESS | 2191 | 11:58:29 INFO - PROCESS | 2191 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 11:58:29 INFO - PROCESS | 2191 | Values: 67.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 64.0 67.0 11:58:29 INFO - PROCESS | 2191 | -------- Summary: end -------- 11:58:29 INFO - PROCESS | 2191 | 11:58:30 INFO - TEST-INFO | 2191: exit 0 11:58:30 INFO - TEST-OK | kraken | took 58879ms 11:58:30 INFO - SUITE-END | took 1175s 11:58:31 INFO - Completed test suite (00:19:36) 11:58:31 INFO - javascript benchmark 11:58:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3250.4961730931705, 3251.6423193448722, 3284.1953721338277, 3294.2917272786344, 3335.2662414268866, 5531.917021244684, 5586.525145362649, 5589.916151257735, 5601.7199140042985, 5602.047651899176, 5512.255845460862, 5599.63602365846, 5608.6073974821775, 5618.2415373924505, 5657.462541058603, 5093.567046801017, 5096.719680417576, 5101.744912754366, 5162.199859021857, 5185.611079169059, 5088.745562721849, 5095.745212739367, 5099.184130539096, 5183.611229157809, 5194.688318700871, 5097.617678674096, 5155.922661160085, 5169.793208271683, 5181.792728290883, 5190.299309593194, 5127.564157046637, 5159.045576568347, 5161.148410512261, 5169.224616307546, 5206.687598744087, 5067.6452648314635, 5139.537441630234, 5142.280080788692, 5159.22611608258, 5178.0, 5466.480684334982, 5516.724163791794, 5530.0, 5603.411641777636, 5610.270664813589, 5961.8807623847715, 5995.37048609894, 6035.8792824143275, 6078.483328917047, 6084.178635884187, 6124.35694252106, 6150.415710507495, 6155.045967874942, 6173.135760993465, 6174.259088909314, 5532.944670553324, 5579.6652200868075, 5637.267155269788, 5643.492085712305, 5649.152627105926, 6130.612163469634, 6206.0, 6215.0, 6231.283402408691, 6274.968625156845, 5945.821625351246, 5956.195913551615, 5960.761569537257, 5963.016102343152, 5963.0459126539545, 6098.664573448415, 6104.664243466652, 6139.4781443577795, 6156.0, 6176.197094377702, 4854.441739200037, 5858.033424484912, 5888.087346461305, 5896.351401345849, 6003.7898673546215, 6028.306744724325, 6033.637981721111, 6043.365446628129, 6046.788362407295, 6088.4215999479975, 4751.0, 4759.785809638505, 4760.238361862154, 4780.282957556395, 4825.9758701206265, 4194.958050419517, 4245.957540424618, 4262.360645903139, 4298.828046878152, 4311.719738217006, 4895.339129217581, 5571.60998730085, 5620.016497112989, 5635.915461268084, 5696.202531645573, 6125.9693701531205, 6142.673046761843, 6148.44663980235, 6150.907736383958, 6159.076138579249, 5618.438156184349, 5642.26650535436, 5647.068233741469, 5649.6327738696855, 5666.376698563155, 5109.8722531936255, 5182.404023537266, 5215.061288968022, 5225.399079105876, 5262.394824595144, 6269.435750782361, 6330.3986121317475, 6349.174607301022, 6351.9047214290895, 6355.300916899045, 6109.327973922954, 6129.693515324305, 6132.325444201224, 6150.630962142286, 6159.5688301818445, 6161.322254551906, 6233.719482623384, 6299.6535190564955, 6308.148399965946, 6350.714217860115, 5812.157237200667, 5859.472647461749, 5867.119932010232, 5928.466438020599, 5963.224780778471, 6029.306629737461, 6054.455099041107, 6054.8183554493435, 6060.6969651516365, 6060.787872424444, 5647.0, 5742.397048309867, 5839.737211825393, 5850.765969361178, 5855.94144058554, 5777.537796976148, 5802.854928626818, 5824.242848429677, 5836.562257830765, 5849.532037436909, 5482.5613950884635, 5763.452472015152, 5771.192033115283, 5781.82654520365, 5804.506616937439, 5836.562257830595, 5869.882602348014, 5880.235569376125, 5886.264216972879, 5900.173975643327, 4845.6123510118405, 5605.971970140124, 5616.66300022, 5674.4892959633835, 5698.2592263005545], "value": 5549.119368212713, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.9207934651111, 473.1577791531076, 473.7347085632046, 490.2939766735899, 519.3170980161088, 30496.39007219857, 40460.1907961841, 41337.37993930093, 41458.0, 41492.37761433581, 42713.78643106788, 42952.57047429525, 43013.35479967803, 43058.56941430585, 43285.56714432855, 8762.25520830727, 9919.950400247988, 10090.798184036315, 10092.990700929922, 10106.191504679644, 8724.956375218115, 12055.276683399024, 12335.25988440692, 12357.629271121881, 12549.686257843581, 12274.631761047183, 12308.076894232969, 12330.0, 12340.753184936297, 12344.691382715459, 10336.948315258376, 12210.023198144127, 12259.264444133381, 12271.815922761165, 12287.754244915097, 11912.761744765055, 12071.456784444634, 12128.332941688204, 12141.271523708605, 12157.574484893075, 39958.0, 40261.59738402608, 40280.0, 40306.193876122314, 40350.39474407886, 3210.7431405487505, 3399.082247793107, 3783.148791521913, 3895.2599006189016, 3903.609639036102, 30603.23491912698, 31232.90684826043, 31239.843800781076, 31553.684463155303, 32233.1941701457, 3131.3424180922034, 3297.7032067113837, 3298.65364136767, 3334.0, 3379.4086034943784, 396177.0, 500946.49526752497, 501747.4912625413, 501823.0, 503481.0, 31082.844585776926, 33494.49758253628, 62413.06380404298, 62927.74144517084, 62949.0, 34663.306733865684, 34898.47652285218, 34980.125496862274, 35076.64923350785, 35080.47379289313, 14926.776098358316, 15033.248337583078, 15063.924680376527, 15070.924645376703, 15087.773683394758, 11516.02113820318, 11762.647120586225, 11779.52881884715, 12764.80852787209, 12817.807732884014, 7665.8850117248285, 7842.137364889858, 7842.725504607425, 7843.333316668033, 7913.208679132041, 3163.2408222027007, 3202.8878989235263, 3209.812369423282, 3246.334501427249, 3247.7888937219004, 917.312015988009, 925.5048549026238, 950.695777351241, 1040.3133931605105, 1057.2704833664748, 23951.16170934009, 28987.0, 30136.547951780303, 30353.544696829566, 30842.53736193959, 1052.4053909541237, 1087.5106202209038, 1102.2614848051664, 1154.49202350967, 1172.8358029875824, 11752.632785023237, 15388.769168462259, 15509.5347139586, 15510.0, 15863.444779432664, 641359.0, 644780.0, 646026.0, 646154.0, 646980.0, 56397.43602564004, 56857.0, 56961.71519142378, 57066.14400783992, 57180.42819571751, 1210.6912737251944, 1244.887960083597, 1325.9469621215428, 1347.3263368315843, 1369.3084992079137, 29295.974640887467, 30665.648643021035, 31238.531422029144, 31289.530657040617, 31905.521417178297, 49202.015959681325, 49744.75127624483, 49774.25338619996, 49777.25334120064, 49889.75055124701, 537628.0, 540094.0, 540989.0, 541939.0, 542682.0, 26486.735132648428, 27254.72745272522, 27332.726672733814, 27987.160385188476, 28115.71884281131, 45954.31068534042, 46212.53787462082, 46516.0, 46870.76564617155, 47109.52890471051, 38305.0, 38346.0, 39124.217515650096, 39156.608433915295, 40411.393829092, 38210.2357952845, 38416.6158338413, 38834.80582597069, 39943.80028099841, 39962.2007559853, 36555.268894621426, 38343.0, 38404.23191536098, 38651.42022869603, 38797.41803872888, 32895.67104329022, 33799.0, 34173.76728593347, 34652.82673586616, 34707.30585388227, 23988.0, 25486.490270194863, 25534.48931021332, 25619.74380256248, 26065.218043457968], "value": 19026.89677842802, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.2440662070617, 357.31930672069717, 380.90477380654835, 387.0826142043357, 408.8814243869278, 11774.587889423872, 12184.81722774159, 14494.782578261334, 15403.383864645415, 20696.586068278626, 22127.889360553214, 22655.98048087836, 22940.31179064631, 23131.653025204592, 23326.883365583148, 6750.156230471179, 7044.894326585106, 7106.609136497491, 7120.287971202864, 7123.78628641139, 6333.904991425133, 6749.616328652614, 6934.583924964493, 7001.964990175042, 7096.325849044332, 6704.899426508607, 7061.152661680606, 7067.045948796924, 7083.397911177556, 7088.220295767487, 5997.37027612101, 6844.828879278008, 6882.69027893741, 6936.791896243096, 7001.0, 6455.160829092188, 6717.6977036033495, 6773.593584384953, 6778.186617605918, 6784.864302713968, 28613.0, 29271.829126835113, 29340.559891601642, 29361.70638293611, 29365.853170734223, 2377.2868139558063, 2460.507898420305, 2515.295717199187, 2597.71425143236, 3207.716913234725, 16421.0, 17171.399001034904, 17220.225089870986, 17264.74102888458, 17464.301427942868, 1984.3550845974971, 2112.904919278636, 2115.8730476171477, 2117.3118736410574, 2163.718716566852, 137130.6286937128, 137593.999999999, 143311.0, 150175.24912375477, 152865.23567382203, 17541.64916701659, 20742.688859667116, 21181.046852891657, 21441.78558214429, 21478.24826131078, 24679.753202467746, 29358.266043349086, 29510.704892951224, 30668.846655767025, 30952.380952381278, 9300.255979521622, 10339.327943683636, 10513.632022879163, 11188.384638844778, 11207.887921120684, 9198.632054717737, 9204.355695101278, 9213.631454741735, 9360.506956660842, 9412.529373531295, 9481.668141615148, 9722.076402741728, 9742.123208911233, 9837.950810245902, 9962.701118966443, 3728.217074414349, 3821.464994900716, 3823.9044023899623, 3827.928180109574, 3828.3584326814407, 837.5644664774284, 903.8327909336793, 933.7152168588646, 942.40157499988, 992.1467537917385, 20714.689279660815, 21585.67621485679, 21617.78382216158, 21673.566528669337, 21811.454713632287, 894.7360528644066, 936.7704912296394, 937.3719607862748, 962.8363178259713, 974.8927617962019, 10515.684529464128, 10889.564417423215, 11187.272827266203, 11222.831657525143, 11278.943605281922, 586183.0, 594013.0, 599855.0, 611311.0, 613923.0, 79694.60152699199, 88735.55632221798, 100931.49534252282, 123744.38127809303, 125264.0, 940.1350757303297, 964.6816550538306, 997.2769741937037, 997.6109317366233, 998.236349192868, 19054.809451905858, 19738.50653733668, 19827.30604428838, 19858.404247872586, 19933.903635300197, 45589.0, 56363.0, 57496.42503575078, 58111.12833307419, 58958.41041589701, 70320.29679703138, 74089.88865166919, 76685.61657191678, 78870.0, 79468.20531794608, 7874.803129921569, 8012.0, 8206.83586328282, 8309.6676132954, 8325.500469971821, 10553.63062292816, 12714.936425317814, 12864.678383040498, 12926.93536532349, 13160.868391316348, 10945.781084378108, 11015.669529914116, 11032.227744057838, 11304.152188585724, 11406.942965285121, 10978.670639880816, 11006.889931100906, 11128.666140015812, 11198.944005279922, 11335.829962550733, 11158.776824463628, 11532.0, 11554.826677599674, 11561.075113991028, 11764.411779411166, 7946.125926148235, 8017.759467215993, 8042.517448953082, 8152.225538573826, 8197.918020819716, 8161.469504482189, 11018.559257629606, 11031.944840275748, 11087.279326843729, 11196.38419886914], "value": 10882.503008285628, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.9805902911457, 1483.5845963130323, 1639.8934069285497, 1821.107657247949, 1870.7568016157907, 8062.153473885245, 8318.70884519042, 8362.289205417539, 8917.821643567126, 8932.419392739468, 8218.835623287545, 8305.83388332233, 8321.500709957392, 8559.743207703763, 8755.1682590154, 2380.119355838338, 2410.192585483865, 2416.359664688859, 2417.371483414316, 2419.1653879411574, 2060.7527096748413, 2396.209250947192, 2434.732179460258, 2441.2554170977933, 2442.5237078769646, 2400.639904014403, 2418.51629674065, 2427.8786060696984, 2434.3670645632174, 2436.378723425533, 2390.4621460171497, 2411.8191135664806, 2414.0464516516054, 2417.395651087228, 2422.87885605719, 2010.4873257319437, 2174.2716190076344, 2238.697775800262, 2404.2426635609727, 2413.3845869303213, 8853.380263381501, 9056.637734490612, 9069.138431848964, 9072.818543629157, 9089.27285817133, 5225.372955245357, 5386.218998245233, 5403.864903377408, 5419.729013549307, 5424.159255315432, 3599.6760291573883, 3624.4200927851416, 3663.139162296858, 3687.4100143976834, 3709.2952339055764, 1083.7128161037253, 1084.5228099636136, 1092.1317552545745, 1099.2854644481072, 1106.2090605217227, 11813.877681620232, 11909.464074116686, 11913.94043029788, 11933.641990740292, 11944.641660750278, 4001.3397789365013, 4162.708610397243, 4735.431748190171, 4788.254095085911, 4949.7772600233075, 10160.4919754012, 10175.84736228957, 10183.032611901857, 10191.133753630877, 10199.796004080024, 5468.863278418072, 5471.5896307777075, 5472.699001554873, 5489.505944465017, 5504.80733174345, 4480.820767169342, 4572.542745725401, 4612.953870461252, 4959.578435832923, 5003.2745251938995, 4005.7396269242404, 4029.8388064477094, 4130.091379896418, 4133.689973251958, 4143.37849322598, 1310.9410076546578, 1330.2949436798513, 1331.227887825059, 1335.1988806715892, 1341.2958196946681, 818.4802650317091, 909.1590278992038, 914.1087439746194, 922.3497434308796, 925.893522244937, 5122.769475373542, 5606.383297837235, 5820.301563812285, 5855.268091488564, 5900.675462849585, 383.5014481174462, 430.26424813568525, 452.988675283114, 456.07872098361787, 462.39657247292604, 3886.358750806142, 3937.330653788863, 3952.8023598819946, 3981.3629819229363, 4053.1488387438967, 9912.801743965081, 10789.136869050457, 10827.0, 10889.346639201514, 11075.05862001739, 10747.623833165802, 10752.892471075345, 10954.726131846768, 11011.61459348919, 11017.1186305097, 8067.878981815277, 8247.257746802816, 8293.585320733939, 8453.746387608382, 8469.11074337198, 5641.971790141023, 5765.077587585966, 5807.651540907559, 5833.4749872511675, 5944.702764861653, 10172.08451239392, 10211.948940255548, 10354.016368444985, 10359.0, 10377.533011014371, 10008.799824003625, 10269.589216431259, 10284.434356110485, 10361.84457233127, 10403.42781147014, 6981.930180698128, 7180.5691658500655, 7446.664900079401, 7636.770896873103, 7792.493487923267, 8204.220599043081, 8321.459105158145, 8415.0, 8417.326613870999, 8424.241818236389, 7418.740344087931, 7501.062367204099, 7653.57905315213, 7706.922930770845, 7736.7678969631, 7279.199288078413, 7451.5901625411125, 7476.289752473506, 7485.70057197706, 7625.351845093007, 6671.232808227116, 7078.301207710216, 7168.56988580666, 7174.461915356474, 7177.031100801325, 4279.893002674958, 4870.561649451566, 4945.876353091202, 4978.979309241525, 5014.598832093351, 4698.130845793539, 4711.293306004127, 4823.059503396944, 4896.510348965075, 4921.778519966539], "value": 4522.334341644282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.75202425610775, 301.5491839699651, 307.1017274472169, 311.9064280715786, 316.20947630922694, 5301.549368303694, 5348.224507446418, 5355.848492574096, 5369.389183245031, 5435.2551961259605, 4291.978540107303, 4570.040291538781, 5170.138750049979, 5197.714125723083, 5203.869903252421, 3322.5846769153854, 3398.0485464069975, 4013.418054382113, 4029.2747305485, 4080.979595102035, 3871.903202419948, 4010.9972506873282, 4086.3053280942313, 4107.630313271805, 4152.356384760367, 3424.366492198951, 3920.7255492115564, 4042.4946881639794, 4049.412835138903, 4070.308047631895, 4026.6376026157495, 4072.7149099563044, 4074.6129117733767, 4091.6931230157707, 4108.301588729923, 2846.985765071182, 3556.270964452281, 3559.519464872235, 3564.8395822188063, 3570.2505772171708, 4889.119958407486, 5062.2406639004075, 5201.843944681666, 5231.2937753403185, 5260.947390526084, 4075.32757095079, 4678.555537223959, 4705.282826567008, 4718.245080787057, 4733.479317275097, 4499.437570303712, 5628.493435590775, 5669.971650141764, 5689.573282003867, 5699.487046165865, 3803.5435747710453, 3966.6628336591425, 3972.8609498667406, 3986.4817573715522, 3987.4218238355274, 4883.804647814119, 5130.589552835801, 5918.674472904032, 5985.25184351956, 5993.340732519463, 3365.6466071062678, 4000.259951908848, 4005.0, 4028.267844826694, 4058.3303754880703, 3619.7466177367332, 4087.162131763041, 4092.836286548564, 4106.967051309561, 4109.486314210723, 3858.7877666728036, 4513.345564893072, 4555.496686093581, 4684.789184486638, 4693.812247510062, 4980.0, 5152.819651312186, 5366.838994830161, 5613.438656134435, 5640.379558248589, 1136.9488373023069, 1365.283226306197, 1386.654944703636, 1396.8672976067257, 1400.1948879394185, 715.1418298042266, 797.2505844506146, 862.9611667474978, 879.0198928195144, 913.9124441914101, 4372.759498227564, 5357.330333708286, 5360.624756267024, 5371.435999220103, 5410.864728381822, 4556.243472699036, 5735.541156707537, 5759.308882934075, 5789.45000224978, 5792.478676919098, 4520.751358675305, 5151.278820965068, 5281.102212623863, 5282.577393808486, 5355.705436201047, 2428.3807629054477, 2926.6488021437563, 3003.819770813758, 3007.7593792496546, 3010.71398217169, 4838.0, 5254.737263136904, 5459.890802183934, 5672.688002159921, 5937.228160339128, 5814.767409303665, 5818.563607729353, 5823.883522329615, 5827.475527202488, 5840.1531777892815, 5847.2869727722355, 5864.501517371071, 5918.3489816121055, 5919.260092488439, 5938.732757025944, 4743.9525604744895, 5433.239346491573, 5658.20785090096, 5703.861052105461, 5720.8283751487525, 4899.877503062309, 4908.386451693538, 5500.4499550044675, 5575.4424557543925, 5575.832725018256, 5147.0, 5527.364353099445, 5832.970835145967, 5856.970715146397, 5861.912071319019, 3908.065507573769, 3919.2749341371937, 3927.8821635350987, 3956.327424337812, 3965.4250133731025, 4992.700437973734, 5146.24324243312, 5331.333583302087, 5635.351934527582, 5656.446560518822, 4374.834456943706, 4885.0, 5559.388467268678, 5559.749811258423, 5579.74891129892, 5137.919142747193, 5463.890722185613, 5512.669239845462, 5521.337439507124, 5537.916931246115, 4888.804447822047, 5015.993602559006, 5149.356330458692, 5395.271638328933, 5445.646033007842, 5094.821681241138, 5189.714565698923, 5410.296661433988, 5672.432756724294, 5672.858178545569, 4461.442319710036, 5516.503514683698, 5530.806421775219, 5534.754680197085, 5535.667859928256], "value": 4066.7259144033246, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.9649112296045, 754.8905408715734, 763.2710761223033, 772.7140957845598, 780.2743448592806, 13641.317934103292, 16607.66784664306, 16614.833851661464, 16620.418285360014, 16689.33242670295, 14673.972821902471, 14856.925715371435, 14999.100053996768, 15148.924255378708, 15179.241037948113, 665.3213722003553, 684.3737979748524, 686.9793906182822, 818.3575892924056, 821.137805304428, 740.6111791309552, 840.0675250471971, 854.9957250213771, 855.2601999270648, 858.3262139220712, 860.9698660546882, 904.0688091266006, 905.4386280506062, 906.8549032154857, 908.4095338030301, 695.4123765418213, 715.8460930899881, 901.9007909130023, 904.430208968349, 905.3255324783013, 553.510143522981, 640.6444423345042, 652.282489261813, 654.9738010479575, 663.0683889135772, 15456.768148477782, 15551.30019149141, 15551.766723499157, 15563.299651515708, 15589.220538973006, 13993.230372329517, 14215.786763198457, 14233.217173055478, 14293.57119286423, 14304.356303966346, 12507.312097834616, 13051.347432628425, 13096.86903130966, 13106.148100373444, 13523.932380338134, 4481.484629267611, 4496.3705081288645, 4553.817847286105, 4555.339475775994, 4653.0, 111874.44062779716, 114138.28792568119, 114411.42794286058, 114910.0, 123255.3837230817, 11253.549858005752, 11313.83029254562, 11385.886141138648, 11883.702907427383, 11884.584039558575, 22706.659400109012, 22877.656835147485, 22923.0, 22935.655965160535, 22938.885305573367, 7966.888774474769, 8001.519908805491, 8038.557879316577, 8131.79670508242, 8147.348212143014, 4129.236091323115, 4174.165166966619, 4383.189110014658, 4457.175422546839, 4458.130664520388, 3501.142220156078, 3701.3892707702926, 3712.461693054492, 3713.3872910969926, 3718.3307004738867, 656.967151642416, 661.9304972977768, 665.2216906219638, 666.7732970789955, 673.2190658835727, 587.9706014699248, 609.2049874913192, 617.8949578571653, 624.725120946782, 641.8908785506475, 8923.910760892439, 9007.549622518847, 9095.363324567217, 9231.123043310874, 9407.717768466957, 481.1891962043967, 549.6235078970918, 587.6885250817073, 609.2719200555382, 623.7754408412968, 3208.903732888017, 4292.699511034198, 4541.931871021938, 4574.45106587205, 4579.95420045802, 98696.50651746696, 104525.0, 156799.0, 164560.17719911324, 172594.0, 96484.0, 121336.78663213432, 133597.33201334125, 138686.0, 147614.52385476007, 115345.26982095276, 122093.0, 124323.37838310751, 125099.74900251062, 130263.34868325788, 9781.710679553622, 10021.949890250502, 10087.949560252151, 10201.948990255001, 10378.636747714096, 48454.757726212556, 53611.46388536221, 57464.42535574758, 58787.987736065894, 61453.0, 90778.57263337575, 95533.52233238789, 101619.49190254002, 102139.0, 102826.48586757018, 12923.547675831302, 13051.934740326238, 13238.205707657571, 13370.799438008244, 13513.729725405634, 15227.0, 15268.847311526742, 15289.923550382176, 15314.387424502895, 15340.232988350761, 13759.0, 13765.0, 13891.305434728425, 14213.218272995084, 14835.629109272355, 14155.716885662436, 14264.928675356558, 14265.358058887168, 14265.358058887168, 14371.353289101806, 13515.256660883353, 13595.32023398846, 13704.10923289983, 13922.443102275796, 14501.129932204101, 11494.94252528732, 11504.389385486205, 11593.768124637629, 11725.88274117248, 12193.0, 11488.368139752394, 11630.76738465209, 11694.356810375511, 11717.589884354347, 11814.232074915102], "value": 7921.806790219463, "unit": "score"}], "name": "dromaeo_css", "value": 7423.921644445813, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 109.0, 142.0, 109.0, 107.0, 114.0, 133.0, 174.0, 109.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 187.0, 185.0, 183.0, 183.0, 186.0, 185.0, 183.0, 182.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 59.0, 90.0, 63.0, 62.0, 58.0, 58.0, 82.0, 57.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 94.0, 69.0, 68.0, 68.0, 92.0, 67.0, 69.0, 88.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 91.0, 126.0, 88.0, 84.0, 88.0, 86.0, 88.0, 87.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 103.0, 97.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 113.0, 132.0, 71.0, 139.0, 131.0, 133.0, 77.0, 136.0, 131.0], "value": 114.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 53.0, 56.0, 57.0, 58.0, 57.0, 56.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 65.0, 74.0, 73.0, 69.0, 71.0, 69.0, 70.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 100.0, 100.0, 100.0, 76.0, 84.0, 85.0, 86.0, 87.0, 84.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 157.0, 148.0, 148.0, 157.0, 148.0, 148.0, 141.0, 171.0, 138.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 218.0, 226.0, 166.0, 163.0, 162.0, 163.0, 164.0, 162.0, 164.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 64.0, 67.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1474.9, "alertThreshold": 2.0}]} 11:58:31 INFO - Return code: 0 11:58:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:58:31 INFO - # TBPL SUCCESS # 11:58:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:58:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:58:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:58:31 INFO - 2016-11-11 11:58:31.189 screenresolution[2201:12906] starting screenresolution argv=screenresolution get 11:58:31 INFO - 2016-11-11 11:58:31.192 screenresolution[2201:12906] Display 0: 1600x1200x32@60 11:58:31 INFO - 2016-11-11 11:58:31.198 screenresolution[2202:12909] starting screenresolution argv=screenresolution list 11:58:31 INFO - Available Modes on Display 0 11:58:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:58:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:58:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:58:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:58:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:58:31 INFO - Intel Iris: 11:58:31 INFO - Chipset Model: Intel Iris 11:58:31 INFO - Type: GPU 11:58:31 INFO - Bus: Built-In 11:58:31 INFO - VRAM (Dynamic, Max): 1536 MB 11:58:31 INFO - Vendor: Intel (0x8086) 11:58:31 INFO - Device ID: 0x0a2e 11:58:31 INFO - Revision ID: 0x0009 11:58:31 INFO - Displays: 11:58:31 INFO - Display: 11:58:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:58:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:58:31 INFO - Display Serial Number: 1600x1200 60 11:58:31 INFO - Main Display: Yes 11:58:31 INFO - Mirror: Off 11:58:31 INFO - Online: Yes 11:58:31 INFO - Rotation: Supported 11:58:31 INFO - Return code: 0 11:58:31 INFO - Running post-action listener: _resource_record_post_action 11:58:31 INFO - [mozharness: 2016-11-11 19:58:31.432787Z] Finished run-tests step (success) 11:58:31 INFO - Running post-run listener: _resource_record_post_run 11:58:31 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 1077248; Write bytes: 665570304; Read time: 11; Write time: 1911 11:58:31 INFO - TinderboxPrint: CPU usage
53.4% 11:58:31 INFO - TinderboxPrint: I/O read bytes / time
1,077,248 / 11 11:58:31 INFO - TinderboxPrint: I/O write bytes / time
665,570,304 / 1,911 11:58:31 INFO - TinderboxPrint: CPU idle
2,254.3 (46.6%) 11:58:31 INFO - TinderboxPrint: CPU system
970.6 (20.1%) 11:58:31 INFO - TinderboxPrint: CPU user
1,612.7 (33.3%) 11:58:31 INFO - TinderboxPrint: Swap in / out
364,728,320 / 0 11:58:31 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 351822336; Write bytes: 348272640; Read time: 26904; Write time: 639 11:58:31 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 1073152; Write bytes: 297239552; Read time: 10; Write time: 1212 11:58:31 INFO - Running post-run listener: _upload_blobber_files 11:58:31 INFO - Blob upload gear active. 11:58:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:58:31 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 11:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:58:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:58:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:58:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:58:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:32 INFO - (blobuploader) - INFO - Done attempting. 11:58:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:58:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:58:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:33 INFO - (blobuploader) - INFO - Done attempting. 11:58:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:58:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:58:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:36 INFO - (blobuploader) - INFO - Done attempting. 11:58:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:58:36 INFO - Return code: 0 11:58:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:58:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:58:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6f023464acab3caeb86ad04482ba2684b01df3192278741b724869029abec127bfe0c4639edc96ac8231e55f71e917f1cb9a45363322be9d6c40227381fb4ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d3a694c4f8711ac03466580fe661ce08597e0404c1d8eb7db91f4caaef9e58bec3939a52d84cc2135906cc2a84aa5a66a53b49f248b743effb741423e268548", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a48b66bfe680ef2de32787e56a9967e626a224ba5c4ce6de5965a35e58e3b0dfc877601b78e1a15871191cd1ca11a751ac3be35a30634e1da3c193778599ad59"} 11:58:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:58:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:58:36 INFO - Contents: 11:58:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6f023464acab3caeb86ad04482ba2684b01df3192278741b724869029abec127bfe0c4639edc96ac8231e55f71e917f1cb9a45363322be9d6c40227381fb4ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d3a694c4f8711ac03466580fe661ce08597e0404c1d8eb7db91f4caaef9e58bec3939a52d84cc2135906cc2a84aa5a66a53b49f248b743effb741423e268548", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a48b66bfe680ef2de32787e56a9967e626a224ba5c4ce6de5965a35e58e3b0dfc877601b78e1a15871191cd1ca11a751ac3be35a30634e1da3c193778599ad59"} 11:58:36 INFO - Running post-run listener: copy_logs_to_upload_dir 11:58:36 INFO - Copying logs to upload dir... 11:58:36 INFO - mkdir: /builds/slave/test/build/upload/logs 11:58:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.292600 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-11 11:58:36.166701) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 11:58:36.170522) ========= 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.etJUfG2usB/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.7AcKxluLdU/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6f023464acab3caeb86ad04482ba2684b01df3192278741b724869029abec127bfe0c4639edc96ac8231e55f71e917f1cb9a45363322be9d6c40227381fb4ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d3a694c4f8711ac03466580fe661ce08597e0404c1d8eb7db91f4caaef9e58bec3939a52d84cc2135906cc2a84aa5a66a53b49f248b743effb741423e268548", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a48b66bfe680ef2de32787e56a9967e626a224ba5c4ce6de5965a35e58e3b0dfc877601b78e1a15871191cd1ca11a751ac3be35a30634e1da3c193778599ad59"} build_url:https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011012 build_url: 'https://queue.taskcluster.net/v1/task/A3srzVVURsiH7Trg923WJw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6f023464acab3caeb86ad04482ba2684b01df3192278741b724869029abec127bfe0c4639edc96ac8231e55f71e917f1cb9a45363322be9d6c40227381fb4ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d3a694c4f8711ac03466580fe661ce08597e0404c1d8eb7db91f4caaef9e58bec3939a52d84cc2135906cc2a84aa5a66a53b49f248b743effb741423e268548", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a48b66bfe680ef2de32787e56a9967e626a224ba5c4ce6de5965a35e58e3b0dfc877601b78e1a15871191cd1ca11a751ac3be35a30634e1da3c193778599ad59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 11:58:36.203562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 11:58:36.203947) ========= 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.etJUfG2usB/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.7AcKxluLdU/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.005242 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 11:58:36.253189) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 11:58:36.253540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 11:58:36.253917) ========= ========= Total master_lag: 0.18 =========