builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0340 starttime: 1477686052.36 results: success (0) buildid: 20161028121858 builduid: 2a4e3c6a8d48420f8fd722d724bc11e8 revision: 353c47fc71ccff8b243c66df027350fe30dbce61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:52.358933) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:52.359372) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:52.359659) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:52.384332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:52.384626) ========= 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.SJeQAmoOzy/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.LGLsz0f458/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-10-28 13:20:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 57.5M=0s 2016-10-28 13:20:52 (57.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:52.531531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:52.531847) ========= 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.SJeQAmoOzy/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.LGLsz0f458/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.039254 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:52.590831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-28 13:20:52.591154) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 353c47fc71ccff8b243c66df027350fe30dbce61 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 353c47fc71ccff8b243c66df027350fe30dbce61 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SJeQAmoOzy/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.LGLsz0f458/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-10-28 13:20:52,676 truncating revision to first 12 chars 2016-10-28 13:20:52,676 Setting DEBUG logging. 2016-10-28 13:20:52,676 attempt 1/10 2016-10-28 13:20:52,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/353c47fc71cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 13:20:54,808 unpacking tar archive at: mozilla-aurora-353c47fc71cc/testing/mozharness/ program finished with exit code 0 elapsedTime=2.407549 ========= master_lag: 2.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-28 13:20:57.134062) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:57.134381) ========= script_repo_revision: 353c47fc71ccff8b243c66df027350fe30dbce61 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:57.134833) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:57.135141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 13:20:57.161077) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-28 13:20:57.161430) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SJeQAmoOzy/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.LGLsz0f458/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:20:57 INFO - MultiFileLogger online at 20161028 13:20:57 in /builds/slave/test 13:20:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:20:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:20:57 INFO - {'append_to_log': False, 13:20:57 INFO - 'base_work_dir': '/builds/slave/test', 13:20:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:20:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:20:57 INFO - 'branch': 'Mozilla-Aurora', 13:20:57 INFO - 'buildbot_json_path': 'buildprops.json', 13:20:57 INFO - 'config_files': ('talos/mac_config.py',), 13:20:57 INFO - 'default_actions': ('clobber', 13:20:57 INFO - 'read-buildbot-config', 13:20:57 INFO - 'download-and-extract', 13:20:57 INFO - 'populate-webroot', 13:20:57 INFO - 'create-virtualenv', 13:20:57 INFO - 'install', 13:20:57 INFO - 'run-tests'), 13:20:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:20:57 INFO - 'download_minidump_stackwalk': True, 13:20:57 INFO - 'download_symbols': 'ondemand', 13:20:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:20:57 INFO - 'tooltool.py': '/tools/tooltool.py', 13:20:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:20:57 INFO - '/tools/misc-python/virtualenv.py')}, 13:20:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:20:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:20:57 INFO - 'installer_path': 'installer.exe', 13:20:57 INFO - 'log_level': 'info', 13:20:57 INFO - 'log_name': 'talos', 13:20:57 INFO - 'log_to_console': True, 13:20:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:20:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:20:57 INFO - 'opt_config_files': (), 13:20:57 INFO - 'pip_index': False, 13:20:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:20:57 INFO - 'cmd': ('bash', 13:20:57 INFO - '-c', 13:20:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:20:57 INFO - 'enabled': True, 13:20:57 INFO - 'halt_on_failure': False, 13:20:57 INFO - 'name': 'check_screen_resolution'},), 13:20:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:20:57 INFO - 'cmd': ('bash', 13:20:57 INFO - '-c', 13:20:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:20:57 INFO - 'enabled': True, 13:20:57 INFO - 'halt_on_failure': False, 13:20:57 INFO - 'name': 'check_screen_resolution'},), 13:20:57 INFO - 'run_cmd_checks_enabled': True, 13:20:57 INFO - 'sps_profile': False, 13:20:57 INFO - 'sps_profile_interval': 0, 13:20:57 INFO - 'suite': 'dromaeojs', 13:20:57 INFO - 'system_bits': '32', 13:20:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:20:57 INFO - 'title': 't-yosemite-r7-0340', 13:20:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:20:57 INFO - 'use_talos_json': True, 13:20:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:20:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:20:57 INFO - 'work_dir': 'build'} 13:20:57 INFO - [mozharness: 2016-10-28 20:20:57.365295Z] Running clobber step. 13:20:57 INFO - Running pre-action listener: _resource_record_pre_action 13:20:57 INFO - Running main action method: clobber 13:20:57 INFO - rmtree: /builds/slave/test/build 13:20:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:20:59 INFO - Running post-action listener: _resource_record_post_action 13:20:59 INFO - [mozharness: 2016-10-28 20:20:59.529610Z] Finished clobber step (success) 13:20:59 INFO - [mozharness: 2016-10-28 20:20:59.529867Z] Running read-buildbot-config step. 13:20:59 INFO - Running pre-action listener: _resource_record_pre_action 13:20:59 INFO - Running main action method: read_buildbot_config 13:20:59 INFO - Using buildbot properties: 13:20:59 INFO - { 13:20:59 INFO - "project": "", 13:20:59 INFO - "product": "firefox", 13:20:59 INFO - "script_repo_revision": "production", 13:20:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:20:59 INFO - "repository": "", 13:20:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:20:59 INFO - "buildid": "20161028121858", 13:20:59 INFO - "pgo_build": "False", 13:20:59 INFO - "basedir": "/builds/slave/test", 13:20:59 INFO - "buildnumber": 54, 13:20:59 INFO - "slavename": "t-yosemite-r7-0340", 13:20:59 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 13:20:59 INFO - "platform": "yosemite_r7", 13:20:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:20:59 INFO - "branch": "mozilla-aurora", 13:20:59 INFO - "repo_path": "releases/mozilla-aurora", 13:20:59 INFO - "revision": "353c47fc71ccff8b243c66df027350fe30dbce61", 13:20:59 INFO - "stage_platform": "macosx64", 13:20:59 INFO - "builduid": "2a4e3c6a8d48420f8fd722d724bc11e8", 13:20:59 INFO - "slavebuilddir": "test" 13:20:59 INFO - } 13:20:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 13:20:59 INFO - Running post-action listener: _resource_record_post_action 13:20:59 INFO - [mozharness: 2016-10-28 20:20:59.535702Z] Finished read-buildbot-config step (success) 13:20:59 INFO - [mozharness: 2016-10-28 20:20:59.535930Z] Running download-and-extract step. 13:20:59 INFO - Running pre-action listener: _resource_record_pre_action 13:20:59 INFO - Running main action method: download_and_extract 13:20:59 INFO - mkdir: /builds/slave/test/build/tests 13:20:59 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')]} 13:20:59 INFO - trying https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 13:20:59 INFO - Downloading https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 13:20:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 13:21:00 INFO - Downloaded 1199 bytes. 13:21:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 13:21:00 INFO - Using the following test package requirements: 13:21:00 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:21:00 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:21:00 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 13:21:00 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:21:00 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 13:21:00 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:21:00 INFO - u'jsshell-mac.zip'], 13:21:00 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:21:00 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 13:21:00 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:21:00 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:21:00 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 13:21:00 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:21:00 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 13:21:00 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:21:00 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 13:21:00 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:21:00 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 13:21:00 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:21:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:21:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:21:00 INFO - Fetch https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:21:01 INFO - Expected file size: 16420958 13:21:08 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:21:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:21:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:21:08 INFO - Fetch https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:21:09 INFO - Expected file size: 16420958 13:21:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 13:21:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:21:15 INFO - Fetch https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 13:21:16 INFO - Expected file size: 14414081 13:21:17 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')]} 13:21:17 INFO - trying https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:21:17 INFO - Downloading https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 13:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 13:21:20 INFO - Downloaded 115425743 bytes. 13:21:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:21:20 INFO - mkdir: /builds/slave/test/properties 13:21:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:21:20 INFO - Writing to file /builds/slave/test/properties/build_url 13:21:20 INFO - Contents: 13:21:20 INFO - build_url:https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:21:20 INFO - Running post-action listener: _resource_record_post_action 13:21:20 INFO - Running post-action listener: set_extra_try_arguments 13:21:20 INFO - [mozharness: 2016-10-28 20:21:20.791674Z] Finished download-and-extract step (success) 13:21:20 INFO - [mozharness: 2016-10-28 20:21:20.791779Z] Running populate-webroot step. 13:21:20 INFO - Running pre-action listener: _resource_record_pre_action 13:21:20 INFO - Running main action method: populate_webroot 13:21:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:21:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:21:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:21:20 INFO - '--tppagecycles', 13:21:20 INFO - '7'], 13:21:20 INFO - 'tests': ['tsvgm']}}, 13:21:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:21:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:21:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:21:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:21:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:20 INFO - 'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:20 INFO - 'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['damp', 'tps']}, 13:21:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:20 INFO - 'tests': ['damp', 'tps']}, 13:21:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['dromaeo_dom']}, 13:21:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:21:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['basic_compositor_video']}, 13:21:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:21:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['a11yr', 13:21:20 INFO - 'ts_paint', 13:21:20 INFO - 'tpaint', 13:21:20 INFO - 'sessionrestore', 13:21:20 INFO - 'sessionrestore_no_auto_restore', 13:21:20 INFO - 'tabpaint']}, 13:21:20 INFO - 'other-e10s': {'tests': ['a11yr', 13:21:20 INFO - 'ts_paint', 13:21:20 INFO - 'tpaint', 13:21:20 INFO - 'sessionrestore', 13:21:20 INFO - 'sessionrestore_no_auto_restore', 13:21:20 INFO - 'tabpaint']}, 13:21:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:21:20 INFO - 'ts_paint', 13:21:20 INFO - 'tpaint', 13:21:20 INFO - 'sessionrestore', 13:21:20 INFO - 'sessionrestore_no_auto_restore', 13:21:20 INFO - 'tabpaint']}, 13:21:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:21:20 INFO - 'ts_paint', 13:21:20 INFO - 'tpaint', 13:21:20 INFO - 'sessionrestore', 13:21:20 INFO - 'sessionrestore_no_auto_restore', 13:21:20 INFO - 'tabpaint']}, 13:21:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['a11yr', 13:21:20 INFO - 'ts_paint', 13:21:20 INFO - 'tpaint', 13:21:20 INFO - 'sessionrestore', 13:21:20 INFO - 'sessionrestore_no_auto_restore', 13:21:20 INFO - 'tabpaint']}, 13:21:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['a11yr', 13:21:20 INFO - 'ts_paint', 13:21:20 INFO - 'tpaint', 13:21:20 INFO - 'sessionrestore', 13:21:20 INFO - 'sessionrestore_no_auto_restore', 13:21:20 INFO - 'tabpaint']}, 13:21:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['tsvgx', 13:21:20 INFO - 'tsvgr_opacity', 13:21:20 INFO - 'tart', 13:21:20 INFO - 'tscrollx', 13:21:20 INFO - 'cart']}, 13:21:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:21:20 INFO - 'tsvgr_opacity', 13:21:20 INFO - 'tart', 13:21:20 INFO - 'tscrollx', 13:21:20 INFO - 'cart']}, 13:21:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:20 INFO - 'talos_options': ['--disable-e10s'], 13:21:20 INFO - 'tests': ['tp5o']}, 13:21:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:20 INFO - 'tests': ['tp5o']}, 13:21:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:20 INFO - 'talos_options': ['--disable-e10s', 13:21:20 INFO - '--xperf_path', 13:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:20 INFO - 'tests': ['tp5n']}, 13:21:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:20 INFO - 'talos_options': ['--xperf_path', 13:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:20 INFO - 'tests': ['tp5n']}}, 13:21:20 INFO - 'talos.zip': {'path': '', 13:21:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:21:20 INFO - Running post-action listener: _resource_record_post_action 13:21:20 INFO - [mozharness: 2016-10-28 20:21:20.810633Z] Finished populate-webroot step (success) 13:21:20 INFO - [mozharness: 2016-10-28 20:21:20.810774Z] Running create-virtualenv step. 13:21:20 INFO - Running pre-action listener: _resource_record_pre_action 13:21:20 INFO - Running main action method: create_virtualenv 13:21:20 INFO - Creating virtualenv /builds/slave/test/build/venv 13:21:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:21:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:21:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:21:20 INFO - Using real prefix '/tools/python27' 13:21:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:21:21 INFO - Installing distribute.............................................................................................................................................................................................done. 13:21:24 INFO - Installing pip.................done. 13:21:24 INFO - Return code: 0 13:21:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:24 INFO - 'HOME': '/Users/cltbld', 13:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:24 INFO - 'LOGNAME': 'cltbld', 13:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:24 INFO - 'MOZ_NO_REMOTE': '1', 13:21:24 INFO - 'NO_EM_RESTART': '1', 13:21:24 INFO - 'PAGER': '/bin/cat', 13:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:24 INFO - 'PWD': '/builds/slave/test', 13:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:24 INFO - 'SHELL': '/bin/bash', 13:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:24 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:24 INFO - 'USER': 'cltbld', 13:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:24 INFO - 'XPC_FLAGS': '0x0', 13:21:24 INFO - 'XPC_SERVICE_NAME': '0', 13:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:21:24 INFO - Cleaning up... 13:21:24 INFO - Return code: 0 13:21:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:24 INFO - 'HOME': '/Users/cltbld', 13:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:24 INFO - 'LOGNAME': 'cltbld', 13:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:24 INFO - 'MOZ_NO_REMOTE': '1', 13:21:24 INFO - 'NO_EM_RESTART': '1', 13:21:24 INFO - 'PAGER': '/bin/cat', 13:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:24 INFO - 'PWD': '/builds/slave/test', 13:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:24 INFO - 'SHELL': '/bin/bash', 13:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:24 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:24 INFO - 'USER': 'cltbld', 13:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:24 INFO - 'XPC_FLAGS': '0x0', 13:21:24 INFO - 'XPC_SERVICE_NAME': '0', 13:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:25 INFO - Downloading/unpacking psutil>=3.1.1 13:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:28 INFO - Installing collected packages: psutil 13:21:28 INFO - Running setup.py install for psutil 13:21:28 INFO - building 'psutil._psutil_osx' extension 13:21:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:21:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:21:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:21:28 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 13:21:28 INFO - building 'psutil._psutil_posix' extension 13:21:28 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 13:21:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:21:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:21:28 INFO - ^ 13:21:29 INFO - 1 warning generated. 13:21:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:21:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:29 INFO - Successfully installed psutil 13:21:29 INFO - Cleaning up... 13:21:29 INFO - Return code: 0 13:21:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:21: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')]} 13:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:21:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:29 INFO - 'HOME': '/Users/cltbld', 13:21:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:29 INFO - 'LOGNAME': 'cltbld', 13:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:29 INFO - 'MOZ_NO_REMOTE': '1', 13:21:29 INFO - 'NO_EM_RESTART': '1', 13:21:29 INFO - 'PAGER': '/bin/cat', 13:21:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:29 INFO - 'PWD': '/builds/slave/test', 13:21:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:29 INFO - 'SHELL': '/bin/bash', 13:21:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:29 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:29 INFO - 'USER': 'cltbld', 13:21:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:29 INFO - 'XPC_FLAGS': '0x0', 13:21:29 INFO - 'XPC_SERVICE_NAME': '0', 13:21:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:21:32 INFO - Installing collected packages: mozsystemmonitor 13:21:32 INFO - Running setup.py install for mozsystemmonitor 13:21:32 INFO - Successfully installed mozsystemmonitor 13:21:32 INFO - Cleaning up... 13:21:32 INFO - Return code: 0 13:21:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:32 INFO - 'HOME': '/Users/cltbld', 13:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:32 INFO - 'LOGNAME': 'cltbld', 13:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:32 INFO - 'MOZ_NO_REMOTE': '1', 13:21:32 INFO - 'NO_EM_RESTART': '1', 13:21:32 INFO - 'PAGER': '/bin/cat', 13:21:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:32 INFO - 'PWD': '/builds/slave/test', 13:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:32 INFO - 'SHELL': '/bin/bash', 13:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:32 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:32 INFO - 'USER': 'cltbld', 13:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:32 INFO - 'XPC_FLAGS': '0x0', 13:21:32 INFO - 'XPC_SERVICE_NAME': '0', 13:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:32 INFO - Downloading/unpacking jsonschema==2.5.1 13:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:21:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:21: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 13:21: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 13:21: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 13:21: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 13:21: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 13:21: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 13:21:35 INFO - Downloading functools32-3.2.3-2.tar.gz 13:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:21:35 INFO - warning: no files found matching '*.txt' 13:21:35 INFO - no previously-included directories found matching 'build' 13:21:35 INFO - no previously-included directories found matching 'dist' 13:21:35 INFO - no previously-included directories found matching '.git*' 13:21:35 INFO - Installing collected packages: jsonschema, functools32 13:21:35 INFO - Running setup.py install for functools32 13:21:35 INFO - warning: no files found matching '*.txt' 13:21:35 INFO - no previously-included directories found matching 'build' 13:21:35 INFO - no previously-included directories found matching 'dist' 13:21:35 INFO - no previously-included directories found matching '.git*' 13:21:35 INFO - Successfully installed jsonschema functools32 13:21:35 INFO - Cleaning up... 13:21:35 INFO - Return code: 0 13:21:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:21: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')]} 13:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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', '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 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:21: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 functools32==3.2.3-2 13:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:35 INFO - 'HOME': '/Users/cltbld', 13:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:35 INFO - 'LOGNAME': 'cltbld', 13:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:35 INFO - 'MOZ_NO_REMOTE': '1', 13:21:35 INFO - 'NO_EM_RESTART': '1', 13:21:35 INFO - 'PAGER': '/bin/cat', 13:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:35 INFO - 'PWD': '/builds/slave/test', 13:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:35 INFO - 'SHELL': '/bin/bash', 13:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:35 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:35 INFO - 'USER': 'cltbld', 13:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:35 INFO - 'XPC_FLAGS': '0x0', 13:21:35 INFO - 'XPC_SERVICE_NAME': '0', 13:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:21:36 INFO - Cleaning up... 13:21:36 INFO - Return code: 0 13:21:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:36 INFO - 'HOME': '/Users/cltbld', 13:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:36 INFO - 'LOGNAME': 'cltbld', 13:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:36 INFO - 'MOZ_NO_REMOTE': '1', 13:21:36 INFO - 'NO_EM_RESTART': '1', 13:21:36 INFO - 'PAGER': '/bin/cat', 13:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:36 INFO - 'PWD': '/builds/slave/test', 13:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:36 INFO - 'SHELL': '/bin/bash', 13:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:36 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:36 INFO - 'USER': 'cltbld', 13:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:36 INFO - 'XPC_FLAGS': '0x0', 13:21:36 INFO - 'XPC_SERVICE_NAME': '0', 13:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:36 INFO - Downloading/unpacking blobuploader==1.2.4 13:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:39 INFO - Downloading blobuploader-1.2.4.tar.gz 13:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:21:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:21:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:40 INFO - Downloading docopt-0.6.1.tar.gz 13:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:21:40 INFO - Installing collected packages: blobuploader, requests, docopt 13:21:40 INFO - Running setup.py install for blobuploader 13:21:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:21:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:21:40 INFO - Running setup.py install for requests 13:21:41 INFO - Running setup.py install for docopt 13:21:41 INFO - Successfully installed blobuploader requests docopt 13:21:41 INFO - Cleaning up... 13:21:41 INFO - Return code: 0 13:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21: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')]} 13:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:21:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:41 INFO - 'HOME': '/Users/cltbld', 13:21:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:41 INFO - 'LOGNAME': 'cltbld', 13:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:41 INFO - 'MOZ_NO_REMOTE': '1', 13:21:41 INFO - 'NO_EM_RESTART': '1', 13:21:41 INFO - 'PAGER': '/bin/cat', 13:21:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:41 INFO - 'PWD': '/builds/slave/test', 13:21:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:41 INFO - 'SHELL': '/bin/bash', 13:21:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:41 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:41 INFO - 'USER': 'cltbld', 13:21:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:41 INFO - 'XPC_FLAGS': '0x0', 13:21:41 INFO - 'XPC_SERVICE_NAME': '0', 13:21:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:21:41 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-EUzQPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:21:41 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-eria2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:21:41 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-3XxPkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:21:41 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-3ky8hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:21:41 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-5pPexN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-JqaOjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-BQQcth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-8QefgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Z3wJ3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-9H8HVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-EFJsyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-NqSik4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-w_eRmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ewWAAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:42 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-p6gEmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:21:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-GKxq2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:21:43 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-vUZpyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:21:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:21:43 INFO - Running setup.py install for manifestparser 13:21:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:21:43 INFO - Running setup.py install for mozcrash 13:21:43 INFO - Running setup.py install for mozdebug 13:21:43 INFO - Running setup.py install for mozdevice 13:21:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:21:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:21:43 INFO - Running setup.py install for mozfile 13:21:44 INFO - Running setup.py install for mozhttpd 13:21:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:21:44 INFO - Running setup.py install for mozinfo 13:21:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:21:44 INFO - Running setup.py install for mozInstall 13:21:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:21:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:21:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:21:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:21:44 INFO - Running setup.py install for mozleak 13:21:44 INFO - Running setup.py install for mozlog 13:21:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:21:44 INFO - Running setup.py install for moznetwork 13:21:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:21:44 INFO - Running setup.py install for mozprocess 13:21:45 INFO - Running setup.py install for mozprofile 13:21:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:21:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:21:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:21:45 INFO - Running setup.py install for mozrunner 13:21:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:21:45 INFO - Running setup.py install for mozscreenshot 13:21:45 INFO - Running setup.py install for moztest 13:21:45 INFO - Running setup.py install for mozversion 13:21:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:21:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:21:45 INFO - Cleaning up... 13:21:45 INFO - Return code: 0 13:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:45 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 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21:45 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 13:21:45 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 13:21:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:45 INFO - 'HOME': '/Users/cltbld', 13:21:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:45 INFO - 'LOGNAME': 'cltbld', 13:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:45 INFO - 'MOZ_NO_REMOTE': '1', 13:21:45 INFO - 'NO_EM_RESTART': '1', 13:21:45 INFO - 'PAGER': '/bin/cat', 13:21:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:45 INFO - 'PWD': '/builds/slave/test', 13:21:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:45 INFO - 'SHELL': '/bin/bash', 13:21:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:45 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:45 INFO - 'USER': 'cltbld', 13:21:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:45 INFO - 'XPC_FLAGS': '0x0', 13:21:45 INFO - 'XPC_SERVICE_NAME': '0', 13:21:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:21:46 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-utZGkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:21:46 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ndWFxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:21:46 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-W4jfhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:21:46 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-6ePwQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:21:46 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-uD0pbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:21:46 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-u6Cnzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:21:46 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-2KqmqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:21:46 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)) 13:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:21:46 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Vk2mc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:21:46 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)) 13:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:21:46 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-a17kxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:21:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-X2GKXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:21:47 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)) 13:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:21:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-CQ7hc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:21:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-rqp0PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:21:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-6GQD4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:21:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-zmV75B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-e29Gzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:21:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-b2e2LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:21:47 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)) 13:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:21:47 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-larHrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:21:47 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)) 13:21:47 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)) 13:21:47 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)) 13:21:47 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)) 13:21:47 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)) 13:21:47 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)) 13:21:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:21:47 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 13:21:47 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 13:21:47 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 13:21:47 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 13:21:47 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 13:21:47 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 13:21:50 INFO - Downloading blessings-1.6.tar.gz 13:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:21:50 INFO - Installing collected packages: blessings 13:21:50 INFO - Running setup.py install for blessings 13:21:50 INFO - Successfully installed blessings 13:21:50 INFO - Cleaning up... 13:21:50 INFO - Return code: 0 13:21:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:21:51 INFO - Reading from file tmpfile_stdout 13:21:51 INFO - Current package versions: 13:21:51 INFO - blessings == 1.6 13:21:51 INFO - blobuploader == 1.2.4 13:21:51 INFO - docopt == 0.6.1 13:21:51 INFO - functools32 == 3.2.3-2 13:21:51 INFO - jsonschema == 2.5.1 13:21:51 INFO - manifestparser == 1.1 13:21:51 INFO - mozInstall == 1.12 13:21:51 INFO - mozcrash == 0.17 13:21:51 INFO - mozdebug == 0.1 13:21:51 INFO - mozdevice == 0.48 13:21:51 INFO - mozfile == 1.2 13:21:51 INFO - mozhttpd == 0.7 13:21:51 INFO - mozinfo == 0.9 13:21:51 INFO - mozleak == 0.1 13:21:51 INFO - mozlog == 3.4 13:21:51 INFO - moznetwork == 0.27 13:21:51 INFO - mozprocess == 0.23 13:21:51 INFO - mozprofile == 0.28 13:21:51 INFO - mozrunner == 6.12 13:21:51 INFO - mozscreenshot == 0.1 13:21:51 INFO - mozsystemmonitor == 0.3 13:21:51 INFO - moztest == 0.7 13:21:51 INFO - mozversion == 1.4 13:21:51 INFO - psutil == 3.1.1 13:21:51 INFO - requests == 1.2.3 13:21:51 INFO - wsgiref == 0.1.2 13:21:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21: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')]} 13:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:51 INFO - 'HOME': '/Users/cltbld', 13:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:51 INFO - 'LOGNAME': 'cltbld', 13:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:51 INFO - 'MOZ_NO_REMOTE': '1', 13:21:51 INFO - 'NO_EM_RESTART': '1', 13:21:51 INFO - 'PAGER': '/bin/cat', 13:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:51 INFO - 'PWD': '/builds/slave/test', 13:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:51 INFO - 'SHELL': '/bin/bash', 13:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:51 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:51 INFO - 'USER': 'cltbld', 13:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:51 INFO - 'XPC_FLAGS': '0x0', 13:21:51 INFO - 'XPC_SERVICE_NAME': '0', 13:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:21:51 INFO - Cleaning up... 13:21:51 INFO - Return code: 0 13:21:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:21: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')]} 13:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1016d7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10164d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3857ac50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, '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.SJeQAmoOzy/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.LGLsz0f458/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 13:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:21:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:21:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:51 INFO - 'HOME': '/Users/cltbld', 13:21:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:51 INFO - 'LOGNAME': 'cltbld', 13:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:51 INFO - 'MOZ_NO_REMOTE': '1', 13:21:51 INFO - 'NO_EM_RESTART': '1', 13:21:51 INFO - 'PAGER': '/bin/cat', 13:21:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:51 INFO - 'PWD': '/builds/slave/test', 13:21:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:51 INFO - 'SHELL': '/bin/bash', 13:21:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:21:51 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:21:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:51 INFO - 'USER': 'cltbld', 13:21:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:51 INFO - 'XPC_FLAGS': '0x0', 13:21:51 INFO - 'XPC_SERVICE_NAME': '0', 13:21:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:21:52 INFO - Cleaning up... 13:21:52 INFO - Return code: 0 13:21:52 INFO - Running post-action listener: _resource_record_post_action 13:21:52 INFO - Running post-action listener: _start_resource_monitoring 13:21:52 INFO - Starting resource monitoring. 13:21:52 INFO - [mozharness: 2016-10-28 20:21:52.106847Z] Finished create-virtualenv step (success) 13:21:52 INFO - [mozharness: 2016-10-28 20:21:52.107869Z] Running install step. 13:21:52 INFO - Running pre-action listener: _resource_record_pre_action 13:21:52 INFO - Running main action method: install 13:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:21:52 INFO - Reading from file tmpfile_stdout 13:21:52 INFO - Detecting whether we're running mozinstall >=1.0... 13:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:21:52 INFO - Reading from file tmpfile_stdout 13:21:52 INFO - Output received: 13:21:52 INFO - Usage: mozinstall [options] installer 13:21:52 INFO - Options: 13:21:52 INFO - -h, --help show this help message and exit 13:21:52 INFO - -d DEST, --destination=DEST 13:21:52 INFO - Directory to install application into. [default: 13:21:52 INFO - "/builds/slave/test"] 13:21:52 INFO - --app=APP Application being installed. [default: firefox] 13:21:52 INFO - mkdir: /builds/slave/test/build/application 13:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:22:25 INFO - Reading from file tmpfile_stdout 13:22:25 INFO - Output received: 13:22:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:22:25 INFO - Running post-action listener: _resource_record_post_action 13:22:25 INFO - [mozharness: 2016-10-28 20:22:25.439640Z] Finished install step (success) 13:22:25 INFO - [mozharness: 2016-10-28 20:22:25.439777Z] Running run-tests step. 13:22:25 INFO - Running pre-action listener: _resource_record_pre_action 13:22:25 INFO - Running main action method: run_tests 13:22:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:22:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:22:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:22:25 INFO - 2016-10-28 13:22:25.454 screenresolution[1640:7585] starting screenresolution argv=screenresolution get 13:22:25 INFO - 2016-10-28 13:22:25.457 screenresolution[1640:7585] Display 0: 1600x1200x32@60 13:22:25 INFO - 2016-10-28 13:22:25.463 screenresolution[1641:7587] starting screenresolution argv=screenresolution list 13:22:25 INFO - Available Modes on Display 0 13:22:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:22:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:22:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:22:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:22:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:22:25 INFO - Intel Iris: 13:22:25 INFO - Chipset Model: Intel Iris 13:22:25 INFO - Type: GPU 13:22:25 INFO - Bus: Built-In 13:22:25 INFO - VRAM (Dynamic, Max): 1536 MB 13:22:25 INFO - Vendor: Intel (0x8086) 13:22:25 INFO - Device ID: 0x0a2e 13:22:25 INFO - Revision ID: 0x0009 13:22:25 INFO - Displays: 13:22:25 INFO - Display: 13:22:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:22:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:22:25 INFO - Display Serial Number: 1600x1200 60 13:22:25 INFO - Main Display: Yes 13:22:25 INFO - Mirror: Off 13:22:25 INFO - Online: Yes 13:22:25 INFO - Rotation: Supported 13:22:25 INFO - Return code: 0 13:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:22:25 INFO - Python 2.7.3 13:22:25 INFO - Return code: 0 13:22:25 INFO - grabbing minidump binary from tooltool 13:22:25 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')]} 13:22:25 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 0x1014ebd30>, '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 0x101351db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1014e3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:22:25 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 13:22:25 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 13:22:25 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 13:22:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:22:25 INFO - Return code: 0 13:22:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:22:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:22:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:22:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:22:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:22:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 13:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0340 --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 13:22:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SJeQAmoOzy/Render', 13:22:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:22:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:22:25 INFO - 'HOME': '/Users/cltbld', 13:22:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:22:25 INFO - 'LOGNAME': 'cltbld', 13:22:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:22:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:25 INFO - 'MOZ_NO_REMOTE': '1', 13:22:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:22:25 INFO - 'NO_EM_RESTART': '1', 13:22:25 INFO - 'PAGER': '/bin/cat', 13:22:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:25 INFO - 'PWD': '/builds/slave/test', 13:22:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:22:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:22:25 INFO - 'SHELL': '/bin/bash', 13:22:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LGLsz0f458/Listeners', 13:22:25 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 13:22:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:22:25 INFO - 'USER': 'cltbld', 13:22:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:22:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:25 INFO - 'XPC_FLAGS': '0x0', 13:22:25 INFO - 'XPC_SERVICE_NAME': '0', 13:22:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:22:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 13:22:26 INFO - mozversion application_buildid: 20161028121858 13:22:26 INFO - mozversion application_changeset: 353c47fc71ccff8b243c66df027350fe30dbce61 13:22:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:22:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:22:26 INFO - mozversion application_name: Firefox 13:22:26 INFO - mozversion application_remotingname: firefox-dev 13:22:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:22:26 INFO - mozversion application_vendor: Mozilla 13:22:26 INFO - mozversion application_version: 51.0a2 13:22:26 INFO - mozversion platform_buildid: 20161028121858 13:22:26 INFO - mozversion platform_changeset: 353c47fc71ccff8b243c66df027350fe30dbce61 13:22:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:22:26 INFO - mozversion platform_version: 51.0a2 13:22:26 INFO - using testdate: 1477686146 13:22:26 INFO - actual date: 1477686146 13:22:26 INFO - starting webserver on 'localhost:49274' 13:22:26 INFO - SUITE-START | Running 2 tests 13:22:26 INFO - TEST-START | dromaeo_css 13:22:26 INFO - operating with platform_type : mac_ 13:22:26 INFO - Initialising browser for dromaeo_css test... 13:22:26 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpuJrnbn/profile http://localhost:49274/getInfo.html) 13:22:28 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 13:22:28 INFO - PROCESS | 1651 | colorDepth:24 13:22:28 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 13:22:28 INFO - PROCESS | 1651 | __metrics 13:22:28 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" 13:22:28 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:22:29 INFO - TEST-INFO | 1651: exit 0 13:22:29 INFO - Browser initialized. 13:22:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:22:29 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpuJrnbn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:41 INFO - PROCESS | 1653 | RSS: Main: 219881472 13:22:41 INFO - PROCESS | 1653 | 13:23:32 INFO - PROCESS | 1653 | 1477686212455 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] 13:25:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 13:25:45 INFO - PROCESS | 1653 | RSS: Main: 326942720 13:25:45 INFO - PROCESS | 1653 | 13:28:48 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 13:28:49 INFO - PROCESS | 1653 | RSS: Main: 351272960 13:28:49 INFO - PROCESS | 1653 | 13:31:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 13:31:52 INFO - PROCESS | 1653 | RSS: Main: 317116416 13:31:52 INFO - PROCESS | 1653 | 13:34:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 13:34:55 INFO - PROCESS | 1653 | RSS: Main: 323702784 13:34:55 INFO - PROCESS | 1653 | 13:37:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 13:37:59 INFO - PROCESS | 1653 | RSS: Main: 310718464 13:37:59 INFO - PROCESS | 1653 | 13:41:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 13:41:02 INFO - PROCESS | 1653 | RSS: Main: 475934720 13:41:02 INFO - PROCESS | 1653 | 13:41:02 INFO - PROCESS | 1653 | __start_tp_report 13:41:02 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 13:41:02 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 13:41:02 INFO - PROCESS | 1653 | |i|pagename|runs| 13:41:02 INFO - PROCESS | 1653 | |0;dojo.html;3227.7417806575477;3360.798352098875;3401.217719924419;3418;3429.0570093224374;5727.656340619561;5739.540836733062;5761.251037365148;5768.07710766278;5830.183774271605;5725.971370143154;5825.359210486843;5839.941600583993;5842.503387212092;5854.151148083536;5247.685138891669;5276.34045744282;5297.44376840432;5320.574354051667;5347.786088556453;5209.973950130244;5219.660722053073;5221.425643179247;5374.543163831059;5385.3268341457315;5287.444818294081;5289.497497737728;5290.761915713783;5311.814086506973;5335.573154147678;5316.255724198596;5341.679499230058;5347.197920311945;5352.170413585901;5354.678719276817;5146.819861304836;5229.37247530295;5285.6300058995885;5290.682559046431;5306.575473962073;5631.352394474606;5691.886162276773;5698.17376480408;5734.541236701054;5736.799212027559;6176.536759742992;6189.98389630015;6219.782307619212;6232.87534249317;6268.09112678659;6151.169592105098;6207.503399728011;6222.12890195373;6235.9376406235815;6246.718897649616;4891.33966914462;5691.3170419549915;5781.884362312772;5807.332156801937;5898.233229680114;6329.430351268408;6335.809925702236;6337.7781777637565;6339.175907132043;6363.427291543783;6126.571140020156;6212.937870621236;6215.9378406216265;6224.657643829632;6236.469900058546;6139.706800529493;6176.505879529627;6216.191895053705;6232.252129744369;6234.438900498977;6171.043488259237;6178.598391104564;6241.469475094577;6243.188385509855;6270.717817698214;6220.471259942956;6263.592866463665;6268.655223962726;6281.026440901667;6282.277538083087;4858.344123543347;4913.70517768935;4917.729524876095;4986.4514903360605;5025.497450254945;4397.912041759211;4478.2386994211065;4478.686491945533;4482.103579284156;4522.66080043998;5848.736806843703;5883.470487656046;5893.970530147321;5897.321807992136;5901.17383566301;6130.887362651087;6255.78104766331;6262.279837818709;6262.436380725757;6279.497640188774;4912.459629440758;5691.630044047124;5835.503982161564;5891.293044834647;5992.970035149883;5406.999705054577;5458.563314934796;5462.754176062087;5467.617266791366;5482;6447.2907980122145;6463.741450341934;6466.997615369625;6476.579022363531;6485.513586481033;6143.757528501975;6164.951958167033;6176.629402235881;6227.719752611053;6249.500039996698;6365.172527571386;6386.584871983307;6391.296957334783;6393.264774550986;6398.520110991787;6077.726502307495;6085.543584231289;6141.170941922962;6175.475084617858;6188.133661287513;5081.974590127025;6072.757089716361;6147.969260153671;6167.383261673976;6217.720202590985;4691.08523837862;6025.216721826135;6149.200603921461;6208.037754148114;6210.285817130907;6102.359252278625;6136.846578835565;6181.381861813783;6188.44304012641;6211.378862113753;5767.279090113736;5866.384029676822;5921.904447677021;6069.696515174312;6106.45041946227;6066.939330606638;6128.105930682507;6133.6319820810895;6145.108959200801;6164.3835616438;5945.702714864326;6020.066889632114;6020.608660437058;6038.849028774316;6043.909341359795 13:41:02 INFO - PROCESS | 1653 | |1;ext.html;479.42469037155416;508.99745501272486;513.5378159656311;523.8873642166934;557.7099908047818;30150.24624384389;34200.1449963751;37832.43251351232;39256.018599535026;42007.78996105023;41416.585834141726;41849.790751046276;41860.16279674404;41926.790366048204;41936;9728.367656102366;9915.801683966352;9921.603135874557;9926.057024582653;9943.751406214866;7513.849723005536;9018.503982280972;11893.940530297335;12148.906598406142;12171.695707607336;12063;12183.32991685457;12184.390780460986;12199.390030498484;12205.57280495183;8808.29533637314;12159.452824622913;12219.26684398939;12236.938815305955;12258.50965961365;8713.869291960626;11505.769884602261;11860.762784744256;11867.05063594919;12134.27194368332;39950.60049399498;40237.59762402397;40381.394279085835;40393;40410;3259.6251431085493;3343.5820522434697;3380.3746306933294;3596.4777682632644;3678.1172518595613;29518.55722164169;30825.537616935762;31091;31111;31535.684643153505;3115.3613509230554;3245.2049247934406;3247.3342964692183;3281.1797050737314;3355.0605830367535;515975;517381.89163379476;517831;519059;519400;32852.67147328544;33535;56627.71686141543;56966.43033569611;57197;34879.30241395158;34936;34981.82509087438;34992.30015399678;35094.29811403758;14942.25288735559;15064.397424103132;15096.943213974917;15117.017393869362;15123.924380378248;11485.310881347146;11702;12829;12913.225206487641;12953.481860725466;7463.365613922877;7662.961685191538;7669;7728.92271077282;7817.491863028885;3160.652328243891;3207.3264614430764;3217.8391080446354;3244.416005119054;3251.349730053999;866.2160744526213;909.5952301226023;967.3180407812475;977.6675930183771;1028.1517747858047;28806.711932880404;29630.851845741065;29745.810167593485;30358.69641303603;30371.544426833614;763.1376544504674;993.279872092727;999.5701848205196;1046.419237323293;1063.5320458998017;14797.482088127079;15401.383944642314;15445.382184712485;15660.295286712126;15797.763033554505;696474;705776;705881;706465;709288;53589.66025849307;56970.715146424;57495.13757293644;57560.42439575551;57563.71218143882;1014.4927536231884;1171.9648410547697;1173.3605185174101;1244.5830646733446;1379.9103058301177;30065.248368790955;30187.69812301849;30744.846275769374;31045.0686479406;31400.68599314069;47951.76024119857;48565;48597;48674.26988595103;48786.756066219445;562102;562399;563174;563305;693850;40218.1956360877;40900.59099408968;40950.59049409587;41139.177216456104;41386.79306603448;44524.10951781011;44554;44580.33129502995;44736.77631611821;45317.32024019576;36787.816060919526;37090.70182543598;38056.80971595124;38941.61058389493;39128;37474.03531197624;37666.623333766314;38376.04059898525;38478.42282365711;38623.42064868973;35889;36406.27187456289;37379.43930840985;37476.812615936746;37525.62474375221;27596.724032759415;31752.841235793672;34297.79957701469;34390;34405;24704;25140.497190056463;25328.113516027588;25591.360215994748;25650 13:41:02 INFO - PROCESS | 1653 | |2;jquery.html;353.63222248861183;373.6319725070805;373.68797054459526;384.9287881741879;405.1370580663189;15150.848491515082;15413.306401211945;17019;20132.59734805303;20800;19569;20202.494937626565;20240.39278821634;20312.59374812503;20380.082896269665;4798.688085274463;5197.714125723083;5448;5452.809151679692;5456.0997435423105;3868.883933482;4079.2657321682086;5979.551533634973;6017.157597936292;6123.479504242123;3980.104476492795;5824.912626310609;6053;6076.635401875879;6127.662978536178;5081.314022606938;6050.2437195350585;6102.847428814271;6123.173371594822;6132.141500189977;5898.056310990264;5901.675407852566;5902.881942361171;5910.34986151523;5910.822675319747;12899.613011609667;13008.219506829526;13051.477940882352;13243.006774491952;13297.468101275937;2142.078906070389;2161.459635091227;2170.4248374180856;2210.5910406574835;2720.64631597893;9530.332876698634;9914.652987145415;10408.479576021244;10424.843627345595;11288.492017859217;1563.7732528783263;1855.4526414707693;1877.1646617255326;1910.570121722615;1945.9610807783906;100800;123590.38204808919;127417.35495870278;128679;132888;11251.099912007183;11431.59989400367;11514.827277590843;11537.88462115368;11705.765884682429;14777.704445911022;14793.186374749277;14799.482018129314;14813.037152585048;14842.183679897493;8422.789430264293;8635.568221588896;8645;8746.91253087461;8761.780955476164;8699.913000870038;8733.737987860375;8773.912260877309;8905.777355566162;8931.660250962277;4446.599806017474;4522.977385113053;4529.728216307032;4616.8614941551805;4647.86056418308;1738.6696527659703;1856.7307740377569;1896.9810301896805;1912.1013123832056;1917.9520511987032;730.0910366593625;807.8384323135278;886.8492356299445;942.6747772018642;978.5058545434653;19835.504112397306;21189.152433902473;21310.147594096372;21437.142514299565;21582.590309775922;900.2348004196512;922.3405265235389;968.3899143539525;977.237754551451;1001.2790790630734;10937.343759374464;11194;11247.437628118561;11258.943705281421;11265;629024;629391;635692;644472;644935;131680;133264;135024.6497535012;138103;139983.30008350097;962.9422234665942;965.4931161140317;993.0466751918095;993.7813680990171;994.0010289658991;18454.81545184531;18649.160787764853;18752.343667971556;18770.718439223696;18785;54602.453975459735;55418.44581554133;55642.443575563724;56552.86894262174;57287.71356143193;67485;79509.20490795017;82541.58729206315;82552.58723706343;84409.57795210984;7889.566073865993;7938.364930805406;8183.263506284225;8204;8470.194419953037;9675.9032409675;12883.613491595268;12971;13032.804507932198;13139.474421023053;11112.888871111185;11220.551177953117;11428.657140285804;11438.771224575628;11528.308301501937;11183.440827958731;11322.830157547809;11323;11534;11627.011704005254;9344.486053267136;11495.827562586735;11504;11506.712332191762;11799.05607551411;8140.226678465537;8286.544240066612;8468.830623387374;11178.88821111811;11997.460114295052;11283.210175287652;11514.424278786195;11646.184767066225;11816.291022538675;11831.763364732486 13:41:02 INFO - PROCESS | 1653 | |3;mootools.html;1427.4718354208944;1480.4226351722828;1695.9915200423995;1891.6973284274518;1922.9230830766778;8073.91926080739;8309.293710034639;8691.869621955675;9099.499527525992;9102.726918192464;8542.444741091826;8775.473471591693;8787.780305492366;8903.065178156297;8916.375853690244;2170.6216552489127;2393.7127544694663;2401.5076909233608;2433.5132973405302;2439.134107391877;2125.3305208859238;2215.745189303235;2336.5093330400637;2379.583572874749;2443.0472115874823;2175.771543987882;2206.249875042485;2317.7102862142233;2412.407810844843;2413.191580820427;2387.9164229252065;2404.6873906392057;2408.205292253552;2410.6866107406013;2415.879206039691;2392.186656536786;2397.44858682504;2402;2406.2420337593603;2413.384586930339;8835.55822208887;8918.92972843263;8971.551422428853;8974.50640214788;8989;5272;5463.125899856004;5468.28912241406;5469.671819690831;5470.452954704538;3480.756347055707;3548.7870727756417;3671.155634204148;3672.8714494992814;3676.7793932364143;1067.6156583629886;1074.693712291993;1102.7849569333982;1117.6870476266658;1120.6918097523246;11999.580014699444;12083.57707480234;12100.394980250952;12104.213226140273;12139;4716;4741.942535156548;4780.521947805191;4881.072596206709;4895.975520122377;8595.828083438297;10058.849117263248;10079.294449388472;10087.142592879542;10101;5423.376311724202;5424.538914192338;5426.321709786277;5435.83692489226;5436.91844622331;4859.781309841065;4931.4821943696115;4939.7897515109025;4954.355933728592;4978.551930326215;3839.827207775657;3846;3879.534455865314;3926;3936.3505021671676;1113.3264375052977;1164.5050853387445;1164.9009834164021;1177.140687298277;1181.8759030301867;780.9062912450429;783.1581050370875;882.6910581296495;890.9242714369221;938.1509733691021;5826.533877289891;5934.525237980951;6101.7559297627595;6111.938880611137;6321.525885558602;880.348542078857;990.1978399313325;1008.5411137932223;1044.4464433850071;1065.3394895164893;3804.2391521695217;3814.7138964577766;3922.7254092213843;3933.7443066200603;3956.7032472564097;10744.355338679705;10990.285631433931;11088.33469991803;11100.389478578594;11149.108071354434;11028.889711102785;11038.448077596087;11040.282381645327;11054.834177487344;11056.170787190993;7830.686772529035;8153.633086511002;8156.306713929383;8196.795080123045;8303.916960830435;4966.801327946841;5981.7607295707685;5984.401559843981;6067.939320606914;6175.465931563485;9416.199623032118;9779.826420829262;9988.151007164472;10285.43430111351;10311.742206444898;9958.701238962843;10305.587776488857;10426.218033647356;10444.529996150039;10453.477326133814;7516.436267280085;7674.654640541077;7776.961115194388;7777.338926191337;7778.027746531684;8361.289290410383;8371.706990255556;8450.19723126302;8451.45065570736;8457.957710211409;7535.54786712799;7588.582627955516;7612.162662107053;7617.390608751176;7641;7363.484556081237;7450.552966822008;7456.478046536908;7461.626918654154;7527.774166775005;6990.825229369307;7083.256258093033;7088.539244949062;7127.8574428512175;7134.607596582237;4213.052063285736;4223.176480586256;4310.771430142394;4347.608715215646;4357.389965404909;5000.424951130666;5011.198208286803;5100.336956195671;5170.8965820684125;5265.473452654704 13:41:02 INFO - PROCESS | 1653 | |4;prototype.html;254.68037612795942;304.83538888999925;308.58187156403073;316.323068633125;317.4666560178899;5057.570106540944;5195.856911479478;5432.402435732071;5541.871305877117;5554.583406244537;4415.631154342156;4616.307553866922;4876.634542328154;5350.384705758839;5426.484483974016;3984.4023396490616;4072.124493233954;4121.505419349683;4126.174765046995;4133.545310015896;3325.883594074208;3867.207222519377;4028.858989935353;4206.41110244566;4257.489101307848;3273.8690452381875;3985.1867400332926;4092.9795351023204;4097.6516996055225;4185.28850095483;4119.402686610455;4129.855455059059;4163.875083747493;4176.540580536139;4198.853040143611;3123.891018688378;3599.748017638766;3618.2582570572968;3623.800690961996;3641.708663306929;4381.912361752779;4437.622802061828;4931.876703082416;5084.669496482717;5114.514121158484;3913.7064720146104;4139.668826493903;4614.5385461453925;4707.882302942419;4775.617950563947;4741.502142275081;5617.578681598897;5718.857028574277;5727.484526392603;5754.798582049608;3502.3345564342694;3525.2679173640377;3583;3900.258950799339;3910.843566257346;5699.658020518741;5889;6042.39576042401;6095.019118786412;6102;3608;3906.7069969752383;3910.550286717007;3916.236333914859;3916.236333914859;3987.5414327352146;3988.4017397390044;3991.002249437641;4007.2987227235117;4030.234255491447;4159.292920203573;4423.447069116361;4676.375808748179;4704.600108990774;4719.59883409914;4779.665423420397;5701.348872774097;5717.742701578439;5729.541636669056;5731.914021289601;1019.1744686803713;1160.5183848702693;1326.4627825730595;1335.3923964596086;1348.7321917397614;835.9456635318685;876.3909083187124;876.6230520875957;878.8198419324024;881.8148188880278;5060.342155519833;5397.353807088875;5481.205225242317;5498.323011481537;5510.476504732044;5881.9705901470215;5915.988563888299;5922.437368449991;5983.640981541122;6078.817635470943;5071.3153724247495;5122.975404918957;5439.972800135974;5467.059193986078;5520.779168833202;3002.7597792176575;3079.5688603595513;3098.2873938993707;3101.937961240808;3132.733717633981;4920.736461227875;5251.947480525146;5808.883822323614;6156.415140561639;6247.344028876993;4847.497275844499;5010.64925455222;5985.910211346833;5998.170557979771;6007.609505382136;5145.819896303761;5281.355864453438;5633.859133529315;6129.570930034944;6154.292256390572;5618.134751276796;5830.47525722687;5910.438508341701;5914.497267732291;5928.851778705567;5766.682832444256;5836.737346819488;5850.327212370462;5859.9121013183985;5868.853278668067;4910.263460480956;5237.371515418175;5344.499352923841;6092.39076092405;6152.50779937595;2990.9083184637884;3028.4258380376505;3237.951430728494;3295.978246743517;3403.9149021274666;4069.9389509156795;4096.610821971908;4913.65604407688;4928.852134435972;4950.8267210647455;4228.78856057202;4746.952530474651;4842.806287748451;4845.781939812647;4853.587445067209;4910.189818679878;5699.145128230799;5752.424757524214;5759;5801.419858014165;4475;4911.852644420673;5255.421903590525;5367.35591728995;5511.0080185566985;4849.684770489906;5328.8276579152525;5598.916016259841;5821.301443826768;5919.507490580578;4209.515905670887;4899.730514821719;5668.234788303526;5719;5741.7655204131315 13:41:02 INFO - PROCESS | 1653 | |5;yui.html;687.2955220898575;695.0790202981051;743.5390058163936;783.5220515485553;815.2255357410462;14681.926590367046;15730.292136853841;15732.84267157328;15758.133302668362;15778.842211577881;14318.92840535796;14455.78316325256;14463.20452375119;14495.420183192686;14501.564953051426;648.9772857949972;671.7010930136091;673.6126727131895;814.9633266502992;815.4006804998321;667.1060778556733;807.3662175192475;842.4187310755559;843.6456688190943;844.5270648436895;896.0636135238659;896.8923729152478;897.228383590112;897.4749771383748;902.1880307723036;684.7055766020609;711.9288071192839;846.4371193156544;889.4129874283007;890.1632465482426;658.4896705053574;659.3768888400464;659.5251418978328;659.9274079851212;661.1966460750211;14895.106293622417;14943.775843362359;14946.925265373713;14958;14966.102033877893;13653.931730341385;13718.725625487534;13842.515511957034;13851.030427870053;13924.164550127025;12015.219010764273;12344.691382715415;12392.81410778839;12404.069694772928;12643.873561264361;4448.733076015417;4465.151621191995;4492.820287188509;4553.749543775091;4661.88345291367;119417.40291298575;125397.37301313526;127670.36164819209;128559.35720321433;128768.35615821954;10402.47987600617;10551.525181366856;10670.51982660782;10715.946420267848;10948.346952545136;20877.478063048242;21156.576868462544;21194.364169074954;21250.574988500142;21289.68065479019;7393.556386616712;7509;7787.143414224431;7804.726834560764;7846.646900889474;4212.757236615206;4313.50394704613;4342.804573794124;4519.796609152596;4539.228331183706;3100.162956001867;3644.908877278036;3697.926041479155;3706.5737440194184;3710.870119545857;687.621808005595;690.4821383962028;695.2144077192739;695.7808290388512;697.6546609428366;562.7073921560766;578.5602941764289;647.4593714248655;661.4741280681774;691.3777600159796;9549.28380371461;9580.95209523948;9587.808243835223;9710;9815.705528834147;570.2814453788257;634.8381162803455;660.2275337854721;660.577230572434;686.7527690031585;3812.390017597171;4316.252735038911;4557.680962332605;4697.154512187839;4756.595689366373;147224.055518889;147510.26244868708;160489;163714;172601.13699431423;133322;139924.3003784995;142303;142954.2852285732;144813.27593361965;90050.54974725084;93673.53163234277;120595.98510037319;124767;127762;8755;9120.179183873483;9200.677976271067;9225.677101301691;9333.346665733334;50595.74702126466;52829;55988;60691.69654151701;63288.68355658192;85678.57160714157;92887;95364;95487.52256238674;97424;11594.94202528982;11795.941020294844;12407.937960310503;12415.565455209024;12508.374581271082;14096.859031409966;15254.771178432555;15398.846011539741;15817.209139543207;16126.354945802037;14202.573922782332;14239.786403204167;14692.412303508168;14789.186594737394;14828.555143345717;12040.698982525157;12262.141650084764;13524.05331626816;13727.382267798173;13731.519396821062;11729.794214136322;13061.477540898257;14018.929905350407;14524.346404412037;14529.927350363181;10252.58989640406;10305;10818.459077045958;11165.72085697864;11819.527218911491;11476.368799716096;11485.598004069818;11551.133664974992;11561.942190289332;11713.355765432983 13:41:02 INFO - PROCESS | 1653 | __end_tp_report 13:41:02 INFO - PROCESS | 1653 | __start_cc_report 13:41:02 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1202 13:41:02 INFO - PROCESS | 1653 | __end_cc_report 13:41:02 INFO - PROCESS | 1653 | __startTimestamp1477687262910__endTimestamp 13:41:02 INFO - PROCESS | 1653 | 13:41:02 INFO - PROCESS | 1653 | ------- Summary: start ------- 13:41:02 INFO - PROCESS | 1653 | Number of tests: 6 13:41:02 INFO - PROCESS | 1653 | 13:41:02 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5766.12 Median:6020.61 stddev:645.26 (10.7%) stddev-sans-first:615.74 13:41:02 INFO - PROCESS | 1653 | Values: 3227.7 3360.8 3401.2 3418.0 3429.1 5727.7 5739.5 5761.3 5768.1 5830.2 5726.0 5825.4 5839.9 5842.5 5854.2 5247.7 5276.3 5297.4 5320.6 5347.8 5210.0 5219.7 5221.4 5374.5 5385.3 5287.4 5289.5 5290.8 5311.8 5335.6 5316.3 5341.7 5347.2 5352.2 5354.7 5146.8 5229.4 5285.6 5290.7 5306.6 5631.4 5691.9 5698.2 5734.5 5736.8 6176.5 6190.0 6219.8 6232.9 6268.1 6151.2 6207.5 6222.1 6235.9 6246.7 4891.3 5691.3 5781.9 5807.3 5898.2 6329.4 6335.8 6337.8 6339.2 6363.4 6126.6 6212.9 6215.9 6224.7 6236.5 6139.7 6176.5 6216.2 6232.3 6234.4 6171.0 6178.6 6241.5 6243.2 6270.7 6220.5 6263.6 6268.7 6281.0 6282.3 4858.3 4913.7 4917.7 4986.5 5025.5 4397.9 4478.2 4478.7 4482.1 4522.7 5848.7 5883.5 5894.0 5897.3 5901.2 6130.9 6255.8 6262.3 6262.4 6279.5 4912.5 5691.6 5835.5 5891.3 5993.0 5407.0 5458.6 5462.8 5467.6 5482.0 6447.3 6463.7 6467.0 6476.6 6485.5 6143.8 6165.0 6176.6 6227.7 6249.5 6365.2 6386.6 6391.3 6393.3 6398.5 6077.7 6085.5 6141.2 6175.5 6188.1 5082.0 6072.8 6148.0 6167.4 6217.7 4691.1 6025.2 6149.2 6208.0 6210.3 6102.4 6136.8 6181.4 6188.4 6211.4 5767.3 5866.4 5921.9 6069.7 6106.5 6066.9 6128.1 6133.6 6145.1 6164.4 5945.7 6020.1 6020.6 6038.8 6043.9 13:41:02 INFO - PROCESS | 1653 | 13:41:02 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:71811.73 Median:36939.26 stddev:163466.86 (442.5%) stddev-sans-first:163837.69 13:41:02 INFO - PROCESS | 1653 | Values: 479.4 509.0 513.5 523.9 557.7 30150.2 34200.1 37832.4 39256.0 42007.8 41416.6 41849.8 41860.2 41926.8 41936.0 9728.4 9915.8 9921.6 9926.1 9943.8 7513.8 9018.5 11893.9 12148.9 12171.7 12063.0 12183.3 12184.4 12199.4 12205.6 8808.3 12159.5 12219.3 12236.9 12258.5 8713.9 11505.8 11860.8 11867.1 12134.3 39950.6 40237.6 40381.4 40393.0 40410.0 3259.6 3343.6 3380.4 3596.5 3678.1 29518.6 30825.5 31091.0 31111.0 31535.7 3115.4 3245.2 3247.3 3281.2 3355.1 515975.0 517381.9 517831.0 519059.0 519400.0 32852.7 33535.0 56627.7 56966.4 57197.0 34879.3 34936.0 34981.8 34992.3 35094.3 14942.3 15064.4 15096.9 15117.0 15123.9 11485.3 11702.0 12829.0 12913.2 12953.5 7463.4 7663.0 7669.0 7728.9 7817.5 3160.7 3207.3 3217.8 3244.4 3251.3 866.2 909.6 967.3 977.7 1028.2 28806.7 29630.9 29745.8 30358.7 30371.5 763.1 993.3 999.6 1046.4 1063.5 14797.5 15401.4 15445.4 15660.3 15797.8 696474.0 705776.0 705881.0 706465.0 709288.0 53589.7 56970.7 57495.1 57560.4 57563.7 1014.5 1172.0 1173.4 1244.6 1379.9 30065.2 30187.7 30744.8 31045.1 31400.7 47951.8 48565.0 48597.0 48674.3 48786.8 562102.0 562399.0 563174.0 563305.0 693850.0 40218.2 40900.6 40950.6 41139.2 41386.8 44524.1 44554.0 44580.3 44736.8 45317.3 36787.8 37090.7 38056.8 38941.6 39128.0 37474.0 37666.6 38376.0 38478.4 38623.4 35889.0 36406.3 37379.4 37476.8 37525.6 27596.7 31752.8 34297.8 34390.0 34405.0 24704.0 25140.5 25328.1 25591.4 25650.0 13:41:02 INFO - PROCESS | 1653 | 13:41:02 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:36203.36 Median:2165.94 stddev:106327.14 (4909.0%) stddev-sans-first:106591.34 13:41:02 INFO - PROCESS | 1653 | Values: 353.6 373.6 373.7 384.9 405.1 15150.8 15413.3 17019.0 20132.6 20800.0 19569.0 20202.5 20240.4 20312.6 20380.1 4798.7 5197.7 5448.0 5452.8 5456.1 3868.9 4079.3 5979.6 6017.2 6123.5 3980.1 5824.9 6053.0 6076.6 6127.7 5081.3 6050.2 6102.8 6123.2 6132.1 5898.1 5901.7 5902.9 5910.3 5910.8 12899.6 13008.2 13051.5 13243.0 13297.5 2142.1 2161.5 2170.4 2210.6 2720.6 9530.3 9914.7 10408.5 10424.8 11288.5 1563.8 1855.5 1877.2 1910.6 1946.0 100800.0 123590.4 127417.4 128679.0 132888.0 11251.1 11431.6 11514.8 11537.9 11705.8 14777.7 14793.2 14799.5 14813.0 14842.2 8422.8 8635.6 8645.0 8746.9 8761.8 8699.9 8733.7 8773.9 8905.8 8931.7 4446.6 4523.0 4529.7 4616.9 4647.9 1738.7 1856.7 1897.0 1912.1 1918.0 730.1 807.8 886.8 942.7 978.5 19835.5 21189.2 21310.1 21437.1 21582.6 900.2 922.3 968.4 977.2 1001.3 10937.3 11194.0 11247.4 11258.9 11265.0 629024.0 629391.0 635692.0 644472.0 644935.0 131680.0 133264.0 135024.6 138103.0 139983.3 962.9 965.5 993.0 993.8 994.0 18454.8 18649.2 18752.3 18770.7 18785.0 54602.5 55418.4 55642.4 56552.9 57287.7 67485.0 79509.2 82541.6 82552.6 84409.6 7889.6 7938.4 8183.3 8204.0 8470.2 9675.9 12883.6 12971.0 13032.8 13139.5 11112.9 11220.6 11428.7 11438.8 11528.3 11183.4 11322.8 11323.0 11534.0 11627.0 9344.5 11495.8 11504.0 11506.7 11799.1 8140.2 8286.5 8468.8 11178.9 11997.5 11283.2 11514.4 11646.2 11816.3 11831.8 13:41:02 INFO - PROCESS | 1653 | 13:41:02 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5772.57 Median:4820.15 stddev:3273.59 (67.9%) stddev-sans-first:3266.49 13:41:02 INFO - PROCESS | 1653 | Values: 1427.5 1480.4 1696.0 1891.7 1922.9 8073.9 8309.3 8691.9 9099.5 9102.7 8542.4 8775.5 8787.8 8903.1 8916.4 2170.6 2393.7 2401.5 2433.5 2439.1 2125.3 2215.7 2336.5 2379.6 2443.0 2175.8 2206.2 2317.7 2412.4 2413.2 2387.9 2404.7 2408.2 2410.7 2415.9 2392.2 2397.4 2402.0 2406.2 2413.4 8835.6 8918.9 8971.6 8974.5 8989.0 5272.0 5463.1 5468.3 5469.7 5470.5 3480.8 3548.8 3671.2 3672.9 3676.8 1067.6 1074.7 1102.8 1117.7 1120.7 11999.6 12083.6 12100.4 12104.2 12139.0 4716.0 4741.9 4780.5 4881.1 4896.0 8595.8 10058.8 10079.3 10087.1 10101.0 5423.4 5424.5 5426.3 5435.8 5436.9 4859.8 4931.5 4939.8 4954.4 4978.6 3839.8 3846.0 3879.5 3926.0 3936.4 1113.3 1164.5 1164.9 1177.1 1181.9 780.9 783.2 882.7 890.9 938.2 5826.5 5934.5 6101.8 6111.9 6321.5 880.3 990.2 1008.5 1044.4 1065.3 3804.2 3814.7 3922.7 3933.7 3956.7 10744.4 10990.3 11088.3 11100.4 11149.1 11028.9 11038.4 11040.3 11054.8 11056.2 7830.7 8153.6 8156.3 8196.8 8303.9 4966.8 5981.8 5984.4 6067.9 6175.5 9416.2 9779.8 9988.2 10285.4 10311.7 9958.7 10305.6 10426.2 10444.5 10453.5 7516.4 7674.7 7777.0 7777.3 7778.0 8361.3 8371.7 8450.2 8451.5 8458.0 7535.5 7588.6 7612.2 7617.4 7641.0 7363.5 7450.6 7456.5 7461.6 7527.8 6990.8 7083.3 7088.5 7127.9 7134.6 4213.1 4223.2 4310.8 4347.6 4357.4 5000.4 5011.2 5100.3 5170.9 5265.5 13:41:02 INFO - PROCESS | 1653 | 13:41:02 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4512.70 Median:4911.06 stddev:1419.64 (28.9%) stddev-sans-first:1387.18 13:41:02 INFO - PROCESS | 1653 | Values: 254.7 304.8 308.6 316.3 317.5 5057.6 5195.9 5432.4 5541.9 5554.6 4415.6 4616.3 4876.6 5350.4 5426.5 3984.4 4072.1 4121.5 4126.2 4133.5 3325.9 3867.2 4028.9 4206.4 4257.5 3273.9 3985.2 4093.0 4097.7 4185.3 4119.4 4129.9 4163.9 4176.5 4198.9 3123.9 3599.7 3618.3 3623.8 3641.7 4381.9 4437.6 4931.9 5084.7 5114.5 3913.7 4139.7 4614.5 4707.9 4775.6 4741.5 5617.6 5718.9 5727.5 5754.8 3502.3 3525.3 3583.0 3900.3 3910.8 5699.7 5889.0 6042.4 6095.0 6102.0 3608.0 3906.7 3910.6 3916.2 3916.2 3987.5 3988.4 3991.0 4007.3 4030.2 4159.3 4423.4 4676.4 4704.6 4719.6 4779.7 5701.3 5717.7 5729.5 5731.9 1019.2 1160.5 1326.5 1335.4 1348.7 835.9 876.4 876.6 878.8 881.8 5060.3 5397.4 5481.2 5498.3 5510.5 5882.0 5916.0 5922.4 5983.6 6078.8 5071.3 5123.0 5440.0 5467.1 5520.8 3002.8 3079.6 3098.3 3101.9 3132.7 4920.7 5251.9 5808.9 6156.4 6247.3 4847.5 5010.6 5985.9 5998.2 6007.6 5145.8 5281.4 5633.9 6129.6 6154.3 5618.1 5830.5 5910.4 5914.5 5928.9 5766.7 5836.7 5850.3 5859.9 5868.9 4910.3 5237.4 5344.5 6092.4 6152.5 2990.9 3028.4 3238.0 3296.0 3403.9 4069.9 4096.6 4913.7 4928.9 4950.8 4228.8 4747.0 4842.8 4845.8 4853.6 4910.2 5699.1 5752.4 5759.0 5801.4 4475.0 4911.9 5255.4 5367.4 5511.0 4849.7 5328.8 5598.9 5821.3 5919.5 4209.5 4899.7 5668.2 5719.0 5741.8 13:41:02 INFO - PROCESS | 1653 | 13:41:02 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25841.41 Median:3702.25 stddev:42454.23 (1146.7%) stddev-sans-first:42531.31 13:41:02 INFO - PROCESS | 1653 | Values: 687.3 695.1 743.5 783.5 815.2 14681.9 15730.3 15732.8 15758.1 15778.8 14318.9 14455.8 14463.2 14495.4 14501.6 649.0 671.7 673.6 815.0 815.4 667.1 807.4 842.4 843.6 844.5 896.1 896.9 897.2 897.5 902.2 684.7 711.9 846.4 889.4 890.2 658.5 659.4 659.5 659.9 661.2 14895.1 14943.8 14946.9 14958.0 14966.1 13653.9 13718.7 13842.5 13851.0 13924.2 12015.2 12344.7 12392.8 12404.1 12643.9 4448.7 4465.2 4492.8 4553.7 4661.9 119417.4 125397.4 127670.4 128559.4 128768.4 10402.5 10551.5 10670.5 10715.9 10948.3 20877.5 21156.6 21194.4 21250.6 21289.7 7393.6 7509.0 7787.1 7804.7 7846.6 4212.8 4313.5 4342.8 4519.8 4539.2 3100.2 3644.9 3697.9 3706.6 3710.9 687.6 690.5 695.2 695.8 697.7 562.7 578.6 647.5 661.5 691.4 9549.3 9581.0 9587.8 9710.0 9815.7 570.3 634.8 660.2 660.6 686.8 3812.4 4316.3 4557.7 4697.2 4756.6 147224.1 147510.3 160489.0 163714.0 172601.1 133322.0 139924.3 142303.0 142954.3 144813.3 90050.5 93673.5 120596.0 124767.0 127762.0 8755.0 9120.2 9200.7 9225.7 9333.3 50595.7 52829.0 55988.0 60691.7 63288.7 85678.6 92887.0 95364.0 95487.5 97424.0 11594.9 11795.9 12407.9 12415.6 12508.4 14096.9 15254.8 15398.8 15817.2 16126.4 14202.6 14239.8 14692.4 14789.2 14828.6 12040.7 12262.1 13524.1 13727.4 13731.5 11729.8 13061.5 14018.9 14524.3 14529.9 10252.6 10305.0 10818.5 11165.7 11819.5 11476.4 11485.6 11551.1 11561.9 11713.4 13:41:02 INFO - PROCESS | 1653 | -------- Summary: end -------- 13:41:02 INFO - PROCESS | 1653 | 13:41:03 INFO - TEST-INFO | 1653: exit 0 13:41:03 INFO - TEST-OK | dromaeo_css | took 1117480ms 13:41:03 INFO - TEST-START | kraken 13:41:03 INFO - operating with platform_type : mac_ 13:41:03 INFO - Initialising browser for kraken test... 13:41:03 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpOja8kY/profile http://localhost:49274/getInfo.html) 13:41:05 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 13:41:05 INFO - PROCESS | 1664 | colorDepth:24 13:41:05 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 13:41:05 INFO - PROCESS | 1664 | __metrics 13:41:06 INFO - PROCESS | 1664 | 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" 13:41:06 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:41:06 INFO - TEST-INFO | 1664: exit 0 13:41:06 INFO - Browser initialized. 13:41:06 INFO - Running cycle 1/1 for kraken test... 13:41:06 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpOja8kY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:41:19 INFO - PROCESS | 1665 | RSS: Main: 219267072 13:41:19 INFO - PROCESS | 1665 | 13:41:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 13:41:22 INFO - PROCESS | 1665 | RSS: Main: 269676544 13:41:22 INFO - PROCESS | 1665 | 13:41:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 13:41:25 INFO - PROCESS | 1665 | RSS: Main: 280305664 13:41:25 INFO - PROCESS | 1665 | 13:41:28 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 13:41:29 INFO - PROCESS | 1665 | RSS: Main: 376938496 13:41:29 INFO - PROCESS | 1665 | 13:41:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 13:41:32 INFO - PROCESS | 1665 | RSS: Main: 279646208 13:41:32 INFO - PROCESS | 1665 | 13:41:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:41:34 INFO - PROCESS | 1665 | RSS: Main: 279998464 13:41:34 INFO - PROCESS | 1665 | 13:41:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 13:41:38 INFO - PROCESS | 1665 | RSS: Main: 319188992 13:41:38 INFO - PROCESS | 1665 | 13:41:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 13:41:42 INFO - PROCESS | 1665 | RSS: Main: 319582208 13:41:42 INFO - PROCESS | 1665 | 13:41:44 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 13:41:45 INFO - PROCESS | 1665 | RSS: Main: 319488000 13:41:45 INFO - PROCESS | 1665 | 13:41:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:41:47 INFO - PROCESS | 1665 | RSS: Main: 290148352 13:41:47 INFO - PROCESS | 1665 | 13:41:49 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:41:50 INFO - PROCESS | 1665 | RSS: Main: 294715392 13:41:50 INFO - PROCESS | 1665 | 13:41:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:41:52 INFO - PROCESS | 1665 | RSS: Main: 298962944 13:41:52 INFO - PROCESS | 1665 | 13:41:55 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:41:56 INFO - PROCESS | 1665 | RSS: Main: 307994624 13:41:56 INFO - PROCESS | 1665 | 13:41:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:42:00 INFO - PROCESS | 1665 | RSS: Main: 307814400 13:42:00 INFO - PROCESS | 1665 | 13:42:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 13:42:02 INFO - PROCESS | 1665 | RSS: Main: 351739904 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | __start_tp_report 13:42:02 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 13:42:02 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 13:42:02 INFO - PROCESS | 1665 | |i|pagename|runs| 13:42:02 INFO - PROCESS | 1665 | |0;ai-astar;115;115;115;112;116;114;114;114;115;114 13:42:02 INFO - PROCESS | 1665 | |1;audio-beat-detection;141;108;111;143;111;109;111;127;173;137 13:42:02 INFO - PROCESS | 1665 | |2;audio-dft;183;183;183;184;181;182;183;185;184;182 13:42:02 INFO - PROCESS | 1665 | |3;audio-fft;80;58;60;78;69;74;82;82;100;57 13:42:02 INFO - PROCESS | 1665 | |4;audio-oscillator;84;69;94;71;67;69;91;66;69;89 13:42:02 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;89;87;92;112;133;130;90;86;89;86 13:42:02 INFO - PROCESS | 1665 | |6;imaging-darkroom;98;98;98;113;167;97;99;98;96;97 13:42:02 INFO - PROCESS | 1665 | |7;imaging-desaturate;85;84;87;86;89;84;86;82;94;87 13:42:02 INFO - PROCESS | 1665 | |8;json-parse-financial;57;52;52;52;54;57;57;56;56;56 13:42:02 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;64;72;72;74;71;68;70;69;69;69 13:42:02 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;80;80;81;103;83;81;81;82;81;88 13:42:02 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;132;137;138;127;145;151;155;139;167;140 13:42:02 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;162;165;170;226;169;166;164;163;176;225 13:42:02 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;69;73;85;85;85;75;69;66;66 13:42:02 INFO - PROCESS | 1665 | __end_tp_report 13:42:02 INFO - PROCESS | 1665 | __start_cc_report 13:42:02 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1977 13:42:02 INFO - PROCESS | 1665 | __end_cc_report 13:42:02 INFO - PROCESS | 1665 | __startTimestamp1477687322129__endTimestamp 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | ------- Summary: start ------- 13:42:02 INFO - PROCESS | 1665 | Number of tests: 14 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 13:42:02 INFO - PROCESS | 1665 | Values: 115.0 115.0 115.0 112.0 116.0 114.0 114.0 114.0 115.0 114.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:132.00 stddev:21.40 (16.2%) stddev-sans-first:22.10 13:42:02 INFO - PROCESS | 1665 | Values: 141.0 108.0 111.0 143.0 111.0 109.0 111.0 127.0 173.0 137.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:1.15 (0.6%) stddev-sans-first:1.22 13:42:02 INFO - PROCESS | 1665 | Values: 183.0 183.0 183.0 184.0 181.0 182.0 183.0 185.0 184.0 182.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:74.00 Median:76.00 stddev:13.42 (17.7%) stddev-sans-first:14.06 13:42:02 INFO - PROCESS | 1665 | Values: 80.0 58.0 60.0 78.0 69.0 74.0 82.0 82.0 100.0 57.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.50 stddev:11.19 (14.4%) stddev-sans-first:11.57 13:42:02 INFO - PROCESS | 1665 | Values: 84.0 69.0 94.0 71.0 67.0 69.0 91.0 66.0 69.0 89.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:88.00 stddev:18.55 (21.1%) stddev-sans-first:19.29 13:42:02 INFO - PROCESS | 1665 | Values: 89.0 87.0 92.0 112.0 133.0 130.0 90.0 86.0 89.0 86.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:98.00 stddev:21.95 (22.4%) stddev-sans-first:23.09 13:42:02 INFO - PROCESS | 1665 | Values: 98.0 98.0 98.0 113.0 167.0 97.0 99.0 98.0 96.0 97.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:86.50 stddev:3.31 (3.8%) stddev-sans-first:3.47 13:42:02 INFO - PROCESS | 1665 | Values: 85.0 84.0 87.0 86.0 89.0 84.0 86.0 82.0 94.0 87.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:56.00 stddev:2.18 (3.9%) stddev-sans-first:2.18 13:42:02 INFO - PROCESS | 1665 | Values: 57.0 52.0 52.0 52.0 54.0 57.0 57.0 56.0 56.0 56.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.50 stddev:2.74 (3.9%) stddev-sans-first:1.94 13:42:02 INFO - PROCESS | 1665 | Values: 64.0 72.0 72.0 74.0 71.0 68.0 70.0 69.0 69.0 69.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:81.00 stddev:7.07 (8.7%) stddev-sans-first:7.35 13:42:02 INFO - PROCESS | 1665 | Values: 80.0 80.0 81.0 103.0 83.0 81.0 81.0 82.0 81.0 88.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:142.50 stddev:11.79 (8.3%) stddev-sans-first:11.80 13:42:02 INFO - PROCESS | 1665 | Values: 132.0 137.0 138.0 127.0 145.0 151.0 155.0 139.0 167.0 140.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:169.50 stddev:25.05 (14.8%) stddev-sans-first:25.84 13:42:02 INFO - PROCESS | 1665 | Values: 162.0 165.0 170.0 226.0 169.0 166.0 164.0 163.0 176.0 225.0 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:74.00 stddev:8.11 (11.0%) stddev-sans-first:8.20 13:42:02 INFO - PROCESS | 1665 | Values: 67.0 69.0 73.0 85.0 85.0 85.0 75.0 69.0 66.0 66.0 13:42:02 INFO - PROCESS | 1665 | -------- Summary: end -------- 13:42:02 INFO - PROCESS | 1665 | 13:42:02 INFO - TEST-INFO | 1665: exit 0 13:42:02 INFO - TEST-OK | kraken | took 59430ms 13:42:02 INFO - SUITE-END | took 1176s 13:42:03 INFO - Completed test suite (00:19:37) 13:42:03 INFO - javascript benchmark 13:42:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3227.7417806575477, 3360.798352098875, 3401.217719924419, 3418.0, 3429.0570093224374, 5727.656340619561, 5739.540836733062, 5761.251037365148, 5768.07710766278, 5830.183774271605, 5725.971370143154, 5825.359210486843, 5839.941600583993, 5842.503387212092, 5854.151148083536, 5247.685138891669, 5276.34045744282, 5297.44376840432, 5320.574354051667, 5347.786088556453, 5209.973950130244, 5219.660722053073, 5221.425643179247, 5374.543163831059, 5385.3268341457315, 5287.444818294081, 5289.497497737728, 5290.761915713783, 5311.814086506973, 5335.573154147678, 5316.255724198596, 5341.679499230058, 5347.197920311945, 5352.170413585901, 5354.678719276817, 5146.819861304836, 5229.37247530295, 5285.6300058995885, 5290.682559046431, 5306.575473962073, 5631.352394474606, 5691.886162276773, 5698.17376480408, 5734.541236701054, 5736.799212027559, 6176.536759742992, 6189.98389630015, 6219.782307619212, 6232.87534249317, 6268.09112678659, 6151.169592105098, 6207.503399728011, 6222.12890195373, 6235.9376406235815, 6246.718897649616, 4891.33966914462, 5691.3170419549915, 5781.884362312772, 5807.332156801937, 5898.233229680114, 6329.430351268408, 6335.809925702236, 6337.7781777637565, 6339.175907132043, 6363.427291543783, 6126.571140020156, 6212.937870621236, 6215.9378406216265, 6224.657643829632, 6236.469900058546, 6139.706800529493, 6176.505879529627, 6216.191895053705, 6232.252129744369, 6234.438900498977, 6171.043488259237, 6178.598391104564, 6241.469475094577, 6243.188385509855, 6270.717817698214, 6220.471259942956, 6263.592866463665, 6268.655223962726, 6281.026440901667, 6282.277538083087, 4858.344123543347, 4913.70517768935, 4917.729524876095, 4986.4514903360605, 5025.497450254945, 4397.912041759211, 4478.2386994211065, 4478.686491945533, 4482.103579284156, 4522.66080043998, 5848.736806843703, 5883.470487656046, 5893.970530147321, 5897.321807992136, 5901.17383566301, 6130.887362651087, 6255.78104766331, 6262.279837818709, 6262.436380725757, 6279.497640188774, 4912.459629440758, 5691.630044047124, 5835.503982161564, 5891.293044834647, 5992.970035149883, 5406.999705054577, 5458.563314934796, 5462.754176062087, 5467.617266791366, 5482.0, 6447.2907980122145, 6463.741450341934, 6466.997615369625, 6476.579022363531, 6485.513586481033, 6143.757528501975, 6164.951958167033, 6176.629402235881, 6227.719752611053, 6249.500039996698, 6365.172527571386, 6386.584871983307, 6391.296957334783, 6393.264774550986, 6398.520110991787, 6077.726502307495, 6085.543584231289, 6141.170941922962, 6175.475084617858, 6188.133661287513, 5081.974590127025, 6072.757089716361, 6147.969260153671, 6167.383261673976, 6217.720202590985, 4691.08523837862, 6025.216721826135, 6149.200603921461, 6208.037754148114, 6210.285817130907, 6102.359252278625, 6136.846578835565, 6181.381861813783, 6188.44304012641, 6211.378862113753, 5767.279090113736, 5866.384029676822, 5921.904447677021, 6069.696515174312, 6106.45041946227, 6066.939330606638, 6128.105930682507, 6133.6319820810895, 6145.108959200801, 6164.3835616438, 5945.702714864326, 6020.066889632114, 6020.608660437058, 6038.849028774316, 6043.909341359795], "value": 5725.834467289352, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.42469037155416, 508.99745501272486, 513.5378159656311, 523.8873642166934, 557.7099908047818, 30150.24624384389, 34200.1449963751, 37832.43251351232, 39256.018599535026, 42007.78996105023, 41416.585834141726, 41849.790751046276, 41860.16279674404, 41926.790366048204, 41936.0, 9728.367656102366, 9915.801683966352, 9921.603135874557, 9926.057024582653, 9943.751406214866, 7513.849723005536, 9018.503982280972, 11893.940530297335, 12148.906598406142, 12171.695707607336, 12063.0, 12183.32991685457, 12184.390780460986, 12199.390030498484, 12205.57280495183, 8808.29533637314, 12159.452824622913, 12219.26684398939, 12236.938815305955, 12258.50965961365, 8713.869291960626, 11505.769884602261, 11860.762784744256, 11867.05063594919, 12134.27194368332, 39950.60049399498, 40237.59762402397, 40381.394279085835, 40393.0, 40410.0, 3259.6251431085493, 3343.5820522434697, 3380.3746306933294, 3596.4777682632644, 3678.1172518595613, 29518.55722164169, 30825.537616935762, 31091.0, 31111.0, 31535.684643153505, 3115.3613509230554, 3245.2049247934406, 3247.3342964692183, 3281.1797050737314, 3355.0605830367535, 515975.0, 517381.89163379476, 517831.0, 519059.0, 519400.0, 32852.67147328544, 33535.0, 56627.71686141543, 56966.43033569611, 57197.0, 34879.30241395158, 34936.0, 34981.82509087438, 34992.30015399678, 35094.29811403758, 14942.25288735559, 15064.397424103132, 15096.943213974917, 15117.017393869362, 15123.924380378248, 11485.310881347146, 11702.0, 12829.0, 12913.225206487641, 12953.481860725466, 7463.365613922877, 7662.961685191538, 7669.0, 7728.92271077282, 7817.491863028885, 3160.652328243891, 3207.3264614430764, 3217.8391080446354, 3244.416005119054, 3251.349730053999, 866.2160744526213, 909.5952301226023, 967.3180407812475, 977.6675930183771, 1028.1517747858047, 28806.711932880404, 29630.851845741065, 29745.810167593485, 30358.69641303603, 30371.544426833614, 763.1376544504674, 993.279872092727, 999.5701848205196, 1046.419237323293, 1063.5320458998017, 14797.482088127079, 15401.383944642314, 15445.382184712485, 15660.295286712126, 15797.763033554505, 696474.0, 705776.0, 705881.0, 706465.0, 709288.0, 53589.66025849307, 56970.715146424, 57495.13757293644, 57560.42439575551, 57563.71218143882, 1014.4927536231884, 1171.9648410547697, 1173.3605185174101, 1244.5830646733446, 1379.9103058301177, 30065.248368790955, 30187.69812301849, 30744.846275769374, 31045.0686479406, 31400.68599314069, 47951.76024119857, 48565.0, 48597.0, 48674.26988595103, 48786.756066219445, 562102.0, 562399.0, 563174.0, 563305.0, 693850.0, 40218.1956360877, 40900.59099408968, 40950.59049409587, 41139.177216456104, 41386.79306603448, 44524.10951781011, 44554.0, 44580.33129502995, 44736.77631611821, 45317.32024019576, 36787.816060919526, 37090.70182543598, 38056.80971595124, 38941.61058389493, 39128.0, 37474.03531197624, 37666.623333766314, 38376.04059898525, 38478.42282365711, 38623.42064868973, 35889.0, 36406.27187456289, 37379.43930840985, 37476.812615936746, 37525.62474375221, 27596.724032759415, 31752.841235793672, 34297.79957701469, 34390.0, 34405.0, 24704.0, 25140.497190056463, 25328.113516027588, 25591.360215994748, 25650.0], "value": 18972.750030909774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.63222248861183, 373.6319725070805, 373.68797054459526, 384.9287881741879, 405.1370580663189, 15150.848491515082, 15413.306401211945, 17019.0, 20132.59734805303, 20800.0, 19569.0, 20202.494937626565, 20240.39278821634, 20312.59374812503, 20380.082896269665, 4798.688085274463, 5197.714125723083, 5448.0, 5452.809151679692, 5456.0997435423105, 3868.883933482, 4079.2657321682086, 5979.551533634973, 6017.157597936292, 6123.479504242123, 3980.104476492795, 5824.912626310609, 6053.0, 6076.635401875879, 6127.662978536178, 5081.314022606938, 6050.2437195350585, 6102.847428814271, 6123.173371594822, 6132.141500189977, 5898.056310990264, 5901.675407852566, 5902.881942361171, 5910.34986151523, 5910.822675319747, 12899.613011609667, 13008.219506829526, 13051.477940882352, 13243.006774491952, 13297.468101275937, 2142.078906070389, 2161.459635091227, 2170.4248374180856, 2210.5910406574835, 2720.64631597893, 9530.332876698634, 9914.652987145415, 10408.479576021244, 10424.843627345595, 11288.492017859217, 1563.7732528783263, 1855.4526414707693, 1877.1646617255326, 1910.570121722615, 1945.9610807783906, 100800.0, 123590.38204808919, 127417.35495870278, 128679.0, 132888.0, 11251.099912007183, 11431.59989400367, 11514.827277590843, 11537.88462115368, 11705.765884682429, 14777.704445911022, 14793.186374749277, 14799.482018129314, 14813.037152585048, 14842.183679897493, 8422.789430264293, 8635.568221588896, 8645.0, 8746.91253087461, 8761.780955476164, 8699.913000870038, 8733.737987860375, 8773.912260877309, 8905.777355566162, 8931.660250962277, 4446.599806017474, 4522.977385113053, 4529.728216307032, 4616.8614941551805, 4647.86056418308, 1738.6696527659703, 1856.7307740377569, 1896.9810301896805, 1912.1013123832056, 1917.9520511987032, 730.0910366593625, 807.8384323135278, 886.8492356299445, 942.6747772018642, 978.5058545434653, 19835.504112397306, 21189.152433902473, 21310.147594096372, 21437.142514299565, 21582.590309775922, 900.2348004196512, 922.3405265235389, 968.3899143539525, 977.237754551451, 1001.2790790630734, 10937.343759374464, 11194.0, 11247.437628118561, 11258.943705281421, 11265.0, 629024.0, 629391.0, 635692.0, 644472.0, 644935.0, 131680.0, 133264.0, 135024.6497535012, 138103.0, 139983.30008350097, 962.9422234665942, 965.4931161140317, 993.0466751918095, 993.7813680990171, 994.0010289658991, 18454.81545184531, 18649.160787764853, 18752.343667971556, 18770.718439223696, 18785.0, 54602.453975459735, 55418.44581554133, 55642.443575563724, 56552.86894262174, 57287.71356143193, 67485.0, 79509.20490795017, 82541.58729206315, 82552.58723706343, 84409.57795210984, 7889.566073865993, 7938.364930805406, 8183.263506284225, 8204.0, 8470.194419953037, 9675.9032409675, 12883.613491595268, 12971.0, 13032.804507932198, 13139.474421023053, 11112.888871111185, 11220.551177953117, 11428.657140285804, 11438.771224575628, 11528.308301501937, 11183.440827958731, 11322.830157547809, 11323.0, 11534.0, 11627.011704005254, 9344.486053267136, 11495.827562586735, 11504.0, 11506.712332191762, 11799.05607551411, 8140.226678465537, 8286.544240066612, 8468.830623387374, 11178.88821111811, 11997.460114295052, 11283.210175287652, 11514.424278786195, 11646.184767066225, 11816.291022538675, 11831.763364732486], "value": 9433.99329129442, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.4718354208944, 1480.4226351722828, 1695.9915200423995, 1891.6973284274518, 1922.9230830766778, 8073.91926080739, 8309.293710034639, 8691.869621955675, 9099.499527525992, 9102.726918192464, 8542.444741091826, 8775.473471591693, 8787.780305492366, 8903.065178156297, 8916.375853690244, 2170.6216552489127, 2393.7127544694663, 2401.5076909233608, 2433.5132973405302, 2439.134107391877, 2125.3305208859238, 2215.745189303235, 2336.5093330400637, 2379.583572874749, 2443.0472115874823, 2175.771543987882, 2206.249875042485, 2317.7102862142233, 2412.407810844843, 2413.191580820427, 2387.9164229252065, 2404.6873906392057, 2408.205292253552, 2410.6866107406013, 2415.879206039691, 2392.186656536786, 2397.44858682504, 2402.0, 2406.2420337593603, 2413.384586930339, 8835.55822208887, 8918.92972843263, 8971.551422428853, 8974.50640214788, 8989.0, 5272.0, 5463.125899856004, 5468.28912241406, 5469.671819690831, 5470.452954704538, 3480.756347055707, 3548.7870727756417, 3671.155634204148, 3672.8714494992814, 3676.7793932364143, 1067.6156583629886, 1074.693712291993, 1102.7849569333982, 1117.6870476266658, 1120.6918097523246, 11999.580014699444, 12083.57707480234, 12100.394980250952, 12104.213226140273, 12139.0, 4716.0, 4741.942535156548, 4780.521947805191, 4881.072596206709, 4895.975520122377, 8595.828083438297, 10058.849117263248, 10079.294449388472, 10087.142592879542, 10101.0, 5423.376311724202, 5424.538914192338, 5426.321709786277, 5435.83692489226, 5436.91844622331, 4859.781309841065, 4931.4821943696115, 4939.7897515109025, 4954.355933728592, 4978.551930326215, 3839.827207775657, 3846.0, 3879.534455865314, 3926.0, 3936.3505021671676, 1113.3264375052977, 1164.5050853387445, 1164.9009834164021, 1177.140687298277, 1181.8759030301867, 780.9062912450429, 783.1581050370875, 882.6910581296495, 890.9242714369221, 938.1509733691021, 5826.533877289891, 5934.525237980951, 6101.7559297627595, 6111.938880611137, 6321.525885558602, 880.348542078857, 990.1978399313325, 1008.5411137932223, 1044.4464433850071, 1065.3394895164893, 3804.2391521695217, 3814.7138964577766, 3922.7254092213843, 3933.7443066200603, 3956.7032472564097, 10744.355338679705, 10990.285631433931, 11088.33469991803, 11100.389478578594, 11149.108071354434, 11028.889711102785, 11038.448077596087, 11040.282381645327, 11054.834177487344, 11056.170787190993, 7830.686772529035, 8153.633086511002, 8156.306713929383, 8196.795080123045, 8303.916960830435, 4966.801327946841, 5981.7607295707685, 5984.401559843981, 6067.939320606914, 6175.465931563485, 9416.199623032118, 9779.826420829262, 9988.151007164472, 10285.43430111351, 10311.742206444898, 9958.701238962843, 10305.587776488857, 10426.218033647356, 10444.529996150039, 10453.477326133814, 7516.436267280085, 7674.654640541077, 7776.961115194388, 7777.338926191337, 7778.027746531684, 8361.289290410383, 8371.706990255556, 8450.19723126302, 8451.45065570736, 8457.957710211409, 7535.54786712799, 7588.582627955516, 7612.162662107053, 7617.390608751176, 7641.0, 7363.484556081237, 7450.552966822008, 7456.478046536908, 7461.626918654154, 7527.774166775005, 6990.825229369307, 7083.256258093033, 7088.539244949062, 7127.8574428512175, 7134.607596582237, 4213.052063285736, 4223.176480586256, 4310.771430142394, 4347.608715215646, 4357.389965404909, 5000.424951130666, 5011.198208286803, 5100.336956195671, 5170.8965820684125, 5265.473452654704], "value": 4618.185580651088, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [254.68037612795942, 304.83538888999925, 308.58187156403073, 316.323068633125, 317.4666560178899, 5057.570106540944, 5195.856911479478, 5432.402435732071, 5541.871305877117, 5554.583406244537, 4415.631154342156, 4616.307553866922, 4876.634542328154, 5350.384705758839, 5426.484483974016, 3984.4023396490616, 4072.124493233954, 4121.505419349683, 4126.174765046995, 4133.545310015896, 3325.883594074208, 3867.207222519377, 4028.858989935353, 4206.41110244566, 4257.489101307848, 3273.8690452381875, 3985.1867400332926, 4092.9795351023204, 4097.6516996055225, 4185.28850095483, 4119.402686610455, 4129.855455059059, 4163.875083747493, 4176.540580536139, 4198.853040143611, 3123.891018688378, 3599.748017638766, 3618.2582570572968, 3623.800690961996, 3641.708663306929, 4381.912361752779, 4437.622802061828, 4931.876703082416, 5084.669496482717, 5114.514121158484, 3913.7064720146104, 4139.668826493903, 4614.5385461453925, 4707.882302942419, 4775.617950563947, 4741.502142275081, 5617.578681598897, 5718.857028574277, 5727.484526392603, 5754.798582049608, 3502.3345564342694, 3525.2679173640377, 3583.0, 3900.258950799339, 3910.843566257346, 5699.658020518741, 5889.0, 6042.39576042401, 6095.019118786412, 6102.0, 3608.0, 3906.7069969752383, 3910.550286717007, 3916.236333914859, 3916.236333914859, 3987.5414327352146, 3988.4017397390044, 3991.002249437641, 4007.2987227235117, 4030.234255491447, 4159.292920203573, 4423.447069116361, 4676.375808748179, 4704.600108990774, 4719.59883409914, 4779.665423420397, 5701.348872774097, 5717.742701578439, 5729.541636669056, 5731.914021289601, 1019.1744686803713, 1160.5183848702693, 1326.4627825730595, 1335.3923964596086, 1348.7321917397614, 835.9456635318685, 876.3909083187124, 876.6230520875957, 878.8198419324024, 881.8148188880278, 5060.342155519833, 5397.353807088875, 5481.205225242317, 5498.323011481537, 5510.476504732044, 5881.9705901470215, 5915.988563888299, 5922.437368449991, 5983.640981541122, 6078.817635470943, 5071.3153724247495, 5122.975404918957, 5439.972800135974, 5467.059193986078, 5520.779168833202, 3002.7597792176575, 3079.5688603595513, 3098.2873938993707, 3101.937961240808, 3132.733717633981, 4920.736461227875, 5251.947480525146, 5808.883822323614, 6156.415140561639, 6247.344028876993, 4847.497275844499, 5010.64925455222, 5985.910211346833, 5998.170557979771, 6007.609505382136, 5145.819896303761, 5281.355864453438, 5633.859133529315, 6129.570930034944, 6154.292256390572, 5618.134751276796, 5830.47525722687, 5910.438508341701, 5914.497267732291, 5928.851778705567, 5766.682832444256, 5836.737346819488, 5850.327212370462, 5859.9121013183985, 5868.853278668067, 4910.263460480956, 5237.371515418175, 5344.499352923841, 6092.39076092405, 6152.50779937595, 2990.9083184637884, 3028.4258380376505, 3237.951430728494, 3295.978246743517, 3403.9149021274666, 4069.9389509156795, 4096.610821971908, 4913.65604407688, 4928.852134435972, 4950.8267210647455, 4228.78856057202, 4746.952530474651, 4842.806287748451, 4845.781939812647, 4853.587445067209, 4910.189818679878, 5699.145128230799, 5752.424757524214, 5759.0, 5801.419858014165, 4475.0, 4911.852644420673, 5255.421903590525, 5367.35591728995, 5511.0080185566985, 4849.684770489906, 5328.8276579152525, 5598.916016259841, 5821.301443826768, 5919.507490580578, 4209.515905670887, 4899.730514821719, 5668.234788303526, 5719.0, 5741.7655204131315], "value": 4059.0939398881114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.2955220898575, 695.0790202981051, 743.5390058163936, 783.5220515485553, 815.2255357410462, 14681.926590367046, 15730.292136853841, 15732.84267157328, 15758.133302668362, 15778.842211577881, 14318.92840535796, 14455.78316325256, 14463.20452375119, 14495.420183192686, 14501.564953051426, 648.9772857949972, 671.7010930136091, 673.6126727131895, 814.9633266502992, 815.4006804998321, 667.1060778556733, 807.3662175192475, 842.4187310755559, 843.6456688190943, 844.5270648436895, 896.0636135238659, 896.8923729152478, 897.228383590112, 897.4749771383748, 902.1880307723036, 684.7055766020609, 711.9288071192839, 846.4371193156544, 889.4129874283007, 890.1632465482426, 658.4896705053574, 659.3768888400464, 659.5251418978328, 659.9274079851212, 661.1966460750211, 14895.106293622417, 14943.775843362359, 14946.925265373713, 14958.0, 14966.102033877893, 13653.931730341385, 13718.725625487534, 13842.515511957034, 13851.030427870053, 13924.164550127025, 12015.219010764273, 12344.691382715415, 12392.81410778839, 12404.069694772928, 12643.873561264361, 4448.733076015417, 4465.151621191995, 4492.820287188509, 4553.749543775091, 4661.88345291367, 119417.40291298575, 125397.37301313526, 127670.36164819209, 128559.35720321433, 128768.35615821954, 10402.47987600617, 10551.525181366856, 10670.51982660782, 10715.946420267848, 10948.346952545136, 20877.478063048242, 21156.576868462544, 21194.364169074954, 21250.574988500142, 21289.68065479019, 7393.556386616712, 7509.0, 7787.143414224431, 7804.726834560764, 7846.646900889474, 4212.757236615206, 4313.50394704613, 4342.804573794124, 4519.796609152596, 4539.228331183706, 3100.162956001867, 3644.908877278036, 3697.926041479155, 3706.5737440194184, 3710.870119545857, 687.621808005595, 690.4821383962028, 695.2144077192739, 695.7808290388512, 697.6546609428366, 562.7073921560766, 578.5602941764289, 647.4593714248655, 661.4741280681774, 691.3777600159796, 9549.28380371461, 9580.95209523948, 9587.808243835223, 9710.0, 9815.705528834147, 570.2814453788257, 634.8381162803455, 660.2275337854721, 660.577230572434, 686.7527690031585, 3812.390017597171, 4316.252735038911, 4557.680962332605, 4697.154512187839, 4756.595689366373, 147224.055518889, 147510.26244868708, 160489.0, 163714.0, 172601.13699431423, 133322.0, 139924.3003784995, 142303.0, 142954.2852285732, 144813.27593361965, 90050.54974725084, 93673.53163234277, 120595.98510037319, 124767.0, 127762.0, 8755.0, 9120.179183873483, 9200.677976271067, 9225.677101301691, 9333.346665733334, 50595.74702126466, 52829.0, 55988.0, 60691.69654151701, 63288.68355658192, 85678.57160714157, 92887.0, 95364.0, 95487.52256238674, 97424.0, 11594.94202528982, 11795.941020294844, 12407.937960310503, 12415.565455209024, 12508.374581271082, 14096.859031409966, 15254.771178432555, 15398.846011539741, 15817.209139543207, 16126.354945802037, 14202.573922782332, 14239.786403204167, 14692.412303508168, 14789.186594737394, 14828.555143345717, 12040.698982525157, 12262.141650084764, 13524.05331626816, 13727.382267798173, 13731.519396821062, 11729.794214136322, 13061.477540898257, 14018.929905350407, 14524.346404412037, 14529.927350363181, 10252.58989640406, 10305.0, 10818.459077045958, 11165.72085697864, 11819.527218911491, 11476.368799716096, 11485.598004069818, 11551.133664974992, 11561.942190289332, 11713.355765432983], "value": 7843.021251732681, "unit": "score"}], "name": "dromaeo_css", "value": 7294.833974113101, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 112.0, 116.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 111.0, 143.0, 111.0, 109.0, 111.0, 127.0, 173.0, 137.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 184.0, 181.0, 182.0, 183.0, 185.0, 184.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 60.0, 78.0, 69.0, 74.0, 82.0, 82.0, 100.0, 57.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 94.0, 71.0, 67.0, 69.0, 91.0, 66.0, 69.0, 89.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 92.0, 112.0, 133.0, 130.0, 90.0, 86.0, 89.0, 86.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 113.0, 167.0, 97.0, 99.0, 98.0, 96.0, 97.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 87.0, 86.0, 89.0, 84.0, 86.0, 82.0, 94.0, 87.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 52.0, 52.0, 54.0, 57.0, 57.0, 56.0, 56.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 72.0, 74.0, 71.0, 68.0, 70.0, 69.0, 69.0, 69.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 103.0, 83.0, 81.0, 81.0, 82.0, 81.0, 88.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 137.0, 138.0, 127.0, 145.0, 151.0, 155.0, 139.0, 167.0, 140.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 170.0, 226.0, 169.0, 166.0, 164.0, 163.0, 176.0, 225.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 73.0, 85.0, 85.0, 85.0, 75.0, 69.0, 66.0, 66.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1471.6999999999998, "alertThreshold": 2.0}]} 13:42:03 INFO - Return code: 0 13:42:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:42:03 INFO - # TBPL SUCCESS # 13:42:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:42:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:42:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:42:03 INFO - 2016-10-28 13:42:03.446 screenresolution[1669:10061] starting screenresolution argv=screenresolution get 13:42:03 INFO - 2016-10-28 13:42:03.448 screenresolution[1669:10061] Display 0: 1600x1200x32@60 13:42:03 INFO - 2016-10-28 13:42:03.454 screenresolution[1670:10064] starting screenresolution argv=screenresolution list 13:42:03 INFO - Available Modes on Display 0 13:42:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:42:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:42:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:42:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:42:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:42:03 INFO - Intel Iris: 13:42:03 INFO - Chipset Model: Intel Iris 13:42:03 INFO - Type: GPU 13:42:03 INFO - Bus: Built-In 13:42:03 INFO - VRAM (Dynamic, Max): 1536 MB 13:42:03 INFO - Vendor: Intel (0x8086) 13:42:03 INFO - Device ID: 0x0a2e 13:42:03 INFO - Revision ID: 0x0009 13:42:03 INFO - Displays: 13:42:03 INFO - Display: 13:42:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:42:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:42:03 INFO - Display Serial Number: 1600x1200 60 13:42:03 INFO - Main Display: Yes 13:42:03 INFO - Mirror: Off 13:42:03 INFO - Online: Yes 13:42:03 INFO - Rotation: Supported 13:42:03 INFO - Return code: 0 13:42:03 INFO - Running post-action listener: _resource_record_post_action 13:42:03 INFO - [mozharness: 2016-10-28 20:42:03.698638Z] Finished run-tests step (success) 13:42:03 INFO - Running post-run listener: _resource_record_post_run 13:42:03 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 48863232; Write bytes: 673895936; Read time: 385; Write time: 1937 13:42:03 INFO - TinderboxPrint: CPU usage
53.3% 13:42:03 INFO - TinderboxPrint: I/O read bytes / time
48,863,232 / 385 13:42:03 INFO - TinderboxPrint: I/O write bytes / time
673,895,936 / 1,937 13:42:03 INFO - TinderboxPrint: CPU idle
2,262.2 (46.7%) 13:42:03 INFO - TinderboxPrint: CPU system
967.7 (20.0%) 13:42:03 INFO - TinderboxPrint: CPU user
1,615.8 (33.3%) 13:42:03 INFO - TinderboxPrint: Swap in / out
405,221,376 / 0 13:42:03 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 360804864; Write bytes: 356411392; Read time: 28134; Write time: 715 13:42:03 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 46774272; Write bytes: 306212352; Read time: 363; Write time: 1185 13:42:04 INFO - Running post-run listener: _upload_blobber_files 13:42:04 INFO - Blob upload gear active. 13:42:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:42:04 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 13:42:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:42:04 INFO - (blobuploader) - INFO - Open directory for files ... 13:42:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:42:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:42:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:05 INFO - (blobuploader) - INFO - Done attempting. 13:42:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:42:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:42:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:07 INFO - (blobuploader) - INFO - Done attempting. 13:42:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:42:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:09 INFO - (blobuploader) - INFO - Done attempting. 13:42:09 INFO - (blobuploader) - INFO - Iteration through files over. 13:42:10 INFO - Return code: 0 13:42:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:42:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:42:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b88af8f659641a9e3d7d8c9b227e7c79c0db2da0d935f3f328708ef6a4799cf98a6bcee9d49f902983fb288ff0b8c60df905392ede1db2705d01573c5edd43be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5f2c7984b7041c059b8af740d1f2909a55fd0177da6115b97b46c8a6a1ff476e29bf91e7326e4b237480f63e326e1d76ebc8d4d5a4045f05fb6c600a18d431c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5e8abaa29a0b73678cb382c6887812e2811c426d5af8251ae0398ab0beaa85aef170a93cbf123eea9809397796f654c5b687e08788ef8659cd7ed3b9a865f73"} 13:42:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:42:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:42:10 INFO - Contents: 13:42:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b88af8f659641a9e3d7d8c9b227e7c79c0db2da0d935f3f328708ef6a4799cf98a6bcee9d49f902983fb288ff0b8c60df905392ede1db2705d01573c5edd43be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5f2c7984b7041c059b8af740d1f2909a55fd0177da6115b97b46c8a6a1ff476e29bf91e7326e4b237480f63e326e1d76ebc8d4d5a4045f05fb6c600a18d431c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5e8abaa29a0b73678cb382c6887812e2811c426d5af8251ae0398ab0beaa85aef170a93cbf123eea9809397796f654c5b687e08788ef8659cd7ed3b9a865f73"} 13:42:10 INFO - Running post-run listener: copy_logs_to_upload_dir 13:42:10 INFO - Copying logs to upload dir... 13:42:10 INFO - mkdir: /builds/slave/test/build/upload/logs 13:42:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.864053 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-28 13:42:10.065455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 13:42:10.069044) ========= 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.SJeQAmoOzy/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.LGLsz0f458/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b88af8f659641a9e3d7d8c9b227e7c79c0db2da0d935f3f328708ef6a4799cf98a6bcee9d49f902983fb288ff0b8c60df905392ede1db2705d01573c5edd43be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5f2c7984b7041c059b8af740d1f2909a55fd0177da6115b97b46c8a6a1ff476e29bf91e7326e4b237480f63e326e1d76ebc8d4d5a4045f05fb6c600a18d431c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5e8abaa29a0b73678cb382c6887812e2811c426d5af8251ae0398ab0beaa85aef170a93cbf123eea9809397796f654c5b687e08788ef8659cd7ed3b9a865f73"} build_url:https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/DtZMFzuGSsafyvR6csxpKw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b88af8f659641a9e3d7d8c9b227e7c79c0db2da0d935f3f328708ef6a4799cf98a6bcee9d49f902983fb288ff0b8c60df905392ede1db2705d01573c5edd43be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5f2c7984b7041c059b8af740d1f2909a55fd0177da6115b97b46c8a6a1ff476e29bf91e7326e4b237480f63e326e1d76ebc8d4d5a4045f05fb6c600a18d431c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e5e8abaa29a0b73678cb382c6887812e2811c426d5af8251ae0398ab0beaa85aef170a93cbf123eea9809397796f654c5b687e08788ef8659cd7ed3b9a865f73"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 13:42:10.103064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 13:42:10.103431) ========= 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.SJeQAmoOzy/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.LGLsz0f458/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.005199 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 13:42:10.152480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 13:42:10.152811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 13:42:10.153153) ========= ========= Total master_lag: 2.29 =========