builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0162 starttime: 1482430554.5 results: success (0) buildid: 20161222080852 builduid: 6f2fc4ef7b3a475fada4c66bbe060880 revision: 4fbf5d14ce92bd45e0c7881dad20a66896402683 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:54.498123) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:54.498581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:54.498861) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:54.667005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:54.667539) ========= 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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-12-22 10:15:54-- 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% 27.5M=0s 2016-12-22 10:15:54 (27.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134527 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:54.962399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:54.962708) ========= 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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.027932 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:55.011616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-22 10:15:55.011976) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4fbf5d14ce92bd45e0c7881dad20a66896402683 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4fbf5d14ce92bd45e0c7881dad20a66896402683 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wDU4N6XBcW/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.1nJBJm7mV8/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-12-22 10:15:55,106 truncating revision to first 12 chars 2016-12-22 10:15:55,106 Setting DEBUG logging. 2016-12-22 10:15:55,106 attempt 1/10 2016-12-22 10:15:55,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4fbf5d14ce92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 10:15:55,801 unpacking tar archive at: mozilla-beta-4fbf5d14ce92/testing/mozharness/ program finished with exit code 0 elapsedTime=0.983214 ========= master_lag: 2.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-22 10:15:58.541639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:58.541900) ========= script_repo_revision: 4fbf5d14ce92bd45e0c7881dad20a66896402683 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:58.542251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:58.542507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 10:15:59.022566) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-12-22 10:15:59.022965) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wDU4N6XBcW/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.1nJBJm7mV8/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:15:59 INFO - MultiFileLogger online at 20161222 10:15:59 in /builds/slave/test 10:15:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:15:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:59 INFO - {'append_to_log': False, 10:15:59 INFO - 'base_work_dir': '/builds/slave/test', 10:15:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:15:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:59 INFO - 'branch': 'Mozilla-Beta', 10:15:59 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:59 INFO - 'config_files': ('talos/mac_config.py',), 10:15:59 INFO - 'default_actions': ('clobber', 10:15:59 INFO - 'read-buildbot-config', 10:15:59 INFO - 'download-and-extract', 10:15:59 INFO - 'populate-webroot', 10:15:59 INFO - 'create-virtualenv', 10:15:59 INFO - 'install', 10:15:59 INFO - 'run-tests'), 10:15:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:59 INFO - 'download_minidump_stackwalk': True, 10:15:59 INFO - 'download_symbols': 'ondemand', 10:15:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:59 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:59 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:59 INFO - 'installer_path': 'installer.exe', 10:15:59 INFO - 'log_level': 'info', 10:15:59 INFO - 'log_name': 'talos', 10:15:59 INFO - 'log_to_console': True, 10:15:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:15:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:15:59 INFO - 'opt_config_files': (), 10:15:59 INFO - 'pip_index': False, 10:15:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:59 INFO - 'cmd': ('bash', 10:15:59 INFO - '-c', 10:15:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:59 INFO - 'enabled': True, 10:15:59 INFO - 'halt_on_failure': False, 10:15:59 INFO - 'name': 'check_screen_resolution'},), 10:15:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:59 INFO - 'cmd': ('bash', 10:15:59 INFO - '-c', 10:15:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:59 INFO - 'enabled': True, 10:15:59 INFO - 'halt_on_failure': False, 10:15:59 INFO - 'name': 'check_screen_resolution'},), 10:15:59 INFO - 'run_cmd_checks_enabled': True, 10:15:59 INFO - 'sps_profile': False, 10:15:59 INFO - 'sps_profile_interval': 0, 10:15:59 INFO - 'suite': 'dromaeojs', 10:15:59 INFO - 'system_bits': '32', 10:15:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:59 INFO - 'title': 't-yosemite-r7-0162', 10:15:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:59 INFO - 'use_talos_json': True, 10:15:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:59 INFO - 'work_dir': 'build'} 10:15:59 INFO - [mozharness: 2016-12-22 18:15:59.226562Z] Running clobber step. 10:15:59 INFO - Running pre-action listener: _resource_record_pre_action 10:15:59 INFO - Running main action method: clobber 10:15:59 INFO - rmtree: /builds/slave/test/build 10:15:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:16:01 INFO - Running post-action listener: _resource_record_post_action 10:16:01 INFO - [mozharness: 2016-12-22 18:16:01.608632Z] Finished clobber step (success) 10:16:01 INFO - [mozharness: 2016-12-22 18:16:01.608783Z] Running read-buildbot-config step. 10:16:01 INFO - Running pre-action listener: _resource_record_pre_action 10:16:01 INFO - Running main action method: read_buildbot_config 10:16:01 INFO - Using buildbot properties: 10:16:01 INFO - { 10:16:01 INFO - "project": "", 10:16:01 INFO - "product": "firefox", 10:16:01 INFO - "script_repo_revision": "production", 10:16:01 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:16:01 INFO - "repository": "", 10:16:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:16:01 INFO - "buildid": "20161222080852", 10:16:01 INFO - "pgo_build": "False", 10:16:01 INFO - "basedir": "/builds/slave/test", 10:16:01 INFO - "buildnumber": 0, 10:16:01 INFO - "slavename": "t-yosemite-r7-0162", 10:16:01 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:16:01 INFO - "platform": "yosemite_r7", 10:16:01 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:16:01 INFO - "branch": "mozilla-beta", 10:16:01 INFO - "repo_path": "releases/mozilla-beta", 10:16:01 INFO - "revision": "4fbf5d14ce92bd45e0c7881dad20a66896402683", 10:16:01 INFO - "stage_platform": "macosx64", 10:16:01 INFO - "builduid": "6f2fc4ef7b3a475fada4c66bbe060880", 10:16:01 INFO - "slavebuilddir": "test" 10:16:01 INFO - } 10:16:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 10:16:01 INFO - Running post-action listener: _resource_record_post_action 10:16:01 INFO - [mozharness: 2016-12-22 18:16:01.612001Z] Finished read-buildbot-config step (success) 10:16:01 INFO - [mozharness: 2016-12-22 18:16:01.612130Z] Running download-and-extract step. 10:16:01 INFO - Running pre-action listener: _resource_record_pre_action 10:16:01 INFO - Running main action method: download_and_extract 10:16:01 INFO - mkdir: /builds/slave/test/build/tests 10:16: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')]} 10:16:01 INFO - trying https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 10:16:01 INFO - Downloading https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 10:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 10:16:02 INFO - Downloaded 1165 bytes. 10:16:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 10:16:02 INFO - Using the following test package requirements: 10:16:02 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 10:16:02 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:16:02 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 10:16:02 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:16:02 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 10:16:02 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:16:02 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:16:02 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 10:16:02 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 10:16:02 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:16:02 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 10:16:02 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:16:02 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 10:16:02 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:16:02 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 10:16:02 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:16:02 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 10:16:02 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 10:16:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 10:16:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 10:16:02 INFO - Fetch https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 10:16:03 INFO - Expected file size: 16232808 10:16:10 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:16:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 10:16:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 10:16:10 INFO - Fetch https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 10:16:10 INFO - Expected file size: 16232808 10:16:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 10:16:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 10:16:17 INFO - Fetch https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 10:16:19 INFO - Expected file size: 14414089 10:16: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')]} 10:16:20 INFO - trying https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 10:16:20 INFO - Downloading https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 10:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 10:16:24 INFO - Downloaded 86034169 bytes. 10:16:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 10:16:24 INFO - mkdir: /builds/slave/test/properties 10:16:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:16:24 INFO - Writing to file /builds/slave/test/properties/build_url 10:16:24 INFO - Contents: 10:16:24 INFO - build_url:https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 10:16:25 INFO - Running post-action listener: _resource_record_post_action 10:16:25 INFO - Running post-action listener: set_extra_try_arguments 10:16:25 INFO - [mozharness: 2016-12-22 18:16:25.952101Z] Finished download-and-extract step (success) 10:16:25 INFO - [mozharness: 2016-12-22 18:16:25.952217Z] Running populate-webroot step. 10:16:25 INFO - Running pre-action listener: _resource_record_pre_action 10:16:25 INFO - Running main action method: populate_webroot 10:16:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:16:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:16:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:16:25 INFO - '--tppagecycles', 10:16:25 INFO - '7'], 10:16:25 INFO - 'tests': ['tsvgm']}}, 10:16:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:16:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:16:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:16:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:16:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:25 INFO - 'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:25 INFO - 'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['damp', 'tps']}, 10:16:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:25 INFO - 'tests': ['damp', 'tps']}, 10:16:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['dromaeo_dom']}, 10:16:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:16:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['basic_compositor_video']}, 10:16:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:16:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['a11yr', 10:16:25 INFO - 'ts_paint', 10:16:25 INFO - 'tpaint', 10:16:25 INFO - 'sessionrestore', 10:16:25 INFO - 'sessionrestore_no_auto_restore', 10:16:25 INFO - 'tabpaint']}, 10:16:25 INFO - 'other-e10s': {'tests': ['a11yr', 10:16:25 INFO - 'ts_paint', 10:16:25 INFO - 'tpaint', 10:16:25 INFO - 'sessionrestore', 10:16:25 INFO - 'sessionrestore_no_auto_restore', 10:16:25 INFO - 'tabpaint']}, 10:16:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:16:25 INFO - 'ts_paint', 10:16:25 INFO - 'tpaint', 10:16:25 INFO - 'sessionrestore', 10:16:25 INFO - 'sessionrestore_no_auto_restore', 10:16:25 INFO - 'tabpaint']}, 10:16:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:16:25 INFO - 'ts_paint', 10:16:25 INFO - 'tpaint', 10:16:25 INFO - 'sessionrestore', 10:16:25 INFO - 'sessionrestore_no_auto_restore', 10:16:25 INFO - 'tabpaint']}, 10:16:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['a11yr', 10:16:25 INFO - 'ts_paint', 10:16:25 INFO - 'tpaint', 10:16:25 INFO - 'sessionrestore', 10:16:25 INFO - 'sessionrestore_no_auto_restore', 10:16:25 INFO - 'tabpaint']}, 10:16:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['a11yr', 10:16:25 INFO - 'ts_paint', 10:16:25 INFO - 'tpaint', 10:16:25 INFO - 'sessionrestore', 10:16:25 INFO - 'sessionrestore_no_auto_restore', 10:16:25 INFO - 'tabpaint']}, 10:16:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['tsvgx', 10:16:25 INFO - 'tsvgr_opacity', 10:16:25 INFO - 'tart', 10:16:25 INFO - 'tscrollx', 10:16:25 INFO - 'cart']}, 10:16:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:16:25 INFO - 'tsvgr_opacity', 10:16:25 INFO - 'tart', 10:16:25 INFO - 'tscrollx', 10:16:25 INFO - 'cart']}, 10:16:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:25 INFO - 'talos_options': ['--disable-e10s'], 10:16:25 INFO - 'tests': ['tp5o']}, 10:16:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:25 INFO - 'tests': ['tp5o']}, 10:16:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:25 INFO - 'talos_options': ['--disable-e10s', 10:16:25 INFO - '--xperf_path', 10:16:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:25 INFO - 'tests': ['tp5n']}, 10:16:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:25 INFO - 'talos_options': ['--xperf_path', 10:16:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:25 INFO - 'tests': ['tp5n']}}, 10:16:25 INFO - 'talos.zip': {'path': '', 10:16:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:16:25 INFO - Running post-action listener: _resource_record_post_action 10:16:25 INFO - [mozharness: 2016-12-22 18:16:25.970927Z] Finished populate-webroot step (success) 10:16:25 INFO - [mozharness: 2016-12-22 18:16:25.971052Z] Running create-virtualenv step. 10:16:25 INFO - Running pre-action listener: _resource_record_pre_action 10:16:25 INFO - Running main action method: create_virtualenv 10:16:25 INFO - Creating virtualenv /builds/slave/test/build/venv 10:16:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:16:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:16:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:16:26 INFO - Using real prefix '/tools/python27' 10:16:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:16:26 INFO - Installing distribute.............................................................................................................................................................................................done. 10:16:29 INFO - Installing pip.................done. 10:16:29 INFO - Return code: 0 10:16:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:16:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:29 INFO - 'HOME': '/Users/cltbld', 10:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:29 INFO - 'LOGNAME': 'cltbld', 10:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:29 INFO - 'MOZ_NO_REMOTE': '1', 10:16:29 INFO - 'NO_EM_RESTART': '1', 10:16:29 INFO - 'PAGER': '/bin/cat', 10:16:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:29 INFO - 'PWD': '/builds/slave/test', 10:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:29 INFO - 'SHELL': '/bin/bash', 10:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:29 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:29 INFO - 'USER': 'cltbld', 10:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:29 INFO - 'XPC_FLAGS': '0x0', 10:16:29 INFO - 'XPC_SERVICE_NAME': '0', 10:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:16:29 INFO - Cleaning up... 10:16:29 INFO - Return code: 0 10:16:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:16:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:29 INFO - 'HOME': '/Users/cltbld', 10:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:29 INFO - 'LOGNAME': 'cltbld', 10:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:29 INFO - 'MOZ_NO_REMOTE': '1', 10:16:29 INFO - 'NO_EM_RESTART': '1', 10:16:29 INFO - 'PAGER': '/bin/cat', 10:16:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:29 INFO - 'PWD': '/builds/slave/test', 10:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:29 INFO - 'SHELL': '/bin/bash', 10:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:29 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:29 INFO - 'USER': 'cltbld', 10:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:29 INFO - 'XPC_FLAGS': '0x0', 10:16:29 INFO - 'XPC_SERVICE_NAME': '0', 10:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:30 INFO - Downloading/unpacking psutil>=3.1.1 10:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:16:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:33 INFO - Installing collected packages: psutil 10:16:33 INFO - Running setup.py install for psutil 10:16:33 INFO - building 'psutil._psutil_osx' extension 10:16:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:16:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:16:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:16:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:16:34 INFO - building 'psutil._psutil_posix' extension 10:16:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:16:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:16:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:16:34 INFO - ^ 10:16:34 INFO - 1 warning generated. 10:16:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:16:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:34 INFO - Successfully installed psutil 10:16:34 INFO - Cleaning up... 10:16:35 INFO - Return code: 0 10:16:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:35 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 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:35 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 10:16:35 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 10:16:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:35 INFO - 'HOME': '/Users/cltbld', 10:16:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:35 INFO - 'LOGNAME': 'cltbld', 10:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:35 INFO - 'MOZ_NO_REMOTE': '1', 10:16:35 INFO - 'NO_EM_RESTART': '1', 10:16:35 INFO - 'PAGER': '/bin/cat', 10:16:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:35 INFO - 'PWD': '/builds/slave/test', 10:16:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:35 INFO - 'SHELL': '/bin/bash', 10:16:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:35 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:35 INFO - 'USER': 'cltbld', 10:16:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:35 INFO - 'XPC_FLAGS': '0x0', 10:16:35 INFO - 'XPC_SERVICE_NAME': '0', 10:16:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:16:37 INFO - Installing collected packages: mozsystemmonitor 10:16:37 INFO - Running setup.py install for mozsystemmonitor 10:16:38 INFO - Successfully installed mozsystemmonitor 10:16:38 INFO - Cleaning up... 10:16:38 INFO - Return code: 0 10:16:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:16:38 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')]} 10:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:38 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')]} 10:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:38 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 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:38 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 10:16:38 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 10:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:38 INFO - 'HOME': '/Users/cltbld', 10:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:38 INFO - 'LOGNAME': 'cltbld', 10:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:38 INFO - 'MOZ_NO_REMOTE': '1', 10:16:38 INFO - 'NO_EM_RESTART': '1', 10:16:38 INFO - 'PAGER': '/bin/cat', 10:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:38 INFO - 'PWD': '/builds/slave/test', 10:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:38 INFO - 'SHELL': '/bin/bash', 10:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:38 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:38 INFO - 'USER': 'cltbld', 10:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:38 INFO - 'XPC_FLAGS': '0x0', 10:16:38 INFO - 'XPC_SERVICE_NAME': '0', 10:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:38 INFO - Downloading/unpacking jsonschema==2.5.1 10:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:41 INFO - warning: no files found matching '*.txt' 10:16:41 INFO - no previously-included directories found matching 'build' 10:16:41 INFO - no previously-included directories found matching 'dist' 10:16:41 INFO - no previously-included directories found matching '.git*' 10:16:41 INFO - Installing collected packages: jsonschema, functools32 10:16:41 INFO - Running setup.py install for functools32 10:16:41 INFO - warning: no files found matching '*.txt' 10:16:41 INFO - no previously-included directories found matching 'build' 10:16:41 INFO - no previously-included directories found matching 'dist' 10:16:41 INFO - no previously-included directories found matching '.git*' 10:16:41 INFO - Successfully installed jsonschema functools32 10:16:41 INFO - Cleaning up... 10:16:41 INFO - Return code: 0 10:16:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:41 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 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:41 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 10:16:41 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 10:16:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:41 INFO - 'HOME': '/Users/cltbld', 10:16:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:41 INFO - 'LOGNAME': 'cltbld', 10:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:41 INFO - 'MOZ_NO_REMOTE': '1', 10:16:41 INFO - 'NO_EM_RESTART': '1', 10:16:41 INFO - 'PAGER': '/bin/cat', 10:16:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:41 INFO - 'PWD': '/builds/slave/test', 10:16:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:41 INFO - 'SHELL': '/bin/bash', 10:16:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:41 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:41 INFO - 'USER': 'cltbld', 10:16:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:41 INFO - 'XPC_FLAGS': '0x0', 10:16:41 INFO - 'XPC_SERVICE_NAME': '0', 10:16:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:16:41 INFO - Cleaning up... 10:16:41 INFO - Return code: 0 10:16:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:16:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:42 INFO - 'HOME': '/Users/cltbld', 10:16:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:42 INFO - 'LOGNAME': 'cltbld', 10:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:42 INFO - 'MOZ_NO_REMOTE': '1', 10:16:42 INFO - 'NO_EM_RESTART': '1', 10:16:42 INFO - 'PAGER': '/bin/cat', 10:16:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:42 INFO - 'PWD': '/builds/slave/test', 10:16:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:42 INFO - 'SHELL': '/bin/bash', 10:16:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:42 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:42 INFO - 'USER': 'cltbld', 10:16:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:42 INFO - 'XPC_FLAGS': '0x0', 10:16:42 INFO - 'XPC_SERVICE_NAME': '0', 10:16:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:16:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:16:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:46 INFO - Downloading docopt-0.6.1.tar.gz 10:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:16:46 INFO - Installing collected packages: blobuploader, requests, docopt 10:16:46 INFO - Running setup.py install for blobuploader 10:16:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:16:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:16:46 INFO - Running setup.py install for requests 10:16:46 INFO - Running setup.py install for docopt 10:16:46 INFO - Successfully installed blobuploader requests docopt 10:16:46 INFO - Cleaning up... 10:16:47 INFO - Return code: 0 10:16:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:47 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 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:16:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:47 INFO - 'HOME': '/Users/cltbld', 10:16:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:47 INFO - 'LOGNAME': 'cltbld', 10:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:47 INFO - 'MOZ_NO_REMOTE': '1', 10:16:47 INFO - 'NO_EM_RESTART': '1', 10:16:47 INFO - 'PAGER': '/bin/cat', 10:16:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:47 INFO - 'PWD': '/builds/slave/test', 10:16:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:47 INFO - 'SHELL': '/bin/bash', 10:16:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:47 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:47 INFO - 'USER': 'cltbld', 10:16:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:47 INFO - 'XPC_FLAGS': '0x0', 10:16:47 INFO - 'XPC_SERVICE_NAME': '0', 10:16:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:47 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-AFZyHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:47 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-8t7Z3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:47 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-mq32Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:47 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-RJXf_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:47 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-bBDWTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:47 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-jddbUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:47 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-aZ0oVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-iUcD0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-tzUkTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-anoFKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-iY5Xak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-YsKhRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-AevRB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-PxNuZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-8OQidz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-1o2Zid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-lWWVqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:16:49 INFO - Running setup.py install for manifestparser 10:16:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:16:49 INFO - Running setup.py install for mozcrash 10:16:49 INFO - Running setup.py install for mozdebug 10:16:49 INFO - Running setup.py install for mozdevice 10:16:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:49 INFO - Running setup.py install for mozfile 10:16:49 INFO - Running setup.py install for mozhttpd 10:16:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:49 INFO - Running setup.py install for mozinfo 10:16:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:50 INFO - Running setup.py install for mozInstall 10:16:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:50 INFO - Running setup.py install for mozleak 10:16:50 INFO - Running setup.py install for mozlog 10:16:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:50 INFO - Running setup.py install for moznetwork 10:16:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:50 INFO - Running setup.py install for mozprocess 10:16:50 INFO - Running setup.py install for mozprofile 10:16:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:51 INFO - Running setup.py install for mozrunner 10:16:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:51 INFO - Running setup.py install for mozscreenshot 10:16:51 INFO - Running setup.py install for moztest 10:16:51 INFO - Running setup.py install for mozversion 10:16:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:51 INFO - Cleaning up... 10:16:51 INFO - Return code: 0 10:16:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:52 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')]} 10:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:52 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 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:16:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:52 INFO - 'HOME': '/Users/cltbld', 10:16:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:52 INFO - 'LOGNAME': 'cltbld', 10:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:52 INFO - 'MOZ_NO_REMOTE': '1', 10:16:52 INFO - 'NO_EM_RESTART': '1', 10:16:52 INFO - 'PAGER': '/bin/cat', 10:16:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:52 INFO - 'PWD': '/builds/slave/test', 10:16:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:52 INFO - 'SHELL': '/bin/bash', 10:16:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:52 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:52 INFO - 'USER': 'cltbld', 10:16:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:52 INFO - 'XPC_FLAGS': '0x0', 10:16:52 INFO - 'XPC_SERVICE_NAME': '0', 10:16:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:52 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-AStiLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:52 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-rrZhSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:52 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Vf7ev3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:52 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-_l0do5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:52 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-lQAmjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:52 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-hq7z3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-J6NpfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-eCWSai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Qj2AWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-z9pov5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:53 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)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-7crmEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-BM8rhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:53 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)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-eHqQxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-YY5aCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:53 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)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-eqWWx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-53Msu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-yElSBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:16:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:57 INFO - Downloading blessings-1.6.tar.gz 10:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:57 INFO - Installing collected packages: blessings 10:16:57 INFO - Running setup.py install for blessings 10:16:57 INFO - Successfully installed blessings 10:16:57 INFO - Cleaning up... 10:16:57 INFO - Return code: 0 10:16:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:57 INFO - Reading from file tmpfile_stdout 10:16:57 INFO - Current package versions: 10:16:57 INFO - blessings == 1.6 10:16:57 INFO - blobuploader == 1.2.4 10:16:57 INFO - docopt == 0.6.1 10:16:57 INFO - functools32 == 3.2.3-2 10:16:57 INFO - jsonschema == 2.5.1 10:16:57 INFO - manifestparser == 1.1 10:16:57 INFO - mozInstall == 1.12 10:16:57 INFO - mozcrash == 0.17 10:16:57 INFO - mozdebug == 0.1 10:16:57 INFO - mozdevice == 0.48 10:16:57 INFO - mozfile == 1.2 10:16:57 INFO - mozhttpd == 0.7 10:16:57 INFO - mozinfo == 0.9 10:16:57 INFO - mozleak == 0.1 10:16:57 INFO - mozlog == 3.4 10:16:57 INFO - moznetwork == 0.27 10:16:57 INFO - mozprocess == 0.23 10:16:57 INFO - mozprofile == 0.28 10:16:57 INFO - mozrunner == 6.12 10:16:57 INFO - mozscreenshot == 0.1 10:16:57 INFO - mozsystemmonitor == 0.3 10:16:57 INFO - moztest == 0.7 10:16:57 INFO - mozversion == 1.4 10:16:57 INFO - psutil == 3.1.1 10:16:57 INFO - requests == 1.2.3 10:16:57 INFO - wsgiref == 0.1.2 10:16:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:57 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 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:16:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:57 INFO - 'HOME': '/Users/cltbld', 10:16:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:57 INFO - 'LOGNAME': 'cltbld', 10:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:57 INFO - 'MOZ_NO_REMOTE': '1', 10:16:57 INFO - 'NO_EM_RESTART': '1', 10:16:57 INFO - 'PAGER': '/bin/cat', 10:16:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:57 INFO - 'PWD': '/builds/slave/test', 10:16:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:57 INFO - 'SHELL': '/bin/bash', 10:16:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:57 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:57 INFO - 'USER': 'cltbld', 10:16:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:57 INFO - 'XPC_FLAGS': '0x0', 10:16:57 INFO - 'XPC_SERVICE_NAME': '0', 10:16:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:16:58 INFO - Cleaning up... 10:16:58 INFO - Return code: 0 10:16:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b702490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b678570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe372c6fe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, '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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16: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', 'jsonschema'] in /builds/slave/test/build 10:16: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 jsonschema 10:16:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:16:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:58 INFO - 'HOME': '/Users/cltbld', 10:16:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:58 INFO - 'LOGNAME': 'cltbld', 10:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:58 INFO - 'MOZ_NO_REMOTE': '1', 10:16:58 INFO - 'NO_EM_RESTART': '1', 10:16:58 INFO - 'PAGER': '/bin/cat', 10:16:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:58 INFO - 'PWD': '/builds/slave/test', 10:16:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:58 INFO - 'SHELL': '/bin/bash', 10:16:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:16:58 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:16:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:58 INFO - 'USER': 'cltbld', 10:16:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:58 INFO - 'XPC_FLAGS': '0x0', 10:16:58 INFO - 'XPC_SERVICE_NAME': '0', 10:16:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:16:58 INFO - Cleaning up... 10:16:58 INFO - Return code: 0 10:16:58 INFO - Running post-action listener: _resource_record_post_action 10:16:58 INFO - Running post-action listener: _start_resource_monitoring 10:16:58 INFO - Starting resource monitoring. 10:16:58 INFO - [mozharness: 2016-12-22 18:16:58.430540Z] Finished create-virtualenv step (success) 10:16:58 INFO - [mozharness: 2016-12-22 18:16:58.431484Z] Running install step. 10:16:58 INFO - Running pre-action listener: _resource_record_pre_action 10:16:58 INFO - Running main action method: install 10:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:58 INFO - Reading from file tmpfile_stdout 10:16:58 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:58 INFO - Reading from file tmpfile_stdout 10:16:58 INFO - Output received: 10:16:58 INFO - Usage: mozinstall [options] installer 10:16:58 INFO - Options: 10:16:58 INFO - -h, --help show this help message and exit 10:16:58 INFO - -d DEST, --destination=DEST 10:16:58 INFO - Directory to install application into. [default: 10:16:58 INFO - "/builds/slave/test"] 10:16:58 INFO - --app=APP Application being installed. [default: firefox] 10:16:58 INFO - mkdir: /builds/slave/test/build/application 10:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:17:20 INFO - Reading from file tmpfile_stdout 10:17:20 INFO - Output received: 10:17:20 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:17:20 INFO - Running post-action listener: _resource_record_post_action 10:17:20 INFO - [mozharness: 2016-12-22 18:17:20.543893Z] Finished install step (success) 10:17:20 INFO - [mozharness: 2016-12-22 18:17:20.544041Z] Running run-tests step. 10:17:20 INFO - Running pre-action listener: _resource_record_pre_action 10:17:20 INFO - Running main action method: run_tests 10:17:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:17:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:17:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:17:20 INFO - 2016-12-22 10:17:20.558 screenresolution[1626:7515] starting screenresolution argv=screenresolution get 10:17:20 INFO - 2016-12-22 10:17:20.561 screenresolution[1626:7515] Display 0: 1600x1200x32@60 10:17:20 INFO - 2016-12-22 10:17:20.567 screenresolution[1627:7517] starting screenresolution argv=screenresolution list 10:17:20 INFO - Available Modes on Display 0 10:17:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:17:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:17:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:17:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:17:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:17:20 INFO - Intel Iris: 10:17:20 INFO - Chipset Model: Intel Iris 10:17:20 INFO - Type: GPU 10:17:20 INFO - Bus: Built-In 10:17:20 INFO - VRAM (Dynamic, Max): 1536 MB 10:17:20 INFO - Vendor: Intel (0x8086) 10:17:20 INFO - Device ID: 0x0a2e 10:17:20 INFO - Revision ID: 0x0009 10:17:20 INFO - Displays: 10:17:20 INFO - Display: 10:17:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:17:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:17:20 INFO - Display Serial Number: 1600x1200 60 10:17:20 INFO - Main Display: Yes 10:17:20 INFO - Mirror: Off 10:17:20 INFO - Online: Yes 10:17:20 INFO - Rotation: Supported 10:17:20 INFO - Return code: 0 10:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:17:20 INFO - Python 2.7.3 10:17:20 INFO - Return code: 0 10:17:20 INFO - grabbing minidump binary from tooltool 10:17: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')]} 10:17:20 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 0x10b516d30>, '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 0x10b37cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:17:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:17:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:17:20 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 10:17:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:17:20 INFO - Return code: 0 10:17:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:17:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:17:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:17:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:17:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDU4N6XBcW/Render', 10:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:20 INFO - 'HOME': '/Users/cltbld', 10:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:20 INFO - 'LOGNAME': 'cltbld', 10:17:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:17:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:20 INFO - 'MOZ_NO_REMOTE': '1', 10:17:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:17:20 INFO - 'NO_EM_RESTART': '1', 10:17:20 INFO - 'PAGER': '/bin/cat', 10:17:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:20 INFO - 'PWD': '/builds/slave/test', 10:17:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:20 INFO - 'SHELL': '/bin/bash', 10:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1nJBJm7mV8/Listeners', 10:17:20 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:20 INFO - 'USER': 'cltbld', 10:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:20 INFO - 'XPC_FLAGS': '0x0', 10:17:20 INFO - 'XPC_SERVICE_NAME': '0', 10:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:17:21 INFO - mozversion application_buildid: 20161222080852 10:17:21 INFO - mozversion application_changeset: 4fbf5d14ce92bd45e0c7881dad20a66896402683 10:17:21 INFO - mozversion application_display_name: Firefox 10:17:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:17:21 INFO - mozversion application_name: Firefox 10:17:21 INFO - mozversion application_remotingname: firefox 10:17:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:17:21 INFO - mozversion application_vendor: Mozilla 10:17:21 INFO - mozversion application_version: 51.0 10:17:21 INFO - mozversion platform_buildid: 20161222080852 10:17:21 INFO - mozversion platform_changeset: 4fbf5d14ce92bd45e0c7881dad20a66896402683 10:17:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:17:21 INFO - mozversion platform_version: 51.0 10:17:21 INFO - using testdate: 1482430641 10:17:21 INFO - actual date: 1482430641 10:17:21 INFO - starting webserver on 'localhost:49241' 10:17:21 INFO - SUITE-START | Running 2 tests 10:17:21 INFO - TEST-START | dromaeo_css 10:17:21 INFO - operating with platform_type : mac_ 10:17:21 INFO - Initialising browser for dromaeo_css test... 10:17:21 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmphbja1g/profile http://localhost:49241/getInfo.html) 10:17:23 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 10:17:23 INFO - PROCESS | 1637 | colorDepth:24 10:17:23 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 10:17:23 INFO - PROCESS | 1637 | __metrics 10:17:23 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:17:23 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:24 INFO - TEST-INFO | 1637: exit 0 10:17:24 INFO - Browser initialized. 10:17:24 INFO - Running cycle 1/1 for dromaeo_css test... 10:17:24 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmphbja1g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:36 INFO - PROCESS | 1640 | RSS: Main: 164286464 10:17:36 INFO - PROCESS | 1640 | 10:18:27 INFO - PROCESS | 1640 | 1482430707017 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:20:38 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 10:20:39 INFO - PROCESS | 1640 | RSS: Main: 296988672 10:20:39 INFO - PROCESS | 1640 | 10:23:42 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 10:23:43 INFO - PROCESS | 1640 | RSS: Main: 301953024 10:23:43 INFO - PROCESS | 1640 | 10:26:45 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 10:26:46 INFO - PROCESS | 1640 | RSS: Main: 275599360 10:26:46 INFO - PROCESS | 1640 | 10:29:48 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:29:49 INFO - PROCESS | 1640 | RSS: Main: 289660928 10:29:49 INFO - PROCESS | 1640 | 10:32:52 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:32:52 INFO - PROCESS | 1640 | RSS: Main: 263188480 10:32:52 INFO - PROCESS | 1640 | 10:35:55 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:35:55 INFO - PROCESS | 1640 | RSS: Main: 307945472 10:35:55 INFO - PROCESS | 1640 | 10:35:55 INFO - PROCESS | 1640 | __start_tp_report 10:35:55 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 10:35:55 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 10:35:55 INFO - PROCESS | 1640 | |i|pagename|runs| 10:35:55 INFO - PROCESS | 1640 | |0;dojo.html;3242.8216448095354;3464.064702530315;3486.0413386318774;3495.1786330212394;3514.7715398499113;5526.668399895999;5767.394423585521;5827.592068555203;5846.181534585151;5873.500752436048;5801.738921748521;5877.147813567041;5894.11588261761;5898.410158984099;5955.523558115351;5218.243354713564;5245.2132180173085;5266.210068489738;5279.524842764151;5311.070562651521;5232.659877107976;5242.239875218091;5254.343207099113;5352.170413585881;5403.189521571776;5273.815416460425;5323.9467605324035;5351.304330437058;5359.7320133993335;5364.356277246736;5286.814961476368;5294.973525132388;5315.654482458628;5340.092184328654;5349.732513374316;5155.278261043457;5263.921041184385;5269.894602107936;5286.920696189522;5294.602904782157;5702.6293290935955;5736.426357364272;5739.311282646067;5896.823095307148;5914.142449344821;6230.96884515579;6236.563440559163;6279.403456671609;6318.71565779541;6328.240611126648;6239.095331176954;6249.312575616678;6257.061440783873;6274.905876411857;6297.464715499188;5723.084306510938;5799.8550036249435;5950.2264705587995;5956.851078723066;5976.641401515923;6182.505399568024;6221.595596286227;6249.78125765596;6271.843203919847;6285.622862628165;6257.4681152102585;6261.123442718023;6275.529335299871;6281.214848143982;6283.622982621057;6142.201513803177;6258.186435763321;6268.529860260499;6271.4669253114;6271.717772700239;6156.784512542129;6181.536384771161;6219.222597175353;6292.370762923671;6315.368463153648;5238.580913526908;6220.813375598739;6278.591891527036;6289.528285378615;6292.307846136921;5037.01778153264;5047.4447810740785;5054.064997975386;5074.441811400743;5091.9236211456855;4491.214037543416;4523.819047238074;4528.366028755977;4550.613197878218;4565.246734288805;5683.346415162309;5737.3688894221605;5741.88516229673;5855.121731740188;5873.295204575478;6202.596831205957;6254.499640028786;6272.8118156455375;6276.6547839869245;6283.214598175228;5841.269841269841;5842.182094506772;5845.947729408662;5864.912026319608;5885;5369.382521010056;5414.40441551429;5467.343918729778;5474.425185355481;5485.17722341644;5303.681779093266;6205.81382558524;6268.216472940882;6274.843128921813;6288.717007734572;6274.560780745304;6275.74897004133;6286.119943207863;6288.151099601495;6295.433410993032;6274.372562743689;6286.119943208046;6289.371062893674;6306.590071645328;6318.304986451579;5194.948050519446;6127.5866022601795;6173.197484327009;6187.071939209155;6191.81424557264;6301.936980630318;6306.747730090929;6307.180066591313;6327.778527751507;6346.9682651586445;6246.406591373812;6261.592996455216;6267.6866156692895;6268.435840774352;6271.153394291712;6048.60684055535;6053.727582258721;6101.481374083252;6177.444030037318;6246.219222597176;5017.874553136201;5957.017092179742;6050.878982420415;6073.423024812636;6124.54065945047;6177.706106034262;6202.658853762906;6209.130721699056;6219.067139929047;6219.595726277777;5952.315483719428;5982.893164764532;5992.8801423972145;6053.727582258721;6094.177286066324 10:35:55 INFO - PROCESS | 1640 | |1;ext.html;513.9254808052832;543.9238506609075;553.0818840724398;559.5775189731752;560.7756897241102;32221;41953.79023104888;43523.56476435235;43648.345274820866;46042.30936535955;45298;45647.08705825882;45689;45710;45922;9251.398659087172;10038.698839034842;10223.233257505679;10228.43743594102;10237.436940968244;9306.953465232698;12293.569725059624;12525.373731313444;12541.811872821914;12752.10735248533;12363.320017399039;12454.377281135952;12460.06549508786;12466.563670271542;12468.563600273992;12465.002799775995;12542;12554.372281385895;12558.434870430761;12589.559365422167;12237.938810305892;12318.199317044364;12323.137380383378;12326.445309961073;12340.691482712915;42731.57268427307;43075.35386969198;43103.35344969828;43135.137297254194;43212.56787432117;3672.889813305605;3738.6822120119823;4061.2486689962157;4092.263392589333;4313.30514698584;32025.83987080073;32034.359312813845;32100.357992840247;32764.344713105842;33058.504122438186;3329.5505106810515;3358.1940334319834;3414.3000684859794;3434.8969530914114;3437.089171369589;525339;525358;526065;526166;529118;66423;66875.66562167255;66947.66526167338;67030.66484667546;67035.65928681496;37007.81496092556;37841.05397365033;37863.24273514514;38909.80545097256;38964.02589935218;17686.29254829818;17902.015389153723;17902.91048544749;17942.91028544875;17954.19206135727;10591.84112238317;12650.746985060247;13575.049746517649;13722.862771372358;13739.656508587364;16534.173291335384;20411.897940510204;20469.692954605394;20871;20882.37352879416;8201.71294004707;8205.302549283379;8211.876821847676;8212.917870821215;8300.916990830014;889.4840992224495;973.8344481438172;975.0590679993699;1025.8461230815287;1150.4995327032768;28292.717072829008;31480.842595786875;31605.367892642018;31887.681123188937;32305.676943230737;941.8478775996814;1050.8003479338902;1140.6977151054978;1183.260462211118;1209.6552482542609;15414;15902.363905443885;15922.681546369007;15945.043297402193;16264.268107935171;592640;598460;599050;599846;600497;60415;61101.69449152815;61132.38867611356;61204.69397652983;61263.774724506155;1289.1105137455127;1328.5217321764158;1382.5022991722772;1408;1427.257825930531;31619.525707113953;32810.17974550655;33015.33969320648;33056.1735956603;33568.66431335655;54319.72840135774;54637;54796;54822;55037.449625504836;579792;580537;582626;849371;865904.7047647466;46943.76528117338;47240.527594723615;47865;48190;48909.309987951005;47251.76374118245;48334.75832620955;51215.487845121075;51744.48255517547;52678.94642107213;40806.79596602117;40977.79511102426;41717.37423938704;42057.158856823306;43429.56570434255;35793.82103089468;41356.58643413527;42038;42543.5745642552;43198.70403887888;40443;41307.7934610325;41469.79265103776;41470.79264603658;41955;34363.65636343604;36155.51099021178;36250.8187459061;36393;36600.45099323459;23068;23257.18599848997;25253.621195681713;26501;27108.72891271062 10:35:55 INFO - PROCESS | 1640 | |2;jquery.html;315.81840441745993;374.18241143102324;385.6586920575291;391.94566615803467;405.4384677222047;20302.984850757457;21845.453863653416;21916.89041554792;22535.09859605616;22566.984485698144;17675.64648707025;21221.469463263387;21442;21580.56838863222;22124.88937555314;5984.850378740544;6062.757489700407;6204.75180992762;6267.341929097447;6285.088662143987;4433.600975912167;4517.887052823673;6157.322694503623;6284.308726040132;6576.967115164418;6791.966040169792;6845.5550389224545;6891.862162756742;6894.379505844473;6910.861782764342;5700.059490184115;6908.1364829396325;6918.238993710688;6927.3419025192525;6941.791746247595;5906.055031195031;5968.641881487125;6024.608400454001;6033.064874944391;6044.214252147237;24130.638040429407;24642.5071498569;25037.749622503725;26009.21972340833;27418.766155523048;2226.7884550967633;2256.5035692147703;2272.1593010586025;2354.846934949223;2487.3905893056135;10134.13859821916;10433.530491127918;10518.842217366746;11684.12369072323;13828.239446830421;1869.3644160985195;1947.8149575790278;1956.7064940258933;2010.1356416740796;2015.506200980769;129429;130004;132704.33647831794;133917.33041334827;134503;11588.94205528967;11651.65045048633;11718.296902185895;11737.589184378507;11845.822312665317;14707.92646036763;14708.338124784197;14709.338079786436;14726.631834204016;14748.778768318483;8679.7193491203;8978.955105224431;9000.8649870252;9071.27429805614;9086;9066.36535442526;9081.137291957253;9085.954570227239;9248.583813728399;9279.814403711887;3707.2400157967554;3707.387286530368;4521.638268938477;4537.160625284267;4616.699914505546;1614.8142963559105;1678.6223099802692;1774.7604073449918;1823.233371894127;1856.4709057918428;875.4047247871381;928.6302703512265;948.5494390164616;985.6057576969126;1039.6621098143135;19314.903425483062;21446.356609301747;22146.44633884166;22335.218267360564;22430.663540046913;943.4245110482738;967;974.8635191073255;977.2084611464736;1058.9886658241362;11479.713007174887;11671.299722016705;11686.94156529212;11687.532498700128;11687.766244675058;578698;579257;584789;585157;589441;127793;129665.35167324291;135940;137208.31395843156;137380;995.0596686131681;999.0409207161207;1003.4781913404988;1014.7361685961703;1018.3737001743874;13942.071186154119;19505.414837554898;20661.380158595268;20662.896685516476;20834.895825520776;57864;58293;58750;59729.31218095109;59878.70060649669;65032;78711;79175;82259.5887020561;82581.3483730334;8211.753647390588;8215;8230.958845205974;8395.160483951557;8457.450265732708;12148.635540933787;13145.868541314847;13176.60470185896;13248.801267980794;13562.79655805144;10465;11591.072714183014;11692.94153529227;11759.47082381312;11844.763104737685;11347.432628368384;11371.943140284246;11407.37259450705;11746.70633234176;11788.941055294668;11460.02589779878;11555.711107222387;11606.593769218036;11868.991135753558;12056.819147712968;7094.290570942864;8098.230668086522;8174.059983102019;8228.177182281963;8346.916530834615;7126.465515086493;10555.788884222118;11410.714732131763;11798.469068892093;11908 10:35:55 INFO - PROCESS | 1640 | |3;mootools.html;1419.886409087273;1533.9693206135878;1722.311075569772;1888.3202047262982;1891.7540719706435;8654.697085602005;9232.6306947722;9235.861462078074;9239.538023098843;9258.490783006931;8090.757277281677;8242.175782421755;8863.91136088639;8909.599068041938;8943.239824614915;2402.4954759500483;2436.7572538005566;2439.0853429963763;2439.097533912446;2439.329184474275;2403.2549909528016;2405.458771776354;2443.5235129149823;2447.2658202539255;2448.5959816630234;2418.117387153694;2423.127674037345;2427.538767634144;2450.2281781238944;2453.6074228123416;2379.4051487128218;2379.4884099918513;2382.845115067515;2387.5821731197057;2412.5054363855365;2385.6540801583674;2399.0883464283634;2399.1483023526744;2399.1722855614785;2399.484110916144;8878.067802880734;9070.954645226797;9092.136247056518;9102.453852768855;9108.952470465914;5243.161094224905;5407.161889907032;5411.756470958777;5412.107002344608;5413.485718856702;3482.582090149173;3598.280343931198;3668.52309199805;3672.669459748609;3689.1883785567134;1086.1310951239057;1118.89929906308;1128.3342827731678;1132.2187690493615;1136.136536232461;11820.349880756556;11844.644660660195;11885.108616853684;11892.762144757144;11918.22531535456;4245.660347172219;4609.262517997105;4759.357486739315;4892.217245240744;4954.355933728592;9869.753256168653;9879.308448408543;9885.406875587487;9888;9917.355371900803;5519.641223320471;5523.861903452445;5525.668459892419;5531.861703457365;5558.194061861008;4608.907821843544;4705.929411058837;4995.125852975715;5045.646804723708;5069.619778516626;3994.8601798936897;4046.078112896351;4100.446439730598;4131.628153466142;4155.148194620096;1300.0964329790893;1304.9543265985835;1308.4242933109592;1317.4335035934448;1318.736252749454;814.6008455856587;915.3135148638521;924.3945215883607;930.2604429478581;933.1321870660352;5638.9436105638415;5721.4278572143285;5782.2194003808945;5842.678652674059;5979.521638268928;467.9883002924954;475.9885243856804;478.9425268967746;1016.517154351677;1041.8697662792151;3517.964820351815;3749.3813520768767;3853.402722578005;3863.96136038636;3899.8245078971513;10917.072048875776;11329.603463878724;11340.319580825177;11345.489452974636;11384.260023098472;9788.608455661693;9864.65473708431;11258;11269.380184089954;11280.984711376015;8520.275776558938;8633.95683021581;8647.962244530696;8649.913500865037;8658.090900455487;5591.944080559142;5644.9435505644415;5750.8849823002465;5827.358990510956;5848.941510584839;10309;10318.48407579633;10446.164306855282;10470.005349491787;10482.37105773656;10167.694969150938;10806;10815.51330190159;10816.513256903301;10835.729106772395;6521.282658907611;6638.966805165944;6642.6014439133805;7272.200057993511;7407.074115735533;8283.668653253802;8391.706290279812;8416.873746893923;8554;8580.184882436159;7509.586972716553;7582.241775822595;7628.771136865903;7667.386609071149;7808.219178082147;6809.93190068093;7249.311315425026;7377.741779037708;7496.512726672749;7665.46341756094;6971.372576468142;7096.680649370687;7110.4667149965;7123.216446191019;7125.429965602636;4875.80496780139;4939.629527785502;4955.108080545537;4961.05739909416;5001.474845141208;4848.248521479177;4934.210526315772;4938.604911606991;5066.569341606005;5125.077486052546 10:35:55 INFO - PROCESS | 1640 | |4;prototype.html;294.9247941774847;300.6092080295615;309.972102510774;317.8807947019867;322.39872637531;4892.510748925106;4992.254260156913;5366.168243922193;5503.945310352753;5557.971775221582;4668.436073915234;4826.203676393391;5306.338626347827;5415.727304083537;5443.401225865152;4168.041350489381;4183.535762483137;4187;4194.496660400756;4203.621674049335;4208.263553878074;4214;4216.198922204787;4225.746455212682;4250.234957707611;3829.7127715421316;4002;4132.152908653718;4138.0482489027545;4194.993201631602;3422.6577342265823;4109.4246805447265;4120.91758164835;4130.545639979599;4146.937795933049;3571.482135090397;3581.552305961755;3586.4261718124976;3588.802615856127;3598.964010359889;4506.954930450719;4977.402711674586;5053.444121146671;5374.838754837361;5423.267858839045;3786.3563194257044;4649.511801260853;4718.834840780591;4720.362751028601;4786.904261914742;4857.951420485821;4894.779734911937;5318.308619879391;5683.431656834325;5739.942600573982;3263.902082937516;3402.081438011723;3809.695224382043;3809.942850857239;3955.8219880105466;5405.621606487547;5528.336599608033;5966.880662386728;5976.402359763989;5988.640681559077;3455.615625218591;3861.0540417597867;3881.941770873439;3995.880123596297;4026.355783074694;4075.5924407559005;4078.9184216315507;4080.6327430531396;4089.672826173899;4115;4300.978495107504;4509.842155524607;4558.407407037064;4738.398816899113;4763.356946812136;5718.056520674042;5757.8044185477465;5764.971175144097;5766.567507436959;5769.884602308014;1350.2236214176887;1370.1092492360478;1372.4853180057478;1381.8341798984186;1390.1797939215912;735.1655870586816;777.8599852026576;790.8339248757825;794.9602519873984;831.4512421801581;4293.355996600472;4441.911731625708;4463.5313292103865;4496.830823985787;4496.842610508682;4039.596440118125;4384.101259241847;4524.321351797257;4838.95161048392;4873.902521949542;3743.9251214975548;4146.564610715892;4397.626201772821;4434.379186913835;4456.554344565518;2150.2366659835848;2213.6458166693574;2318.3160967514286;2467.9136230232216;2606;4474.955250447519;4927.852164435073;4961.925571116436;5070.7464626768515;5101.285819985205;4792.226876055812;4922.901541969212;4923.409190897115;4957.182064959241;5023.598112151019;4710.570532169509;5062.620303477181;5067.391912970394;5071.670341427795;5090.618203634742;4310.814526005373;4464.709793863389;4671.672982891165;4863.756812159449;4900.681455705368;4769.451513076041;4779.880502987453;4788.497207793271;4793.585892161751;4793.616510679207;4309.6983211176175;5394.9460505394445;5398.757055932571;6184.350643182581;6187.81436556904;3698.2788356271344;3727.310447567209;3791.7487229214844;4035.7174997749876;4075.91848163041;4629.421322334708;5212.009718153538;5982.4316689914385;6058.757649693963;6074.757009719562;5414.593905457028;5801.303843538633;5869.038399080689;5886;5902.5277977762535;5860.769238459971;5878.588498805214;5885.911711324419;5892.587518873637;5898.439648233411;4573.742220889282;4999.375078115236;5731.942680573141;5761.559610097475;5764.682942438206;4897.4857639947295;5082.567981721447;5811.738471768696;5823.883522329615;5837.6497410155525;4785.066911952136;5096.337476128079;5678.097837224411;5733.541316694738;5786.594938354443 10:35:55 INFO - PROCESS | 1640 | |5;yui.html;703.5954326262397;759.6885277036414;765.8698021336372;836.9539675317857;846.9491830490175;15496.845031549681;16620.750688739678;16648.500544983654;16703.498895033168;16770.41303554376;14901.850981490183;14990.100593964342;15021;15042.84957150428;15079.54761357161;723.1647447198468;739.4638886807076;741.1995045351008;743.2047708951424;867.6312567158948;736.7973807203008;740.9259074092574;859.8495263328924;892.2594246775193;895.8342706599267;944.8535477001042;955.5174636808403;960.0687333286701;960.0735290444719;961;944.3248077624531;944.3389627260876;945.2579724915943;947.8672985781996;949.1694767078806;710.7015053677417;711.4308553157454;711.590835269722;713.8144082538525;713.9178994415656;15065.774013389808;15114.244287785566;15119.31963061654;15134.924325378413;15143.848561514355;10459.581616735322;14777.157595463023;14920.32858521369;15138.621534461616;15232.847671523254;11656.650300491;11745.177837551375;11977.760444791142;11984.543168650493;12482.251064936132;3376.358491886558;3931.3513270310364;3954.54522729884;4036.4348991141264;4094.877153685394;102803;119958.40020799928;126690;127901.36049319693;131272.68727312796;10632.415217162976;10645.361278323326;10816.188785840935;11184.664460066211;11769.823452648217;21686.915654217228;21993.450163746034;22044.448888777908;22047.559048818934;22060.33818985433;7548.773536793905;7780.94967641655;8000.8799868002025;8103.918960810316;8106.797330066795;4487.214737420938;4619.630429565626;4668.159731248408;4735.076660051257;4744.24092145262;3600.6399360063783;3735.8505659773305;3750.587435382106;3752.981235093807;3762.3039737648623;657.4280376072848;668.7124536449373;672.1832972937904;689.441552342604;690.9136357955256;593.4006653280131;638.396715104222;654.5810681164058;705.7988473285089;709.4714437743913;9276.604672771153;9306.674266400643;9461.574229159703;9518.381305215138;9861.950690246504;568.866316415642;691.6057847027247;704.7322017633267;712.4442934511089;713.4328209073799;4351.6518678505645;4716.740579268105;4719.622430205575;4764.618830493621;4815.951840481621;121901;158858;160898;162977;164147;139724;141205.29397352948;144645.27677361545;145292;148853.51146488395;118219;119157;119715;121403;122155;9025.638974440948;9027.638894444412;9029.051949545203;9090.36367454272;9146;65356.673216633615;66119.00821487777;66788;68200.63598728097;69038;92445;99208.50395747976;105180;108153;109566;11702;11952.46213920393;12167.87832121703;12324.014078873848;12423.937880310541;10910.563577457131;12273.956713679438;13617.04680672383;13952;14094.929525352307;12256.632301030982;12568.308743018855;12827.10210285271;12832.935835320764;12915.095943283879;12562.748745025232;12614.873851261369;12808.935955320163;12925.095243332877;13326.86673133295;11905.226160299553;11928.58249961282;11932.403379831147;11958.521659133885;12102.93948530287;10483.842742358718;11186.384748838567;11285.040771534512;11306.321620702784;11337.489812958273;10787.30012883649;10896.346219226873;10995;11054.778904422028;11080.279781814157 10:35:55 INFO - PROCESS | 1640 | __end_tp_report 10:35:55 INFO - PROCESS | 1640 | __start_cc_report 10:35:55 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1249 10:35:55 INFO - PROCESS | 1640 | __end_cc_report 10:35:55 INFO - PROCESS | 1640 | __startTimestamp1482431755837__endTimestamp 10:35:55 INFO - PROCESS | 1640 | 10:35:55 INFO - PROCESS | 1640 | ------- Summary: start ------- 10:35:55 INFO - PROCESS | 1640 | Number of tests: 6 10:35:55 INFO - PROCESS | 1640 | 10:35:55 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5792.66 Median:5992.88 stddev:624.49 (10.4%) stddev-sans-first:593.51 10:35:55 INFO - PROCESS | 1640 | Values: 3242.8 3464.1 3486.0 3495.2 3514.8 5526.7 5767.4 5827.6 5846.2 5873.5 5801.7 5877.1 5894.1 5898.4 5955.5 5218.2 5245.2 5266.2 5279.5 5311.1 5232.7 5242.2 5254.3 5352.2 5403.2 5273.8 5323.9 5351.3 5359.7 5364.4 5286.8 5295.0 5315.7 5340.1 5349.7 5155.3 5263.9 5269.9 5286.9 5294.6 5702.6 5736.4 5739.3 5896.8 5914.1 6231.0 6236.6 6279.4 6318.7 6328.2 6239.1 6249.3 6257.1 6274.9 6297.5 5723.1 5799.9 5950.2 5956.9 5976.6 6182.5 6221.6 6249.8 6271.8 6285.6 6257.5 6261.1 6275.5 6281.2 6283.6 6142.2 6258.2 6268.5 6271.5 6271.7 6156.8 6181.5 6219.2 6292.4 6315.4 5238.6 6220.8 6278.6 6289.5 6292.3 5037.0 5047.4 5054.1 5074.4 5091.9 4491.2 4523.8 4528.4 4550.6 4565.2 5683.3 5737.4 5741.9 5855.1 5873.3 6202.6 6254.5 6272.8 6276.7 6283.2 5841.3 5842.2 5845.9 5864.9 5885.0 5369.4 5414.4 5467.3 5474.4 5485.2 5303.7 6205.8 6268.2 6274.8 6288.7 6274.6 6275.7 6286.1 6288.2 6295.4 6274.4 6286.1 6289.4 6306.6 6318.3 5194.9 6127.6 6173.2 6187.1 6191.8 6301.9 6306.7 6307.2 6327.8 6347.0 6246.4 6261.6 6267.7 6268.4 6271.2 6048.6 6053.7 6101.5 6177.4 6246.2 5017.9 5957.0 6050.9 6073.4 6124.5 6177.7 6202.7 6209.1 6219.1 6219.6 5952.3 5982.9 5992.9 6053.7 6094.2 10:35:55 INFO - PROCESS | 1640 | 10:35:55 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:74772.64 Median:38386.52 stddev:164230.14 (427.8%) stddev-sans-first:164596.21 10:35:55 INFO - PROCESS | 1640 | Values: 513.9 543.9 553.1 559.6 560.8 32221.0 41953.8 43523.6 43648.3 46042.3 45298.0 45647.1 45689.0 45710.0 45922.0 9251.4 10038.7 10223.2 10228.4 10237.4 9307.0 12293.6 12525.4 12541.8 12752.1 12363.3 12454.4 12460.1 12466.6 12468.6 12465.0 12542.0 12554.4 12558.4 12589.6 12237.9 12318.2 12323.1 12326.4 12340.7 42731.6 43075.4 43103.4 43135.1 43212.6 3672.9 3738.7 4061.2 4092.3 4313.3 32025.8 32034.4 32100.4 32764.3 33058.5 3329.6 3358.2 3414.3 3434.9 3437.1 525339.0 525358.0 526065.0 526166.0 529118.0 66423.0 66875.7 66947.7 67030.7 67035.7 37007.8 37841.1 37863.2 38909.8 38964.0 17686.3 17902.0 17902.9 17942.9 17954.2 10591.8 12650.7 13575.0 13722.9 13739.7 16534.2 20411.9 20469.7 20871.0 20882.4 8201.7 8205.3 8211.9 8212.9 8300.9 889.5 973.8 975.1 1025.8 1150.5 28292.7 31480.8 31605.4 31887.7 32305.7 941.8 1050.8 1140.7 1183.3 1209.7 15414.0 15902.4 15922.7 15945.0 16264.3 592640.0 598460.0 599050.0 599846.0 600497.0 60415.0 61101.7 61132.4 61204.7 61263.8 1289.1 1328.5 1382.5 1408.0 1427.3 31619.5 32810.2 33015.3 33056.2 33568.7 54319.7 54637.0 54796.0 54822.0 55037.4 579792.0 580537.0 582626.0 849371.0 865904.7 46943.8 47240.5 47865.0 48190.0 48909.3 47251.8 48334.8 51215.5 51744.5 52678.9 40806.8 40977.8 41717.4 42057.2 43429.6 35793.8 41356.6 42038.0 42543.6 43198.7 40443.0 41307.8 41469.8 41470.8 41955.0 34363.7 36155.5 36250.8 36393.0 36600.5 23068.0 23257.2 25253.6 26501.0 27108.7 10:35:55 INFO - PROCESS | 1640 | 10:35:55 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:35593.57 Median:12419.57 stddev:98014.67 (789.2%) stddev-sans-first:98253.84 10:35:55 INFO - PROCESS | 1640 | Values: 315.8 374.2 385.7 391.9 405.4 20303.0 21845.5 21916.9 22535.1 22567.0 17675.6 21221.5 21442.0 21580.6 22124.9 5984.9 6062.8 6204.8 6267.3 6285.1 4433.6 4517.9 6157.3 6284.3 6577.0 6792.0 6845.6 6891.9 6894.4 6910.9 5700.1 6908.1 6918.2 6927.3 6941.8 5906.1 5968.6 6024.6 6033.1 6044.2 24130.6 24642.5 25037.7 26009.2 27418.8 2226.8 2256.5 2272.2 2354.8 2487.4 10134.1 10433.5 10518.8 11684.1 13828.2 1869.4 1947.8 1956.7 2010.1 2015.5 129429.0 130004.0 132704.3 133917.3 134503.0 11588.9 11651.7 11718.3 11737.6 11845.8 14707.9 14708.3 14709.3 14726.6 14748.8 8679.7 8979.0 9000.9 9071.3 9086.0 9066.4 9081.1 9086.0 9248.6 9279.8 3707.2 3707.4 4521.6 4537.2 4616.7 1614.8 1678.6 1774.8 1823.2 1856.5 875.4 928.6 948.5 985.6 1039.7 19314.9 21446.4 22146.4 22335.2 22430.7 943.4 967.0 974.9 977.2 1059.0 11479.7 11671.3 11686.9 11687.5 11687.8 578698.0 579257.0 584789.0 585157.0 589441.0 127793.0 129665.4 135940.0 137208.3 137380.0 995.1 999.0 1003.5 1014.7 1018.4 13942.1 19505.4 20661.4 20662.9 20834.9 57864.0 58293.0 58750.0 59729.3 59878.7 65032.0 78711.0 79175.0 82259.6 82581.3 8211.8 8215.0 8231.0 8395.2 8457.5 12148.6 13145.9 13176.6 13248.8 13562.8 10465.0 11591.1 11692.9 11759.5 11844.8 11347.4 11371.9 11407.4 11746.7 11788.9 11460.0 11555.7 11606.6 11869.0 12056.8 7094.3 8098.2 8174.1 8228.2 8346.9 7126.5 10555.8 11410.7 11798.5 11908.0 10:35:55 INFO - PROCESS | 1640 | 10:35:55 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5800.84 Median:4913.21 stddev:3294.37 (67.1%) stddev-sans-first:3287.16 10:35:55 INFO - PROCESS | 1640 | Values: 1419.9 1534.0 1722.3 1888.3 1891.8 8654.7 9232.6 9235.9 9239.5 9258.5 8090.8 8242.2 8863.9 8909.6 8943.2 2402.5 2436.8 2439.1 2439.1 2439.3 2403.3 2405.5 2443.5 2447.3 2448.6 2418.1 2423.1 2427.5 2450.2 2453.6 2379.4 2379.5 2382.8 2387.6 2412.5 2385.7 2399.1 2399.1 2399.2 2399.5 8878.1 9071.0 9092.1 9102.5 9109.0 5243.2 5407.2 5411.8 5412.1 5413.5 3482.6 3598.3 3668.5 3672.7 3689.2 1086.1 1118.9 1128.3 1132.2 1136.1 11820.3 11844.6 11885.1 11892.8 11918.2 4245.7 4609.3 4759.4 4892.2 4954.4 9869.8 9879.3 9885.4 9888.0 9917.4 5519.6 5523.9 5525.7 5531.9 5558.2 4608.9 4705.9 4995.1 5045.6 5069.6 3994.9 4046.1 4100.4 4131.6 4155.1 1300.1 1305.0 1308.4 1317.4 1318.7 814.6 915.3 924.4 930.3 933.1 5638.9 5721.4 5782.2 5842.7 5979.5 468.0 476.0 478.9 1016.5 1041.9 3518.0 3749.4 3853.4 3864.0 3899.8 10917.1 11329.6 11340.3 11345.5 11384.3 9788.6 9864.7 11258.0 11269.4 11281.0 8520.3 8634.0 8648.0 8649.9 8658.1 5591.9 5644.9 5750.9 5827.4 5848.9 10309.0 10318.5 10446.2 10470.0 10482.4 10167.7 10806.0 10815.5 10816.5 10835.7 6521.3 6639.0 6642.6 7272.2 7407.1 8283.7 8391.7 8416.9 8554.0 8580.2 7509.6 7582.2 7628.8 7667.4 7808.2 6809.9 7249.3 7377.7 7496.5 7665.5 6971.4 7096.7 7110.5 7123.2 7125.4 4875.8 4939.6 4955.1 4961.1 5001.5 4848.2 4934.2 4938.6 5066.6 5125.1 10:35:55 INFO - PROCESS | 1640 | 10:35:55 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4394.05 Median:4750.88 stddev:1351.57 (28.4%) stddev-sans-first:1319.88 10:35:55 INFO - PROCESS | 1640 | Values: 294.9 300.6 310.0 317.9 322.4 4892.5 4992.3 5366.2 5503.9 5558.0 4668.4 4826.2 5306.3 5415.7 5443.4 4168.0 4183.5 4187.0 4194.5 4203.6 4208.3 4214.0 4216.2 4225.7 4250.2 3829.7 4002.0 4132.2 4138.0 4195.0 3422.7 4109.4 4120.9 4130.5 4146.9 3571.5 3581.6 3586.4 3588.8 3599.0 4507.0 4977.4 5053.4 5374.8 5423.3 3786.4 4649.5 4718.8 4720.4 4786.9 4858.0 4894.8 5318.3 5683.4 5739.9 3263.9 3402.1 3809.7 3809.9 3955.8 5405.6 5528.3 5966.9 5976.4 5988.6 3455.6 3861.1 3881.9 3995.9 4026.4 4075.6 4078.9 4080.6 4089.7 4115.0 4301.0 4509.8 4558.4 4738.4 4763.4 5718.1 5757.8 5765.0 5766.6 5769.9 1350.2 1370.1 1372.5 1381.8 1390.2 735.2 777.9 790.8 795.0 831.5 4293.4 4441.9 4463.5 4496.8 4496.8 4039.6 4384.1 4524.3 4839.0 4873.9 3743.9 4146.6 4397.6 4434.4 4456.6 2150.2 2213.6 2318.3 2467.9 2606.0 4475.0 4927.9 4961.9 5070.7 5101.3 4792.2 4922.9 4923.4 4957.2 5023.6 4710.6 5062.6 5067.4 5071.7 5090.6 4310.8 4464.7 4671.7 4863.8 4900.7 4769.5 4779.9 4788.5 4793.6 4793.6 4309.7 5394.9 5398.8 6184.4 6187.8 3698.3 3727.3 3791.7 4035.7 4075.9 4629.4 5212.0 5982.4 6058.8 6074.8 5414.6 5801.3 5869.0 5886.0 5902.5 5860.8 5878.6 5885.9 5892.6 5898.4 4573.7 4999.4 5731.9 5761.6 5764.7 4897.5 5082.6 5811.7 5823.9 5837.6 4785.1 5096.3 5678.1 5733.5 5786.6 10:35:55 INFO - PROCESS | 1640 | 10:35:55 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:26395.23 Median:22046.00 stddev:43277.50 (196.3%) stddev-sans-first:43355.91 10:35:55 INFO - PROCESS | 1640 | Values: 703.6 759.7 765.9 837.0 846.9 15496.8 16620.8 16648.5 16703.5 16770.4 14901.9 14990.1 15021.0 15042.8 15079.5 723.2 739.5 741.2 743.2 867.6 736.8 740.9 859.8 892.3 895.8 944.9 955.5 960.1 960.1 961.0 944.3 944.3 945.3 947.9 949.2 710.7 711.4 711.6 713.8 713.9 15065.8 15114.2 15119.3 15134.9 15143.8 10459.6 14777.2 14920.3 15138.6 15232.8 11656.7 11745.2 11977.8 11984.5 12482.3 3376.4 3931.4 3954.5 4036.4 4094.9 102803.0 119958.4 126690.0 127901.4 131272.7 10632.4 10645.4 10816.2 11184.7 11769.8 21686.9 21993.5 22044.4 22047.6 22060.3 7548.8 7780.9 8000.9 8103.9 8106.8 4487.2 4619.6 4668.2 4735.1 4744.2 3600.6 3735.9 3750.6 3753.0 3762.3 657.4 668.7 672.2 689.4 690.9 593.4 638.4 654.6 705.8 709.5 9276.6 9306.7 9461.6 9518.4 9862.0 568.9 691.6 704.7 712.4 713.4 4351.7 4716.7 4719.6 4764.6 4816.0 121901.0 158858.0 160898.0 162977.0 164147.0 139724.0 141205.3 144645.3 145292.0 148853.5 118219.0 119157.0 119715.0 121403.0 122155.0 9025.6 9027.6 9029.1 9090.4 9146.0 65356.7 66119.0 66788.0 68200.6 69038.0 92445.0 99208.5 105180.0 108153.0 109566.0 11702.0 11952.5 12167.9 12324.0 12423.9 10910.6 12274.0 13617.0 13952.0 14094.9 12256.6 12568.3 12827.1 12832.9 12915.1 12562.7 12614.9 12808.9 12925.1 13326.9 11905.2 11928.6 11932.4 11958.5 12102.9 10483.8 11186.4 11285.0 11306.3 11337.5 10787.3 10896.3 10995.0 11054.8 11080.3 10:35:55 INFO - PROCESS | 1640 | -------- Summary: end -------- 10:35:55 INFO - PROCESS | 1640 | 10:35:56 INFO - TEST-INFO | 1640: exit 0 10:35:56 INFO - TEST-OK | dromaeo_css | took 1115271ms 10:35:56 INFO - TEST-START | kraken 10:35:56 INFO - operating with platform_type : mac_ 10:35:56 INFO - Initialising browser for kraken test... 10:35:56 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpzorkfD/profile http://localhost:49241/getInfo.html) 10:35:58 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 10:35:58 INFO - PROCESS | 1651 | colorDepth:24 10:35:58 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 10:35:58 INFO - PROCESS | 1651 | __metrics 10:35:58 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:35:58 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:59 INFO - TEST-INFO | 1651: exit 0 10:35:59 INFO - Browser initialized. 10:35:59 INFO - Running cycle 1/1 for kraken test... 10:35:59 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpzorkfD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:11 INFO - PROCESS | 1653 | RSS: Main: 169148416 10:36:11 INFO - PROCESS | 1653 | 10:36:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:36:14 INFO - PROCESS | 1653 | RSS: Main: 218521600 10:36:14 INFO - PROCESS | 1653 | 10:36:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:36:17 INFO - PROCESS | 1653 | RSS: Main: 232230912 10:36:17 INFO - PROCESS | 1653 | 10:36:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:36:21 INFO - PROCESS | 1653 | RSS: Main: 329355264 10:36:21 INFO - PROCESS | 1653 | 10:36:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:36:24 INFO - PROCESS | 1653 | RSS: Main: 229044224 10:36:24 INFO - PROCESS | 1653 | 10:36:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:36:26 INFO - PROCESS | 1653 | RSS: Main: 229646336 10:36:26 INFO - PROCESS | 1653 | 10:36:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:36:30 INFO - PROCESS | 1653 | RSS: Main: 266588160 10:36:30 INFO - PROCESS | 1653 | 10:36:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:36:33 INFO - PROCESS | 1653 | RSS: Main: 268423168 10:36:33 INFO - PROCESS | 1653 | 10:36:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:36:36 INFO - PROCESS | 1653 | RSS: Main: 268066816 10:36:36 INFO - PROCESS | 1653 | 10:36:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:36:38 INFO - PROCESS | 1653 | RSS: Main: 240517120 10:36:38 INFO - PROCESS | 1653 | 10:36:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:36:41 INFO - PROCESS | 1653 | RSS: Main: 245678080 10:36:41 INFO - PROCESS | 1653 | 10:36:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:36:44 INFO - PROCESS | 1653 | RSS: Main: 250146816 10:36:44 INFO - PROCESS | 1653 | 10:36:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:36:47 INFO - PROCESS | 1653 | RSS: Main: 276905984 10:36:47 INFO - PROCESS | 1653 | 10:36:50 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:51 INFO - PROCESS | 1653 | RSS: Main: 264642560 10:36:51 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:36:53 INFO - PROCESS | 1653 | RSS: Main: 308854784 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | __start_tp_report 10:36:53 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 10:36:53 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 10:36:53 INFO - PROCESS | 1653 | |i|pagename|runs| 10:36:53 INFO - PROCESS | 1653 | |0;ai-astar;115;114;114;113;113;113;114;114;113;113 10:36:53 INFO - PROCESS | 1653 | |1;audio-beat-detection;140;108;135;170;139;114;109;107;129;104 10:36:53 INFO - PROCESS | 1653 | |2;audio-dft;183;184;184;184;181;184;184;183;184;182 10:36:53 INFO - PROCESS | 1653 | |3;audio-fft;81;58;57;89;61;57;58;58;81;57 10:36:53 INFO - PROCESS | 1653 | |4;audio-oscillator;81;70;93;71;68;69;92;69;69;90 10:36:53 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;88;83;120;86;89;86;91;86;89;85 10:36:53 INFO - PROCESS | 1653 | |6;imaging-darkroom;95;95;96;95;96;94;95;96;95;96 10:36:53 INFO - PROCESS | 1653 | |7;imaging-desaturate;84;85;85;85;85;85;84;84;87;84 10:36:53 INFO - PROCESS | 1653 | |8;json-parse-financial;56;52;52;51;55;56;56;55;55;55 10:36:53 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;63;64;75;74;69;69;71;67;67;69 10:36:53 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;85;82;79;84;83;83;81;86;89;100 10:36:53 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;138;124;151;144;136;128;134;136;126;166 10:36:53 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;191;218;216;161;159;158;159;167;210;209 10:36:53 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;66;66;66;66;65;65;63;66;62;63 10:36:53 INFO - PROCESS | 1653 | __end_tp_report 10:36:53 INFO - PROCESS | 1653 | __start_cc_report 10:36:53 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1917 10:36:53 INFO - PROCESS | 1653 | __end_cc_report 10:36:53 INFO - PROCESS | 1653 | __startTimestamp1482431813284__endTimestamp 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | ------- Summary: start ------- 10:36:53 INFO - PROCESS | 1653 | Number of tests: 14 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 10:36:53 INFO - PROCESS | 1653 | Values: 115.0 114.0 114.0 113.0 113.0 113.0 114.0 114.0 113.0 113.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:132.00 stddev:21.06 (16.0%) stddev-sans-first:21.67 10:36:53 INFO - PROCESS | 1653 | Values: 140.0 108.0 135.0 170.0 139.0 114.0 109.0 107.0 129.0 104.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.06 (0.6%) stddev-sans-first:1.12 10:36:53 INFO - PROCESS | 1653 | Values: 183.0 184.0 184.0 184.0 181.0 184.0 184.0 183.0 184.0 182.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.70 Median:59.50 stddev:12.64 (21.2%) stddev-sans-first:12.13 10:36:53 INFO - PROCESS | 1653 | Values: 81.0 58.0 57.0 89.0 61.0 57.0 58.0 58.0 81.0 57.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:76.00 stddev:10.66 (14.0%) stddev-sans-first:11.22 10:36:53 INFO - PROCESS | 1653 | Values: 81.0 70.0 93.0 71.0 68.0 69.0 92.0 69.0 69.0 90.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:87.00 stddev:10.69 (12.3%) stddev-sans-first:11.30 10:36:53 INFO - PROCESS | 1653 | Values: 88.0 83.0 120.0 86.0 89.0 86.0 91.0 86.0 89.0 85.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:36:53 INFO - PROCESS | 1653 | Values: 95.0 95.0 96.0 95.0 96.0 94.0 95.0 96.0 95.0 96.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 10:36:53 INFO - PROCESS | 1653 | Values: 84.0 85.0 85.0 85.0 85.0 85.0 84.0 84.0 87.0 84.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.89 (3.4%) stddev-sans-first:1.90 10:36:53 INFO - PROCESS | 1653 | Values: 56.0 52.0 52.0 51.0 55.0 56.0 56.0 55.0 55.0 55.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:3.85 (5.6%) stddev-sans-first:3.47 10:36:53 INFO - PROCESS | 1653 | Values: 63.0 64.0 75.0 74.0 69.0 69.0 71.0 67.0 67.0 69.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:83.50 stddev:5.88 (7.0%) stddev-sans-first:6.24 10:36:53 INFO - PROCESS | 1653 | Values: 85.0 82.0 79.0 84.0 83.0 83.0 81.0 86.0 89.0 100.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:137.00 stddev:12.70 (9.3%) stddev-sans-first:13.47 10:36:53 INFO - PROCESS | 1653 | Values: 138.0 124.0 151.0 144.0 136.0 128.0 134.0 136.0 126.0 166.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.80 Median:200.00 stddev:26.39 (13.2%) stddev-sans-first:27.89 10:36:53 INFO - PROCESS | 1653 | Values: 191.0 218.0 216.0 161.0 159.0 158.0 159.0 167.0 210.0 209.0 10:36:53 INFO - PROCESS | 1653 | 10:36:53 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:66.00 stddev:1.55 (2.3%) stddev-sans-first:1.58 10:36:53 INFO - PROCESS | 1653 | Values: 66.0 66.0 66.0 66.0 65.0 65.0 63.0 66.0 62.0 63.0 10:36:53 INFO - PROCESS | 1653 | -------- Summary: end -------- 10:36:53 INFO - PROCESS | 1653 | 10:36:54 INFO - TEST-INFO | 1653: exit 0 10:36:54 INFO - TEST-OK | kraken | took 57665ms 10:36:54 INFO - SUITE-END | took 1172s 10:36:54 INFO - Completed test suite (00:19:33) 10:36:54 INFO - javascript benchmark 10:36:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3242.8216448095354, 3464.064702530315, 3486.0413386318774, 3495.1786330212394, 3514.7715398499113, 5526.668399895999, 5767.394423585521, 5827.592068555203, 5846.181534585151, 5873.500752436048, 5801.738921748521, 5877.147813567041, 5894.11588261761, 5898.410158984099, 5955.523558115351, 5218.243354713564, 5245.2132180173085, 5266.210068489738, 5279.524842764151, 5311.070562651521, 5232.659877107976, 5242.239875218091, 5254.343207099113, 5352.170413585881, 5403.189521571776, 5273.815416460425, 5323.9467605324035, 5351.304330437058, 5359.7320133993335, 5364.356277246736, 5286.814961476368, 5294.973525132388, 5315.654482458628, 5340.092184328654, 5349.732513374316, 5155.278261043457, 5263.921041184385, 5269.894602107936, 5286.920696189522, 5294.602904782157, 5702.6293290935955, 5736.426357364272, 5739.311282646067, 5896.823095307148, 5914.142449344821, 6230.96884515579, 6236.563440559163, 6279.403456671609, 6318.71565779541, 6328.240611126648, 6239.095331176954, 6249.312575616678, 6257.061440783873, 6274.905876411857, 6297.464715499188, 5723.084306510938, 5799.8550036249435, 5950.2264705587995, 5956.851078723066, 5976.641401515923, 6182.505399568024, 6221.595596286227, 6249.78125765596, 6271.843203919847, 6285.622862628165, 6257.4681152102585, 6261.123442718023, 6275.529335299871, 6281.214848143982, 6283.622982621057, 6142.201513803177, 6258.186435763321, 6268.529860260499, 6271.4669253114, 6271.717772700239, 6156.784512542129, 6181.536384771161, 6219.222597175353, 6292.370762923671, 6315.368463153648, 5238.580913526908, 6220.813375598739, 6278.591891527036, 6289.528285378615, 6292.307846136921, 5037.01778153264, 5047.4447810740785, 5054.064997975386, 5074.441811400743, 5091.9236211456855, 4491.214037543416, 4523.819047238074, 4528.366028755977, 4550.613197878218, 4565.246734288805, 5683.346415162309, 5737.3688894221605, 5741.88516229673, 5855.121731740188, 5873.295204575478, 6202.596831205957, 6254.499640028786, 6272.8118156455375, 6276.6547839869245, 6283.214598175228, 5841.269841269841, 5842.182094506772, 5845.947729408662, 5864.912026319608, 5885.0, 5369.382521010056, 5414.40441551429, 5467.343918729778, 5474.425185355481, 5485.17722341644, 5303.681779093266, 6205.81382558524, 6268.216472940882, 6274.843128921813, 6288.717007734572, 6274.560780745304, 6275.74897004133, 6286.119943207863, 6288.151099601495, 6295.433410993032, 6274.372562743689, 6286.119943208046, 6289.371062893674, 6306.590071645328, 6318.304986451579, 5194.948050519446, 6127.5866022601795, 6173.197484327009, 6187.071939209155, 6191.81424557264, 6301.936980630318, 6306.747730090929, 6307.180066591313, 6327.778527751507, 6346.9682651586445, 6246.406591373812, 6261.592996455216, 6267.6866156692895, 6268.435840774352, 6271.153394291712, 6048.60684055535, 6053.727582258721, 6101.481374083252, 6177.444030037318, 6246.219222597176, 5017.874553136201, 5957.017092179742, 6050.878982420415, 6073.423024812636, 6124.54065945047, 6177.706106034262, 6202.658853762906, 6209.130721699056, 6219.067139929047, 6219.595726277777, 5952.315483719428, 5982.893164764532, 5992.8801423972145, 6053.727582258721, 6094.177286066324], "value": 5754.860372371845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.9254808052832, 543.9238506609075, 553.0818840724398, 559.5775189731752, 560.7756897241102, 32221.0, 41953.79023104888, 43523.56476435235, 43648.345274820866, 46042.30936535955, 45298.0, 45647.08705825882, 45689.0, 45710.0, 45922.0, 9251.398659087172, 10038.698839034842, 10223.233257505679, 10228.43743594102, 10237.436940968244, 9306.953465232698, 12293.569725059624, 12525.373731313444, 12541.811872821914, 12752.10735248533, 12363.320017399039, 12454.377281135952, 12460.06549508786, 12466.563670271542, 12468.563600273992, 12465.002799775995, 12542.0, 12554.372281385895, 12558.434870430761, 12589.559365422167, 12237.938810305892, 12318.199317044364, 12323.137380383378, 12326.445309961073, 12340.691482712915, 42731.57268427307, 43075.35386969198, 43103.35344969828, 43135.137297254194, 43212.56787432117, 3672.889813305605, 3738.6822120119823, 4061.2486689962157, 4092.263392589333, 4313.30514698584, 32025.83987080073, 32034.359312813845, 32100.357992840247, 32764.344713105842, 33058.504122438186, 3329.5505106810515, 3358.1940334319834, 3414.3000684859794, 3434.8969530914114, 3437.089171369589, 525339.0, 525358.0, 526065.0, 526166.0, 529118.0, 66423.0, 66875.66562167255, 66947.66526167338, 67030.66484667546, 67035.65928681496, 37007.81496092556, 37841.05397365033, 37863.24273514514, 38909.80545097256, 38964.02589935218, 17686.29254829818, 17902.015389153723, 17902.91048544749, 17942.91028544875, 17954.19206135727, 10591.84112238317, 12650.746985060247, 13575.049746517649, 13722.862771372358, 13739.656508587364, 16534.173291335384, 20411.897940510204, 20469.692954605394, 20871.0, 20882.37352879416, 8201.71294004707, 8205.302549283379, 8211.876821847676, 8212.917870821215, 8300.916990830014, 889.4840992224495, 973.8344481438172, 975.0590679993699, 1025.8461230815287, 1150.4995327032768, 28292.717072829008, 31480.842595786875, 31605.367892642018, 31887.681123188937, 32305.676943230737, 941.8478775996814, 1050.8003479338902, 1140.6977151054978, 1183.260462211118, 1209.6552482542609, 15414.0, 15902.363905443885, 15922.681546369007, 15945.043297402193, 16264.268107935171, 592640.0, 598460.0, 599050.0, 599846.0, 600497.0, 60415.0, 61101.69449152815, 61132.38867611356, 61204.69397652983, 61263.774724506155, 1289.1105137455127, 1328.5217321764158, 1382.5022991722772, 1408.0, 1427.257825930531, 31619.525707113953, 32810.17974550655, 33015.33969320648, 33056.1735956603, 33568.66431335655, 54319.72840135774, 54637.0, 54796.0, 54822.0, 55037.449625504836, 579792.0, 580537.0, 582626.0, 849371.0, 865904.7047647466, 46943.76528117338, 47240.527594723615, 47865.0, 48190.0, 48909.309987951005, 47251.76374118245, 48334.75832620955, 51215.487845121075, 51744.48255517547, 52678.94642107213, 40806.79596602117, 40977.79511102426, 41717.37423938704, 42057.158856823306, 43429.56570434255, 35793.82103089468, 41356.58643413527, 42038.0, 42543.5745642552, 43198.70403887888, 40443.0, 41307.7934610325, 41469.79265103776, 41470.79264603658, 41955.0, 34363.65636343604, 36155.51099021178, 36250.8187459061, 36393.0, 36600.45099323459, 23068.0, 23257.18599848997, 25253.621195681713, 26501.0, 27108.72891271062], "value": 21637.54653499985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.81840441745993, 374.18241143102324, 385.6586920575291, 391.94566615803467, 405.4384677222047, 20302.984850757457, 21845.453863653416, 21916.89041554792, 22535.09859605616, 22566.984485698144, 17675.64648707025, 21221.469463263387, 21442.0, 21580.56838863222, 22124.88937555314, 5984.850378740544, 6062.757489700407, 6204.75180992762, 6267.341929097447, 6285.088662143987, 4433.600975912167, 4517.887052823673, 6157.322694503623, 6284.308726040132, 6576.967115164418, 6791.966040169792, 6845.5550389224545, 6891.862162756742, 6894.379505844473, 6910.861782764342, 5700.059490184115, 6908.1364829396325, 6918.238993710688, 6927.3419025192525, 6941.791746247595, 5906.055031195031, 5968.641881487125, 6024.608400454001, 6033.064874944391, 6044.214252147237, 24130.638040429407, 24642.5071498569, 25037.749622503725, 26009.21972340833, 27418.766155523048, 2226.7884550967633, 2256.5035692147703, 2272.1593010586025, 2354.846934949223, 2487.3905893056135, 10134.13859821916, 10433.530491127918, 10518.842217366746, 11684.12369072323, 13828.239446830421, 1869.3644160985195, 1947.8149575790278, 1956.7064940258933, 2010.1356416740796, 2015.506200980769, 129429.0, 130004.0, 132704.33647831794, 133917.33041334827, 134503.0, 11588.94205528967, 11651.65045048633, 11718.296902185895, 11737.589184378507, 11845.822312665317, 14707.92646036763, 14708.338124784197, 14709.338079786436, 14726.631834204016, 14748.778768318483, 8679.7193491203, 8978.955105224431, 9000.8649870252, 9071.27429805614, 9086.0, 9066.36535442526, 9081.137291957253, 9085.954570227239, 9248.583813728399, 9279.814403711887, 3707.2400157967554, 3707.387286530368, 4521.638268938477, 4537.160625284267, 4616.699914505546, 1614.8142963559105, 1678.6223099802692, 1774.7604073449918, 1823.233371894127, 1856.4709057918428, 875.4047247871381, 928.6302703512265, 948.5494390164616, 985.6057576969126, 1039.6621098143135, 19314.903425483062, 21446.356609301747, 22146.44633884166, 22335.218267360564, 22430.663540046913, 943.4245110482738, 967.0, 974.8635191073255, 977.2084611464736, 1058.9886658241362, 11479.713007174887, 11671.299722016705, 11686.94156529212, 11687.532498700128, 11687.766244675058, 578698.0, 579257.0, 584789.0, 585157.0, 589441.0, 127793.0, 129665.35167324291, 135940.0, 137208.31395843156, 137380.0, 995.0596686131681, 999.0409207161207, 1003.4781913404988, 1014.7361685961703, 1018.3737001743874, 13942.071186154119, 19505.414837554898, 20661.380158595268, 20662.896685516476, 20834.895825520776, 57864.0, 58293.0, 58750.0, 59729.31218095109, 59878.70060649669, 65032.0, 78711.0, 79175.0, 82259.5887020561, 82581.3483730334, 8211.753647390588, 8215.0, 8230.958845205974, 8395.160483951557, 8457.450265732708, 12148.635540933787, 13145.868541314847, 13176.60470185896, 13248.801267980794, 13562.79655805144, 10465.0, 11591.072714183014, 11692.94153529227, 11759.47082381312, 11844.763104737685, 11347.432628368384, 11371.943140284246, 11407.37259450705, 11746.70633234176, 11788.941055294668, 11460.02589779878, 11555.711107222387, 11606.593769218036, 11868.991135753558, 12056.819147712968, 7094.290570942864, 8098.230668086522, 8174.059983102019, 8228.177182281963, 8346.916530834615, 7126.465515086493, 10555.788884222118, 11410.714732131763, 11798.469068892093, 11908.0], "value": 9889.509052439496, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.886409087273, 1533.9693206135878, 1722.311075569772, 1888.3202047262982, 1891.7540719706435, 8654.697085602005, 9232.6306947722, 9235.861462078074, 9239.538023098843, 9258.490783006931, 8090.757277281677, 8242.175782421755, 8863.91136088639, 8909.599068041938, 8943.239824614915, 2402.4954759500483, 2436.7572538005566, 2439.0853429963763, 2439.097533912446, 2439.329184474275, 2403.2549909528016, 2405.458771776354, 2443.5235129149823, 2447.2658202539255, 2448.5959816630234, 2418.117387153694, 2423.127674037345, 2427.538767634144, 2450.2281781238944, 2453.6074228123416, 2379.4051487128218, 2379.4884099918513, 2382.845115067515, 2387.5821731197057, 2412.5054363855365, 2385.6540801583674, 2399.0883464283634, 2399.1483023526744, 2399.1722855614785, 2399.484110916144, 8878.067802880734, 9070.954645226797, 9092.136247056518, 9102.453852768855, 9108.952470465914, 5243.161094224905, 5407.161889907032, 5411.756470958777, 5412.107002344608, 5413.485718856702, 3482.582090149173, 3598.280343931198, 3668.52309199805, 3672.669459748609, 3689.1883785567134, 1086.1310951239057, 1118.89929906308, 1128.3342827731678, 1132.2187690493615, 1136.136536232461, 11820.349880756556, 11844.644660660195, 11885.108616853684, 11892.762144757144, 11918.22531535456, 4245.660347172219, 4609.262517997105, 4759.357486739315, 4892.217245240744, 4954.355933728592, 9869.753256168653, 9879.308448408543, 9885.406875587487, 9888.0, 9917.355371900803, 5519.641223320471, 5523.861903452445, 5525.668459892419, 5531.861703457365, 5558.194061861008, 4608.907821843544, 4705.929411058837, 4995.125852975715, 5045.646804723708, 5069.619778516626, 3994.8601798936897, 4046.078112896351, 4100.446439730598, 4131.628153466142, 4155.148194620096, 1300.0964329790893, 1304.9543265985835, 1308.4242933109592, 1317.4335035934448, 1318.736252749454, 814.6008455856587, 915.3135148638521, 924.3945215883607, 930.2604429478581, 933.1321870660352, 5638.9436105638415, 5721.4278572143285, 5782.2194003808945, 5842.678652674059, 5979.521638268928, 467.9883002924954, 475.9885243856804, 478.9425268967746, 1016.517154351677, 1041.8697662792151, 3517.964820351815, 3749.3813520768767, 3853.402722578005, 3863.96136038636, 3899.8245078971513, 10917.072048875776, 11329.603463878724, 11340.319580825177, 11345.489452974636, 11384.260023098472, 9788.608455661693, 9864.65473708431, 11258.0, 11269.380184089954, 11280.984711376015, 8520.275776558938, 8633.95683021581, 8647.962244530696, 8649.913500865037, 8658.090900455487, 5591.944080559142, 5644.9435505644415, 5750.8849823002465, 5827.358990510956, 5848.941510584839, 10309.0, 10318.48407579633, 10446.164306855282, 10470.005349491787, 10482.37105773656, 10167.694969150938, 10806.0, 10815.51330190159, 10816.513256903301, 10835.729106772395, 6521.282658907611, 6638.966805165944, 6642.6014439133805, 7272.200057993511, 7407.074115735533, 8283.668653253802, 8391.706290279812, 8416.873746893923, 8554.0, 8580.184882436159, 7509.586972716553, 7582.241775822595, 7628.771136865903, 7667.386609071149, 7808.219178082147, 6809.93190068093, 7249.311315425026, 7377.741779037708, 7496.512726672749, 7665.46341756094, 6971.372576468142, 7096.680649370687, 7110.4667149965, 7123.216446191019, 7125.429965602636, 4875.80496780139, 4939.629527785502, 4955.108080545537, 4961.05739909416, 5001.474845141208, 4848.248521479177, 4934.210526315772, 4938.604911606991, 5066.569341606005, 5125.077486052546], "value": 4627.245605578763, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.9247941774847, 300.6092080295615, 309.972102510774, 317.8807947019867, 322.39872637531, 4892.510748925106, 4992.254260156913, 5366.168243922193, 5503.945310352753, 5557.971775221582, 4668.436073915234, 4826.203676393391, 5306.338626347827, 5415.727304083537, 5443.401225865152, 4168.041350489381, 4183.535762483137, 4187.0, 4194.496660400756, 4203.621674049335, 4208.263553878074, 4214.0, 4216.198922204787, 4225.746455212682, 4250.234957707611, 3829.7127715421316, 4002.0, 4132.152908653718, 4138.0482489027545, 4194.993201631602, 3422.6577342265823, 4109.4246805447265, 4120.91758164835, 4130.545639979599, 4146.937795933049, 3571.482135090397, 3581.552305961755, 3586.4261718124976, 3588.802615856127, 3598.964010359889, 4506.954930450719, 4977.402711674586, 5053.444121146671, 5374.838754837361, 5423.267858839045, 3786.3563194257044, 4649.511801260853, 4718.834840780591, 4720.362751028601, 4786.904261914742, 4857.951420485821, 4894.779734911937, 5318.308619879391, 5683.431656834325, 5739.942600573982, 3263.902082937516, 3402.081438011723, 3809.695224382043, 3809.942850857239, 3955.8219880105466, 5405.621606487547, 5528.336599608033, 5966.880662386728, 5976.402359763989, 5988.640681559077, 3455.615625218591, 3861.0540417597867, 3881.941770873439, 3995.880123596297, 4026.355783074694, 4075.5924407559005, 4078.9184216315507, 4080.6327430531396, 4089.672826173899, 4115.0, 4300.978495107504, 4509.842155524607, 4558.407407037064, 4738.398816899113, 4763.356946812136, 5718.056520674042, 5757.8044185477465, 5764.971175144097, 5766.567507436959, 5769.884602308014, 1350.2236214176887, 1370.1092492360478, 1372.4853180057478, 1381.8341798984186, 1390.1797939215912, 735.1655870586816, 777.8599852026576, 790.8339248757825, 794.9602519873984, 831.4512421801581, 4293.355996600472, 4441.911731625708, 4463.5313292103865, 4496.830823985787, 4496.842610508682, 4039.596440118125, 4384.101259241847, 4524.321351797257, 4838.95161048392, 4873.902521949542, 3743.9251214975548, 4146.564610715892, 4397.626201772821, 4434.379186913835, 4456.554344565518, 2150.2366659835848, 2213.6458166693574, 2318.3160967514286, 2467.9136230232216, 2606.0, 4474.955250447519, 4927.852164435073, 4961.925571116436, 5070.7464626768515, 5101.285819985205, 4792.226876055812, 4922.901541969212, 4923.409190897115, 4957.182064959241, 5023.598112151019, 4710.570532169509, 5062.620303477181, 5067.391912970394, 5071.670341427795, 5090.618203634742, 4310.814526005373, 4464.709793863389, 4671.672982891165, 4863.756812159449, 4900.681455705368, 4769.451513076041, 4779.880502987453, 4788.497207793271, 4793.585892161751, 4793.616510679207, 4309.6983211176175, 5394.9460505394445, 5398.757055932571, 6184.350643182581, 6187.81436556904, 3698.2788356271344, 3727.310447567209, 3791.7487229214844, 4035.7174997749876, 4075.91848163041, 4629.421322334708, 5212.009718153538, 5982.4316689914385, 6058.757649693963, 6074.757009719562, 5414.593905457028, 5801.303843538633, 5869.038399080689, 5886.0, 5902.5277977762535, 5860.769238459971, 5878.588498805214, 5885.911711324419, 5892.587518873637, 5898.439648233411, 4573.742220889282, 4999.375078115236, 5731.942680573141, 5761.559610097475, 5764.682942438206, 4897.4857639947295, 5082.567981721447, 5811.738471768696, 5823.883522329615, 5837.6497410155525, 4785.066911952136, 5096.337476128079, 5678.097837224411, 5733.541316694738, 5786.594938354443], "value": 3963.85957905204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.5954326262397, 759.6885277036414, 765.8698021336372, 836.9539675317857, 846.9491830490175, 15496.845031549681, 16620.750688739678, 16648.500544983654, 16703.498895033168, 16770.41303554376, 14901.850981490183, 14990.100593964342, 15021.0, 15042.84957150428, 15079.54761357161, 723.1647447198468, 739.4638886807076, 741.1995045351008, 743.2047708951424, 867.6312567158948, 736.7973807203008, 740.9259074092574, 859.8495263328924, 892.2594246775193, 895.8342706599267, 944.8535477001042, 955.5174636808403, 960.0687333286701, 960.0735290444719, 961.0, 944.3248077624531, 944.3389627260876, 945.2579724915943, 947.8672985781996, 949.1694767078806, 710.7015053677417, 711.4308553157454, 711.590835269722, 713.8144082538525, 713.9178994415656, 15065.774013389808, 15114.244287785566, 15119.31963061654, 15134.924325378413, 15143.848561514355, 10459.581616735322, 14777.157595463023, 14920.32858521369, 15138.621534461616, 15232.847671523254, 11656.650300491, 11745.177837551375, 11977.760444791142, 11984.543168650493, 12482.251064936132, 3376.358491886558, 3931.3513270310364, 3954.54522729884, 4036.4348991141264, 4094.877153685394, 102803.0, 119958.40020799928, 126690.0, 127901.36049319693, 131272.68727312796, 10632.415217162976, 10645.361278323326, 10816.188785840935, 11184.664460066211, 11769.823452648217, 21686.915654217228, 21993.450163746034, 22044.448888777908, 22047.559048818934, 22060.33818985433, 7548.773536793905, 7780.94967641655, 8000.8799868002025, 8103.918960810316, 8106.797330066795, 4487.214737420938, 4619.630429565626, 4668.159731248408, 4735.076660051257, 4744.24092145262, 3600.6399360063783, 3735.8505659773305, 3750.587435382106, 3752.981235093807, 3762.3039737648623, 657.4280376072848, 668.7124536449373, 672.1832972937904, 689.441552342604, 690.9136357955256, 593.4006653280131, 638.396715104222, 654.5810681164058, 705.7988473285089, 709.4714437743913, 9276.604672771153, 9306.674266400643, 9461.574229159703, 9518.381305215138, 9861.950690246504, 568.866316415642, 691.6057847027247, 704.7322017633267, 712.4442934511089, 713.4328209073799, 4351.6518678505645, 4716.740579268105, 4719.622430205575, 4764.618830493621, 4815.951840481621, 121901.0, 158858.0, 160898.0, 162977.0, 164147.0, 139724.0, 141205.29397352948, 144645.27677361545, 145292.0, 148853.51146488395, 118219.0, 119157.0, 119715.0, 121403.0, 122155.0, 9025.638974440948, 9027.638894444412, 9029.051949545203, 9090.36367454272, 9146.0, 65356.673216633615, 66119.00821487777, 66788.0, 68200.63598728097, 69038.0, 92445.0, 99208.50395747976, 105180.0, 108153.0, 109566.0, 11702.0, 11952.46213920393, 12167.87832121703, 12324.014078873848, 12423.937880310541, 10910.563577457131, 12273.956713679438, 13617.04680672383, 13952.0, 14094.929525352307, 12256.632301030982, 12568.308743018855, 12827.10210285271, 12832.935835320764, 12915.095943283879, 12562.748745025232, 12614.873851261369, 12808.935955320163, 12925.095243332877, 13326.86673133295, 11905.226160299553, 11928.58249961282, 11932.403379831147, 11958.521659133885, 12102.93948530287, 10483.842742358718, 11186.384748838567, 11285.040771534512, 11306.321620702784, 11337.489812958273, 10787.30012883649, 10896.346219226873, 10995.0, 11054.778904422028, 11080.279781814157], "value": 7953.444827821737, "unit": "score"}], "name": "dromaeo_css", "value": 7511.800281407507, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 108.0, 135.0, 170.0, 139.0, 114.0, 109.0, 107.0, 129.0, 104.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 184.0, 184.0, 181.0, 184.0, 184.0, 183.0, 184.0, 182.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 57.0, 89.0, 61.0, 57.0, 58.0, 58.0, 81.0, 57.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 93.0, 71.0, 68.0, 69.0, 92.0, 69.0, 69.0, 90.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 120.0, 86.0, 89.0, 86.0, 91.0, 86.0, 89.0, 85.0], "value": 90.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 87.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 52.0, 51.0, 55.0, 56.0, 56.0, 55.0, 55.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 75.0, 74.0, 69.0, 69.0, 71.0, 67.0, 67.0, 69.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 79.0, 84.0, 83.0, 83.0, 81.0, 86.0, 89.0, 100.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 124.0, 151.0, 144.0, 136.0, 128.0, 134.0, 136.0, 126.0, 166.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 218.0, 216.0, 161.0, 159.0, 158.0, 159.0, 167.0, 210.0, 209.0], "value": 184.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 63.0, 66.0, 62.0, 63.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1431.8999999999996, "alertThreshold": 2.0}]} 10:36:54 INFO - Return code: 0 10:36:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:36:54 INFO - # TBPL SUCCESS # 10:36:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:36:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:36:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:36:54 INFO - 2016-12-22 10:36:54.612 screenresolution[1657:9912] starting screenresolution argv=screenresolution get 10:36:54 INFO - 2016-12-22 10:36:54.615 screenresolution[1657:9912] Display 0: 1600x1200x32@60 10:36:54 INFO - 2016-12-22 10:36:54.621 screenresolution[1658:9915] starting screenresolution argv=screenresolution list 10:36:54 INFO - Available Modes on Display 0 10:36:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:36:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:36:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:36:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:36:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:36:54 INFO - Intel Iris: 10:36:54 INFO - Chipset Model: Intel Iris 10:36:54 INFO - Type: GPU 10:36:54 INFO - Bus: Built-In 10:36:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:36:54 INFO - Vendor: Intel (0x8086) 10:36:54 INFO - Device ID: 0x0a2e 10:36:54 INFO - Revision ID: 0x0009 10:36:54 INFO - Displays: 10:36:54 INFO - Display: 10:36:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:36:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:36:54 INFO - Display Serial Number: 1600x1200 60 10:36:54 INFO - Main Display: Yes 10:36:54 INFO - Mirror: Off 10:36:54 INFO - Online: Yes 10:36:54 INFO - Rotation: Supported 10:36:54 INFO - Return code: 0 10:36:54 INFO - Running post-action listener: _resource_record_post_action 10:36:54 INFO - [mozharness: 2016-12-22 18:36:54.855678Z] Finished run-tests step (success) 10:36:54 INFO - Running post-run listener: _resource_record_post_run 10:36:54 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 38450176; Write bytes: 492884480; Read time: 382; Write time: 2013 10:36:54 INFO - TinderboxPrint: CPU usage
53.7% 10:36:54 INFO - TinderboxPrint: I/O read bytes / time
38,450,176 / 382 10:36:54 INFO - TinderboxPrint: I/O write bytes / time
492,884,480 / 2,013 10:36:54 INFO - TinderboxPrint: CPU idle
2,213.0 (46.3%) 10:36:54 INFO - TinderboxPrint: CPU system
962.3 (20.1%) 10:36:54 INFO - TinderboxPrint: CPU user
1,606.2 (33.6%) 10:36:54 INFO - TinderboxPrint: Swap in / out
233,922,560 / 0 10:36:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196037120; Write bytes: 195747840; Read time: 17961; Write time: 368 10:36:54 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 34481152; Write bytes: 295625216; Read time: 349; Write time: 1639 10:36:55 INFO - Running post-run listener: _upload_blobber_files 10:36:55 INFO - Blob upload gear active. 10:36:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:36:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:36:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:36:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:36:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:56 INFO - (blobuploader) - INFO - Done attempting. 10:36:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:36:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:36:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:57 INFO - (blobuploader) - INFO - Done attempting. 10:36:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:36:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:36:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:59 INFO - (blobuploader) - INFO - Done attempting. 10:36:59 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:59 INFO - Return code: 0 10:36:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/774c8261a915ba5cbb0aa38934f69801a560a0c5e58f32e5d4e1955c7f3dc0a2a16c21af4d4444ecf904514efbc250676522b93e4c1afbb6579723b7521eab74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cf5fc4f89f0cafacdb4a4a7b7500228e92ce334f52306d1cc98fb5869a1bbb7bc56038880a653c4dd3c94e1f46248b236c17bbf1acc3266ccac570c1b0ab898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d194c20753614a73157d82958cc7989ecf05453ac67882f8a4fd487812f4bf3538672ed527b790101e6ecd5f6b5048a0ff57c36bb42b88152da354f425446a8b"} 10:36:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:59 INFO - Contents: 10:36:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/774c8261a915ba5cbb0aa38934f69801a560a0c5e58f32e5d4e1955c7f3dc0a2a16c21af4d4444ecf904514efbc250676522b93e4c1afbb6579723b7521eab74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cf5fc4f89f0cafacdb4a4a7b7500228e92ce334f52306d1cc98fb5869a1bbb7bc56038880a653c4dd3c94e1f46248b236c17bbf1acc3266ccac570c1b0ab898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d194c20753614a73157d82958cc7989ecf05453ac67882f8a4fd487812f4bf3538672ed527b790101e6ecd5f6b5048a0ff57c36bb42b88152da354f425446a8b"} 10:36:59 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:59 INFO - Copying logs to upload dir... 10:36:59 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.896083 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-12-22 10:36:59.958874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 10:36:59.962311) ========= 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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/774c8261a915ba5cbb0aa38934f69801a560a0c5e58f32e5d4e1955c7f3dc0a2a16c21af4d4444ecf904514efbc250676522b93e4c1afbb6579723b7521eab74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cf5fc4f89f0cafacdb4a4a7b7500228e92ce334f52306d1cc98fb5869a1bbb7bc56038880a653c4dd3c94e1f46248b236c17bbf1acc3266ccac570c1b0ab898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d194c20753614a73157d82958cc7989ecf05453ac67882f8a4fd487812f4bf3538672ed527b790101e6ecd5f6b5048a0ff57c36bb42b88152da354f425446a8b"} build_url:https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/QQnzv33IQdaHEF2clEPMRw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/774c8261a915ba5cbb0aa38934f69801a560a0c5e58f32e5d4e1955c7f3dc0a2a16c21af4d4444ecf904514efbc250676522b93e4c1afbb6579723b7521eab74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cf5fc4f89f0cafacdb4a4a7b7500228e92ce334f52306d1cc98fb5869a1bbb7bc56038880a653c4dd3c94e1f46248b236c17bbf1acc3266ccac570c1b0ab898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d194c20753614a73157d82958cc7989ecf05453ac67882f8a4fd487812f4bf3538672ed527b790101e6ecd5f6b5048a0ff57c36bb42b88152da354f425446a8b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 10:36:59.995520) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:36:59.995832) ========= 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.wDU4N6XBcW/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.1nJBJm7mV8/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005463 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:37:00.045141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 10:37:00.045465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 10:37:00.045780) ========= ========= Total master_lag: 2.83 =========