builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0199 starttime: 1487001991.81 results: success (0) buildid: 20170213070540 builduid: 1fc6b61c4883413698beb74ddcd024a0 revision: 55b9181a1979e32d583a85cb6106900301444e69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:31.805876) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:31.806337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:31.806615) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:31.835814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:31.836078) ========= 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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 --2017-02-13 08:06:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 176M=0s 2017-02-13 08:06:32 (176 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.591122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:32.451066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:32.454398) ========= 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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.028272 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:32.503774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 08:06:32.504098) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 55b9181a1979e32d583a85cb6106900301444e69 --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 55b9181a1979e32d583a85cb6106900301444e69 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 2017-02-13 08:06:32,594 truncating revision to first 12 chars 2017-02-13 08:06:32,594 Setting DEBUG logging. 2017-02-13 08:06:32,594 attempt 1/10 2017-02-13 08:06:32,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/55b9181a1979?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 08:06:33,600 unpacking tar archive at: mozilla-aurora-55b9181a1979/testing/mozharness/ program finished with exit code 0 elapsedTime=1.275825 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 08:06:33.803297) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.806617) ========= script_repo_revision: 55b9181a1979e32d583a85cb6106900301444e69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.806997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.807257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.826835) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-13 08:06:33.827101) ========= /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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:06:34 INFO - MultiFileLogger online at 20170213 08:06:34 in /builds/slave/test 08:06:34 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 08:06:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:34 INFO - {'append_to_log': False, 08:06:34 INFO - 'base_work_dir': '/builds/slave/test', 08:06:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:06:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:34 INFO - 'branch': 'Mozilla-Aurora', 08:06:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:34 INFO - 'config_files': ('talos/mac_config.py',), 08:06:34 INFO - 'default_actions': ('clobber', 08:06:34 INFO - 'read-buildbot-config', 08:06:34 INFO - 'download-and-extract', 08:06:34 INFO - 'populate-webroot', 08:06:34 INFO - 'create-virtualenv', 08:06:34 INFO - 'install', 08:06:34 INFO - 'run-tests'), 08:06:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:34 INFO - 'download_minidump_stackwalk': True, 08:06:34 INFO - 'download_symbols': 'ondemand', 08:06:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:34 INFO - 'installer_path': 'installer.exe', 08:06:34 INFO - 'log_level': 'info', 08:06:34 INFO - 'log_name': 'talos', 08:06:34 INFO - 'log_to_console': True, 08:06:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:06:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:06:34 INFO - 'opt_config_files': (), 08:06:34 INFO - 'pip_index': False, 08:06:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:06:34 INFO - 'cmd': ('bash', 08:06:34 INFO - '-c', 08:06:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:06:34 INFO - 'enabled': True, 08:06:34 INFO - 'halt_on_failure': False, 08:06:34 INFO - 'name': 'check_screen_resolution'},), 08:06:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:06:34 INFO - 'cmd': ('bash', 08:06:34 INFO - '-c', 08:06:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:06:34 INFO - 'enabled': True, 08:06:34 INFO - 'halt_on_failure': False, 08:06:34 INFO - 'name': 'check_screen_resolution'},), 08:06:34 INFO - 'run_cmd_checks_enabled': True, 08:06:34 INFO - 'sps_profile': False, 08:06:34 INFO - 'sps_profile_interval': 0, 08:06:34 INFO - 'suite': 'dromaeojs', 08:06:34 INFO - 'system_bits': '32', 08:06:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:34 INFO - 'title': 't-yosemite-r7-0199', 08:06:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:34 INFO - 'use_talos_json': True, 08:06:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:34 INFO - 'work_dir': 'build'} 08:06:34 INFO - [mozharness: 2017-02-13 16:06:34.032285Z] Running clobber step. 08:06:34 INFO - Running pre-action listener: _resource_record_pre_action 08:06:34 INFO - Running main action method: clobber 08:06:34 INFO - rmtree: /builds/slave/test/build 08:06:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:36 INFO - Running post-action listener: _resource_record_post_action 08:06:36 INFO - [mozharness: 2017-02-13 16:06:36.563740Z] Finished clobber step (success) 08:06:36 INFO - [mozharness: 2017-02-13 16:06:36.563865Z] Running read-buildbot-config step. 08:06:36 INFO - Running pre-action listener: _resource_record_pre_action 08:06:36 INFO - Running main action method: read_buildbot_config 08:06:36 INFO - Using buildbot properties: 08:06:36 INFO - { 08:06:36 INFO - "project": "", 08:06:36 INFO - "product": "firefox", 08:06:36 INFO - "script_repo_revision": "production", 08:06:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:06:36 INFO - "repository": "", 08:06:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:06:36 INFO - "buildid": "20170213070540", 08:06:36 INFO - "pgo_build": "False", 08:06:36 INFO - "basedir": "/builds/slave/test", 08:06:36 INFO - "buildnumber": 4, 08:06:36 INFO - "slavename": "t-yosemite-r7-0199", 08:06:36 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:06:36 INFO - "platform": "yosemite_r7", 08:06:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:06:36 INFO - "branch": "mozilla-aurora", 08:06:36 INFO - "repo_path": "releases/mozilla-aurora", 08:06:36 INFO - "revision": "55b9181a1979e32d583a85cb6106900301444e69", 08:06:36 INFO - "stage_platform": "macosx64", 08:06:36 INFO - "builduid": "1fc6b61c4883413698beb74ddcd024a0", 08:06:36 INFO - "slavebuilddir": "test" 08:06:36 INFO - } 08:06:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:06:36 INFO - Running post-action listener: _resource_record_post_action 08:06:36 INFO - [mozharness: 2017-02-13 16:06:36.567145Z] Finished read-buildbot-config step (success) 08:06:36 INFO - [mozharness: 2017-02-13 16:06:36.567261Z] Running download-and-extract step. 08:06:36 INFO - Running pre-action listener: _resource_record_pre_action 08:06:36 INFO - Running main action method: download_and_extract 08:06:36 INFO - mkdir: /builds/slave/test/build/tests 08:06: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')]} 08:06:36 INFO - trying https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:06:36 INFO - Downloading https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:06:37 INFO - Downloaded 1199 bytes. 08:06:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:06:37 INFO - Using the following test package requirements: 08:06:37 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:06:37 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:37 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:06:37 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:37 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:06:37 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:37 INFO - u'jsshell-mac.zip'], 08:06:37 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:37 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:06:37 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:06:37 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:37 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:06:37 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:37 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:06:37 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:37 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:06:37 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:37 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:06:37 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:06:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:06:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:06:37 INFO - Fetch https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:06:38 INFO - Expected file size: 16358347 08:06:38 INFO - Obtained file size: 16358347 08:06:45 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:06:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:06:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:06:45 INFO - Fetch https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:06:46 INFO - Expected file size: 16358347 08:06:46 INFO - Obtained file size: 16358347 08:06:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:06:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:06:53 INFO - Fetch https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:06:54 INFO - Expected file size: 14403485 08:06:54 INFO - Obtained file size: 14403485 08:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:54 INFO - trying https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:06:54 INFO - Downloading https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:06:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:06:56 INFO - Downloaded 73961800 bytes. 08:06:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:06:56 INFO - mkdir: /builds/slave/test/properties 08:06:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:06:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:06:56 INFO - Contents: 08:06:56 INFO - build_url:https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:06:57 INFO - Running post-action listener: _resource_record_post_action 08:06:57 INFO - Running post-action listener: set_extra_try_arguments 08:06:57 INFO - [mozharness: 2017-02-13 16:06:57.281960Z] Finished download-and-extract step (success) 08:06:57 INFO - [mozharness: 2017-02-13 16:06:57.282153Z] Running populate-webroot step. 08:06:57 INFO - Running pre-action listener: _resource_record_pre_action 08:06:57 INFO - Running main action method: populate_webroot 08:06:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:06:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:06:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:06:57 INFO - '--tppagecycles', 08:06:57 INFO - '7'], 08:06:57 INFO - 'tests': ['tsvgm']}}, 08:06:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:06:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:06:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:06:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:06:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['damp', 'tps']}, 08:06:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'tests': ['damp', 'tps']}, 08:06:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['dromaeo_dom']}, 08:06:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:06:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['basic_compositor_video']}, 08:06:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:06:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other-e10s': {'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['tsvgx', 08:06:57 INFO - 'tsvgr_opacity', 08:06:57 INFO - 'tart', 08:06:57 INFO - 'tscrollx', 08:06:57 INFO - 'cart', 08:06:57 INFO - 'tsvg_static']}, 08:06:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:06:57 INFO - 'tsvgr_opacity', 08:06:57 INFO - 'tart', 08:06:57 INFO - 'tscrollx', 08:06:57 INFO - 'cart', 08:06:57 INFO - 'tsvg_static']}, 08:06:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['tp5o']}, 08:06:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:06:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--disable-e10s', 08:06:57 INFO - '--xperf_path', 08:06:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:57 INFO - 'tests': ['tp5n']}, 08:06:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--xperf_path', 08:06:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:57 INFO - 'tests': ['tp5n']}}, 08:06:57 INFO - 'talos.zip': {'path': '', 08:06:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:06:57 INFO - Running post-action listener: _resource_record_post_action 08:06:57 INFO - [mozharness: 2017-02-13 16:06:57.300889Z] Finished populate-webroot step (success) 08:06:57 INFO - [mozharness: 2017-02-13 16:06:57.301006Z] Running create-virtualenv step. 08:06:57 INFO - Running pre-action listener: _resource_record_pre_action 08:06:57 INFO - Running main action method: create_virtualenv 08:06:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:06:57 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 08:06:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:06:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:06:57 INFO - Using real prefix '/tools/python27' 08:06:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:06:58 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:01 INFO - Installing pip.................done. 08:07:01 INFO - Return code: 0 08:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:07:01 INFO - Reading from file tmpfile_stdout 08:07:01 INFO - Output received: 08:07:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:07:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:07:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:01 INFO - 'HOME': '/Users/cltbld', 08:07:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:01 INFO - 'LOGNAME': 'cltbld', 08:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:01 INFO - 'MOZ_NO_REMOTE': '1', 08:07:01 INFO - 'NO_EM_RESTART': '1', 08:07:01 INFO - 'PAGER': '/bin/cat', 08:07:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:01 INFO - 'PWD': '/builds/slave/test', 08:07:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:01 INFO - 'SHELL': '/bin/bash', 08:07:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:01 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:01 INFO - 'USER': 'cltbld', 08:07:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:01 INFO - 'XPC_FLAGS': '0x0', 08:07:01 INFO - 'XPC_SERVICE_NAME': '0', 08:07:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:01 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 08:07:01 INFO - Cleaning up... 08:07:01 INFO - Return code: 0 08:07:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:07:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:01 INFO - 'HOME': '/Users/cltbld', 08:07:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:01 INFO - 'LOGNAME': 'cltbld', 08:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:01 INFO - 'MOZ_NO_REMOTE': '1', 08:07:01 INFO - 'NO_EM_RESTART': '1', 08:07:01 INFO - 'PAGER': '/bin/cat', 08:07:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:01 INFO - 'PWD': '/builds/slave/test', 08:07:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:01 INFO - 'SHELL': '/bin/bash', 08:07:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:01 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:01 INFO - 'USER': 'cltbld', 08:07:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:01 INFO - 'XPC_FLAGS': '0x0', 08:07:01 INFO - 'XPC_SERVICE_NAME': '0', 08:07:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:01 INFO - Downloading/unpacking psutil>=3.1.1 08:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:05 INFO - Installing collected packages: psutil 08:07:05 INFO - Running setup.py install for psutil 08:07:05 INFO - building 'psutil._psutil_osx' extension 08:07:05 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 08:07:06 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 08:07:06 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 08:07:06 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 08:07:06 INFO - building 'psutil._psutil_posix' extension 08:07:06 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 08:07:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:07:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:07:06 INFO - ^ 08:07:06 INFO - 1 warning generated. 08:07:06 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 08:07:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:06 INFO - Successfully installed psutil 08:07:06 INFO - Cleaning up... 08:07:06 INFO - Return code: 0 08:07:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:06 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 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07:06 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 08:07:06 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 08:07:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:06 INFO - 'HOME': '/Users/cltbld', 08:07:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:06 INFO - 'LOGNAME': 'cltbld', 08:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:06 INFO - 'MOZ_NO_REMOTE': '1', 08:07:06 INFO - 'NO_EM_RESTART': '1', 08:07:06 INFO - 'PAGER': '/bin/cat', 08:07:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:06 INFO - 'PWD': '/builds/slave/test', 08:07:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:06 INFO - 'SHELL': '/bin/bash', 08:07:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:06 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:06 INFO - 'USER': 'cltbld', 08:07:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:06 INFO - 'XPC_FLAGS': '0x0', 08:07:06 INFO - 'XPC_SERVICE_NAME': '0', 08:07:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:07:09 INFO - Installing collected packages: mozsystemmonitor 08:07:09 INFO - Running setup.py install for mozsystemmonitor 08:07:09 INFO - Successfully installed mozsystemmonitor 08:07:09 INFO - Cleaning up... 08:07:09 INFO - Return code: 0 08:07:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:09 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 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07:09 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 08:07:09 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 08:07:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:09 INFO - 'HOME': '/Users/cltbld', 08:07:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:09 INFO - 'LOGNAME': 'cltbld', 08:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:09 INFO - 'MOZ_NO_REMOTE': '1', 08:07:09 INFO - 'NO_EM_RESTART': '1', 08:07:09 INFO - 'PAGER': '/bin/cat', 08:07:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:09 INFO - 'PWD': '/builds/slave/test', 08:07:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:09 INFO - 'SHELL': '/bin/bash', 08:07:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:09 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:09 INFO - 'USER': 'cltbld', 08:07:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:09 INFO - 'XPC_FLAGS': '0x0', 08:07:09 INFO - 'XPC_SERVICE_NAME': '0', 08:07:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:10 INFO - Downloading/unpacking jsonschema==2.5.1 08:07:10 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 08:07:10 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 08:07:10 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 08:07:10 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 08:07:10 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 08:07:10 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 08:07:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:07:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:07:12 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 08:07:12 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 08:07:12 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 08:07:12 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 08:07:12 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 08:07:12 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 08:07:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:07:13 INFO - warning: no files found matching '*.txt' 08:07:13 INFO - no previously-included directories found matching 'build' 08:07:13 INFO - no previously-included directories found matching 'dist' 08:07:13 INFO - no previously-included directories found matching '.git*' 08:07:13 INFO - Installing collected packages: jsonschema, functools32 08:07:13 INFO - Running setup.py install for functools32 08:07:13 INFO - warning: no files found matching '*.txt' 08:07:13 INFO - no previously-included directories found matching 'build' 08:07:13 INFO - no previously-included directories found matching 'dist' 08:07:13 INFO - no previously-included directories found matching '.git*' 08:07:13 INFO - Successfully installed jsonschema functools32 08:07:13 INFO - Cleaning up... 08:07:13 INFO - Return code: 0 08:07:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:13 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 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07:13 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 08:07:13 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 08:07:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:13 INFO - 'HOME': '/Users/cltbld', 08:07:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:13 INFO - 'LOGNAME': 'cltbld', 08:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:13 INFO - 'MOZ_NO_REMOTE': '1', 08:07:13 INFO - 'NO_EM_RESTART': '1', 08:07:13 INFO - 'PAGER': '/bin/cat', 08:07:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:13 INFO - 'PWD': '/builds/slave/test', 08:07:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:13 INFO - 'SHELL': '/bin/bash', 08:07:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:13 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:13 INFO - 'USER': 'cltbld', 08:07:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:13 INFO - 'XPC_FLAGS': '0x0', 08:07:13 INFO - 'XPC_SERVICE_NAME': '0', 08:07:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:07:13 INFO - Cleaning up... 08:07:13 INFO - Return code: 0 08:07:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:13 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 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07:13 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 08:07:13 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 08:07:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:13 INFO - 'HOME': '/Users/cltbld', 08:07:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:13 INFO - 'LOGNAME': 'cltbld', 08:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:13 INFO - 'MOZ_NO_REMOTE': '1', 08:07:13 INFO - 'NO_EM_RESTART': '1', 08:07:13 INFO - 'PAGER': '/bin/cat', 08:07:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:13 INFO - 'PWD': '/builds/slave/test', 08:07:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:13 INFO - 'SHELL': '/bin/bash', 08:07:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:13 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:13 INFO - 'USER': 'cltbld', 08:07:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:13 INFO - 'XPC_FLAGS': '0x0', 08:07:13 INFO - 'XPC_SERVICE_NAME': '0', 08:07:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:07:14 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 08:07:14 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 08:07:14 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 08:07:14 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 08:07:14 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 08:07:14 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 08:07:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:07:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:07:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:07:17 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 08:07:17 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 08:07:17 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 08:07:17 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 08:07:17 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 08:07:17 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 08:07:17 INFO - Downloading docopt-0.6.1.tar.gz 08:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:07:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:07:18 INFO - Running setup.py install for blobuploader 08:07:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:07:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:07:18 INFO - Running setup.py install for requests 08:07:18 INFO - Running setup.py install for docopt 08:07:18 INFO - Successfully installed blobuploader requests docopt 08:07:18 INFO - Cleaning up... 08:07:18 INFO - Return code: 0 08:07:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:18 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')]} 08:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:18 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')]} 08:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:18 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 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07:18 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 08:07:18 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 08:07:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:18 INFO - 'HOME': '/Users/cltbld', 08:07:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:18 INFO - 'LOGNAME': 'cltbld', 08:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:18 INFO - 'MOZ_NO_REMOTE': '1', 08:07:18 INFO - 'NO_EM_RESTART': '1', 08:07:18 INFO - 'PAGER': '/bin/cat', 08:07:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:18 INFO - 'PWD': '/builds/slave/test', 08:07:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:18 INFO - 'SHELL': '/bin/bash', 08:07:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:18 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:18 INFO - 'USER': 'cltbld', 08:07:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:18 INFO - 'XPC_FLAGS': '0x0', 08:07:18 INFO - 'XPC_SERVICE_NAME': '0', 08:07:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-WciVAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Lb6_fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-rQ2P_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-rD3sq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-ZQz4lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-q54JRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-WbFg7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-KK7I64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:19 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-ENQQ9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-9BAVOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-JPytn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Dh7aZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-qRMin3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-D20BgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-RFUu7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-kuQlVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:20 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-MEDLDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:07:20 INFO - Running setup.py install for manifestparser 08:07:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:07:21 INFO - Running setup.py install for mozcrash 08:07:21 INFO - Running setup.py install for mozdebug 08:07:21 INFO - Running setup.py install for mozdevice 08:07:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:07:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:07:21 INFO - Running setup.py install for mozfile 08:07:21 INFO - Running setup.py install for mozhttpd 08:07:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:07:21 INFO - Running setup.py install for mozinfo 08:07:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Running setup.py install for mozInstall 08:07:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Running setup.py install for mozleak 08:07:22 INFO - Running setup.py install for mozlog 08:07:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Running setup.py install for moznetwork 08:07:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Running setup.py install for mozprocess 08:07:22 INFO - Running setup.py install for mozprofile 08:07:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Running setup.py install for mozrunner 08:07:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Running setup.py install for mozscreenshot 08:07:23 INFO - Running setup.py install for moztest 08:07:23 INFO - Running setup.py install for mozversion 08:07:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:07:23 INFO - Cleaning up... 08:07:23 INFO - Return code: 0 08:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:23 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')]} 08:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:23 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')]} 08:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:23 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 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07:23 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 08:07:23 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 08:07:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:23 INFO - 'HOME': '/Users/cltbld', 08:07:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:23 INFO - 'LOGNAME': 'cltbld', 08:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:23 INFO - 'MOZ_NO_REMOTE': '1', 08:07:23 INFO - 'NO_EM_RESTART': '1', 08:07:23 INFO - 'PAGER': '/bin/cat', 08:07:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:23 INFO - 'PWD': '/builds/slave/test', 08:07:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:23 INFO - 'SHELL': '/bin/bash', 08:07:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:23 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:23 INFO - 'USER': 'cltbld', 08:07:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:23 INFO - 'XPC_FLAGS': '0x0', 08:07:23 INFO - 'XPC_SERVICE_NAME': '0', 08:07:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:23 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-ueYDQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:23 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)) 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:23 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-xCImAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:24 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-j9qhpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:24 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:24 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-LIdSZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:24 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-J1Va8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:24 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:24 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-vgE9o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:24 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:24 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-DGdCE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:24 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:24 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-WWjdVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:24 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:24 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-hDkBk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:24 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:24 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Tck_Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:24 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:24 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-PY9mv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:24 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:25 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-CIwNLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:25 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-IBBiH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:25 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-mqohd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:25 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-g4NVMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:25 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-2ZmTyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:25 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-99xNMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:25 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)) 08:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:07:25 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)) 08:07:25 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:07:25 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:07:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07:28 INFO - Downloading blessings-1.6.tar.gz 08:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:07:28 INFO - Installing collected packages: blessings 08:07:28 INFO - Running setup.py install for blessings 08:07:28 INFO - Successfully installed blessings 08:07:28 INFO - Cleaning up... 08:07:28 INFO - Return code: 0 08:07:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:28 INFO - Reading from file tmpfile_stdout 08:07:28 INFO - Current package versions: 08:07:28 INFO - blessings == 1.6 08:07:28 INFO - blobuploader == 1.2.4 08:07:28 INFO - docopt == 0.6.1 08:07:28 INFO - functools32 == 3.2.3-2 08:07:28 INFO - jsonschema == 2.5.1 08:07:28 INFO - manifestparser == 1.1 08:07:28 INFO - mozInstall == 1.12 08:07:28 INFO - mozcrash == 1.0 08:07:28 INFO - mozdebug == 0.1 08:07:28 INFO - mozdevice == 0.49 08:07:28 INFO - mozfile == 1.2 08:07:28 INFO - mozhttpd == 0.7 08:07:28 INFO - mozinfo == 0.9 08:07:28 INFO - mozleak == 0.1 08:07:28 INFO - mozlog == 3.4 08:07:28 INFO - moznetwork == 0.27 08:07:28 INFO - mozprocess == 0.24 08:07:28 INFO - mozprofile == 0.28 08:07:28 INFO - mozrunner == 6.13 08:07:28 INFO - mozscreenshot == 0.1 08:07:28 INFO - mozsystemmonitor == 0.3 08:07:28 INFO - moztest == 0.8 08:07:28 INFO - mozversion == 1.4 08:07:28 INFO - psutil == 3.1.1 08:07:28 INFO - requests == 1.2.3 08:07:28 INFO - wsgiref == 0.1.2 08:07:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:28 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 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07:28 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 08:07:28 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 08:07:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:28 INFO - 'HOME': '/Users/cltbld', 08:07:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:28 INFO - 'LOGNAME': 'cltbld', 08:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:28 INFO - 'MOZ_NO_REMOTE': '1', 08:07:28 INFO - 'NO_EM_RESTART': '1', 08:07:28 INFO - 'PAGER': '/bin/cat', 08:07:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:28 INFO - 'PWD': '/builds/slave/test', 08:07:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:28 INFO - 'SHELL': '/bin/bash', 08:07:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:28 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:28 INFO - 'USER': 'cltbld', 08:07:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:28 INFO - 'XPC_FLAGS': '0x0', 08:07:28 INFO - 'XPC_SERVICE_NAME': '0', 08:07:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:29 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)) 08:07:29 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)) 08:07:29 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)) 08:07:29 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)) 08:07:29 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)) 08:07:29 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)) 08:07:29 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)) 08:07:29 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)) 08:07:29 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)) 08:07:29 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)) 08:07:29 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)) 08:07:29 INFO - Cleaning up... 08:07:29 INFO - Return code: 0 08:07:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc063ca8170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, '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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 08:07: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', 'jsonschema'] in /builds/slave/test/build 08:07: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 jsonschema 08:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:29 INFO - 'HOME': '/Users/cltbld', 08:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:29 INFO - 'LOGNAME': 'cltbld', 08:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:29 INFO - 'MOZ_NO_REMOTE': '1', 08:07:29 INFO - 'NO_EM_RESTART': '1', 08:07:29 INFO - 'PAGER': '/bin/cat', 08:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:29 INFO - 'PWD': '/builds/slave/test', 08:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:29 INFO - 'SHELL': '/bin/bash', 08:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:29 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:29 INFO - 'USER': 'cltbld', 08:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:29 INFO - 'XPC_FLAGS': '0x0', 08:07:29 INFO - 'XPC_SERVICE_NAME': '0', 08:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:07:29 INFO - Cleaning up... 08:07:29 INFO - Return code: 0 08:07:29 INFO - Running post-action listener: _resource_record_post_action 08:07:29 INFO - Running post-action listener: _start_resource_monitoring 08:07:29 INFO - Starting resource monitoring. 08:07:29 INFO - [mozharness: 2017-02-13 16:07:29.509994Z] Finished create-virtualenv step (success) 08:07:29 INFO - [mozharness: 2017-02-13 16:07:29.510990Z] Running install step. 08:07:29 INFO - Running pre-action listener: _resource_record_pre_action 08:07:29 INFO - Running main action method: install 08:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:29 INFO - Reading from file tmpfile_stdout 08:07:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:07:29 INFO - Reading from file tmpfile_stdout 08:07:29 INFO - Output received: 08:07:29 INFO - Usage: mozinstall [options] installer 08:07:29 INFO - Options: 08:07:29 INFO - -h, --help show this help message and exit 08:07:29 INFO - -d DEST, --destination=DEST 08:07:29 INFO - Directory to install application into. [default: 08:07:29 INFO - "/builds/slave/test"] 08:07:29 INFO - --app=APP Application being installed. [default: firefox] 08:07:29 INFO - mkdir: /builds/slave/test/build/application 08:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:07:49 INFO - Reading from file tmpfile_stdout 08:07:49 INFO - Output received: 08:07:49 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:07:49 INFO - Running post-action listener: _resource_record_post_action 08:07:49 INFO - [mozharness: 2017-02-13 16:07:49.715097Z] Finished install step (success) 08:07:49 INFO - [mozharness: 2017-02-13 16:07:49.715243Z] Running run-tests step. 08:07:49 INFO - Running pre-action listener: _resource_record_pre_action 08:07:49 INFO - Running main action method: run_tests 08:07:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:07:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:07:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:07:49 INFO - 2017-02-13 08:07:49.730 screenresolution[1630:7916] starting screenresolution argv=screenresolution get 08:07:49 INFO - 2017-02-13 08:07:49.732 screenresolution[1630:7916] Display 0: 1600x1200x32@60 08:07:49 INFO - 2017-02-13 08:07:49.738 screenresolution[1631:7919] starting screenresolution argv=screenresolution list 08:07:49 INFO - Available Modes on Display 0 08:07:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:07:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:07:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:07:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:49 INFO - Intel Iris: 08:07:49 INFO - Chipset Model: Intel Iris 08:07:49 INFO - Type: GPU 08:07:49 INFO - Bus: Built-In 08:07:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:49 INFO - Vendor: Intel (0x8086) 08:07:49 INFO - Device ID: 0x0a2e 08:07:49 INFO - Revision ID: 0x0009 08:07:49 INFO - Displays: 08:07:49 INFO - Display: 08:07:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:49 INFO - Display Serial Number: 1600x1200 60 08:07:49 INFO - Main Display: Yes 08:07:49 INFO - Mirror: Off 08:07:49 INFO - Online: Yes 08:07:49 INFO - Rotation: Supported 08:07:49 INFO - Return code: 0 08:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:07:49 INFO - Python 2.7.3 08:07:49 INFO - Return code: 0 08:07:49 INFO - grabbing minidump binary from tooltool 08:07:49 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')]} 08:07:49 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 0x10b17ed30>, '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 0x10b0a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b173be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:07:49 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 08:07:49 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 08:07:49 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 08:07:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:07:50 INFO - Return code: 0 08:07:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:07:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:07:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:07:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:07:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:07:50 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/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--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 08:07:50 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/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0199 --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 08:07:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vUbbLqlYCb/Render', 08:07:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:50 INFO - 'HOME': '/Users/cltbld', 08:07:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:50 INFO - 'LOGNAME': 'cltbld', 08:07:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:07:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:50 INFO - 'MOZ_NO_REMOTE': '1', 08:07:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:07:50 INFO - 'NO_EM_RESTART': '1', 08:07:50 INFO - 'PAGER': '/bin/cat', 08:07:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:50 INFO - 'PWD': '/builds/slave/test', 08:07:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:07:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:50 INFO - 'SHELL': '/bin/bash', 08:07:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5iDs0ZQpgI/Listeners', 08:07:50 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 08:07:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:50 INFO - 'USER': 'cltbld', 08:07:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:50 INFO - 'XPC_FLAGS': '0x0', 08:07:50 INFO - 'XPC_SERVICE_NAME': '0', 08:07:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:50 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/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--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 08:07:50 INFO - mozversion application_buildid: 20170213070540 08:07:50 INFO - mozversion application_changeset: 55b9181a1979e32d583a85cb6106900301444e69 08:07:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:07:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:07:50 INFO - mozversion application_name: Firefox 08:07:50 INFO - mozversion application_remotingname: firefox-dev 08:07:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:07:50 INFO - mozversion application_vendor: Mozilla 08:07:50 INFO - mozversion application_version: 53.0a2 08:07:50 INFO - mozversion platform_buildid: 20170213070540 08:07:50 INFO - mozversion platform_changeset: 55b9181a1979e32d583a85cb6106900301444e69 08:07:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:07:50 INFO - mozversion platform_version: 53.0a2 08:07:50 INFO - using testdate: 1487002070 08:07:50 INFO - actual date: 1487002070 08:07:50 INFO - starting webserver on 'localhost:49241' 08:07:50 INFO - SUITE-START | Running 2 tests 08:07:50 INFO - TEST-START | dromaeo_css 08:07:50 INFO - operating with platform_type : mac_ 08:07:50 INFO - Initialising browser for dromaeo_css test... 08:07:50 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpLFQ6v5/profile http://localhost:49241/getInfo.html) 08:07:52 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 08:07:52 INFO - PROCESS | 1641 | colorDepth:24 08:07:52 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 08:07:52 INFO - PROCESS | 1641 | __metrics 08:07:53 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:07:53 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:07:53 INFO - TEST-INFO | 1641: exit 0 08:07:53 INFO - Browser initialized. 08:07:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:07:53 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpLFQ6v5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:05 INFO - PROCESS | 1644 | RSS: Main: 213233664 08:08:05 INFO - PROCESS | 1644 | 08:11:09 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:11:10 INFO - PROCESS | 1644 | RSS: Main: 337022976 08:11:10 INFO - PROCESS | 1644 | 08:12:55 INFO - PROCESS | 1644 | ************************* 08:12:55 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 08:12:55 INFO - PROCESS | 1644 | 08:12:55 ERROR - PROCESS | 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:12:55 INFO - PROCESS | 1644 | Full stack: 08:12:55 INFO - PROCESS | 1644 | ************************* 08:14:13 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:14:14 INFO - PROCESS | 1644 | RSS: Main: 347533312 08:14:14 INFO - PROCESS | 1644 | 08:17:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:17:17 INFO - PROCESS | 1644 | RSS: Main: 322752512 08:17:17 INFO - PROCESS | 1644 | 08:20:19 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:20:20 INFO - PROCESS | 1644 | RSS: Main: 343838720 08:20:20 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:23:24 INFO - PROCESS | 1644 | RSS: Main: 318234624 08:23:24 INFO - PROCESS | 1644 | 08:26:27 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:26:27 INFO - PROCESS | 1644 | RSS: Main: 399937536 08:26:27 INFO - PROCESS | 1644 | 08:26:27 INFO - PROCESS | 1644 | __start_tp_report 08:26:27 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 08:26:27 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 08:26:27 INFO - PROCESS | 1644 | |i|pagename|runs| 08:26:27 INFO - PROCESS | 1644 | |0;dojo.html;2798.048663454425;3280.475123980162;3287.8849240276595;3307.43773558495;3375.2911888503413;5616.157576363547;5631;5644.74598643061;5648.237487939127;5648.717564121793;5620.803271885485;5626.437356264371;5631.549476041917;5718.857028574288;5729.885402291951;5169.974150129254;5175.482451754813;5212.739363031852;5219.112750832368;5255.816046438375;5113.463086375933;5127.282180494715;5131.102057139986;5269.235960785683;5324.068288049595;5146.202338637517;5195.116830138866;5205;5226.2944502492055;5258.631895767278;5240.240165176028;5240.8689782755355;5244.449332820056;5267.3679158500845;5302.946970530284;4974.328465657126;5073.416557095944;5162.92255616166;5174.456682048406;5200.583953283728;5578.63738856973;5603.859903502404;5644.717764111778;5673.971630141823;5707.914381284284;6170.136180934673;6181.165542651775;6196.132541444202;6196.81409557714;6201.193844800147;6190.50475961922;6231.781887633911;6261.937380626181;6273.717682704244;6275.403836635513;4825.0349930013435;5557.110862262019;5624.5781566382275;5698.772049117989;5712.942870571241;6253.530985176039;6261.8747625047245;6263.217097862767;6265.154204182468;6277.937220627735;6087.66517841523;6156.953317935961;6161.96919015411;6172.105044768484;6179.5056395489155;6139.4781443577795;6140.688304616475;6144.218176728788;6182.505399568024;6271.843203919939;6130.734471166763;6171.938280617226;6172.259328880563;6205.317415084337;6208.286047104641;6210.378962103753;6218.22272215973;6232.25212974446;6237.345078766664;6237.625742455467;4729.219678753036;4826;4841.588464980516;4890.24201248807;4925;4330.870073897788;4359.258925982591;4390.07808360248;4432.578905004019;4439.467263928284;5660.2075709400715;5770;5808.79669211584;5820.563457740686;5869.559783016205;6092.055731361646;6131.448169664752;6136.478399336017;6139.154842350747;6189.597676151126;5180.041692286939;5689.175069614883;5818.5636077294375;5829.562782791308;5831.475167234969;5379.731013449312;5384.326959130109;5397.9460205397445;5403.891922161535;5409.918851217235;6164.198654174928;6168.691565421621;6230.937690623035;6357.046443033582;6389.520785941073;6174.228221472316;6175.59858609189;6187.443130118311;6217.129601855653;6264.655443950626;6272.5922815016875;6321.715522801577;6339.175907132228;6345.7144428499905;6356.872862542816;6117.724702388314;6171.290301615371;6181.629102253879;6185.474234690102;6197.96901015492;5082.517160869711;5949.405059494189;6123.969380153071;6156.322804491413;6208.9689551551955;6096.634201947897;6110.175126357884;6112.602680825732;6115.388461153849;6130.938690613037;5987.491063259497;6089.48239399656;6097.207363042776;6104.755809767559;6117.990531562243;5717.113847353667;5768.2501274834;5808.912866307093;5852.356240813592;5914.763409463573;6093.086037094471;6108.541859360655;6119.602225855305;6120.938790612036;6133.355997620186;5898.970505147447;5910.911336330045;5925.111233314865;5926.436988486087;5929.1995580597795 08:26:27 INFO - PROCESS | 1644 | |1;ext.html;473.4413392197208;508.4788092205491;513.3659929986468;515.6725479320633;535.2399592578538;30240;38625.80687096564;40504.39243411348;40560.79719601398;40705.796471017675;41994.7900260499;42661.36007959875;43127.78436107815;43158.56841431585;43161.35257971133;9372.390794598346;9570.52147392631;9581.137697607213;9589.66436174734;9600.663976760814;8388.790280242982;8574.228319451247;11176.776464470706;11366.37484938328;11421.371824549646;11332.376719280437;11339.603113891015;11344.773104537904;11456.255343402694;11563.768724625503;8423.284020858235;11404.258723182966;11485.712857178554;11489.965903068764;11492.425378731072;8454;11104.44477776116;11338.149638777124;11361.488733007034;11596;33165.83417082899;41013.769586912145;41044.58955410468;41076.38385424221;41116;3934.6262105100254;4010.5187377514885;4031.1937612477623;4074.5925407459017;4255.659547236213;26669.46661066787;27524.174274771787;27552.448951020866;28931.710682893114;30558.930437434807;3189.3621275744713;3189.649138594753;3349.79407413331;3381.22231886665;3385.542951701513;457317;457421;457841.7107914439;458016;459471;61529.69235153795;61906.69046654828;61995.690021549606;62043.37956620376;62111.068333975025;64838;64998;65023;65027;65072;16261.67476650484;16516.42192523256;16544.42094526686;16546.58633534171;16547.338106475607;11523.96284334414;11850.229735067192;12791.168574042658;12834.101612887009;12871.163374380636;13995.37020834065;15967.760483592756;16110.436134735228;16276.75584866228;16763.580910477092;6740.741851479711;6819.147606549182;6856.554323968926;6885.345892140239;6887.311268873073;707.8831992721247;809.8581000788977;861.440063958432;876.588003638289;893.2764460786783;26496.8675156623;29018.7098129016;29398.166600239394;29617.703822961925;29716.702832971827;897.7341947853495;1052.952617132231;1064.3454275620438;1089.536946797608;1187.7386974865515;14862.925685371503;15445.691086178214;15635.93349936866;15675.843241567438;15803.972741771748;616011;618750;620558;621118;621546;60118.69940650269;60370;60382.698086509285;60441.093383599284;60469;1442.4964832313663;1445.6313640021726;1475.4835807467516;1481.8147731533559;1485.9182744948916;28108.297292567848;28567.857160714062;29220.26949326199;29387;30023.849880750455;49942;50397.49602503928;50416.966642667765;50478.7380315495;50482;516975;517126;522365;522383;523742;23347.88326058359;26088.73911260939;26438.339041523348;26501;26560;38912.2217555653;42151.78924105482;43828.12343753171;44025.89935251644;45908;37254.8137259312;37396;37511.81244093762;38645.22709545737;39136;34727.826360868035;34893.30213395769;34935;35348.29303413866;35619.82190089033;34399.484007739404;35371.29257414889;36510;36857.07857303589;36938.63061369459;29952.850235749553;31272.530912035883;31868;31876.68123318737;31915;23786.524269514168;24170.516589667757;24656.50686986286;24685.753142468344;24716.752832471444 08:26:27 INFO - PROCESS | 1644 | |2;jquery.html;370.4572800846759;387.4208058951867;388.5182373856417;403.1071177342187;417.7744018230156;13068.934655326722;14348.928255358735;17504.474865754033;20408.59182816343;20660;20955.790442095575;21005.26481573145;21271.14915403382;21278;21697.891510542464;5564.554835613161;5597.384287728347;5784.2480477537865;5817.447342502455;5832.825015249549;5677.801276955307;5684.2326285951285;5718.17086522454;5723.027085395472;5734.827955161351;4040.9595904041025;4242.193983143208;6056.152138700585;6308.369163083677;6342;6159.38406159385;6333.588316759442;6382.808515744535;6396.42432181106;6401.551891367606;5617.522510586605;5622.269105016322;5622.437756224344;5632.2678051853;5635.042042852725;21383.67924481134;25437.872810636014;25745;26506.867465662548;26782.46435071307;2698.17705599792;2730.6177135201087;2737.5209338365707;2742.122520793347;2777.4306267215375;15244.847551524454;15312.387504499919;15319.540413787492;15557.688846223013;15648.843511564852;1765.7792775903013;1810.3301778341965;1810.357323150289;1826.2786199451143;1841.1898764543557;125189;126672;131253;135151;141315;11141;11529.654110376701;11561.76876462466;11566.94216528912;11739;14625.707485850224;14640.633984150481;14641.487547935983;14665.706685866224;14668.926655366655;8571.742847714579;8780.121987801169;8800.295976321879;8886.822263554694;8887.200151986352;7527.9084532742445;8455.577221139041;8773.166549177819;8788.8681669775;8881.644734210558;5871.3541510433815;6220.267839296476;6990.755323563651;7079.575225486487;7080.362767350963;1837.2926423327115;1940.2530025939832;1941.9029048547516;1944.5041514414017;1946.202057156559;994.3636072913341;1014.2747935226348;1015.5633077776479;1029.8455231715302;1030.5465595138114;20143.79856201419;21062.47343816417;21550.353489395344;21666.62509665035;21712.69723816576;1015.7054454208345;1020.3163880200284;1026.38416949831;1027.1474676018886;1051.1433181956681;10749.677509674722;11289.491972861077;11291.3789741565;11299.3785341807;11301.830472542919;503622;578272;745067.6479705618;756124;769271;129517;141740.94992684026;162785;164874;170521;1083;1125.1055410948316;1136.431784107946;1136.9204155709187;1145.4330106597288;19004.904975475034;19333.516662083;19812.207511699948;19852.404427867186;19864;55140.72429637826;61475.07787383282;61755.38244617496;61780;63379.51412672347;83414.33171336418;85304;86190.13809862072;87430.1256987422;88655;8174.877376839233;8186.795330116556;8376.706815261437;8436.029856566329;8675.696350627697;9417.058294170529;12485.500579976699;13157.407916643582;13272.203667779964;13459.327033648082;11269.12637277489;11327.490262938023;11501.597444089417;11577.942110289394;11750.529978800752;9082.727518174466;11225.158113141384;11343.20597558163;11398.575178102737;11781.76436471283;10024.899751002396;11493;11631.360275184947;11839.05287577009;11889;8309.210624990616;8381.413301069111;8381.455205411628;8569.314454843723;8709;8475.491470511543;9373.625054997723;11089.889101108885;11242.213045086766;11265.662030139109 08:26:27 INFO - PROCESS | 1644 | |3;mootools.html;1342.704604986903;1434.734574103791;1454.3310077364413;1457.8687918087371;1462.3857979648549;7932.881006784895;8220.177982201776;8366.53984030878;8372.790680232998;8382.994040715115;7351.963240183792;7642.541447513139;7648.808779780508;7972.641231144598;8187.467814592047;2322.1175953137827;2351.7177938647387;2356.045801450415;2356.3166681662383;2357.127862690807;2341.8711970841596;2371.8221133414977;2373.537160253751;2377.8335516513853;2383.6305372667266;1845.6308738252337;2040.3470889315424;2126.8936553172357;2317.200565804803;2317.6986991691056;2294.3690485116645;2307.180950762472;2307.953840923189;2309.9538009239723;2312.421894526377;2268.160780511205;2326.790588846995;2345.1791872844537;2350.7766762157567;2351;8193.590320483952;8262.545559994198;8276.503409795432;8280.917190828075;8308.169183081704;4975.7512124394;5149.819756308549;5150.9742451287875;5156.097682905476;5163.8192663256605;3332.250243695149;3477.200243943907;3480.5997310309385;3528.4178110611974;3549.219171782204;976.6874600127962;1196.3719047500044;1201.627495476405;1247.214255019332;1257.4844313831286;10576.418296993663;10733.731656708645;10734.892651073545;10742.946285268601;10776.299540529919;4481.170983368087;4641.675082744176;4679.27471241958;4730.787114579852;4732.668713190113;9432.62269509212;9432.95283523578;9437.952810236042;9443.480608566595;9472.147506724428;5159;5203.583713302926;5206.453322401169;5208.8958220835375;5217.452167522431;4248.893777655583;4379.189849877783;4543.909121817545;4669.136209801198;4683.555062269079;3806.3338915690197;3871.922561548753;3928.46965659638;3943.743656662308;3956.7625942443547;1294.9611511654666;1305.11252348404;1308.3719814489098;1313.0939651640338;1316.230005446805;789.6525528767324;872.389327470773;909.7680091576606;920.7937601741739;921.8663293822358;5503.367112782002;5636.408177141423;5688.40271771458;5800.59395842287;5852.824415267549;1001.8897921228659;1004.5178314408978;1014.5079636376352;1016.6899095775859;1039.1946241662772;3679.392900171442;3838.2323535293053;3923.822278635385;3993.5639260051344;3999.280129576646;9695.224382049419;9745.853812192823;9920.950395247977;9922.950385248172;9938.204943604494;9773.41359518431;9867.06262905023;9877.555510002067;9962.950185249172;9972.750681232883;7555.16893141754;7782.066152061789;7805.258500442563;7835.804104897423;7840.960795195988;5333.5199832015305;5562.360328562268;5579.414161513145;5753.223314852441;5775.220345253337;8989.955050224708;9029.36794424384;9302.44185348854;9317.673881414117;9326.533673316442;8929.508877011827;9264.258859291105;9289.117533834275;9296.72109836706;9319.487428191243;6589.4728421725185;6788.422984046214;6796.422304104207;7067.0106185135155;7224.241454647186;7568.5837278950185;7687.615619219128;7792.18182090895;7892.289693927344;7902.288794008567;6996.930030699627;7083.787486375417;7107.182673992557;7118.822029449305;7233.63831808418;5845.269341332333;6991.860162796614;7000.264972178052;7014.088168538057;7045.788626341218;6228.750849966132;6314.305426403183;6410.134631824644;6410.871782564229;6413.102165696713;4960.8759781005765;5026.648134630687;5028.522290382408;5034.270030845581;5073.264376665436;4359.912801744011;4879.4876537963;4991.875203119951;4997.250412438163;5186.040582492251 08:26:27 INFO - PROCESS | 1644 | |4;prototype.html;357.3906489435513;360.3765485709722;368.8911771027547;376.46917845837373;378.81248781852986;4365.912681746363;5145.845624631258;5192.014591609825;5231.834739982313;5239.738013099349;3957.576696157817;4522.321651752239;4798.256270278103;4894.339264199332;5047.167217409133;3672.7061835053264;3722.6445059280572;3811.4473401356786;3985.8206380712863;4020.5974457968478;3370.325934813035;3695.8336874840697;4093.89765255868;4123.257813593552;4140.730852494593;3696.5009723687363;3792.127810603563;4013.337799263118;4090.897727556805;4094.283500387435;3701.944470832926;3742.5696044954907;4050.392441133824;4071.124708187724;4089.6319331260033;3617.8371973261264;3626.4741612466046;3627.474016267626;3628.564572251347;3644.9041800964287;4135.710500264982;4475.507694153641;4960.280759289919;4984.426790919055;5062.721550314731;4592.678512504126;4605.355250264965;4629.421322334708;4669.486356500782;4677.298405239208;4376.474823021258;5404.51359377654;5406;5407.324084489439;5409.188621706736;3687.94468082979;3854.79378201096;3992.8602498912687;4000.4599379083743;4009.5389030261604;4581.816727330903;4585.601391575601;4791.377120974251;5604.600388694896;5642.943570564283;4000.7799571023293;4044.1396957399925;4061.2080644274083;4063.512378514538;4080.449139366207;3477.7217822574135;4068.2880495913096;4101.692373072032;4106.2198182345255;4109.301418758818;4332.415123958288;4573.885652858705;4588.311753236974;4634.281686338623;4694.859154225379;5386.703731294817;5395.865103372447;5410.296661434067;5415.783368665288;5438.864028399322;1150.6317978247048;1207.29373316609;1237.77720010399;1311.8032295155804;1343.536479914428;793.9837008628849;877.3858299190465;902.5397047505688;907.7594437474074;942.252122313113;3945.585713500099;4078.6125318094732;4698.2247929092;4711.670183087151;4801.18379875422;4484.708493947883;4686.554777296152;5072.898542029138;5194.428612852583;5206.947930520722;4073.653739432122;4371.497277813029;4531.909361812745;4738.360321356573;4883.536064073907;2308.6652435396772;2408.1818227238673;2521.7856482199218;2650.509655713699;2778.597103419993;4508.481524624644;4768.880777980578;5052.686301561621;5275.657082289639;5486.478784515464;4570.451545814523;4980.028894365564;5059.785651443627;5423.647462914898;5709.572606848288;5459.29029226206;5603.655122770588;5774.94225057744;5843.312076444798;5872.265966754156;4837.975810120927;4981.452040275494;5305.787768489372;5601.747921343631;5624;4925.38432695913;5098.082345177903;5214.582833373397;5366.141417373202;5521.80342939377;5074.467180945948;5836.299644042742;5902.6458412495385;5904.8780731660845;5906.911396328973;4138.896527586834;4177;4184.288670925889;4198.811053502539;4205.642520385679;5324.414314425488;5565;5628.831135065954;5639.238702775073;5655.462731040545;5460.249582862934;5467.671939683472;5474.671519708831;5484.424135465719;5500.339959204921;4539.79570919316;5398.676079435247;5450.863728406822;5472.808451704172;5476.342838859203;5204.918032786764;5274.630775845808;5297.443768404262;5301.469853014668;5322.813701520428;4586.4266966629175;4738.981119059419;4779.112250661039;5182.6113041521285;5377.462253774747;4911.533404326583;4962.578180854668;5105.617078719185;5260.342457192851;5287.779132764325 08:26:27 INFO - PROCESS | 1644 | |5;yui.html;714.742692630653;715.3418854653718;723.4935545118415;786.5320134519959;831.9126491718367;14837.777433338508;15805.60485987848;15812.84187158131;15829.525114246577;15846;14420.35108420121;14429;14450.98843080982;14612.634684132901;14614.415423383078;543.8069485332719;678.9932100679005;831.7463173732009;846.9280111190525;849.02362283374;861.6682577207757;866.7919699272193;874.3617159473556;874.5102742464209;875.6541166239332;923.1553128887094;923.9538023098852;924.9398789078722;925.6482536636103;926.263620421763;701.396798753072;716.9784906452815;884.7788052986754;886.9157430044136;886.9822603547925;651.726274964516;664.3887623386496;665.3180489997743;672.1363048482725;672.4485921544335;15022.774658380133;15044.548663540112;15046.473373431987;15079.396824127132;15089.773653395208;13201.60395188146;13418.664533386645;13453.394597243148;13512.189268643913;13514.729705405836;11698.824517632242;12113.878861211364;12388.380580970916;12459.377031148406;13229.735405291936;4492.865214043584;4501.7194067178525;4503.819847206108;4667.4632417272105;4696.553827386393;113323.86676133216;115337;117382;118266;119780;10300.742481437874;10639.840402393971;10891;11095.611653592247;11132.666020019413;21099.26152584683;21619.567608648053;21669.133234670753;21769.23807666724;21831.563368732535;7650.73222437212;7681.423893208032;7728.806779830549;7792.337651299589;7806.882896756553;4253.21315556623;4310;4313.827446902089;4322.935155972663;4328.394024836525;3415.1803567143706;3491.825408729604;3537.911552211215;3545.539079919594;3565.037439891215;643.9774607888795;649.04590252329;653.4576301669603;653.4706887421204;661.8610091880759;525.5604493492324;543.3371287029818;545.9672419654834;546.3634865381865;554.3154204557369;9133.634654613741;9577.747224111085;9705.466199359103;9806.558704858298;9833.704988850346;619.3837132053635;635.6821589205397;658.4600627485416;660.831487970574;667.302668711198;4741.83403580873;4771.988427928084;4826.806927722922;4890.193118135468;5291.470852914755;84446;85400;95170;100573.49713251533;101555;88563.55718221367;88936;91364;91655;92308.53845730728;79394.60302698566;80159;81114;81524.77712834312;82151.58924205341;9923.957984411532;10072.798544029225;11036;11315.660530184108;11328.32030078165;45778;47194.76402618102;47306.52693473159;50167;53395.4660453406;53977.46022539724;66294.67410651856;66599.66700166468;71748.64125679547;74045.51908961899;12981.350932453528;13198.670033249246;13404.664883377993;13466.192028478323;13644;14141.858581414053;14169.362378692776;14829.184394858386;14905.776413354026;15372.923135384252;13605.319734013457;13764.380602873094;13772.586822395344;14013.089149205269;14519.274036298355;13287.534936277183;13450.192988420726;13720.108192967426;13834.584962451143;13898.16611003343;12970.805437918627;12997.610071697864;13522.86477135216;13796;14122.576322710334;10787.67636970892;10818;11405.714857128638;11565.479553419947;11848.76302473963;8587.613557389808;10882.238243322892;11557.24877882935;11603.303801771921;11611.6516504505 08:26:27 INFO - PROCESS | 1644 | __end_tp_report 08:26:27 INFO - PROCESS | 1644 | __start_cc_report 08:26:27 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1262 08:26:27 INFO - PROCESS | 1644 | __end_cc_report 08:26:27 INFO - PROCESS | 1644 | __startTimestamp1487003187884__endTimestamp 08:26:27 INFO - PROCESS | 1644 | 08:26:27 INFO - PROCESS | 1644 | ------- Summary: start ------- 08:26:27 INFO - PROCESS | 1644 | Number of tests: 6 08:26:27 INFO - PROCESS | 1644 | 08:26:27 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5702.45 Median:5914.76 stddev:660.22 (11.2%) stddev-sans-first:621.69 08:26:27 INFO - PROCESS | 1644 | Values: 2798.0 3280.5 3287.9 3307.4 3375.3 5616.2 5631.0 5644.7 5648.2 5648.7 5620.8 5626.4 5631.5 5718.9 5729.9 5170.0 5175.5 5212.7 5219.1 5255.8 5113.5 5127.3 5131.1 5269.2 5324.1 5146.2 5195.1 5205.0 5226.3 5258.6 5240.2 5240.9 5244.4 5267.4 5302.9 4974.3 5073.4 5162.9 5174.5 5200.6 5578.6 5603.9 5644.7 5674.0 5707.9 6170.1 6181.2 6196.1 6196.8 6201.2 6190.5 6231.8 6261.9 6273.7 6275.4 4825.0 5557.1 5624.6 5698.8 5712.9 6253.5 6261.9 6263.2 6265.2 6277.9 6087.7 6157.0 6162.0 6172.1 6179.5 6139.5 6140.7 6144.2 6182.5 6271.8 6130.7 6171.9 6172.3 6205.3 6208.3 6210.4 6218.2 6232.3 6237.3 6237.6 4729.2 4826.0 4841.6 4890.2 4925.0 4330.9 4359.3 4390.1 4432.6 4439.5 5660.2 5770.0 5808.8 5820.6 5869.6 6092.1 6131.4 6136.5 6139.2 6189.6 5180.0 5689.2 5818.6 5829.6 5831.5 5379.7 5384.3 5397.9 5403.9 5409.9 6164.2 6168.7 6230.9 6357.0 6389.5 6174.2 6175.6 6187.4 6217.1 6264.7 6272.6 6321.7 6339.2 6345.7 6356.9 6117.7 6171.3 6181.6 6185.5 6198.0 5082.5 5949.4 6124.0 6156.3 6209.0 6096.6 6110.2 6112.6 6115.4 6130.9 5987.5 6089.5 6097.2 6104.8 6118.0 5717.1 5768.3 5808.9 5852.4 5914.8 6093.1 6108.5 6119.6 6120.9 6133.4 5899.0 5910.9 5925.1 5926.4 5929.2 08:26:27 INFO - PROCESS | 1644 | 08:26:27 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:66860.03 Median:36897.85 stddev:143277.33 (388.3%) stddev-sans-first:143592.56 08:26:27 INFO - PROCESS | 1644 | Values: 473.4 508.5 513.4 515.7 535.2 30240.0 38625.8 40504.4 40560.8 40705.8 41994.8 42661.4 43127.8 43158.6 43161.4 9372.4 9570.5 9581.1 9589.7 9600.7 8388.8 8574.2 11176.8 11366.4 11421.4 11332.4 11339.6 11344.8 11456.3 11563.8 8423.3 11404.3 11485.7 11490.0 11492.4 8454.0 11104.4 11338.1 11361.5 11596.0 33165.8 41013.8 41044.6 41076.4 41116.0 3934.6 4010.5 4031.2 4074.6 4255.7 26669.5 27524.2 27552.4 28931.7 30558.9 3189.4 3189.6 3349.8 3381.2 3385.5 457317.0 457421.0 457841.7 458016.0 459471.0 61529.7 61906.7 61995.7 62043.4 62111.1 64838.0 64998.0 65023.0 65027.0 65072.0 16261.7 16516.4 16544.4 16546.6 16547.3 11524.0 11850.2 12791.2 12834.1 12871.2 13995.4 15967.8 16110.4 16276.8 16763.6 6740.7 6819.1 6856.6 6885.3 6887.3 707.9 809.9 861.4 876.6 893.3 26496.9 29018.7 29398.2 29617.7 29716.7 897.7 1053.0 1064.3 1089.5 1187.7 14862.9 15445.7 15635.9 15675.8 15804.0 616011.0 618750.0 620558.0 621118.0 621546.0 60118.7 60370.0 60382.7 60441.1 60469.0 1442.5 1445.6 1475.5 1481.8 1485.9 28108.3 28567.9 29220.3 29387.0 30023.8 49942.0 50397.5 50417.0 50478.7 50482.0 516975.0 517126.0 522365.0 522383.0 523742.0 23347.9 26088.7 26438.3 26501.0 26560.0 38912.2 42151.8 43828.1 44025.9 45908.0 37254.8 37396.0 37511.8 38645.2 39136.0 34727.8 34893.3 34935.0 35348.3 35619.8 34399.5 35371.3 36510.0 36857.1 36938.6 29952.9 31272.5 31868.0 31876.7 31915.0 23786.5 24170.5 24656.5 24685.8 24716.8 08:26:27 INFO - PROCESS | 1644 | 08:26:27 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:38789.00 Median:21330.84 stddev:113816.41 (533.6%) stddev-sans-first:114099.13 08:26:27 INFO - PROCESS | 1644 | Values: 370.5 387.4 388.5 403.1 417.8 13068.9 14348.9 17504.5 20408.6 20660.0 20955.8 21005.3 21271.1 21278.0 21697.9 5564.6 5597.4 5784.2 5817.4 5832.8 5677.8 5684.2 5718.2 5723.0 5734.8 4041.0 4242.2 6056.2 6308.4 6342.0 6159.4 6333.6 6382.8 6396.4 6401.6 5617.5 5622.3 5622.4 5632.3 5635.0 21383.7 25437.9 25745.0 26506.9 26782.5 2698.2 2730.6 2737.5 2742.1 2777.4 15244.8 15312.4 15319.5 15557.7 15648.8 1765.8 1810.3 1810.4 1826.3 1841.2 125189.0 126672.0 131253.0 135151.0 141315.0 11141.0 11529.7 11561.8 11566.9 11739.0 14625.7 14640.6 14641.5 14665.7 14668.9 8571.7 8780.1 8800.3 8886.8 8887.2 7527.9 8455.6 8773.2 8788.9 8881.6 5871.4 6220.3 6990.8 7079.6 7080.4 1837.3 1940.3 1941.9 1944.5 1946.2 994.4 1014.3 1015.6 1029.8 1030.5 20143.8 21062.5 21550.4 21666.6 21712.7 1015.7 1020.3 1026.4 1027.1 1051.1 10749.7 11289.5 11291.4 11299.4 11301.8 503622.0 578272.0 745067.6 756124.0 769271.0 129517.0 141740.9 162785.0 164874.0 170521.0 1083.0 1125.1 1136.4 1136.9 1145.4 19004.9 19333.5 19812.2 19852.4 19864.0 55140.7 61475.1 61755.4 61780.0 63379.5 83414.3 85304.0 86190.1 87430.1 88655.0 8174.9 8186.8 8376.7 8436.0 8675.7 9417.1 12485.5 13157.4 13272.2 13459.3 11269.1 11327.5 11501.6 11577.9 11750.5 9082.7 11225.2 11343.2 11398.6 11781.8 10024.9 11493.0 11631.4 11839.1 11889.0 8309.2 8381.4 8381.5 8569.3 8709.0 8475.5 9373.6 11089.9 11242.2 11265.7 08:26:27 INFO - PROCESS | 1644 | 08:26:27 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5402.54 Median:5205.02 stddev:2912.72 (56.0%) stddev-sans-first:2904.91 08:26:27 INFO - PROCESS | 1644 | Values: 1342.7 1434.7 1454.3 1457.9 1462.4 7932.9 8220.2 8366.5 8372.8 8383.0 7352.0 7642.5 7648.8 7972.6 8187.5 2322.1 2351.7 2356.0 2356.3 2357.1 2341.9 2371.8 2373.5 2377.8 2383.6 1845.6 2040.3 2126.9 2317.2 2317.7 2294.4 2307.2 2308.0 2310.0 2312.4 2268.2 2326.8 2345.2 2350.8 2351.0 8193.6 8262.5 8276.5 8280.9 8308.2 4975.8 5149.8 5151.0 5156.1 5163.8 3332.3 3477.2 3480.6 3528.4 3549.2 976.7 1196.4 1201.6 1247.2 1257.5 10576.4 10733.7 10734.9 10742.9 10776.3 4481.2 4641.7 4679.3 4730.8 4732.7 9432.6 9433.0 9438.0 9443.5 9472.1 5159.0 5203.6 5206.5 5208.9 5217.5 4248.9 4379.2 4543.9 4669.1 4683.6 3806.3 3871.9 3928.5 3943.7 3956.8 1295.0 1305.1 1308.4 1313.1 1316.2 789.7 872.4 909.8 920.8 921.9 5503.4 5636.4 5688.4 5800.6 5852.8 1001.9 1004.5 1014.5 1016.7 1039.2 3679.4 3838.2 3923.8 3993.6 3999.3 9695.2 9745.9 9921.0 9923.0 9938.2 9773.4 9867.1 9877.6 9963.0 9972.8 7555.2 7782.1 7805.3 7835.8 7841.0 5333.5 5562.4 5579.4 5753.2 5775.2 8990.0 9029.4 9302.4 9317.7 9326.5 8929.5 9264.3 9289.1 9296.7 9319.5 6589.5 6788.4 6796.4 7067.0 7224.2 7568.6 7687.6 7792.2 7892.3 7902.3 6996.9 7083.8 7107.2 7118.8 7233.6 5845.3 6991.9 7000.3 7014.1 7045.8 6228.8 6314.3 6410.1 6410.9 6413.1 4960.9 5026.6 5028.5 5034.3 5073.3 4359.9 4879.5 4991.9 4997.3 5186.0 08:26:27 INFO - PROCESS | 1644 | 08:26:27 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4368.03 Median:4725.02 stddev:1295.32 (27.4%) stddev-sans-first:1263.49 08:26:27 INFO - PROCESS | 1644 | Values: 357.4 360.4 368.9 376.5 378.8 4365.9 5145.8 5192.0 5231.8 5239.7 3957.6 4522.3 4798.3 4894.3 5047.2 3672.7 3722.6 3811.4 3985.8 4020.6 3370.3 3695.8 4093.9 4123.3 4140.7 3696.5 3792.1 4013.3 4090.9 4094.3 3701.9 3742.6 4050.4 4071.1 4089.6 3617.8 3626.5 3627.5 3628.6 3644.9 4135.7 4475.5 4960.3 4984.4 5062.7 4592.7 4605.4 4629.4 4669.5 4677.3 4376.5 5404.5 5406.0 5407.3 5409.2 3687.9 3854.8 3992.9 4000.5 4009.5 4581.8 4585.6 4791.4 5604.6 5642.9 4000.8 4044.1 4061.2 4063.5 4080.4 3477.7 4068.3 4101.7 4106.2 4109.3 4332.4 4573.9 4588.3 4634.3 4694.9 5386.7 5395.9 5410.3 5415.8 5438.9 1150.6 1207.3 1237.8 1311.8 1343.5 794.0 877.4 902.5 907.8 942.3 3945.6 4078.6 4698.2 4711.7 4801.2 4484.7 4686.6 5072.9 5194.4 5206.9 4073.7 4371.5 4531.9 4738.4 4883.5 2308.7 2408.2 2521.8 2650.5 2778.6 4508.5 4768.9 5052.7 5275.7 5486.5 4570.5 4980.0 5059.8 5423.6 5709.6 5459.3 5603.7 5774.9 5843.3 5872.3 4838.0 4981.5 5305.8 5601.7 5624.0 4925.4 5098.1 5214.6 5366.1 5521.8 5074.5 5836.3 5902.6 5904.9 5906.9 4138.9 4177.0 4184.3 4198.8 4205.6 5324.4 5565.0 5628.8 5639.2 5655.5 5460.2 5467.7 5474.7 5484.4 5500.3 4539.8 5398.7 5450.9 5472.8 5476.3 5204.9 5274.6 5297.4 5301.5 5322.8 4586.4 4739.0 4779.1 5182.6 5377.5 4911.5 4962.6 5105.6 5260.3 5287.8 08:26:27 INFO - PROCESS | 1644 | 08:26:27 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20655.19 Median:4497.29 stddev:29818.07 (663.0%) stddev-sans-first:29864.12 08:26:27 INFO - PROCESS | 1644 | Values: 714.7 715.3 723.5 786.5 831.9 14837.8 15805.6 15812.8 15829.5 15846.0 14420.4 14429.0 14451.0 14612.6 14614.4 543.8 679.0 831.7 846.9 849.0 861.7 866.8 874.4 874.5 875.7 923.2 924.0 924.9 925.6 926.3 701.4 717.0 884.8 886.9 887.0 651.7 664.4 665.3 672.1 672.4 15022.8 15044.5 15046.5 15079.4 15089.8 13201.6 13418.7 13453.4 13512.2 13514.7 11698.8 12113.9 12388.4 12459.4 13229.7 4492.9 4501.7 4503.8 4667.5 4696.6 113323.9 115337.0 117382.0 118266.0 119780.0 10300.7 10639.8 10891.0 11095.6 11132.7 21099.3 21619.6 21669.1 21769.2 21831.6 7650.7 7681.4 7728.8 7792.3 7806.9 4253.2 4310.0 4313.8 4322.9 4328.4 3415.2 3491.8 3537.9 3545.5 3565.0 644.0 649.0 653.5 653.5 661.9 525.6 543.3 546.0 546.4 554.3 9133.6 9577.7 9705.5 9806.6 9833.7 619.4 635.7 658.5 660.8 667.3 4741.8 4772.0 4826.8 4890.2 5291.5 84446.0 85400.0 95170.0 100573.5 101555.0 88563.6 88936.0 91364.0 91655.0 92308.5 79394.6 80159.0 81114.0 81524.8 82151.6 9924.0 10072.8 11036.0 11315.7 11328.3 45778.0 47194.8 47306.5 50167.0 53395.5 53977.5 66294.7 66599.7 71748.6 74045.5 12981.4 13198.7 13404.7 13466.2 13644.0 14141.9 14169.4 14829.2 14905.8 15372.9 13605.3 13764.4 13772.6 14013.1 14519.3 13287.5 13450.2 13720.1 13834.6 13898.2 12970.8 12997.6 13522.9 13796.0 14122.6 10787.7 10818.0 11405.7 11565.5 11848.8 8587.6 10882.2 11557.2 11603.3 11611.7 08:26:27 INFO - PROCESS | 1644 | -------- Summary: end -------- 08:26:27 INFO - PROCESS | 1644 | 08:26:28 INFO - TEST-INFO | 1644: exit 0 08:26:28 INFO - TEST-OK | dromaeo_css | took 1118159ms 08:26:28 INFO - TEST-START | kraken 08:26:28 INFO - operating with platform_type : mac_ 08:26:28 INFO - Initialising browser for kraken test... 08:26:28 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpqwhzBA/profile http://localhost:49241/getInfo.html) 08:26:30 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:26:30 INFO - PROCESS | 1649 | colorDepth:24 08:26:30 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:26:30 INFO - PROCESS | 1649 | __metrics 08:26:30 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:26:30 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:26:31 INFO - TEST-INFO | 1649: exit 0 08:26:31 INFO - Browser initialized. 08:26:31 INFO - Running cycle 1/1 for kraken test... 08:26:31 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpqwhzBA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:43 INFO - PROCESS | 1650 | RSS: Main: 213049344 08:26:43 INFO - PROCESS | 1650 | 08:26:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:26:47 INFO - PROCESS | 1650 | RSS: Main: 266293248 08:26:47 INFO - PROCESS | 1650 | 08:26:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:26:50 INFO - PROCESS | 1650 | RSS: Main: 276008960 08:26:50 INFO - PROCESS | 1650 | 08:26:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:26:54 INFO - PROCESS | 1650 | RSS: Main: 371343360 08:26:54 INFO - PROCESS | 1650 | 08:26:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:26:57 INFO - PROCESS | 1650 | RSS: Main: 275922944 08:26:57 INFO - PROCESS | 1650 | 08:26:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:26:59 INFO - PROCESS | 1650 | RSS: Main: 276926464 08:26:59 INFO - PROCESS | 1650 | 08:27:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:03 INFO - PROCESS | 1650 | RSS: Main: 315662336 08:27:03 INFO - PROCESS | 1650 | 08:27:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:06 INFO - PROCESS | 1650 | RSS: Main: 318185472 08:27:06 INFO - PROCESS | 1650 | 08:27:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:27:10 INFO - PROCESS | 1650 | RSS: Main: 314400768 08:27:10 INFO - PROCESS | 1650 | 08:27:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:12 INFO - PROCESS | 1650 | RSS: Main: 293388288 08:27:12 INFO - PROCESS | 1650 | 08:27:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:14 INFO - PROCESS | 1650 | RSS: Main: 297140224 08:27:14 INFO - PROCESS | 1650 | 08:27:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:27:17 INFO - PROCESS | 1650 | RSS: Main: 299098112 08:27:17 INFO - PROCESS | 1650 | 08:27:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:27:21 INFO - PROCESS | 1650 | RSS: Main: 316997632 08:27:21 INFO - PROCESS | 1650 | 08:27:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:27:25 INFO - PROCESS | 1650 | RSS: Main: 311173120 08:27:25 INFO - PROCESS | 1650 | 08:27:26 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:27:27 INFO - PROCESS | 1650 | RSS: Main: 355614720 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | __start_tp_report 08:27:27 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 08:27:27 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 08:27:27 INFO - PROCESS | 1650 | |i|pagename|runs| 08:27:27 INFO - PROCESS | 1650 | |0;ai-astar;116;114;114;114;113;114;114;114;113;114 08:27:27 INFO - PROCESS | 1650 | |1;audio-beat-detection;139;112;108;152;143;138;126;106;124;108 08:27:27 INFO - PROCESS | 1650 | |2;audio-dft;184;183;208;258;202;182;179;182;183;180 08:27:27 INFO - PROCESS | 1650 | |3;audio-fft;78;58;57;89;59;58;57;60;70;57 08:27:27 INFO - PROCESS | 1650 | |4;audio-oscillator;85;70;88;95;98;98;81;67;69;82 08:27:27 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;86;84;87;84;86;84;87;84;87;83 08:27:27 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;94;94;94;96;94;94;94;93;94 08:27:27 INFO - PROCESS | 1650 | |7;imaging-desaturate;84;85;85;88;88;82;83;88;100;144 08:27:27 INFO - PROCESS | 1650 | |8;json-parse-financial;56;52;53;54;57;56;56;56;56;57 08:27:27 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;71;68;78;72;71;67;68;72;99;100 08:27:27 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;84;83;83;83;81;82;84;84;84;84 08:27:27 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;139;137;140;136;137;139;140;141;191;172 08:27:27 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;166;172;168;167;165;167;167;166;167;202 08:27:27 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;57;73;85;83;69;65;66;68;83;85 08:27:27 INFO - PROCESS | 1650 | __end_tp_report 08:27:27 INFO - PROCESS | 1650 | __start_cc_report 08:27:27 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2092 08:27:27 INFO - PROCESS | 1650 | __end_cc_report 08:27:27 INFO - PROCESS | 1650 | __startTimestamp1487003247130__endTimestamp 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | ------- Summary: start ------- 08:27:27 INFO - PROCESS | 1650 | Number of tests: 14 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.44 08:27:27 INFO - PROCESS | 1650 | Values: 116.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:125.60 Median:132.00 stddev:16.75 (12.7%) stddev-sans-first:17.05 08:27:27 INFO - PROCESS | 1650 | Values: 139.0 112.0 108.0 152.0 143.0 138.0 126.0 106.0 124.0 108.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:194.10 Median:183.50 stddev:24.51 (13.4%) stddev-sans-first:25.72 08:27:27 INFO - PROCESS | 1650 | Values: 184.0 183.0 208.0 258.0 202.0 182.0 179.0 182.0 183.0 180.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:64.30 Median:59.50 stddev:11.14 (18.7%) stddev-sans-first:10.65 08:27:27 INFO - PROCESS | 1650 | Values: 78.0 58.0 57.0 89.0 59.0 58.0 57.0 60.0 70.0 57.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:86.50 stddev:11.78 (13.6%) stddev-sans-first:12.47 08:27:27 INFO - PROCESS | 1650 | Values: 85.0 70.0 88.0 95.0 98.0 98.0 81.0 67.0 69.0 82.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.62 08:27:27 INFO - PROCESS | 1650 | Values: 86.0 84.0 87.0 84.0 86.0 84.0 87.0 84.0 87.0 83.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 08:27:27 INFO - PROCESS | 1650 | Values: 93.0 94.0 94.0 94.0 96.0 94.0 94.0 94.0 93.0 94.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:85.00 stddev:18.72 (22.0%) stddev-sans-first:19.59 08:27:27 INFO - PROCESS | 1650 | Values: 84.0 85.0 85.0 88.0 88.0 82.0 83.0 88.0 100.0 144.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.79 08:27:27 INFO - PROCESS | 1650 | Values: 56.0 52.0 53.0 54.0 57.0 56.0 56.0 56.0 56.0 57.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:76.60 Median:71.50 stddev:12.46 (17.4%) stddev-sans-first:13.05 08:27:27 INFO - PROCESS | 1650 | Values: 71.0 68.0 78.0 72.0 71.0 67.0 68.0 72.0 99.0 100.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 08:27:27 INFO - PROCESS | 1650 | Values: 84.0 83.0 83.0 83.0 81.0 82.0 84.0 84.0 84.0 84.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:140.00 stddev:18.69 (13.3%) stddev-sans-first:19.59 08:27:27 INFO - PROCESS | 1650 | Values: 139.0 137.0 140.0 136.0 137.0 139.0 140.0 141.0 191.0 172.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:167.00 stddev:11.16 (6.7%) stddev-sans-first:11.70 08:27:27 INFO - PROCESS | 1650 | Values: 166.0 172.0 168.0 167.0 165.0 167.0 167.0 166.0 167.0 202.0 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:78.00 stddev:9.98 (12.8%) stddev-sans-first:8.64 08:27:27 INFO - PROCESS | 1650 | Values: 57.0 73.0 85.0 83.0 69.0 65.0 66.0 68.0 83.0 85.0 08:27:27 INFO - PROCESS | 1650 | -------- Summary: end -------- 08:27:27 INFO - PROCESS | 1650 | 08:27:27 INFO - TEST-INFO | 1650: exit 0 08:27:27 INFO - TEST-OK | kraken | took 59503ms 08:27:27 INFO - SUITE-END | took 1177s 08:27:28 INFO - Completed test suite (00:19:37) 08:27:28 INFO - javascript benchmark 08:27:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2798.048663454425, 3280.475123980162, 3287.8849240276595, 3307.43773558495, 3375.2911888503413, 5616.157576363547, 5631.0, 5644.74598643061, 5648.237487939127, 5648.717564121793, 5620.803271885485, 5626.437356264371, 5631.549476041917, 5718.857028574288, 5729.885402291951, 5169.974150129254, 5175.482451754813, 5212.739363031852, 5219.112750832368, 5255.816046438375, 5113.463086375933, 5127.282180494715, 5131.102057139986, 5269.235960785683, 5324.068288049595, 5146.202338637517, 5195.116830138866, 5205.0, 5226.2944502492055, 5258.631895767278, 5240.240165176028, 5240.8689782755355, 5244.449332820056, 5267.3679158500845, 5302.946970530284, 4974.328465657126, 5073.416557095944, 5162.92255616166, 5174.456682048406, 5200.583953283728, 5578.63738856973, 5603.859903502404, 5644.717764111778, 5673.971630141823, 5707.914381284284, 6170.136180934673, 6181.165542651775, 6196.132541444202, 6196.81409557714, 6201.193844800147, 6190.50475961922, 6231.781887633911, 6261.937380626181, 6273.717682704244, 6275.403836635513, 4825.0349930013435, 5557.110862262019, 5624.5781566382275, 5698.772049117989, 5712.942870571241, 6253.530985176039, 6261.8747625047245, 6263.217097862767, 6265.154204182468, 6277.937220627735, 6087.66517841523, 6156.953317935961, 6161.96919015411, 6172.105044768484, 6179.5056395489155, 6139.4781443577795, 6140.688304616475, 6144.218176728788, 6182.505399568024, 6271.843203919939, 6130.734471166763, 6171.938280617226, 6172.259328880563, 6205.317415084337, 6208.286047104641, 6210.378962103753, 6218.22272215973, 6232.25212974446, 6237.345078766664, 6237.625742455467, 4729.219678753036, 4826.0, 4841.588464980516, 4890.24201248807, 4925.0, 4330.870073897788, 4359.258925982591, 4390.07808360248, 4432.578905004019, 4439.467263928284, 5660.2075709400715, 5770.0, 5808.79669211584, 5820.563457740686, 5869.559783016205, 6092.055731361646, 6131.448169664752, 6136.478399336017, 6139.154842350747, 6189.597676151126, 5180.041692286939, 5689.175069614883, 5818.5636077294375, 5829.562782791308, 5831.475167234969, 5379.731013449312, 5384.326959130109, 5397.9460205397445, 5403.891922161535, 5409.918851217235, 6164.198654174928, 6168.691565421621, 6230.937690623035, 6357.046443033582, 6389.520785941073, 6174.228221472316, 6175.59858609189, 6187.443130118311, 6217.129601855653, 6264.655443950626, 6272.5922815016875, 6321.715522801577, 6339.175907132228, 6345.7144428499905, 6356.872862542816, 6117.724702388314, 6171.290301615371, 6181.629102253879, 6185.474234690102, 6197.96901015492, 5082.517160869711, 5949.405059494189, 6123.969380153071, 6156.322804491413, 6208.9689551551955, 6096.634201947897, 6110.175126357884, 6112.602680825732, 6115.388461153849, 6130.938690613037, 5987.491063259497, 6089.48239399656, 6097.207363042776, 6104.755809767559, 6117.990531562243, 5717.113847353667, 5768.2501274834, 5808.912866307093, 5852.356240813592, 5914.763409463573, 6093.086037094471, 6108.541859360655, 6119.602225855305, 6120.938790612036, 6133.355997620186, 5898.970505147447, 5910.911336330045, 5925.111233314865, 5926.436988486087, 5929.1995580597795], "value": 5657.815808610613, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.4413392197208, 508.4788092205491, 513.3659929986468, 515.6725479320633, 535.2399592578538, 30240.0, 38625.80687096564, 40504.39243411348, 40560.79719601398, 40705.796471017675, 41994.7900260499, 42661.36007959875, 43127.78436107815, 43158.56841431585, 43161.35257971133, 9372.390794598346, 9570.52147392631, 9581.137697607213, 9589.66436174734, 9600.663976760814, 8388.790280242982, 8574.228319451247, 11176.776464470706, 11366.37484938328, 11421.371824549646, 11332.376719280437, 11339.603113891015, 11344.773104537904, 11456.255343402694, 11563.768724625503, 8423.284020858235, 11404.258723182966, 11485.712857178554, 11489.965903068764, 11492.425378731072, 8454.0, 11104.44477776116, 11338.149638777124, 11361.488733007034, 11596.0, 33165.83417082899, 41013.769586912145, 41044.58955410468, 41076.38385424221, 41116.0, 3934.6262105100254, 4010.5187377514885, 4031.1937612477623, 4074.5925407459017, 4255.659547236213, 26669.46661066787, 27524.174274771787, 27552.448951020866, 28931.710682893114, 30558.930437434807, 3189.3621275744713, 3189.649138594753, 3349.79407413331, 3381.22231886665, 3385.542951701513, 457317.0, 457421.0, 457841.7107914439, 458016.0, 459471.0, 61529.69235153795, 61906.69046654828, 61995.690021549606, 62043.37956620376, 62111.068333975025, 64838.0, 64998.0, 65023.0, 65027.0, 65072.0, 16261.67476650484, 16516.42192523256, 16544.42094526686, 16546.58633534171, 16547.338106475607, 11523.96284334414, 11850.229735067192, 12791.168574042658, 12834.101612887009, 12871.163374380636, 13995.37020834065, 15967.760483592756, 16110.436134735228, 16276.75584866228, 16763.580910477092, 6740.741851479711, 6819.147606549182, 6856.554323968926, 6885.345892140239, 6887.311268873073, 707.8831992721247, 809.8581000788977, 861.440063958432, 876.588003638289, 893.2764460786783, 26496.8675156623, 29018.7098129016, 29398.166600239394, 29617.703822961925, 29716.702832971827, 897.7341947853495, 1052.952617132231, 1064.3454275620438, 1089.536946797608, 1187.7386974865515, 14862.925685371503, 15445.691086178214, 15635.93349936866, 15675.843241567438, 15803.972741771748, 616011.0, 618750.0, 620558.0, 621118.0, 621546.0, 60118.69940650269, 60370.0, 60382.698086509285, 60441.093383599284, 60469.0, 1442.4964832313663, 1445.6313640021726, 1475.4835807467516, 1481.8147731533559, 1485.9182744948916, 28108.297292567848, 28567.857160714062, 29220.26949326199, 29387.0, 30023.849880750455, 49942.0, 50397.49602503928, 50416.966642667765, 50478.7380315495, 50482.0, 516975.0, 517126.0, 522365.0, 522383.0, 523742.0, 23347.88326058359, 26088.73911260939, 26438.339041523348, 26501.0, 26560.0, 38912.2217555653, 42151.78924105482, 43828.12343753171, 44025.89935251644, 45908.0, 37254.8137259312, 37396.0, 37511.81244093762, 38645.22709545737, 39136.0, 34727.826360868035, 34893.30213395769, 34935.0, 35348.29303413866, 35619.82190089033, 34399.484007739404, 35371.29257414889, 36510.0, 36857.07857303589, 36938.63061369459, 29952.850235749553, 31272.530912035883, 31868.0, 31876.68123318737, 31915.0, 23786.524269514168, 24170.516589667757, 24656.50686986286, 24685.753142468344, 24716.752832471444], "value": 19753.412865637747, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4572800846759, 387.4208058951867, 388.5182373856417, 403.1071177342187, 417.7744018230156, 13068.934655326722, 14348.928255358735, 17504.474865754033, 20408.59182816343, 20660.0, 20955.790442095575, 21005.26481573145, 21271.14915403382, 21278.0, 21697.891510542464, 5564.554835613161, 5597.384287728347, 5784.2480477537865, 5817.447342502455, 5832.825015249549, 5677.801276955307, 5684.2326285951285, 5718.17086522454, 5723.027085395472, 5734.827955161351, 4040.9595904041025, 4242.193983143208, 6056.152138700585, 6308.369163083677, 6342.0, 6159.38406159385, 6333.588316759442, 6382.808515744535, 6396.42432181106, 6401.551891367606, 5617.522510586605, 5622.269105016322, 5622.437756224344, 5632.2678051853, 5635.042042852725, 21383.67924481134, 25437.872810636014, 25745.0, 26506.867465662548, 26782.46435071307, 2698.17705599792, 2730.6177135201087, 2737.5209338365707, 2742.122520793347, 2777.4306267215375, 15244.847551524454, 15312.387504499919, 15319.540413787492, 15557.688846223013, 15648.843511564852, 1765.7792775903013, 1810.3301778341965, 1810.357323150289, 1826.2786199451143, 1841.1898764543557, 125189.0, 126672.0, 131253.0, 135151.0, 141315.0, 11141.0, 11529.654110376701, 11561.76876462466, 11566.94216528912, 11739.0, 14625.707485850224, 14640.633984150481, 14641.487547935983, 14665.706685866224, 14668.926655366655, 8571.742847714579, 8780.121987801169, 8800.295976321879, 8886.822263554694, 8887.200151986352, 7527.9084532742445, 8455.577221139041, 8773.166549177819, 8788.8681669775, 8881.644734210558, 5871.3541510433815, 6220.267839296476, 6990.755323563651, 7079.575225486487, 7080.362767350963, 1837.2926423327115, 1940.2530025939832, 1941.9029048547516, 1944.5041514414017, 1946.202057156559, 994.3636072913341, 1014.2747935226348, 1015.5633077776479, 1029.8455231715302, 1030.5465595138114, 20143.79856201419, 21062.47343816417, 21550.353489395344, 21666.62509665035, 21712.69723816576, 1015.7054454208345, 1020.3163880200284, 1026.38416949831, 1027.1474676018886, 1051.1433181956681, 10749.677509674722, 11289.491972861077, 11291.3789741565, 11299.3785341807, 11301.830472542919, 503622.0, 578272.0, 745067.6479705618, 756124.0, 769271.0, 129517.0, 141740.94992684026, 162785.0, 164874.0, 170521.0, 1083.0, 1125.1055410948316, 1136.431784107946, 1136.9204155709187, 1145.4330106597288, 19004.904975475034, 19333.516662083, 19812.207511699948, 19852.404427867186, 19864.0, 55140.72429637826, 61475.07787383282, 61755.38244617496, 61780.0, 63379.51412672347, 83414.33171336418, 85304.0, 86190.13809862072, 87430.1256987422, 88655.0, 8174.877376839233, 8186.795330116556, 8376.706815261437, 8436.029856566329, 8675.696350627697, 9417.058294170529, 12485.500579976699, 13157.407916643582, 13272.203667779964, 13459.327033648082, 11269.12637277489, 11327.490262938023, 11501.597444089417, 11577.942110289394, 11750.529978800752, 9082.727518174466, 11225.158113141384, 11343.20597558163, 11398.575178102737, 11781.76436471283, 10024.899751002396, 11493.0, 11631.360275184947, 11839.05287577009, 11889.0, 8309.210624990616, 8381.413301069111, 8381.455205411628, 8569.314454843723, 8709.0, 8475.491470511543, 9373.625054997723, 11089.889101108885, 11242.213045086766, 11265.662030139109], "value": 10096.022251186952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.704604986903, 1434.734574103791, 1454.3310077364413, 1457.8687918087371, 1462.3857979648549, 7932.881006784895, 8220.177982201776, 8366.53984030878, 8372.790680232998, 8382.994040715115, 7351.963240183792, 7642.541447513139, 7648.808779780508, 7972.641231144598, 8187.467814592047, 2322.1175953137827, 2351.7177938647387, 2356.045801450415, 2356.3166681662383, 2357.127862690807, 2341.8711970841596, 2371.8221133414977, 2373.537160253751, 2377.8335516513853, 2383.6305372667266, 1845.6308738252337, 2040.3470889315424, 2126.8936553172357, 2317.200565804803, 2317.6986991691056, 2294.3690485116645, 2307.180950762472, 2307.953840923189, 2309.9538009239723, 2312.421894526377, 2268.160780511205, 2326.790588846995, 2345.1791872844537, 2350.7766762157567, 2351.0, 8193.590320483952, 8262.545559994198, 8276.503409795432, 8280.917190828075, 8308.169183081704, 4975.7512124394, 5149.819756308549, 5150.9742451287875, 5156.097682905476, 5163.8192663256605, 3332.250243695149, 3477.200243943907, 3480.5997310309385, 3528.4178110611974, 3549.219171782204, 976.6874600127962, 1196.3719047500044, 1201.627495476405, 1247.214255019332, 1257.4844313831286, 10576.418296993663, 10733.731656708645, 10734.892651073545, 10742.946285268601, 10776.299540529919, 4481.170983368087, 4641.675082744176, 4679.27471241958, 4730.787114579852, 4732.668713190113, 9432.62269509212, 9432.95283523578, 9437.952810236042, 9443.480608566595, 9472.147506724428, 5159.0, 5203.583713302926, 5206.453322401169, 5208.8958220835375, 5217.452167522431, 4248.893777655583, 4379.189849877783, 4543.909121817545, 4669.136209801198, 4683.555062269079, 3806.3338915690197, 3871.922561548753, 3928.46965659638, 3943.743656662308, 3956.7625942443547, 1294.9611511654666, 1305.11252348404, 1308.3719814489098, 1313.0939651640338, 1316.230005446805, 789.6525528767324, 872.389327470773, 909.7680091576606, 920.7937601741739, 921.8663293822358, 5503.367112782002, 5636.408177141423, 5688.40271771458, 5800.59395842287, 5852.824415267549, 1001.8897921228659, 1004.5178314408978, 1014.5079636376352, 1016.6899095775859, 1039.1946241662772, 3679.392900171442, 3838.2323535293053, 3923.822278635385, 3993.5639260051344, 3999.280129576646, 9695.224382049419, 9745.853812192823, 9920.950395247977, 9922.950385248172, 9938.204943604494, 9773.41359518431, 9867.06262905023, 9877.555510002067, 9962.950185249172, 9972.750681232883, 7555.16893141754, 7782.066152061789, 7805.258500442563, 7835.804104897423, 7840.960795195988, 5333.5199832015305, 5562.360328562268, 5579.414161513145, 5753.223314852441, 5775.220345253337, 8989.955050224708, 9029.36794424384, 9302.44185348854, 9317.673881414117, 9326.533673316442, 8929.508877011827, 9264.258859291105, 9289.117533834275, 9296.72109836706, 9319.487428191243, 6589.4728421725185, 6788.422984046214, 6796.422304104207, 7067.0106185135155, 7224.241454647186, 7568.5837278950185, 7687.615619219128, 7792.18182090895, 7892.289693927344, 7902.288794008567, 6996.930030699627, 7083.787486375417, 7107.182673992557, 7118.822029449305, 7233.63831808418, 5845.269341332333, 6991.860162796614, 7000.264972178052, 7014.088168538057, 7045.788626341218, 6228.750849966132, 6314.305426403183, 6410.134631824644, 6410.871782564229, 6413.102165696713, 4960.8759781005765, 5026.648134630687, 5028.522290382408, 5034.270030845581, 5073.264376665436, 4359.912801744011, 4879.4876537963, 4991.875203119951, 4997.250412438163, 5186.040582492251], "value": 4413.442518607603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.3906489435513, 360.3765485709722, 368.8911771027547, 376.46917845837373, 378.81248781852986, 4365.912681746363, 5145.845624631258, 5192.014591609825, 5231.834739982313, 5239.738013099349, 3957.576696157817, 4522.321651752239, 4798.256270278103, 4894.339264199332, 5047.167217409133, 3672.7061835053264, 3722.6445059280572, 3811.4473401356786, 3985.8206380712863, 4020.5974457968478, 3370.325934813035, 3695.8336874840697, 4093.89765255868, 4123.257813593552, 4140.730852494593, 3696.5009723687363, 3792.127810603563, 4013.337799263118, 4090.897727556805, 4094.283500387435, 3701.944470832926, 3742.5696044954907, 4050.392441133824, 4071.124708187724, 4089.6319331260033, 3617.8371973261264, 3626.4741612466046, 3627.474016267626, 3628.564572251347, 3644.9041800964287, 4135.710500264982, 4475.507694153641, 4960.280759289919, 4984.426790919055, 5062.721550314731, 4592.678512504126, 4605.355250264965, 4629.421322334708, 4669.486356500782, 4677.298405239208, 4376.474823021258, 5404.51359377654, 5406.0, 5407.324084489439, 5409.188621706736, 3687.94468082979, 3854.79378201096, 3992.8602498912687, 4000.4599379083743, 4009.5389030261604, 4581.816727330903, 4585.601391575601, 4791.377120974251, 5604.600388694896, 5642.943570564283, 4000.7799571023293, 4044.1396957399925, 4061.2080644274083, 4063.512378514538, 4080.449139366207, 3477.7217822574135, 4068.2880495913096, 4101.692373072032, 4106.2198182345255, 4109.301418758818, 4332.415123958288, 4573.885652858705, 4588.311753236974, 4634.281686338623, 4694.859154225379, 5386.703731294817, 5395.865103372447, 5410.296661434067, 5415.783368665288, 5438.864028399322, 1150.6317978247048, 1207.29373316609, 1237.77720010399, 1311.8032295155804, 1343.536479914428, 793.9837008628849, 877.3858299190465, 902.5397047505688, 907.7594437474074, 942.252122313113, 3945.585713500099, 4078.6125318094732, 4698.2247929092, 4711.670183087151, 4801.18379875422, 4484.708493947883, 4686.554777296152, 5072.898542029138, 5194.428612852583, 5206.947930520722, 4073.653739432122, 4371.497277813029, 4531.909361812745, 4738.360321356573, 4883.536064073907, 2308.6652435396772, 2408.1818227238673, 2521.7856482199218, 2650.509655713699, 2778.597103419993, 4508.481524624644, 4768.880777980578, 5052.686301561621, 5275.657082289639, 5486.478784515464, 4570.451545814523, 4980.028894365564, 5059.785651443627, 5423.647462914898, 5709.572606848288, 5459.29029226206, 5603.655122770588, 5774.94225057744, 5843.312076444798, 5872.265966754156, 4837.975810120927, 4981.452040275494, 5305.787768489372, 5601.747921343631, 5624.0, 4925.38432695913, 5098.082345177903, 5214.582833373397, 5366.141417373202, 5521.80342939377, 5074.467180945948, 5836.299644042742, 5902.6458412495385, 5904.8780731660845, 5906.911396328973, 4138.896527586834, 4177.0, 4184.288670925889, 4198.811053502539, 4205.642520385679, 5324.414314425488, 5565.0, 5628.831135065954, 5639.238702775073, 5655.462731040545, 5460.249582862934, 5467.671939683472, 5474.671519708831, 5484.424135465719, 5500.339959204921, 4539.79570919316, 5398.676079435247, 5450.863728406822, 5472.808451704172, 5476.342838859203, 5204.918032786764, 5274.630775845808, 5297.443768404262, 5301.469853014668, 5322.813701520428, 4586.4266966629175, 4738.981119059419, 4779.112250661039, 5182.6113041521285, 5377.462253774747, 4911.533404326583, 4962.578180854668, 5105.617078719185, 5260.342457192851, 5287.779132764325], "value": 3973.638627613687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.742692630653, 715.3418854653718, 723.4935545118415, 786.5320134519959, 831.9126491718367, 14837.777433338508, 15805.60485987848, 15812.84187158131, 15829.525114246577, 15846.0, 14420.35108420121, 14429.0, 14450.98843080982, 14612.634684132901, 14614.415423383078, 543.8069485332719, 678.9932100679005, 831.7463173732009, 846.9280111190525, 849.02362283374, 861.6682577207757, 866.7919699272193, 874.3617159473556, 874.5102742464209, 875.6541166239332, 923.1553128887094, 923.9538023098852, 924.9398789078722, 925.6482536636103, 926.263620421763, 701.396798753072, 716.9784906452815, 884.7788052986754, 886.9157430044136, 886.9822603547925, 651.726274964516, 664.3887623386496, 665.3180489997743, 672.1363048482725, 672.4485921544335, 15022.774658380133, 15044.548663540112, 15046.473373431987, 15079.396824127132, 15089.773653395208, 13201.60395188146, 13418.664533386645, 13453.394597243148, 13512.189268643913, 13514.729705405836, 11698.824517632242, 12113.878861211364, 12388.380580970916, 12459.377031148406, 13229.735405291936, 4492.865214043584, 4501.7194067178525, 4503.819847206108, 4667.4632417272105, 4696.553827386393, 113323.86676133216, 115337.0, 117382.0, 118266.0, 119780.0, 10300.742481437874, 10639.840402393971, 10891.0, 11095.611653592247, 11132.666020019413, 21099.26152584683, 21619.567608648053, 21669.133234670753, 21769.23807666724, 21831.563368732535, 7650.73222437212, 7681.423893208032, 7728.806779830549, 7792.337651299589, 7806.882896756553, 4253.21315556623, 4310.0, 4313.827446902089, 4322.935155972663, 4328.394024836525, 3415.1803567143706, 3491.825408729604, 3537.911552211215, 3545.539079919594, 3565.037439891215, 643.9774607888795, 649.04590252329, 653.4576301669603, 653.4706887421204, 661.8610091880759, 525.5604493492324, 543.3371287029818, 545.9672419654834, 546.3634865381865, 554.3154204557369, 9133.634654613741, 9577.747224111085, 9705.466199359103, 9806.558704858298, 9833.704988850346, 619.3837132053635, 635.6821589205397, 658.4600627485416, 660.831487970574, 667.302668711198, 4741.83403580873, 4771.988427928084, 4826.806927722922, 4890.193118135468, 5291.470852914755, 84446.0, 85400.0, 95170.0, 100573.49713251533, 101555.0, 88563.55718221367, 88936.0, 91364.0, 91655.0, 92308.53845730728, 79394.60302698566, 80159.0, 81114.0, 81524.77712834312, 82151.58924205341, 9923.957984411532, 10072.798544029225, 11036.0, 11315.660530184108, 11328.32030078165, 45778.0, 47194.76402618102, 47306.52693473159, 50167.0, 53395.4660453406, 53977.46022539724, 66294.67410651856, 66599.66700166468, 71748.64125679547, 74045.51908961899, 12981.350932453528, 13198.670033249246, 13404.664883377993, 13466.192028478323, 13644.0, 14141.858581414053, 14169.362378692776, 14829.184394858386, 14905.776413354026, 15372.923135384252, 13605.319734013457, 13764.380602873094, 13772.586822395344, 14013.089149205269, 14519.274036298355, 13287.534936277183, 13450.192988420726, 13720.108192967426, 13834.584962451143, 13898.16611003343, 12970.805437918627, 12997.610071697864, 13522.86477135216, 13796.0, 14122.576322710334, 10787.67636970892, 10818.0, 11405.714857128638, 11565.479553419947, 11848.76302473963, 8587.613557389808, 10882.238243322892, 11557.24877882935, 11603.303801771921, 11611.6516504505], "value": 7506.043972107078, "unit": "score"}], "name": "dromaeo_css", "value": 7277.427807888834, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 112.0, 108.0, 152.0, 143.0, 138.0, 126.0, 106.0, 124.0, 108.0], "value": 125.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 208.0, 258.0, 202.0, 182.0, 179.0, 182.0, 183.0, 180.0], "value": 194.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 57.0, 89.0, 59.0, 58.0, 57.0, 60.0, 70.0, 57.0], "value": 64.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 88.0, 95.0, 98.0, 98.0, 81.0, 67.0, 69.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 84.0, 86.0, 84.0, 87.0, 84.0, 87.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 88.0, 88.0, 82.0, 83.0, 88.0, 100.0, 144.0], "value": 92.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 53.0, 54.0, 57.0, 56.0, 56.0, 56.0, 56.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 78.0, 72.0, 71.0, 67.0, 68.0, 72.0, 99.0, 100.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 81.0, 82.0, 84.0, 84.0, 84.0, 84.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 140.0, 136.0, 137.0, 139.0, 140.0, 141.0, 191.0, 172.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 172.0, 168.0, 167.0, 165.0, 167.0, 167.0, 166.0, 167.0, 202.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 73.0, 85.0, 83.0, 69.0, 65.0, 66.0, 68.0, 83.0, 85.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1459.6000000000001, "alertThreshold": 2.0}]} 08:27:28 INFO - Return code: 0 08:27:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:27:28 ERROR - # TBPL SUCCESS # 08:27:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:27:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:27:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:27:28 INFO - 2017-02-13 08:27:28.403 screenresolution[1654:10147] starting screenresolution argv=screenresolution get 08:27:28 INFO - 2017-02-13 08:27:28.406 screenresolution[1654:10147] Display 0: 1600x1200x32@60 08:27:28 INFO - 2017-02-13 08:27:28.412 screenresolution[1655:10150] starting screenresolution argv=screenresolution list 08:27:28 INFO - Available Modes on Display 0 08:27:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:27:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:27:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:27:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:27:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:27:28 INFO - Intel Iris: 08:27:28 INFO - Chipset Model: Intel Iris 08:27:28 INFO - Type: GPU 08:27:28 INFO - Bus: Built-In 08:27:28 INFO - VRAM (Dynamic, Max): 1536 MB 08:27:28 INFO - Vendor: Intel (0x8086) 08:27:28 INFO - Device ID: 0x0a2e 08:27:28 INFO - Revision ID: 0x0009 08:27:28 INFO - Displays: 08:27:28 INFO - Display: 08:27:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:27:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:27:28 INFO - Display Serial Number: 1600x1200 60 08:27:28 INFO - Main Display: Yes 08:27:28 INFO - Mirror: Off 08:27:28 INFO - Online: Yes 08:27:28 INFO - Rotation: Supported 08:27:28 INFO - Return code: 0 08:27:28 INFO - Running post-action listener: _resource_record_post_action 08:27:28 INFO - [mozharness: 2017-02-13 16:27:28.656736Z] Finished run-tests step (success) 08:27:28 INFO - Running post-run listener: _resource_record_post_run 08:27:28 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 32877568; Write bytes: 508080128; Read time: 303; Write time: 1770 08:27:28 INFO - TinderboxPrint: CPU usage
53.5% 08:27:28 INFO - TinderboxPrint: I/O read bytes / time
32,877,568 / 303 08:27:28 INFO - TinderboxPrint: I/O write bytes / time
508,080,128 / 1,770 08:27:28 INFO - TinderboxPrint: CPU idle
2,230.3 (46.5%) 08:27:28 INFO - TinderboxPrint: CPU system
958.3 (20.0%) 08:27:28 INFO - TinderboxPrint: CPU user
1,605.0 (33.5%) 08:27:28 INFO - TinderboxPrint: Swap in / out
236,580,864 / 0 08:27:28 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207655424; Write bytes: 201824256; Read time: 15892; Write time: 443 08:27:28 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 28720128; Write bytes: 296183808; Read time: 273; Write time: 1290 08:27:29 INFO - Running post-run listener: _upload_blobber_files 08:27:29 INFO - Blob upload gear active. 08:27:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:27:29 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 08:27:29 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'] 08:27:29 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 08:27:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:30 INFO - (blobuploader) - INFO - Done attempting. 08:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:31 INFO - (blobuploader) - INFO - Done attempting. 08:27:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:27:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:27:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:32 INFO - (blobuploader) - INFO - Done attempting. 08:27:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:27:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:34 INFO - (blobuploader) - INFO - Done attempting. 08:27:34 INFO - (blobuploader) - INFO - Iteration through files over. 08:27:34 INFO - Return code: 0 08:27:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:27:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:27:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b84b212fe5d8505edb332fa5a32bbb7d19afc8b88a4952424d321e5d48304b0bb3f3f5425045a4301aa47b751cbc90eb92d6844ff9cf2c3e71ed3718faf9c1b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3e14eea6cb948288d85a565f578940c4ecac3f195157df2b26d8216b5567c096e1212f96e46eed40efe7a07675f21cfd024b767001f6a97ff2315b4abab0277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33d3e4af29c5d25dd5107a80ee5595f1c1aab93982284c777730c1cfbe011864bba19c163d9f60249760cd318c70a5ebdb9130257a96c32bebf15c75bd007bd5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/137860cf07b7389cfc72025a69da089bb6aa29094a6a056a81e9ca5aac46257f5c383c2d806f50a013d13f08ab9387363e5cbe7680c5ca73aace60711af3dc18"} 08:27:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:27:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:27:34 INFO - Contents: 08:27:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b84b212fe5d8505edb332fa5a32bbb7d19afc8b88a4952424d321e5d48304b0bb3f3f5425045a4301aa47b751cbc90eb92d6844ff9cf2c3e71ed3718faf9c1b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3e14eea6cb948288d85a565f578940c4ecac3f195157df2b26d8216b5567c096e1212f96e46eed40efe7a07675f21cfd024b767001f6a97ff2315b4abab0277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33d3e4af29c5d25dd5107a80ee5595f1c1aab93982284c777730c1cfbe011864bba19c163d9f60249760cd318c70a5ebdb9130257a96c32bebf15c75bd007bd5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/137860cf07b7389cfc72025a69da089bb6aa29094a6a056a81e9ca5aac46257f5c383c2d806f50a013d13f08ab9387363e5cbe7680c5ca73aace60711af3dc18"} 08:27:34 INFO - Running post-run listener: copy_logs_to_upload_dir 08:27:34 INFO - Copying logs to upload dir... 08:27:34 INFO - mkdir: /builds/slave/test/build/upload/logs 08:27:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.083345 ========= master_lag: 1.73 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-13 08:27:36.644461) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 08:27:36.650754) ========= 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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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/b84b212fe5d8505edb332fa5a32bbb7d19afc8b88a4952424d321e5d48304b0bb3f3f5425045a4301aa47b751cbc90eb92d6844ff9cf2c3e71ed3718faf9c1b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3e14eea6cb948288d85a565f578940c4ecac3f195157df2b26d8216b5567c096e1212f96e46eed40efe7a07675f21cfd024b767001f6a97ff2315b4abab0277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33d3e4af29c5d25dd5107a80ee5595f1c1aab93982284c777730c1cfbe011864bba19c163d9f60249760cd318c70a5ebdb9130257a96c32bebf15c75bd007bd5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/137860cf07b7389cfc72025a69da089bb6aa29094a6a056a81e9ca5aac46257f5c383c2d806f50a013d13f08ab9387363e5cbe7680c5ca73aace60711af3dc18"} build_url:https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010895 build_url: 'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b84b212fe5d8505edb332fa5a32bbb7d19afc8b88a4952424d321e5d48304b0bb3f3f5425045a4301aa47b751cbc90eb92d6844ff9cf2c3e71ed3718faf9c1b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3e14eea6cb948288d85a565f578940c4ecac3f195157df2b26d8216b5567c096e1212f96e46eed40efe7a07675f21cfd024b767001f6a97ff2315b4abab0277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33d3e4af29c5d25dd5107a80ee5595f1c1aab93982284c777730c1cfbe011864bba19c163d9f60249760cd318c70a5ebdb9130257a96c32bebf15c75bd007bd5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/137860cf07b7389cfc72025a69da089bb6aa29094a6a056a81e9ca5aac46257f5c383c2d806f50a013d13f08ab9387363e5cbe7680c5ca73aace60711af3dc18"}' ========= master_lag: 0.55 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 08:27:37.208537) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:27:37.208918) ========= 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.vUbbLqlYCb/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.5iDs0ZQpgI/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005221 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:27:37.238863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 08:27:37.239150) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 08:27:37.239436) ========= ========= Total master_lag: 2.37 =========