builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0092 starttime: 1485548807.66 results: success (0) buildid: 20170127104620 builduid: 9dafd3c9081d4bc7bf760c12e4566a8d revision: 86c2de8ec8d1741d9fa27cb8707bfd8248d5d1e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:47.661405) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:47.661872) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:47.662151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:47.688184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:47.688576) ========= 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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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-01-27 12:26:47-- 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% 164M=0s 2017-01-27 12:26:47 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113026 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:47.826044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:47.826368) ========= 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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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.031222 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:47.881745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-27 12:26:47.882110) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 86c2de8ec8d1741d9fa27cb8707bfd8248d5d1e0 --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 86c2de8ec8d1741d9fa27cb8707bfd8248d5d1e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d5kXwMh7nN/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.DpL1dCwz8V/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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-01-27 12:26:47,992 truncating revision to first 12 chars 2017-01-27 12:26:47,992 Setting DEBUG logging. 2017-01-27 12:26:47,992 attempt 1/10 2017-01-27 12:26:47,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/86c2de8ec8d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 12:26:50,570 unpacking tar archive at: mozilla-aurora-86c2de8ec8d1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.857514 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-27 12:26:50.762515) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:50.762855) ========= script_repo_revision: 86c2de8ec8d1741d9fa27cb8707bfd8248d5d1e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:50.763251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:50.763518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 12:26:50.782897) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-27 12:26:50.783256) ========= /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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:26:50 INFO - MultiFileLogger online at 20170127 12:26:50 in /builds/slave/test 12:26:50 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 12:26:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:26:50 INFO - {'append_to_log': False, 12:26:50 INFO - 'base_work_dir': '/builds/slave/test', 12:26:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:26:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:26:50 INFO - 'branch': 'Mozilla-Aurora', 12:26:50 INFO - 'buildbot_json_path': 'buildprops.json', 12:26:50 INFO - 'config_files': ('talos/mac_config.py',), 12:26:50 INFO - 'default_actions': ('clobber', 12:26:50 INFO - 'read-buildbot-config', 12:26:50 INFO - 'download-and-extract', 12:26:50 INFO - 'populate-webroot', 12:26:50 INFO - 'create-virtualenv', 12:26:50 INFO - 'install', 12:26:50 INFO - 'run-tests'), 12:26:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:26:50 INFO - 'download_minidump_stackwalk': True, 12:26:50 INFO - 'download_symbols': 'ondemand', 12:26:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:26:50 INFO - 'tooltool.py': '/tools/tooltool.py', 12:26:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:26:50 INFO - '/tools/misc-python/virtualenv.py')}, 12:26:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:26:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:26:50 INFO - 'installer_path': 'installer.exe', 12:26:50 INFO - 'log_level': 'info', 12:26:50 INFO - 'log_name': 'talos', 12:26:50 INFO - 'log_to_console': True, 12:26:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:26:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:26:50 INFO - 'opt_config_files': (), 12:26:50 INFO - 'pip_index': False, 12:26:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:26:50 INFO - 'cmd': ('bash', 12:26:50 INFO - '-c', 12:26:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:26:50 INFO - 'enabled': True, 12:26:50 INFO - 'halt_on_failure': False, 12:26:50 INFO - 'name': 'check_screen_resolution'},), 12:26:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:26:50 INFO - 'cmd': ('bash', 12:26:50 INFO - '-c', 12:26:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:26:50 INFO - 'enabled': True, 12:26:50 INFO - 'halt_on_failure': False, 12:26:50 INFO - 'name': 'check_screen_resolution'},), 12:26:50 INFO - 'run_cmd_checks_enabled': True, 12:26:50 INFO - 'sps_profile': False, 12:26:50 INFO - 'sps_profile_interval': 0, 12:26:50 INFO - 'suite': 'dromaeojs', 12:26:50 INFO - 'system_bits': '32', 12:26:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:26:50 INFO - 'title': 't-yosemite-r7-0092', 12:26:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:26:50 INFO - 'use_talos_json': True, 12:26:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:26:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:26:50 INFO - 'work_dir': 'build'} 12:26:50 INFO - [mozharness: 2017-01-27 20:26:50.997075Z] Running clobber step. 12:26:50 INFO - Running pre-action listener: _resource_record_pre_action 12:26:50 INFO - Running main action method: clobber 12:26:50 INFO - rmtree: /builds/slave/test/build 12:26:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:26:53 INFO - Running post-action listener: _resource_record_post_action 12:26:53 INFO - [mozharness: 2017-01-27 20:26:53.500716Z] Finished clobber step (success) 12:26:53 INFO - [mozharness: 2017-01-27 20:26:53.500870Z] Running read-buildbot-config step. 12:26:53 INFO - Running pre-action listener: _resource_record_pre_action 12:26:53 INFO - Running main action method: read_buildbot_config 12:26:53 INFO - Using buildbot properties: 12:26:53 INFO - { 12:26:53 INFO - "project": "", 12:26:53 INFO - "product": "firefox", 12:26:53 INFO - "script_repo_revision": "production", 12:26:53 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:26:53 INFO - "repository": "", 12:26:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:26:53 INFO - "buildid": "20170127104620", 12:26:53 INFO - "pgo_build": "False", 12:26:53 INFO - "basedir": "/builds/slave/test", 12:26:53 INFO - "buildnumber": 79, 12:26:53 INFO - "slavename": "t-yosemite-r7-0092", 12:26:53 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:26:53 INFO - "platform": "yosemite_r7", 12:26:53 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:26:53 INFO - "branch": "mozilla-aurora", 12:26:53 INFO - "repo_path": "releases/mozilla-aurora", 12:26:53 INFO - "revision": "86c2de8ec8d1741d9fa27cb8707bfd8248d5d1e0", 12:26:53 INFO - "stage_platform": "macosx64", 12:26:53 INFO - "builduid": "9dafd3c9081d4bc7bf760c12e4566a8d", 12:26:53 INFO - "slavebuilddir": "test" 12:26:53 INFO - } 12:26:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 12:26:53 INFO - Running post-action listener: _resource_record_post_action 12:26:53 INFO - [mozharness: 2017-01-27 20:26:53.504287Z] Finished read-buildbot-config step (success) 12:26:53 INFO - [mozharness: 2017-01-27 20:26:53.504438Z] Running download-and-extract step. 12:26:53 INFO - Running pre-action listener: _resource_record_pre_action 12:26:53 INFO - Running main action method: download_and_extract 12:26:53 INFO - mkdir: /builds/slave/test/build/tests 12:26:53 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')]} 12:26:53 INFO - trying https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 12:26:53 INFO - Downloading https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/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 12:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/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 12:26:54 INFO - Downloaded 1199 bytes. 12:26:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 12:26:54 INFO - Using the following test package requirements: 12:26:54 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 12:26:54 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:26:54 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 12:26:54 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:26:54 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 12:26:54 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:26:54 INFO - u'jsshell-mac.zip'], 12:26:54 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:26:54 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 12:26:54 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 12:26:54 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:26:54 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 12:26:54 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:26:54 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 12:26:54 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:26:54 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 12:26:54 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:26:54 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 12:26:54 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:26:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 12:26:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:26:54 INFO - Fetch https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 12:26:55 INFO - Expected file size: 16350791 12:26:55 INFO - Obtained file size: 16350791 12:27:02 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 12:27:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 12:27:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:27:02 INFO - Fetch https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 12:27:03 INFO - Expected file size: 16350791 12:27:03 INFO - Obtained file size: 16350791 12:27:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 12:27:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:27:09 INFO - Fetch https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 12:27:10 INFO - Expected file size: 14403485 12:27:10 INFO - Obtained file size: 14403485 12:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:10 INFO - trying https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 12:27:10 INFO - Downloading https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 12:27:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/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 12:27:12 INFO - Downloaded 73896664 bytes. 12:27:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 12:27:12 INFO - mkdir: /builds/slave/test/properties 12:27:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:27:12 INFO - Writing to file /builds/slave/test/properties/build_url 12:27:12 INFO - Contents: 12:27:12 INFO - build_url:https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 12:27:13 INFO - Running post-action listener: _resource_record_post_action 12:27:13 INFO - Running post-action listener: set_extra_try_arguments 12:27:13 INFO - [mozharness: 2017-01-27 20:27:13.433848Z] Finished download-and-extract step (success) 12:27:13 INFO - [mozharness: 2017-01-27 20:27:13.434002Z] Running populate-webroot step. 12:27:13 INFO - Running pre-action listener: _resource_record_pre_action 12:27:13 INFO - Running main action method: populate_webroot 12:27:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:27:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:27:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:27:13 INFO - '--tppagecycles', 12:27:13 INFO - '7'], 12:27:13 INFO - 'tests': ['tsvgm']}}, 12:27:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:27:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:27:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:27:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:27:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:27:13 INFO - 'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:27:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:27:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:27:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:27:13 INFO - 'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['damp', 'tps']}, 12:27:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:27:13 INFO - 'tests': ['damp', 'tps']}, 12:27:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['dromaeo_dom']}, 12:27:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:27:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['basic_compositor_video']}, 12:27:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:27:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['a11yr', 12:27:13 INFO - 'ts_paint', 12:27:13 INFO - 'tpaint', 12:27:13 INFO - 'sessionrestore', 12:27:13 INFO - 'sessionrestore_no_auto_restore', 12:27:13 INFO - 'tabpaint']}, 12:27:13 INFO - 'other-e10s': {'tests': ['a11yr', 12:27:13 INFO - 'ts_paint', 12:27:13 INFO - 'tpaint', 12:27:13 INFO - 'sessionrestore', 12:27:13 INFO - 'sessionrestore_no_auto_restore', 12:27:13 INFO - 'tabpaint']}, 12:27:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:27:13 INFO - 'ts_paint', 12:27:13 INFO - 'tpaint', 12:27:13 INFO - 'sessionrestore', 12:27:13 INFO - 'sessionrestore_no_auto_restore', 12:27:13 INFO - 'tabpaint']}, 12:27:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:27:13 INFO - 'ts_paint', 12:27:13 INFO - 'tpaint', 12:27:13 INFO - 'sessionrestore', 12:27:13 INFO - 'sessionrestore_no_auto_restore', 12:27:13 INFO - 'tabpaint']}, 12:27:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['a11yr', 12:27:13 INFO - 'ts_paint', 12:27:13 INFO - 'tpaint', 12:27:13 INFO - 'sessionrestore', 12:27:13 INFO - 'sessionrestore_no_auto_restore', 12:27:13 INFO - 'tabpaint']}, 12:27:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['a11yr', 12:27:13 INFO - 'ts_paint', 12:27:13 INFO - 'tpaint', 12:27:13 INFO - 'sessionrestore', 12:27:13 INFO - 'sessionrestore_no_auto_restore', 12:27:13 INFO - 'tabpaint']}, 12:27:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['tsvgx', 12:27:13 INFO - 'tsvgr_opacity', 12:27:13 INFO - 'tart', 12:27:13 INFO - 'tscrollx', 12:27:13 INFO - 'cart', 12:27:13 INFO - 'tsvg_static']}, 12:27:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:27:13 INFO - 'tsvgr_opacity', 12:27:13 INFO - 'tart', 12:27:13 INFO - 'tscrollx', 12:27:13 INFO - 'cart', 12:27:13 INFO - 'tsvg_static']}, 12:27:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:27:13 INFO - 'talos_options': ['--disable-e10s'], 12:27:13 INFO - 'tests': ['tp5o']}, 12:27:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:27:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:27:13 INFO - 'talos_options': ['--disable-e10s', 12:27:13 INFO - '--xperf_path', 12:27:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:27:13 INFO - 'tests': ['tp5n']}, 12:27:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:27:13 INFO - 'talos_options': ['--xperf_path', 12:27:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:27:13 INFO - 'tests': ['tp5n']}}, 12:27:13 INFO - 'talos.zip': {'path': '', 12:27:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:27:13 INFO - Running post-action listener: _resource_record_post_action 12:27:13 INFO - [mozharness: 2017-01-27 20:27:13.452437Z] Finished populate-webroot step (success) 12:27:13 INFO - [mozharness: 2017-01-27 20:27:13.452574Z] Running create-virtualenv step. 12:27:13 INFO - Running pre-action listener: _resource_record_pre_action 12:27:13 INFO - Running main action method: create_virtualenv 12:27:13 INFO - Creating virtualenv /builds/slave/test/build/venv 12:27:13 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 12:27:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:27:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:27:13 INFO - Using real prefix '/tools/python27' 12:27:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:27:14 INFO - Installing distribute.............................................................................................................................................................................................done. 12:27:17 INFO - Installing pip.................done. 12:27:17 INFO - Return code: 0 12:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:27:17 INFO - Reading from file tmpfile_stdout 12:27:17 INFO - Output received: 12:27:17 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) 12:27:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:17 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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27:17 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 12:27:17 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 12:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:17 INFO - 'HOME': '/Users/cltbld', 12:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:17 INFO - 'LOGNAME': 'cltbld', 12:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:17 INFO - 'MOZ_NO_REMOTE': '1', 12:27:17 INFO - 'NO_EM_RESTART': '1', 12:27:17 INFO - 'PAGER': '/bin/cat', 12:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:17 INFO - 'PWD': '/builds/slave/test', 12:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:17 INFO - 'SHELL': '/bin/bash', 12:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:17 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:17 INFO - 'USER': 'cltbld', 12:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:17 INFO - 'XPC_FLAGS': '0x0', 12:27:17 INFO - 'XPC_SERVICE_NAME': '0', 12:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:17 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 12:27:17 INFO - Cleaning up... 12:27:17 INFO - Return code: 0 12:27:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:17 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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27:17 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 12:27:17 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 12:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:17 INFO - 'HOME': '/Users/cltbld', 12:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:17 INFO - 'LOGNAME': 'cltbld', 12:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:17 INFO - 'MOZ_NO_REMOTE': '1', 12:27:17 INFO - 'NO_EM_RESTART': '1', 12:27:17 INFO - 'PAGER': '/bin/cat', 12:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:17 INFO - 'PWD': '/builds/slave/test', 12:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:17 INFO - 'SHELL': '/bin/bash', 12:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:17 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:17 INFO - 'USER': 'cltbld', 12:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:17 INFO - 'XPC_FLAGS': '0x0', 12:27:17 INFO - 'XPC_SERVICE_NAME': '0', 12:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:17 INFO - Downloading/unpacking psutil>=3.1.1 12:27: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 12:27: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 12:27: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 12:27: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 12:27: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 12:27: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 12:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:27:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:27:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:27:21 INFO - Installing collected packages: psutil 12:27:21 INFO - Running setup.py install for psutil 12:27:21 INFO - building 'psutil._psutil_osx' extension 12:27:21 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 12:27:22 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 12:27:22 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 12:27:22 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 12:27:22 INFO - building 'psutil._psutil_posix' extension 12:27:22 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 12:27:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:27:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:27:22 INFO - ^ 12:27:22 INFO - 1 warning generated. 12:27:22 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 12:27:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:27:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:27:22 INFO - Successfully installed psutil 12:27:22 INFO - Cleaning up... 12:27:22 INFO - Return code: 0 12:27:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:27:22 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')]} 12:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:22 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')]} 12:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:22 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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27:22 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 12:27:22 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 12:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:22 INFO - 'HOME': '/Users/cltbld', 12:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:22 INFO - 'LOGNAME': 'cltbld', 12:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:22 INFO - 'MOZ_NO_REMOTE': '1', 12:27:22 INFO - 'NO_EM_RESTART': '1', 12:27:22 INFO - 'PAGER': '/bin/cat', 12:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:22 INFO - 'PWD': '/builds/slave/test', 12:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:22 INFO - 'SHELL': '/bin/bash', 12:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:22 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:22 INFO - 'USER': 'cltbld', 12:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:22 INFO - 'XPC_FLAGS': '0x0', 12:27:22 INFO - 'XPC_SERVICE_NAME': '0', 12:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:27:22 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 12:27:22 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 12:27:22 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 12:27:22 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 12:27:22 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 12:27:22 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 12:27:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:27:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:27:25 INFO - Installing collected packages: mozsystemmonitor 12:27:25 INFO - Running setup.py install for mozsystemmonitor 12:27:25 INFO - Successfully installed mozsystemmonitor 12:27:25 INFO - Cleaning up... 12:27:25 INFO - Return code: 0 12:27:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:25 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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27:25 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 12:27:25 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 12:27:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:25 INFO - 'HOME': '/Users/cltbld', 12:27:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:25 INFO - 'LOGNAME': 'cltbld', 12:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:25 INFO - 'MOZ_NO_REMOTE': '1', 12:27:25 INFO - 'NO_EM_RESTART': '1', 12:27:25 INFO - 'PAGER': '/bin/cat', 12:27:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:25 INFO - 'PWD': '/builds/slave/test', 12:27:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:25 INFO - 'SHELL': '/bin/bash', 12:27:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:25 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:25 INFO - 'USER': 'cltbld', 12:27:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:25 INFO - 'XPC_FLAGS': '0x0', 12:27:25 INFO - 'XPC_SERVICE_NAME': '0', 12:27:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:26 INFO - Downloading/unpacking jsonschema==2.5.1 12:27:26 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 12:27:26 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 12:27:26 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 12:27:26 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 12:27:26 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 12:27:26 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 12:27:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:27:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:27:28 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 12:27:28 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 12:27:28 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 12:27:28 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 12:27:28 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 12:27:28 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 12:27:29 INFO - Downloading functools32-3.2.3-2.tar.gz 12:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:27:29 INFO - warning: no files found matching '*.txt' 12:27:29 INFO - no previously-included directories found matching 'build' 12:27:29 INFO - no previously-included directories found matching 'dist' 12:27:29 INFO - no previously-included directories found matching '.git*' 12:27:29 INFO - Installing collected packages: jsonschema, functools32 12:27:29 INFO - Running setup.py install for functools32 12:27:29 INFO - warning: no files found matching '*.txt' 12:27:29 INFO - no previously-included directories found matching 'build' 12:27:29 INFO - no previously-included directories found matching 'dist' 12:27:29 INFO - no previously-included directories found matching '.git*' 12:27:29 INFO - Successfully installed jsonschema functools32 12:27:29 INFO - Cleaning up... 12:27:29 INFO - Return code: 0 12:27:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:27: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')]} 12:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27: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')]} 12:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27: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', '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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:27: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 functools32==3.2.3-2 12:27:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:29 INFO - 'HOME': '/Users/cltbld', 12:27:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:29 INFO - 'LOGNAME': 'cltbld', 12:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:29 INFO - 'MOZ_NO_REMOTE': '1', 12:27:29 INFO - 'NO_EM_RESTART': '1', 12:27:29 INFO - 'PAGER': '/bin/cat', 12:27:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:29 INFO - 'PWD': '/builds/slave/test', 12:27:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:29 INFO - 'SHELL': '/bin/bash', 12:27:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:29 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:29 INFO - 'USER': 'cltbld', 12:27:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:29 INFO - 'XPC_FLAGS': '0x0', 12:27:29 INFO - 'XPC_SERVICE_NAME': '0', 12:27:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:27:29 INFO - Cleaning up... 12:27:29 INFO - Return code: 0 12:27:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:27: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')]} 12:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27: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')]} 12:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27: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', '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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:27: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 blobuploader==1.2.4 12:27:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:29 INFO - 'HOME': '/Users/cltbld', 12:27:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:29 INFO - 'LOGNAME': 'cltbld', 12:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:29 INFO - 'MOZ_NO_REMOTE': '1', 12:27:29 INFO - 'NO_EM_RESTART': '1', 12:27:29 INFO - 'PAGER': '/bin/cat', 12:27:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:29 INFO - 'PWD': '/builds/slave/test', 12:27:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:29 INFO - 'SHELL': '/bin/bash', 12:27:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:29 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:29 INFO - 'USER': 'cltbld', 12:27:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:29 INFO - 'XPC_FLAGS': '0x0', 12:27:29 INFO - 'XPC_SERVICE_NAME': '0', 12:27:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:29 INFO - Downloading/unpacking blobuploader==1.2.4 12:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:32 INFO - Downloading blobuploader-1.2.4.tar.gz 12:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:27:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:27:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:27:33 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 12:27:33 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 12:27:33 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 12:27:33 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 12:27:33 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 12:27:33 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 12:27:33 INFO - Downloading docopt-0.6.1.tar.gz 12:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:27:34 INFO - Installing collected packages: blobuploader, requests, docopt 12:27:34 INFO - Running setup.py install for blobuploader 12:27:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:27:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:27:34 INFO - Running setup.py install for requests 12:27:34 INFO - Running setup.py install for docopt 12:27:34 INFO - Successfully installed blobuploader requests docopt 12:27:34 INFO - Cleaning up... 12:27:34 INFO - Return code: 0 12:27:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:27:34 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')]} 12:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:34 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')]} 12:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:34 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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27:34 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 12:27:34 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 12:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:34 INFO - 'HOME': '/Users/cltbld', 12:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:34 INFO - 'LOGNAME': 'cltbld', 12:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:34 INFO - 'MOZ_NO_REMOTE': '1', 12:27:34 INFO - 'NO_EM_RESTART': '1', 12:27:34 INFO - 'PAGER': '/bin/cat', 12:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:34 INFO - 'PWD': '/builds/slave/test', 12:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:34 INFO - 'SHELL': '/bin/bash', 12:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:34 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:34 INFO - 'USER': 'cltbld', 12:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:34 INFO - 'XPC_FLAGS': '0x0', 12:27:34 INFO - 'XPC_SERVICE_NAME': '0', 12:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:27:35 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-8BNWtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:27:35 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-Y2fjLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:27:35 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-wSTm0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:27:35 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-rR5S09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:27:35 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-CwdIzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:27:35 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-cIoTmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:27:35 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-AY9Obv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:27:35 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-on4Fln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:27:36 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-2EmHwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:27:36 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-u4lH9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:27:36 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-sZCi73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:27:36 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-3OL1TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:27:36 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-vxiX_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:27:36 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-MKNGuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:27:36 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-f8Sbof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:27:36 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-TV77WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:27:36 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-NYrnNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:27:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:27:36 INFO - Running setup.py install for manifestparser 12:27:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:27:37 INFO - Running setup.py install for mozcrash 12:27:37 INFO - Running setup.py install for mozdebug 12:27:37 INFO - Running setup.py install for mozdevice 12:27:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:27:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:27:37 INFO - Running setup.py install for mozfile 12:27:37 INFO - Running setup.py install for mozhttpd 12:27:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:27:37 INFO - Running setup.py install for mozinfo 12:27:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:27:37 INFO - Running setup.py install for mozInstall 12:27:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:27:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:27:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:27:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:27:38 INFO - Running setup.py install for mozleak 12:27:38 INFO - Running setup.py install for mozlog 12:27:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:27:38 INFO - Running setup.py install for moznetwork 12:27:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:27:38 INFO - Running setup.py install for mozprocess 12:27:38 INFO - Running setup.py install for mozprofile 12:27:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:27:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:27:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:27:38 INFO - Running setup.py install for mozrunner 12:27:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:27:39 INFO - Running setup.py install for mozscreenshot 12:27:39 INFO - Running setup.py install for moztest 12:27:39 INFO - Running setup.py install for mozversion 12:27:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:27:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:27:39 INFO - Cleaning up... 12:27:39 INFO - Return code: 0 12:27:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:27:39 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')]} 12:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:39 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')]} 12:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:39 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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27:39 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 12:27:39 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 12:27:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:39 INFO - 'HOME': '/Users/cltbld', 12:27:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:39 INFO - 'LOGNAME': 'cltbld', 12:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:39 INFO - 'MOZ_NO_REMOTE': '1', 12:27:39 INFO - 'NO_EM_RESTART': '1', 12:27:39 INFO - 'PAGER': '/bin/cat', 12:27:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:39 INFO - 'PWD': '/builds/slave/test', 12:27:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:39 INFO - 'SHELL': '/bin/bash', 12:27:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:39 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:39 INFO - 'USER': 'cltbld', 12:27:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:39 INFO - 'XPC_FLAGS': '0x0', 12:27:39 INFO - 'XPC_SERVICE_NAME': '0', 12:27:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:27:39 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-oVvUJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:27:39 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)) 12:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:27:39 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-27NdUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-61Z3sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-0ZIU7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-ros8SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-clNbU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-4f__HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-M7OBwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-qCkpRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-8koynu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-3SUGdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:27:40 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)) 12:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:27:40 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-4ddoyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:27:41 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)) 12:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:27:41 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-zzzp39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:27:41 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)) 12:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:27:41 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-bxzlvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:27:41 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)) 12:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:27:41 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-Dx1wmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:27:41 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)) 12:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:27:41 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-dfN5cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:27:41 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)) 12:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:27:41 INFO - Running setup.py (path:/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/pip-1OsDlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:27:41 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)) 12:27:41 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)) 12:27:41 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)) 12:27:41 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)) 12:27:41 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)) 12:27:41 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)) 12:27:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:27:41 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 12:27:41 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 12:27:41 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 12:27:41 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 12:27:41 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 12:27:41 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 12:27:44 INFO - Downloading blessings-1.6.tar.gz 12:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:27:44 INFO - Installing collected packages: blessings 12:27:44 INFO - Running setup.py install for blessings 12:27:44 INFO - Successfully installed blessings 12:27:44 INFO - Cleaning up... 12:27:44 INFO - Return code: 0 12:27:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:27:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:27:44 INFO - Reading from file tmpfile_stdout 12:27:44 INFO - Current package versions: 12:27:44 INFO - blessings == 1.6 12:27:44 INFO - blobuploader == 1.2.4 12:27:44 INFO - docopt == 0.6.1 12:27:44 INFO - functools32 == 3.2.3-2 12:27:44 INFO - jsonschema == 2.5.1 12:27:44 INFO - manifestparser == 1.1 12:27:44 INFO - mozInstall == 1.12 12:27:44 INFO - mozcrash == 1.0 12:27:44 INFO - mozdebug == 0.1 12:27:44 INFO - mozdevice == 0.49 12:27:44 INFO - mozfile == 1.2 12:27:44 INFO - mozhttpd == 0.7 12:27:44 INFO - mozinfo == 0.9 12:27:44 INFO - mozleak == 0.1 12:27:44 INFO - mozlog == 3.4 12:27:44 INFO - moznetwork == 0.27 12:27:44 INFO - mozprocess == 0.24 12:27:44 INFO - mozprofile == 0.28 12:27:44 INFO - mozrunner == 6.13 12:27:44 INFO - mozscreenshot == 0.1 12:27:44 INFO - mozsystemmonitor == 0.3 12:27:44 INFO - moztest == 0.8 12:27:44 INFO - mozversion == 1.4 12:27:44 INFO - psutil == 3.1.1 12:27:44 INFO - requests == 1.2.3 12:27:44 INFO - wsgiref == 0.1.2 12:27:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:27:44 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')]} 12:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:45 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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27:45 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 12:27:45 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 12:27:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:45 INFO - 'HOME': '/Users/cltbld', 12:27:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:45 INFO - 'LOGNAME': 'cltbld', 12:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:45 INFO - 'MOZ_NO_REMOTE': '1', 12:27:45 INFO - 'NO_EM_RESTART': '1', 12:27:45 INFO - 'PAGER': '/bin/cat', 12:27:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:45 INFO - 'PWD': '/builds/slave/test', 12:27:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:45 INFO - 'SHELL': '/bin/bash', 12:27:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:45 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:45 INFO - 'USER': 'cltbld', 12:27:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:45 INFO - 'XPC_FLAGS': '0x0', 12:27:45 INFO - 'XPC_SERVICE_NAME': '0', 12:27:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:45 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)) 12:27:45 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)) 12:27:45 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)) 12:27:45 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)) 12:27:45 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)) 12:27:45 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)) 12:27:45 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)) 12:27:45 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)) 12:27:45 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)) 12:27:45 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)) 12:27:45 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)) 12:27:45 INFO - Cleaning up... 12:27:45 INFO - Return code: 0 12:27:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:27:46 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 0x103ccdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cd0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a1ccb280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, '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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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 12:27:46 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 12:27:46 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 12:27:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:27:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:27:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:27:46 INFO - 'HOME': '/Users/cltbld', 12:27:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:27:46 INFO - 'LOGNAME': 'cltbld', 12:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:46 INFO - 'MOZ_NO_REMOTE': '1', 12:27:46 INFO - 'NO_EM_RESTART': '1', 12:27:46 INFO - 'PAGER': '/bin/cat', 12:27:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:46 INFO - 'PWD': '/builds/slave/test', 12:27:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:27:46 INFO - 'SHELL': '/bin/bash', 12:27:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:27:46 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:27:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:27:46 INFO - 'USER': 'cltbld', 12:27:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:27:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:46 INFO - 'XPC_FLAGS': '0x0', 12:27:46 INFO - 'XPC_SERVICE_NAME': '0', 12:27:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:27:46 INFO - Cleaning up... 12:27:46 INFO - Return code: 0 12:27:46 INFO - Running post-action listener: _resource_record_post_action 12:27:46 INFO - Running post-action listener: _start_resource_monitoring 12:27:46 INFO - Starting resource monitoring. 12:27:46 INFO - [mozharness: 2017-01-27 20:27:46.568250Z] Finished create-virtualenv step (success) 12:27:46 INFO - [mozharness: 2017-01-27 20:27:46.569185Z] Running install step. 12:27:46 INFO - Running pre-action listener: _resource_record_pre_action 12:27:46 INFO - Running main action method: install 12:27:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:27:46 INFO - Reading from file tmpfile_stdout 12:27:46 INFO - Detecting whether we're running mozinstall >=1.0... 12:27:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:27:46 INFO - Reading from file tmpfile_stdout 12:27:46 INFO - Output received: 12:27:46 INFO - Usage: mozinstall [options] installer 12:27:46 INFO - Options: 12:27:46 INFO - -h, --help show this help message and exit 12:27:46 INFO - -d DEST, --destination=DEST 12:27:46 INFO - Directory to install application into. [default: 12:27:46 INFO - "/builds/slave/test"] 12:27:46 INFO - --app=APP Application being installed. [default: firefox] 12:27:46 INFO - mkdir: /builds/slave/test/build/application 12:27:46 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'] 12:27:46 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 12:28:06 INFO - Reading from file tmpfile_stdout 12:28:06 INFO - Output received: 12:28:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:28:06 INFO - Running post-action listener: _resource_record_post_action 12:28:06 INFO - [mozharness: 2017-01-27 20:28:06.856382Z] Finished install step (success) 12:28:06 INFO - [mozharness: 2017-01-27 20:28:06.856558Z] Running run-tests step. 12:28:06 INFO - Running pre-action listener: _resource_record_pre_action 12:28:06 INFO - Running main action method: run_tests 12:28:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:28:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:28:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:28:06 INFO - 2017-01-27 12:28:06.871 screenresolution[1630:7391] starting screenresolution argv=screenresolution get 12:28:06 INFO - 2017-01-27 12:28:06.873 screenresolution[1630:7391] Display 0: 1600x1200x32@60 12:28:06 INFO - 2017-01-27 12:28:06.879 screenresolution[1631:7394] starting screenresolution argv=screenresolution list 12:28:06 INFO - Available Modes on Display 0 12:28:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:28:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:28:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:28:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:28:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:28:07 INFO - Intel Iris: 12:28:07 INFO - Chipset Model: Intel Iris 12:28:07 INFO - Type: GPU 12:28:07 INFO - Bus: Built-In 12:28:07 INFO - VRAM (Dynamic, Max): 1536 MB 12:28:07 INFO - Vendor: Intel (0x8086) 12:28:07 INFO - Device ID: 0x0a2e 12:28:07 INFO - Revision ID: 0x0009 12:28:07 INFO - Displays: 12:28:07 INFO - Display: 12:28:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:28:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:28:07 INFO - Display Serial Number: 1600x1200 60 12:28:07 INFO - Main Display: Yes 12:28:07 INFO - Mirror: Off 12:28:07 INFO - Online: Yes 12:28:07 INFO - Rotation: Supported 12:28:07 INFO - Return code: 0 12:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:28:07 INFO - Python 2.7.3 12:28:07 INFO - Return code: 0 12:28:07 INFO - grabbing minidump binary from tooltool 12:28:07 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')]} 12:28:07 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 0x103aabd30>, '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 0x1039d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103aa0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:28:07 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 12:28:07 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 12:28:07 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 12:28:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:28:07 INFO - Return code: 0 12:28:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:28:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:28:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:28:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:28:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:28:07 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/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 12:28:07 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/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0092 --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 12:28:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d5kXwMh7nN/Render', 12:28:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:07 INFO - 'HOME': '/Users/cltbld', 12:28:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:07 INFO - 'LOGNAME': 'cltbld', 12:28:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:28:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:07 INFO - 'MOZ_NO_REMOTE': '1', 12:28:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:28:07 INFO - 'NO_EM_RESTART': '1', 12:28:07 INFO - 'PAGER': '/bin/cat', 12:28:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:07 INFO - 'PWD': '/builds/slave/test', 12:28:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:28:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:07 INFO - 'SHELL': '/bin/bash', 12:28:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpL1dCwz8V/Listeners', 12:28:07 INFO - 'TMPDIR': '/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/', 12:28:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:07 INFO - 'USER': 'cltbld', 12:28:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:07 INFO - 'XPC_FLAGS': '0x0', 12:28:07 INFO - 'XPC_SERVICE_NAME': '0', 12:28:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:07 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/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 12:28:07 INFO - mozversion application_buildid: 20170127104620 12:28:07 INFO - mozversion application_changeset: 86c2de8ec8d1741d9fa27cb8707bfd8248d5d1e0 12:28:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:28:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:28:07 INFO - mozversion application_name: Firefox 12:28:07 INFO - mozversion application_remotingname: firefox-dev 12:28:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:28:07 INFO - mozversion application_vendor: Mozilla 12:28:07 INFO - mozversion application_version: 53.0a2 12:28:07 INFO - mozversion platform_buildid: 20170127104620 12:28:07 INFO - mozversion platform_changeset: 86c2de8ec8d1741d9fa27cb8707bfd8248d5d1e0 12:28:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:28:07 INFO - mozversion platform_version: 53.0a2 12:28:07 INFO - using testdate: 1485548887 12:28:07 INFO - actual date: 1485548887 12:28:07 INFO - starting webserver on 'localhost:49247' 12:28:07 INFO - SUITE-START | Running 2 tests 12:28:07 INFO - TEST-START | dromaeo_css 12:28:07 INFO - operating with platform_type : mac_ 12:28:07 INFO - Initialising browser for dromaeo_css test... 12:28:07 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/tmpz4LAcU/profile http://localhost:49247/getInfo.html) 12:28:09 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 12:28:09 INFO - PROCESS | 1641 | colorDepth:24 12:28:09 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 12:28:09 INFO - PROCESS | 1641 | __metrics 12:28:10 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" 12:28:10 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] 12:28:10 INFO - TEST-INFO | 1641: exit 0 12:28:10 INFO - Browser initialized. 12:28:10 INFO - Running cycle 1/1 for dromaeo_css test... 12:28:10 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/tmpz4LAcU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:28:22 INFO - PROCESS | 1643 | RSS: Main: 212267008 12:28:22 INFO - PROCESS | 1643 | 12:31:26 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 12:31:27 INFO - PROCESS | 1643 | RSS: Main: 349061120 12:31:27 INFO - PROCESS | 1643 | 12:33:12 INFO - PROCESS | 1643 | ************************* 12:33:12 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 12:33:12 INFO - PROCESS | 1643 | 12:33:12 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:33:12 INFO - PROCESS | 1643 | Full stack: 12:33:12 INFO - PROCESS | 1643 | ************************* 12:34:30 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 12:34:31 INFO - PROCESS | 1643 | RSS: Main: 348446720 12:34:31 INFO - PROCESS | 1643 | 12:37:33 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 12:37:34 INFO - PROCESS | 1643 | RSS: Main: 346075136 12:37:34 INFO - PROCESS | 1643 | 12:40:36 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 12:40:37 INFO - PROCESS | 1643 | RSS: Main: 324698112 12:40:37 INFO - PROCESS | 1643 | 12:43:40 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 12:43:41 INFO - PROCESS | 1643 | RSS: Main: 309936128 12:43:41 INFO - PROCESS | 1643 | 12:46:44 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 12:46:44 INFO - PROCESS | 1643 | RSS: Main: 406949888 12:46:44 INFO - PROCESS | 1643 | 12:46:44 INFO - PROCESS | 1643 | __start_tp_report 12:46:44 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 12:46:44 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 12:46:44 INFO - PROCESS | 1643 | |i|pagename|runs| 12:46:44 INFO - PROCESS | 1643 | |0;dojo.html;3058.3424563718804;3379.4761811919147;3388.6780755828204;3398.8810391636266;3436.1924947637317;5776.451237132465;5787.13193021047;5794.362620111784;5808.390119037498;5848.707564621763;5813.098969659699;5902.2622172228475;5908.734106965187;5912.408759124096;5931.199288096106;4416.315471101968;5281.63028587999;5305.469453054702;5403.459654034585;5412.323459567554;5236.842894713165;5246.055709972223;5271.525562699357;5369.677819330833;5390.164524498709;5288.629795914288;5308.92036619451;5319.654222475527;5343.305370301875;5368.248445217672;5369.570434365241;5370.838874833761;5373.731313434352;5377.784888604451;5381.838544843661;5204.063268611649;5271.103912334912;5327.786888524493;5345.893082138336;5361.061814182542;5713.200151978726;5732.684702341369;5758.337791154029;5764.74058667361;5833.095870140135;6362.172917520739;6363.554551181419;6368.10846481493;6375.330590287999;6376;6244.656543890084;6292.811215663537;6311.905321420182;6317.084022816712;6317.399847014526;5824.039033559416;5896.852578685567;5910.261217347832;5992.610480318809;6034.125051867454;6199.752009919553;6265.812025639147;6293.96853015732;6304;6366.713497892606;6292.685365731695;6295.433410992941;6302.401271879165;6303.810885673437;6307.369263073656;6188.690565471708;6323.9051414228825;6324.525660575383;6326.620402775849;6347.746090156435;6131.816594322154;6206.975848984957;6224.657643829632;6280.371962803683;6353.428191462791;6331.2085989251345;6340.587861788969;6347.936520634827;6351.079093531412;6351.650659213695;4060;5026.447090820006;5052.065367906949;5074.213496907985;5087.3386459759995;4461.776911154429;4514.7291162530355;4520.81916723334;4551.13528429604;4559.156556037144;5842.415758424124;5855.355910849803;5867.471927526543;5869.853253668693;5882.147088672119;6219.657918814509;6242.219722534684;6254.562180647402;6284.025975973731;6295.401936816087;5874.588778785529;5917.408259174134;5922.2597175353085;5925.9407405925385;6007.339192688801;5566.053770858964;5572.777088916398;5572.916406253909;5586.55307575393;5601.80393686219;6240.469560087444;6290.245170579651;6303.306636269915;6344.365563443619;6402.935970640234;6304.968475157595;6316.968415157895;6324.747010119544;6327.3988971047675;6442.065900444503;5365.678059316453;6446.226452825691;6450.451711604566;6465.77369792055;6490;6145.539084568764;6209.037599172136;6224.782132625336;6337.334579869232;6356.745730170926;6221.346758590283;6282.277538082996;6316.7157477914525;6316.778912738032;6319.146915166394;6231.158793562992;6261.8747625046335;6271.811845644638;6275.968620157053;6286.057091436322;6096.207493025879;6118.619179173164;6194.101855231056;6243.7814676486105;6252.406021427957;6018.638881667114;6034.9094763577705;6116.633002019893;6138.051223665453;6147.170132032118;6039.063945088518;6245.5628106032145;6260.655663938345;6262.5929314594405;6269.185005949197;5784.074548072288;5807.070868660994;5822.039363504974;5916.940830591639;6134.539909506716 12:46:44 INFO - PROCESS | 1643 | |1;ext.html;455.57176254320945;460.99273088302084;462.20500738729385;495.2398068964138;519.9922001169983;31337;41312.38031429531;43414.348784768255;43441;43450.78274608627;42484.787576062074;42922.570774292326;42940.14119717604;43043.78478107613;43155.56844431555;8425.325973922072;9290.1174388433;9480.146786789188;9522.85715714265;9536.380135291183;8422.49465032097;11087;11343.149263805206;11367.602133925273;11507.769844603103;11422.600208992686;11454;11466.484008219608;11474;11516.733159352465;8457.873131903027;11367.943160284229;11401.258918170292;11407.600733974312;11424.600138995178;8466.78833029173;11066.280691755092;11384.943075284653;11392.772144557146;11543.88456115445;42405.78797106026;42653.36019959672;42806.78596607028;42817;42897;3570.1967057412135;4064.9227954592056;4081.3265811141127;4089;4090.9386359204636;30625.387492250255;30982.845085774654;31066.378672426425;31357.37285254282;31618.209544761336;3276.410246155691;3304.9504257436156;3311.6688331166933;3312.1057314525183;3321.850516726753;493704;496561.9999999964;497012;497310;497746;67137;67670;67678.32321676819;67753;67892.660536697;70343;70445;70502;70546.64726676334;70556.29443705497;16662.750058749127;17203.65592688139;17250.827491724922;17256.137193140294;17270.050147242022;9879.357841740408;12160.391980400944;13195.010374221973;13201.60395188146;13223.537176198786;15029;16527;18423.447296581126;18929.810701892806;19359.741616794865;6305.148804911279;6385.553011289165;6435.613863168225;6442.516811239176;6486.708098135595;877.3376101043672;887.4364778365784;904.5748498205833;904.9276057915351;922.1147698209794;30155.276578661702;30559.8472007643;30645.693543064728;31085.844570777;31404.528932066038;1068.3216157739892;1069.764651776608;1079.1636481726568;1084.5878566144972;1216.1608490141773;12680.365981701063;15996.680066398607;16270.593235168979;16281.348746050262;16498.092604906844;639381;641157;641652;642016;644345;63866.0420093699;63992;64058.67970660117;64099;64147.71704565883;1410.3230449384148;1435.9497417590335;1463.0709499467703;1464.6924145929474;1465.3552436927719;26387.888968882828;28958;29134.7086529132;29819;31125;54666.45333546614;54796;54967.9999999984;55008.44991550194;55167;444457;445257;446000.5399946089;447044;447330;35696.464553032245;36436;42271.57728422799;42559.5744042568;43151.784241078596;38590;47947;48209.75895120502;48520.272195917794;53326;39996;40887;41079;41458;42382.57617423786;40169;40541.59458405496;40754.77735667935;41861;42175.36736949009;39431.80466922972;39471.2105757889;39659;39746.60253397429;39860.2027959445;33448.66551334455;33506.32987340288;35135.7702480412;35847.46228806518;35876;25912;25920.8703956479;25968;26340.20979370622;26360 12:46:44 INFO - PROCESS | 1643 | |2;jquery.html;380.34960218027175;392.8467897519966;396.46675221826644;400.9418634298027;421.61632914048204;13940.651483712913;18533.44399668009;20707.171713131458;21394.679079813795;21451.82014989177;16070.5982350441;17838.643227135482;21515.569688606258;21592.460188495297;21614.8111853848;5731.312242530902;6064.72708728106;6093.0555763856455;6106.114613381057;6110.9694451527685;5748.281464816898;5971.283445986488;5999;6031.306399764017;6069.605475644069;5290.941811637668;5997.610155339889;6000.729967151467;6004.969975150118;6011.458968692817;4791.832285869978;5728.198052272685;5838.328592211887;5939.821805345847;5959.851003724898;5224.190250511177;5233.084210263189;5234.607404444644;5236.3978142513715;5240.082985477527;20370.5925881483;25477.49045019108;26006.34984125412;26144.607830882553;26368.472630547283;2667.733226677336;2789.1632510247046;2791.483575538532;2793.7345952134515;2797.216779301799;7212.026376439166;7283.417326613858;8681.565921703952;14043.174387329684;16743.330266789315;1814.872958892878;1822.462373599778;1834.7614810074606;1857.9163937622704;1868.7477190579234;120748.79251207551;122982;125024;125456;126805.09792353214;10079.538466922402;10754.462276886281;11633.302001879914;11644.76710465786;11801.173917825841;14686.55940321792;14692.338844752012;14714;14727.631809204642;14731.705365892836;7844.294013538809;8278.917210827814;8299.377546684023;8537.274331681876;8662.090480499457;7230.42156627479;8916.019237883827;8968.820623587622;8970.013298537157;9100.31747618918;7083.114610673666;7167.806977009898;7175.712971481083;7178.2103968563415;7289.671964761598;1885.6228754249205;1944.1251436853472;1948.4057362504573;1953.2772874036698;1956.8923709195847;1004.8743907011624;1032.385730490357;1041.2190856857358;1047.0994944347856;1047.1099565369375;21757.456063598536;22415.663765043537;22473.43816404603;22559.774402256095;22653.886730566242;924.2236521322121;1041.3907863899703;1045.72288343589;1053.3258714422775;1060.2631171335847;9906.306558540977;10023.599056037678;11055.889441105646;11565.826512602318;11720.355380454157;736385;755482;768521;781379;795995;105579;134849;138937;139983.30008349894;142551.28724356313;998.0817647763929;1026.2046913641987;1037.5538518437145;1038.4963292802984;1045.4563626913962;18147.818521814614;19025;19468.415947521597;19562.90218548898;19563.413097607096;53058.46941530535;55109;55168.89662206814;56178.719106404205;56389.436105638415;78621.82067268882;83176.16823831684;83826.32347352897;84200;84966;7638.579878106758;7996.480228785111;8114.959425203072;8116.959415202886;8309.418340716093;13384.464621415034;13516.93241533786;13568;14090;14113.153210807384;10595.311304765166;11451.59919402817;11561.595344162914;11601.767964640829;12131.332776697367;11584.594539191088;11605.941970290094;11888.881111188777;11889.28664280146;12060.216085954386;11766.294022358687;11773.234739741889;12179.330136842558;12224;12227;8369.079401265977;8496.800274475348;8555.016173140168;8664.610092545725;8676.219140277406;9612.471314077793;10844.728881778019;10864.511097000812;11753;11897.940510297392 12:46:44 INFO - PROCESS | 1643 | |3;mootools.html;1301.765682177208;1430.7353139669162;1447.2835946206628;1451.1003178029623;1458.3510337899631;8188.672453101876;8586.957065214681;8596.3122950164;8599.570021498923;8612;7566.810829729259;7848.843023139548;7849.68601255949;8123.796905077376;8305.875411868827;2256.909723611054;2299.632058870581;2302.6661134135625;2302.9193978210765;2306.5848147333472;2055.219016773624;2331.1374791327235;2347.8239132065078;2367.183321753992;2370.905163793455;1788.1238193285326;1974.99012504938;2235.6087684655204;2323.9535209295805;2342.636891281854;2296.0815673730476;2344.7420783713865;2350.5651454480976;2352.4001379648253;2353.070537137821;1984.811442912921;2323.326235391751;2379.464620460383;2393.56915755164;2395.5208958208254;8440.240378365976;8493.023302320189;8495.490270583785;8514.872276915852;8519.53142577158;5091.287219789232;5266.7629956652045;5273.815416460444;5281.577473802086;5294.338207724035;3386.508956201337;3504.351694936445;3520.9119772005906;3553.591336996227;3612.638736126393;1182.2020136407975;1195.0678470792795;1250.7123361626786;1261.4449642157422;1270.4056409206387;10535.420551869644;10753.301035432673;10778.892211077946;10810.945945270223;10940.507677154546;4584.610308123847;4676.111538807616;4750.358701575243;4800.423949126058;4800.655816371422;9609.375390599589;9616.615335386647;9621.08599683029;9631.759206019906;9641.566129524048;5300.549453296513;5315.6279060465395;5320.281761962163;5324.92012619811;5328.094223981932;4278.978605106954;4337.436133302651;4559.566841150086;4762.404699412574;4817.855464336076;3469.774464659789;3808.8666896658483;3934.370500719871;3979.721419500607;4028.7179897407486;1261.9682311478512;1284.2679672586537;1286.1382873474795;1295.164618820874;1299.4152631315947;792.6868886789686;883.1830556735123;883.3860466975519;905.8550631898864;910.0671811393374;5490.945090549123;5660.603757736919;5715.485606295453;5885.852258809491;5903.321118071477;868.7828042989253;1005.8893521712606;1010.9090181883665;1023.5854478936043;1056.9418681972566;3459.3427248822645;3716.479692843004;3883.456316115746;3977.244323578511;3999.260136874629;9591.376560523544;9600.75998100039;9983.051610097174;10023.198144148451;10166.694999150037;10071.496425178859;10138.188944884392;10141.087302142843;10152.898471015194;10162.136218421369;7536.585487798224;7813.335866451415;7859.017622797151;7953.2842044216295;7966.203379661987;5633.211350410864;5656.23640808502;5695.231143795535;5892.145638882424;5974.820755377345;9128.49793261377;9194.31042671789;9273;9371.969083400683;9383.483908385104;9175.587098580447;9337.953310233406;9413.341066125306;9468.47923364194;9597.808043839224;7050.25972272904;7193.064901562763;7195.244499327705;7284.307990740871;7361.043064401593;8033.55815430157;8119.837603247784;8122.187781221831;8122.918770812216;8138.145494723206;6259.217597800275;7076.433885289268;7162.355388015104;7210.423166146591;7231.819204519929;6706.83232919181;6735.764248251287;6744.190697116377;6748.6963086660235;6767.661616919233;6364.522660800366;6463.353664633687;6516.869662606816;6517.967410162919;6535.313792051957;5028.220625803006;5065.620078494201;5077.416097148875;5078.289039534542;5128.256402821645;4978.775955081957;5034.244863270539;5075.441701412916;5163.8192663258105;5169.560587350117 12:46:44 INFO - PROCESS | 1643 | |4;prototype.html;355.0785711079748;360.6916086745832;364.4769755401;369.1730523627076;372.0308596107139;4241.766702831343;4881.585065269452;5026.798928042878;5279.445658205891;5387.299651045369;4543.840965566206;5182.896342073166;5272.340957380327;5284.260203571503;5320.122179840331;3536.8231588420604;4222.957770422303;4224.957750422487;4231.4710661167355;4242.278812601865;3579.49887015818;3737.4580685800543;3961.3265744823448;4024.8126802593306;4241;3991.42124391963;4034.495688038995;4035.334169861984;4044.9797751011206;4046.797660116997;3382.391169589473;3964.8215830287563;4011;4025.497816899287;4033.193361327717;3504.5093686883856;3513.4905438711244;3514.68367846895;3517.4723791431234;3518.3491054155065;4570.451545814491;4874.317595536628;5136.486351364871;5218.0693143536755;5241.528262456359;4600.263957766775;4608.700434471749;4631.768411579441;4636.605888499482;4639.976800115978;4568.520305367955;4575.290829921368;5590.853874955625;5617.831465056055;5628.887422251573;3242.3839470500766;3812.694984401241;3835.1946091320856;3861.806909654534;3866.6520013198665;5206.401263854629;5872.882542349172;5904.202932604129;5906.460222104493;5925.614835035709;3542.734294927891;3709.9814500927323;3851.768893866377;3913.6477717005605;3924.2151569686175;3397.592288925295;3633.1280492681567;3775.7734535927384;3967.107400834789;3969.5236571611013;4145.66834653227;4602.3786788783755;4624.543268870295;4633.4671512775785;4642.953570464252;5226.210997027125;5421.457854214547;5619.904118696815;5705.232962013421;5766.654000759968;1221.322166197751;1239.6343078791779;1242.863285038645;1263.6651287408845;1264.9747005059846;852.8763329317214;863.456022705704;871.2333146830875;876.7106854737921;888.8977767556813;4251.702380833374;4410.6030457259;4642.396488456479;5000.999400359828;5026.447090820006;4747.406574178228;5132.717700526432;5291.867703307371;5443.583634283834;5446.863828404322;4396.384506169139;4809.687370320918;5097.260897169889;5341.946580534222;5352.652077614943;2517.433577445097;2647.5234457797783;2681.611166380864;2783.1928740665385;2830.448062627809;5038.647294689336;5340.492653198017;5611.877624475122;5845.444682755132;5876.294844618673;5019.899602007939;5075.295034624744;5552.668398960672;5629.915551266734;5683.374828768832;5167.844964651066;5220.425753167073;5744.146196463981;5771.499410153307;5832.854178645568;4406.625436837905;4926.950730492649;4944.925826112683;5449.373322067854;5466.867921510693;5197.584193264605;5393.1370980642905;5431.83704488866;5436.53789427903;5497.6805566662915;5123;5297.390800058042;5377.919331210113;5499;5822.883542329215;2975.687552807011;3737.346483996393;3737.6822970046765;3743.36362818327;3767.3783825668456;4886.853394398174;5082.975629500442;5508.338999320107;5598.440155984532;5598.832035038955;4525.198832980313;4809.567138957511;4826.9244224983595;5287.656302340336;5364.46355364476;4988.27669987857;5042.084008076908;5046.57104146137;5361.839144825662;5366.651167674088;4692.6480513960905;5208.348956380452;5332.6000549958135;5349.421920533374;5354.705491197866;5112.71880046601;5462.726863656881;5606.831795046155;5611.597100724819;5637.9718101409235;4706.858794236178;5176;5449.618526703092;5480.890382192413;5493.560515158858 12:46:44 INFO - PROCESS | 1643 | |5;yui.html;730.3280981497022;742.4209116888821;768.5043147170072;836.4312267657994;853.7705703786547;14594.562163135097;15409.537713868574;15429;15438.459653912116;15550.533483995485;14145;14367.137971721679;14371.78442323366;14394.712105757879;15653;710.0591715976326;729.2015243308595;735.5513136986434;873.9388242823005;886.7738726624718;841.8400503904269;897.4391005621486;909.6997990663066;910.4855756497591;913.9405938614002;955.8614000969856;957.3681370295607;958.1281034258826;960.2749923807515;961.2166084640995;737.7639155470251;758.4956004257162;915.2220612479406;957.4877440569297;961.3558915526579;715.059696499102;715.8854583266652;716.4733920568378;717.6304203335286;718.3678363040491;15384.615384615474;15592.37630494779;15618.9219053904;15627.531174064796;15628;13917.512887049006;14173.007889447743;14292.785608215885;14348.49780257686;14487.348069336906;11523.19337646365;11674.073777826648;11810.409479526075;11820.172587918849;11873.346965916871;3715.294094122108;3734.3278209922205;3800.467934489174;3931.803409829497;4021.3565829467143;104607;106601;107607;108202.91797082007;108938.45530772295;11004;11413.657590272305;11454.599089031844;11535.423228838525;11850.525978960744;23602;23730.169444069375;23885.402864928517;24061.879690601436;24082.7591724084;7909.20907909216;7934.484258523177;7946.284834364819;8071.838563228703;8150.38872084596;3886.2810380079777;4071.531773845986;4222.472190976128;4296.183725092223;4389.495208051051;3646.4530320452145;3739.495168152319;3742.120601658608;3742.7941463219786;3749.981250093732;572.86537663649;660.0693022837776;664.2726214794792;679.9456043516507;690.0511796280115;683.1733602341222;697.9965100174467;700.849317396752;705.6295444891473;733.1751779248345;9695.66065187715;10477;10494.108000819862;10522.63170789034;10785.676429707122;684.7192651013061;696.5159214345981;707.8117399461931;719.0939416335455;719.830275801822;5074.893919023564;5077.672269283776;5084.872878178076;5133.435322114565;5135.717535535581;101092.49453752684;102009;102255;102684;104597.47701261444;88409.55795220983;89904;91527.08472915318;92655;93262;80228;81831;82185.356292875;82564.58717706492;83689.16310836814;9748.02519748048;10896.673099807018;10919.235653504178;11492.195546312012;11517.25137866036;43939.90150246269;44611.77694111638;49058;49566.50433495619;51432.485675144264;52611.73694131505;68162;69844.56886007244;70793.87618371457;73361.53276934325;13131.671708207372;13144.211347319191;13276.402561884544;13678.110922790385;13699.315034248048;13834.446622135001;14027.29863506841;14463.710725785635;14539.563813085624;15822.367105315658;12404.379781010733;13776.448942042207;14241.715165696422;14270.429182832571;14772.926135369255;13293.268870211845;13826.823299557816;13902.652433689238;14271.71456570842;14314.212718300594;12898.67753306175;12945.09384343087;13553.796693049415;13799.51701690436;13826.585202443943;10167.644132455329;10748.301360411548;11368.261063030877;11768.52925882955;12246;11089.778204436028;11253.71865703364;11285.43572821372;11305.095592352427;11306.434678265889 12:46:44 INFO - PROCESS | 1643 | __end_tp_report 12:46:44 INFO - PROCESS | 1643 | __start_cc_report 12:46:44 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1332 12:46:44 INFO - PROCESS | 1643 | __end_cc_report 12:46:44 INFO - PROCESS | 1643 | __startTimestamp1485550004688__endTimestamp 12:46:44 INFO - PROCESS | 1643 | 12:46:44 INFO - PROCESS | 1643 | ------- Summary: start ------- 12:46:44 INFO - PROCESS | 1643 | Number of tests: 6 12:46:44 INFO - PROCESS | 1643 | 12:46:44 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5831.43 Median:6039.06 stddev:662.96 (11.0%) stddev-sans-first:628.29 12:46:44 INFO - PROCESS | 1643 | Values: 3058.3 3379.5 3388.7 3398.9 3436.2 5776.5 5787.1 5794.4 5808.4 5848.7 5813.1 5902.3 5908.7 5912.4 5931.2 4416.3 5281.6 5305.5 5403.5 5412.3 5236.8 5246.1 5271.5 5369.7 5390.2 5288.6 5308.9 5319.7 5343.3 5368.2 5369.6 5370.8 5373.7 5377.8 5381.8 5204.1 5271.1 5327.8 5345.9 5361.1 5713.2 5732.7 5758.3 5764.7 5833.1 6362.2 6363.6 6368.1 6375.3 6376.0 6244.7 6292.8 6311.9 6317.1 6317.4 5824.0 5896.9 5910.3 5992.6 6034.1 6199.8 6265.8 6294.0 6304.0 6366.7 6292.7 6295.4 6302.4 6303.8 6307.4 6188.7 6323.9 6324.5 6326.6 6347.7 6131.8 6207.0 6224.7 6280.4 6353.4 6331.2 6340.6 6347.9 6351.1 6351.7 4060.0 5026.4 5052.1 5074.2 5087.3 4461.8 4514.7 4520.8 4551.1 4559.2 5842.4 5855.4 5867.5 5869.9 5882.1 6219.7 6242.2 6254.6 6284.0 6295.4 5874.6 5917.4 5922.3 5925.9 6007.3 5566.1 5572.8 5572.9 5586.6 5601.8 6240.5 6290.2 6303.3 6344.4 6402.9 6305.0 6317.0 6324.7 6327.4 6442.1 5365.7 6446.2 6450.5 6465.8 6490.0 6145.5 6209.0 6224.8 6337.3 6356.7 6221.3 6282.3 6316.7 6316.8 6319.1 6231.2 6261.9 6271.8 6276.0 6286.1 6096.2 6118.6 6194.1 6243.8 6252.4 6018.6 6034.9 6116.6 6138.1 6147.2 6039.1 6245.6 6260.7 6262.6 6269.2 5784.1 5807.1 5822.0 5916.9 6134.5 12:46:44 INFO - PROCESS | 1643 | 12:46:44 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:68385.71 Median:22418.05 stddev:142403.20 (635.2%) stddev-sans-first:142711.35 12:46:44 INFO - PROCESS | 1643 | Values: 455.6 461.0 462.2 495.2 520.0 31337.0 41312.4 43414.3 43441.0 43450.8 42484.8 42922.6 42940.1 43043.8 43155.6 8425.3 9290.1 9480.1 9522.9 9536.4 8422.5 11087.0 11343.1 11367.6 11507.8 11422.6 11454.0 11466.5 11474.0 11516.7 8457.9 11367.9 11401.3 11407.6 11424.6 8466.8 11066.3 11384.9 11392.8 11543.9 42405.8 42653.4 42806.8 42817.0 42897.0 3570.2 4064.9 4081.3 4089.0 4090.9 30625.4 30982.8 31066.4 31357.4 31618.2 3276.4 3305.0 3311.7 3312.1 3321.9 493704.0 496562.0 497012.0 497310.0 497746.0 67137.0 67670.0 67678.3 67753.0 67892.7 70343.0 70445.0 70502.0 70546.6 70556.3 16662.8 17203.7 17250.8 17256.1 17270.1 9879.4 12160.4 13195.0 13201.6 13223.5 15029.0 16527.0 18423.4 18929.8 19359.7 6305.1 6385.6 6435.6 6442.5 6486.7 877.3 887.4 904.6 904.9 922.1 30155.3 30559.8 30645.7 31085.8 31404.5 1068.3 1069.8 1079.2 1084.6 1216.2 12680.4 15996.7 16270.6 16281.3 16498.1 639381.0 641157.0 641652.0 642016.0 644345.0 63866.0 63992.0 64058.7 64099.0 64147.7 1410.3 1435.9 1463.1 1464.7 1465.4 26387.9 28958.0 29134.7 29819.0 31125.0 54666.5 54796.0 54968.0 55008.4 55167.0 444457.0 445257.0 446000.5 447044.0 447330.0 35696.5 36436.0 42271.6 42559.6 43151.8 38590.0 47947.0 48209.8 48520.3 53326.0 39996.0 40887.0 41079.0 41458.0 42382.6 40169.0 40541.6 40754.8 41861.0 42175.4 39431.8 39471.2 39659.0 39746.6 39860.2 33448.7 33506.3 35135.8 35847.5 35876.0 25912.0 25920.9 25968.0 26340.2 26360.0 12:46:44 INFO - PROCESS | 1643 | 12:46:44 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:40407.63 Median:22444.55 stddev:127058.90 (566.1%) stddev-sans-first:127379.78 12:46:44 INFO - PROCESS | 1643 | Values: 380.3 392.8 396.5 400.9 421.6 13940.7 18533.4 20707.2 21394.7 21451.8 16070.6 17838.6 21515.6 21592.5 21614.8 5731.3 6064.7 6093.1 6106.1 6111.0 5748.3 5971.3 5999.0 6031.3 6069.6 5290.9 5997.6 6000.7 6005.0 6011.5 4791.8 5728.2 5838.3 5939.8 5959.9 5224.2 5233.1 5234.6 5236.4 5240.1 20370.6 25477.5 26006.3 26144.6 26368.5 2667.7 2789.2 2791.5 2793.7 2797.2 7212.0 7283.4 8681.6 14043.2 16743.3 1814.9 1822.5 1834.8 1857.9 1868.7 120748.8 122982.0 125024.0 125456.0 126805.1 10079.5 10754.5 11633.3 11644.8 11801.2 14686.6 14692.3 14714.0 14727.6 14731.7 7844.3 8278.9 8299.4 8537.3 8662.1 7230.4 8916.0 8968.8 8970.0 9100.3 7083.1 7167.8 7175.7 7178.2 7289.7 1885.6 1944.1 1948.4 1953.3 1956.9 1004.9 1032.4 1041.2 1047.1 1047.1 21757.5 22415.7 22473.4 22559.8 22653.9 924.2 1041.4 1045.7 1053.3 1060.3 9906.3 10023.6 11055.9 11565.8 11720.4 736385.0 755482.0 768521.0 781379.0 795995.0 105579.0 134849.0 138937.0 139983.3 142551.3 998.1 1026.2 1037.6 1038.5 1045.5 18147.8 19025.0 19468.4 19562.9 19563.4 53058.5 55109.0 55168.9 56178.7 56389.4 78621.8 83176.2 83826.3 84200.0 84966.0 7638.6 7996.5 8115.0 8117.0 8309.4 13384.5 13516.9 13568.0 14090.0 14113.2 10595.3 11451.6 11561.6 11601.8 12131.3 11584.6 11605.9 11888.9 11889.3 12060.2 11766.3 11773.2 12179.3 12224.0 12227.0 8369.1 8496.8 8555.0 8664.6 8676.2 9612.5 10844.7 10864.5 11753.0 11897.9 12:46:44 INFO - PROCESS | 1643 | 12:46:44 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5477.51 Median:5166.69 stddev:2977.39 (57.6%) stddev-sans-first:2969.20 12:46:44 INFO - PROCESS | 1643 | Values: 1301.8 1430.7 1447.3 1451.1 1458.4 8188.7 8587.0 8596.3 8599.6 8612.0 7566.8 7848.8 7849.7 8123.8 8305.9 2256.9 2299.6 2302.7 2302.9 2306.6 2055.2 2331.1 2347.8 2367.2 2370.9 1788.1 1975.0 2235.6 2324.0 2342.6 2296.1 2344.7 2350.6 2352.4 2353.1 1984.8 2323.3 2379.5 2393.6 2395.5 8440.2 8493.0 8495.5 8514.9 8519.5 5091.3 5266.8 5273.8 5281.6 5294.3 3386.5 3504.4 3520.9 3553.6 3612.6 1182.2 1195.1 1250.7 1261.4 1270.4 10535.4 10753.3 10778.9 10810.9 10940.5 4584.6 4676.1 4750.4 4800.4 4800.7 9609.4 9616.6 9621.1 9631.8 9641.6 5300.5 5315.6 5320.3 5324.9 5328.1 4279.0 4337.4 4559.6 4762.4 4817.9 3469.8 3808.9 3934.4 3979.7 4028.7 1262.0 1284.3 1286.1 1295.2 1299.4 792.7 883.2 883.4 905.9 910.1 5490.9 5660.6 5715.5 5885.9 5903.3 868.8 1005.9 1010.9 1023.6 1056.9 3459.3 3716.5 3883.5 3977.2 3999.3 9591.4 9600.8 9983.1 10023.2 10166.7 10071.5 10138.2 10141.1 10152.9 10162.1 7536.6 7813.3 7859.0 7953.3 7966.2 5633.2 5656.2 5695.2 5892.1 5974.8 9128.5 9194.3 9273.0 9372.0 9383.5 9175.6 9338.0 9413.3 9468.5 9597.8 7050.3 7193.1 7195.2 7284.3 7361.0 8033.6 8119.8 8122.2 8122.9 8138.1 6259.2 7076.4 7162.4 7210.4 7231.8 6706.8 6735.8 6744.2 6748.7 6767.7 6364.5 6463.4 6516.9 6518.0 6535.3 5028.2 5065.6 5077.4 5078.3 5128.3 4978.8 5034.2 5075.4 5163.8 5169.6 12:46:44 INFO - PROCESS | 1643 | 12:46:44 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4411.58 Median:4935.94 stddev:1336.09 (27.1%) stddev-sans-first:1304.68 12:46:44 INFO - PROCESS | 1643 | Values: 355.1 360.7 364.5 369.2 372.0 4241.8 4881.6 5026.8 5279.4 5387.3 4543.8 5182.9 5272.3 5284.3 5320.1 3536.8 4223.0 4225.0 4231.5 4242.3 3579.5 3737.5 3961.3 4024.8 4241.0 3991.4 4034.5 4035.3 4045.0 4046.8 3382.4 3964.8 4011.0 4025.5 4033.2 3504.5 3513.5 3514.7 3517.5 3518.3 4570.5 4874.3 5136.5 5218.1 5241.5 4600.3 4608.7 4631.8 4636.6 4640.0 4568.5 4575.3 5590.9 5617.8 5628.9 3242.4 3812.7 3835.2 3861.8 3866.7 5206.4 5872.9 5904.2 5906.5 5925.6 3542.7 3710.0 3851.8 3913.6 3924.2 3397.6 3633.1 3775.8 3967.1 3969.5 4145.7 4602.4 4624.5 4633.5 4643.0 5226.2 5421.5 5619.9 5705.2 5766.7 1221.3 1239.6 1242.9 1263.7 1265.0 852.9 863.5 871.2 876.7 888.9 4251.7 4410.6 4642.4 5001.0 5026.4 4747.4 5132.7 5291.9 5443.6 5446.9 4396.4 4809.7 5097.3 5341.9 5352.7 2517.4 2647.5 2681.6 2783.2 2830.4 5038.6 5340.5 5611.9 5845.4 5876.3 5019.9 5075.3 5552.7 5629.9 5683.4 5167.8 5220.4 5744.1 5771.5 5832.9 4406.6 4927.0 4944.9 5449.4 5466.9 5197.6 5393.1 5431.8 5436.5 5497.7 5123.0 5297.4 5377.9 5499.0 5822.9 2975.7 3737.3 3737.7 3743.4 3767.4 4886.9 5083.0 5508.3 5598.4 5598.8 4525.2 4809.6 4826.9 5287.7 5364.5 4988.3 5042.1 5046.6 5361.8 5366.7 4692.6 5208.3 5332.6 5349.4 5354.7 5112.7 5462.7 5606.8 5611.6 5638.0 4706.9 5176.0 5449.6 5480.9 5493.6 12:46:44 INFO - PROCESS | 1643 | 12:46:44 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20813.07 Median:3736.91 stddev:29710.19 (795.0%) stddev-sans-first:29755.26 12:46:44 INFO - PROCESS | 1643 | Values: 730.3 742.4 768.5 836.4 853.8 14594.6 15409.5 15429.0 15438.5 15550.5 14145.0 14367.1 14371.8 14394.7 15653.0 710.1 729.2 735.6 873.9 886.8 841.8 897.4 909.7 910.5 913.9 955.9 957.4 958.1 960.3 961.2 737.8 758.5 915.2 957.5 961.4 715.1 715.9 716.5 717.6 718.4 15384.6 15592.4 15618.9 15627.5 15628.0 13917.5 14173.0 14292.8 14348.5 14487.3 11523.2 11674.1 11810.4 11820.2 11873.3 3715.3 3734.3 3800.5 3931.8 4021.4 104607.0 106601.0 107607.0 108202.9 108938.5 11004.0 11413.7 11454.6 11535.4 11850.5 23602.0 23730.2 23885.4 24061.9 24082.8 7909.2 7934.5 7946.3 8071.8 8150.4 3886.3 4071.5 4222.5 4296.2 4389.5 3646.5 3739.5 3742.1 3742.8 3750.0 572.9 660.1 664.3 679.9 690.1 683.2 698.0 700.8 705.6 733.2 9695.7 10477.0 10494.1 10522.6 10785.7 684.7 696.5 707.8 719.1 719.8 5074.9 5077.7 5084.9 5133.4 5135.7 101092.5 102009.0 102255.0 102684.0 104597.5 88409.6 89904.0 91527.1 92655.0 93262.0 80228.0 81831.0 82185.4 82564.6 83689.2 9748.0 10896.7 10919.2 11492.2 11517.3 43939.9 44611.8 49058.0 49566.5 51432.5 52611.7 68162.0 69844.6 70793.9 73361.5 13131.7 13144.2 13276.4 13678.1 13699.3 13834.4 14027.3 14463.7 14539.6 15822.4 12404.4 13776.4 14241.7 14270.4 14772.9 13293.3 13826.8 13902.7 14271.7 14314.2 12898.7 12945.1 13553.8 13799.5 13826.6 10167.6 10748.3 11368.3 11768.5 12246.0 11089.8 11253.7 11285.4 11305.1 11306.4 12:46:44 INFO - PROCESS | 1643 | -------- Summary: end -------- 12:46:44 INFO - PROCESS | 1643 | 12:46:45 INFO - TEST-INFO | 1643: exit 0 12:46:45 INFO - TEST-OK | dromaeo_css | took 1117895ms 12:46:45 INFO - TEST-START | kraken 12:46:45 INFO - operating with platform_type : mac_ 12:46:45 INFO - Initialising browser for kraken test... 12:46:45 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/tmpSnA6DA/profile http://localhost:49247/getInfo.html) 12:46:47 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 12:46:47 INFO - PROCESS | 1654 | colorDepth:24 12:46:47 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 12:46:47 INFO - PROCESS | 1654 | __metrics 12:46:47 INFO - PROCESS | 1654 | 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" 12:46:47 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:46:48 INFO - TEST-INFO | 1654: exit 0 12:46:48 INFO - Browser initialized. 12:46:48 INFO - Running cycle 1/1 for kraken test... 12:46:48 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/T/tmpSnA6DA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:47:00 INFO - PROCESS | 1655 | RSS: Main: 213061632 12:47:00 INFO - PROCESS | 1655 | 12:47:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 12:47:04 INFO - PROCESS | 1655 | RSS: Main: 263602176 12:47:04 INFO - PROCESS | 1655 | 12:47:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 12:47:07 INFO - PROCESS | 1655 | RSS: Main: 276668416 12:47:07 INFO - PROCESS | 1655 | 12:47:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 12:47:11 INFO - PROCESS | 1655 | RSS: Main: 373137408 12:47:11 INFO - PROCESS | 1655 | 12:47:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 12:47:13 INFO - PROCESS | 1655 | RSS: Main: 278544384 12:47:13 INFO - PROCESS | 1655 | 12:47:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:47:16 INFO - PROCESS | 1655 | RSS: Main: 280141824 12:47:16 INFO - PROCESS | 1655 | 12:47:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 12:47:20 INFO - PROCESS | 1655 | RSS: Main: 319311872 12:47:20 INFO - PROCESS | 1655 | 12:47:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 12:47:23 INFO - PROCESS | 1655 | RSS: Main: 321142784 12:47:23 INFO - PROCESS | 1655 | 12:47:26 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 12:47:26 INFO - PROCESS | 1655 | RSS: Main: 317140992 12:47:26 INFO - PROCESS | 1655 | 12:47:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:47:29 INFO - PROCESS | 1655 | RSS: Main: 294572032 12:47:29 INFO - PROCESS | 1655 | 12:47:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:47:31 INFO - PROCESS | 1655 | RSS: Main: 297451520 12:47:31 INFO - PROCESS | 1655 | 12:47:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:47:34 INFO - PROCESS | 1655 | RSS: Main: 301080576 12:47:34 INFO - PROCESS | 1655 | 12:47:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:47:38 INFO - PROCESS | 1655 | RSS: Main: 311914496 12:47:38 INFO - PROCESS | 1655 | 12:47:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:47:41 INFO - PROCESS | 1655 | RSS: Main: 310628352 12:47:41 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 12:47:43 INFO - PROCESS | 1655 | RSS: Main: 354975744 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | __start_tp_report 12:47:43 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 12:47:43 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 12:47:43 INFO - PROCESS | 1655 | |i|pagename|runs| 12:47:43 INFO - PROCESS | 1655 | |0;ai-astar;113;117;118;115;116;117;114;114;114;115 12:47:43 INFO - PROCESS | 1655 | |1;audio-beat-detection;146;109;108;156;113;112;141;133;129;110 12:47:43 INFO - PROCESS | 1655 | |2;audio-dft;185;181;184;183;186;253;238;186;187;184 12:47:43 INFO - PROCESS | 1655 | |3;audio-fft;79;58;57;88;58;58;58;59;75;65 12:47:43 INFO - PROCESS | 1655 | |4;audio-oscillator;90;69;85;76;94;101;115;67;69;81 12:47:43 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;87;85;88;86;92;83;89;86;88;85 12:47:43 INFO - PROCESS | 1655 | |6;imaging-darkroom;96;97;97;97;96;96;97;96;97;96 12:47:43 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;85;86;85;86;87;90;85;86;87 12:47:43 INFO - PROCESS | 1655 | |8;json-parse-financial;58;52;53;52;55;56;57;56;57;57 12:47:43 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;64;72;72;75;71;69;69;69;70;70 12:47:43 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;85;84;82;84;84;82;83;84;87;84 12:47:43 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;139;145;150;137;135;141;157;154;235;149 12:47:43 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;166;167;211;170;167;167;168;166;166;167 12:47:43 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;67;67;66;64;67;66;66;64;63;66 12:47:43 INFO - PROCESS | 1655 | __end_tp_report 12:47:43 INFO - PROCESS | 1655 | __start_cc_report 12:47:43 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1961 12:47:43 INFO - PROCESS | 1655 | __end_cc_report 12:47:43 INFO - PROCESS | 1655 | __startTimestamp1485550063510__endTimestamp 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | ------- Summary: start ------- 12:47:43 INFO - PROCESS | 1655 | Number of tests: 14 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.50 stddev:1.64 (1.4%) stddev-sans-first:1.51 12:47:43 INFO - PROCESS | 1655 | Values: 113.0 117.0 118.0 115.0 116.0 117.0 114.0 114.0 114.0 115.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:131.00 stddev:17.69 (13.5%) stddev-sans-first:17.17 12:47:43 INFO - PROCESS | 1655 | Values: 146.0 109.0 108.0 156.0 113.0 112.0 141.0 133.0 129.0 110.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:196.70 Median:186.00 stddev:26.02 (14.0%) stddev-sans-first:27.25 12:47:43 INFO - PROCESS | 1655 | Values: 185.0 181.0 184.0 183.0 186.0 253.0 238.0 186.0 187.0 184.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:65.50 Median:62.00 stddev:11.15 (18.0%) stddev-sans-first:10.70 12:47:43 INFO - PROCESS | 1655 | Values: 79.0 58.0 57.0 88.0 58.0 58.0 58.0 59.0 75.0 65.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:78.50 stddev:15.61 (19.9%) stddev-sans-first:16.44 12:47:43 INFO - PROCESS | 1655 | Values: 90.0 69.0 85.0 76.0 94.0 101.0 115.0 67.0 69.0 81.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.50 stddev:2.51 (2.9%) stddev-sans-first:2.67 12:47:43 INFO - PROCESS | 1655 | Values: 87.0 85.0 88.0 86.0 92.0 83.0 89.0 86.0 88.0 85.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:47:43 INFO - PROCESS | 1655 | Values: 96.0 97.0 97.0 97.0 96.0 96.0 97.0 96.0 97.0 96.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.00 stddev:1.49 (1.7%) stddev-sans-first:1.58 12:47:43 INFO - PROCESS | 1655 | Values: 86.0 85.0 86.0 85.0 86.0 87.0 90.0 85.0 86.0 87.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.50 stddev:2.21 (3.9%) stddev-sans-first:2.12 12:47:43 INFO - PROCESS | 1655 | Values: 58.0 52.0 53.0 52.0 55.0 56.0 57.0 56.0 57.0 57.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:2.85 (4.0%) stddev-sans-first:1.99 12:47:43 INFO - PROCESS | 1655 | Values: 64.0 72.0 72.0 75.0 71.0 69.0 69.0 69.0 70.0 70.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.45 (1.7%) stddev-sans-first:1.48 12:47:43 INFO - PROCESS | 1655 | Values: 85.0 84.0 82.0 84.0 84.0 82.0 83.0 84.0 87.0 84.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:154.20 Median:149.50 stddev:29.32 (19.6%) stddev-sans-first:30.58 12:47:43 INFO - PROCESS | 1655 | Values: 139.0 145.0 150.0 137.0 135.0 141.0 157.0 154.0 235.0 149.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:167.00 stddev:13.93 (8.3%) stddev-sans-first:14.63 12:47:43 INFO - PROCESS | 1655 | Values: 166.0 167.0 211.0 170.0 167.0 167.0 168.0 166.0 166.0 167.0 12:47:43 INFO - PROCESS | 1655 | 12:47:43 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.42 12:47:43 INFO - PROCESS | 1655 | Values: 67.0 67.0 66.0 64.0 67.0 66.0 66.0 64.0 63.0 66.0 12:47:43 INFO - PROCESS | 1655 | -------- Summary: end -------- 12:47:43 INFO - PROCESS | 1655 | 12:47:44 INFO - TEST-INFO | 1655: exit 0 12:47:44 INFO - TEST-OK | kraken | took 59042ms 12:47:44 INFO - SUITE-END | took 1176s 12:47:44 INFO - Completed test suite (00:19:37) 12:47:44 INFO - javascript benchmark 12:47:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.3424563718804, 3379.4761811919147, 3388.6780755828204, 3398.8810391636266, 3436.1924947637317, 5776.451237132465, 5787.13193021047, 5794.362620111784, 5808.390119037498, 5848.707564621763, 5813.098969659699, 5902.2622172228475, 5908.734106965187, 5912.408759124096, 5931.199288096106, 4416.315471101968, 5281.63028587999, 5305.469453054702, 5403.459654034585, 5412.323459567554, 5236.842894713165, 5246.055709972223, 5271.525562699357, 5369.677819330833, 5390.164524498709, 5288.629795914288, 5308.92036619451, 5319.654222475527, 5343.305370301875, 5368.248445217672, 5369.570434365241, 5370.838874833761, 5373.731313434352, 5377.784888604451, 5381.838544843661, 5204.063268611649, 5271.103912334912, 5327.786888524493, 5345.893082138336, 5361.061814182542, 5713.200151978726, 5732.684702341369, 5758.337791154029, 5764.74058667361, 5833.095870140135, 6362.172917520739, 6363.554551181419, 6368.10846481493, 6375.330590287999, 6376.0, 6244.656543890084, 6292.811215663537, 6311.905321420182, 6317.084022816712, 6317.399847014526, 5824.039033559416, 5896.852578685567, 5910.261217347832, 5992.610480318809, 6034.125051867454, 6199.752009919553, 6265.812025639147, 6293.96853015732, 6304.0, 6366.713497892606, 6292.685365731695, 6295.433410992941, 6302.401271879165, 6303.810885673437, 6307.369263073656, 6188.690565471708, 6323.9051414228825, 6324.525660575383, 6326.620402775849, 6347.746090156435, 6131.816594322154, 6206.975848984957, 6224.657643829632, 6280.371962803683, 6353.428191462791, 6331.2085989251345, 6340.587861788969, 6347.936520634827, 6351.079093531412, 6351.650659213695, 4060.0, 5026.447090820006, 5052.065367906949, 5074.213496907985, 5087.3386459759995, 4461.776911154429, 4514.7291162530355, 4520.81916723334, 4551.13528429604, 4559.156556037144, 5842.415758424124, 5855.355910849803, 5867.471927526543, 5869.853253668693, 5882.147088672119, 6219.657918814509, 6242.219722534684, 6254.562180647402, 6284.025975973731, 6295.401936816087, 5874.588778785529, 5917.408259174134, 5922.2597175353085, 5925.9407405925385, 6007.339192688801, 5566.053770858964, 5572.777088916398, 5572.916406253909, 5586.55307575393, 5601.80393686219, 6240.469560087444, 6290.245170579651, 6303.306636269915, 6344.365563443619, 6402.935970640234, 6304.968475157595, 6316.968415157895, 6324.747010119544, 6327.3988971047675, 6442.065900444503, 5365.678059316453, 6446.226452825691, 6450.451711604566, 6465.77369792055, 6490.0, 6145.539084568764, 6209.037599172136, 6224.782132625336, 6337.334579869232, 6356.745730170926, 6221.346758590283, 6282.277538082996, 6316.7157477914525, 6316.778912738032, 6319.146915166394, 6231.158793562992, 6261.8747625046335, 6271.811845644638, 6275.968620157053, 6286.057091436322, 6096.207493025879, 6118.619179173164, 6194.101855231056, 6243.7814676486105, 6252.406021427957, 6018.638881667114, 6034.9094763577705, 6116.633002019893, 6138.051223665453, 6147.170132032118, 6039.063945088518, 6245.5628106032145, 6260.655663938345, 6262.5929314594405, 6269.185005949197, 5784.074548072288, 5807.070868660994, 5822.039363504974, 5916.940830591639, 6134.539909506716], "value": 5787.804920000976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.57176254320945, 460.99273088302084, 462.20500738729385, 495.2398068964138, 519.9922001169983, 31337.0, 41312.38031429531, 43414.348784768255, 43441.0, 43450.78274608627, 42484.787576062074, 42922.570774292326, 42940.14119717604, 43043.78478107613, 43155.56844431555, 8425.325973922072, 9290.1174388433, 9480.146786789188, 9522.85715714265, 9536.380135291183, 8422.49465032097, 11087.0, 11343.149263805206, 11367.602133925273, 11507.769844603103, 11422.600208992686, 11454.0, 11466.484008219608, 11474.0, 11516.733159352465, 8457.873131903027, 11367.943160284229, 11401.258918170292, 11407.600733974312, 11424.600138995178, 8466.78833029173, 11066.280691755092, 11384.943075284653, 11392.772144557146, 11543.88456115445, 42405.78797106026, 42653.36019959672, 42806.78596607028, 42817.0, 42897.0, 3570.1967057412135, 4064.9227954592056, 4081.3265811141127, 4089.0, 4090.9386359204636, 30625.387492250255, 30982.845085774654, 31066.378672426425, 31357.37285254282, 31618.209544761336, 3276.410246155691, 3304.9504257436156, 3311.6688331166933, 3312.1057314525183, 3321.850516726753, 493704.0, 496561.9999999964, 497012.0, 497310.0, 497746.0, 67137.0, 67670.0, 67678.32321676819, 67753.0, 67892.660536697, 70343.0, 70445.0, 70502.0, 70546.64726676334, 70556.29443705497, 16662.750058749127, 17203.65592688139, 17250.827491724922, 17256.137193140294, 17270.050147242022, 9879.357841740408, 12160.391980400944, 13195.010374221973, 13201.60395188146, 13223.537176198786, 15029.0, 16527.0, 18423.447296581126, 18929.810701892806, 19359.741616794865, 6305.148804911279, 6385.553011289165, 6435.613863168225, 6442.516811239176, 6486.708098135595, 877.3376101043672, 887.4364778365784, 904.5748498205833, 904.9276057915351, 922.1147698209794, 30155.276578661702, 30559.8472007643, 30645.693543064728, 31085.844570777, 31404.528932066038, 1068.3216157739892, 1069.764651776608, 1079.1636481726568, 1084.5878566144972, 1216.1608490141773, 12680.365981701063, 15996.680066398607, 16270.593235168979, 16281.348746050262, 16498.092604906844, 639381.0, 641157.0, 641652.0, 642016.0, 644345.0, 63866.0420093699, 63992.0, 64058.67970660117, 64099.0, 64147.71704565883, 1410.3230449384148, 1435.9497417590335, 1463.0709499467703, 1464.6924145929474, 1465.3552436927719, 26387.888968882828, 28958.0, 29134.7086529132, 29819.0, 31125.0, 54666.45333546614, 54796.0, 54967.9999999984, 55008.44991550194, 55167.0, 444457.0, 445257.0, 446000.5399946089, 447044.0, 447330.0, 35696.464553032245, 36436.0, 42271.57728422799, 42559.5744042568, 43151.784241078596, 38590.0, 47947.0, 48209.75895120502, 48520.272195917794, 53326.0, 39996.0, 40887.0, 41079.0, 41458.0, 42382.57617423786, 40169.0, 40541.59458405496, 40754.77735667935, 41861.0, 42175.36736949009, 39431.80466922972, 39471.2105757889, 39659.0, 39746.60253397429, 39860.2027959445, 33448.66551334455, 33506.32987340288, 35135.7702480412, 35847.46228806518, 35876.0, 25912.0, 25920.8703956479, 25968.0, 26340.20979370622, 26360.0], "value": 20742.292765812574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.34960218027175, 392.8467897519966, 396.46675221826644, 400.9418634298027, 421.61632914048204, 13940.651483712913, 18533.44399668009, 20707.171713131458, 21394.679079813795, 21451.82014989177, 16070.5982350441, 17838.643227135482, 21515.569688606258, 21592.460188495297, 21614.8111853848, 5731.312242530902, 6064.72708728106, 6093.0555763856455, 6106.114613381057, 6110.9694451527685, 5748.281464816898, 5971.283445986488, 5999.0, 6031.306399764017, 6069.605475644069, 5290.941811637668, 5997.610155339889, 6000.729967151467, 6004.969975150118, 6011.458968692817, 4791.832285869978, 5728.198052272685, 5838.328592211887, 5939.821805345847, 5959.851003724898, 5224.190250511177, 5233.084210263189, 5234.607404444644, 5236.3978142513715, 5240.082985477527, 20370.5925881483, 25477.49045019108, 26006.34984125412, 26144.607830882553, 26368.472630547283, 2667.733226677336, 2789.1632510247046, 2791.483575538532, 2793.7345952134515, 2797.216779301799, 7212.026376439166, 7283.417326613858, 8681.565921703952, 14043.174387329684, 16743.330266789315, 1814.872958892878, 1822.462373599778, 1834.7614810074606, 1857.9163937622704, 1868.7477190579234, 120748.79251207551, 122982.0, 125024.0, 125456.0, 126805.09792353214, 10079.538466922402, 10754.462276886281, 11633.302001879914, 11644.76710465786, 11801.173917825841, 14686.55940321792, 14692.338844752012, 14714.0, 14727.631809204642, 14731.705365892836, 7844.294013538809, 8278.917210827814, 8299.377546684023, 8537.274331681876, 8662.090480499457, 7230.42156627479, 8916.019237883827, 8968.820623587622, 8970.013298537157, 9100.31747618918, 7083.114610673666, 7167.806977009898, 7175.712971481083, 7178.2103968563415, 7289.671964761598, 1885.6228754249205, 1944.1251436853472, 1948.4057362504573, 1953.2772874036698, 1956.8923709195847, 1004.8743907011624, 1032.385730490357, 1041.2190856857358, 1047.0994944347856, 1047.1099565369375, 21757.456063598536, 22415.663765043537, 22473.43816404603, 22559.774402256095, 22653.886730566242, 924.2236521322121, 1041.3907863899703, 1045.72288343589, 1053.3258714422775, 1060.2631171335847, 9906.306558540977, 10023.599056037678, 11055.889441105646, 11565.826512602318, 11720.355380454157, 736385.0, 755482.0, 768521.0, 781379.0, 795995.0, 105579.0, 134849.0, 138937.0, 139983.30008349894, 142551.28724356313, 998.0817647763929, 1026.2046913641987, 1037.5538518437145, 1038.4963292802984, 1045.4563626913962, 18147.818521814614, 19025.0, 19468.415947521597, 19562.90218548898, 19563.413097607096, 53058.46941530535, 55109.0, 55168.89662206814, 56178.719106404205, 56389.436105638415, 78621.82067268882, 83176.16823831684, 83826.32347352897, 84200.0, 84966.0, 7638.579878106758, 7996.480228785111, 8114.959425203072, 8116.959415202886, 8309.418340716093, 13384.464621415034, 13516.93241533786, 13568.0, 14090.0, 14113.153210807384, 10595.311304765166, 11451.59919402817, 11561.595344162914, 11601.767964640829, 12131.332776697367, 11584.594539191088, 11605.941970290094, 11888.881111188777, 11889.28664280146, 12060.216085954386, 11766.294022358687, 11773.234739741889, 12179.330136842558, 12224.0, 12227.0, 8369.079401265977, 8496.800274475348, 8555.016173140168, 8664.610092545725, 8676.219140277406, 9612.471314077793, 10844.728881778019, 10864.511097000812, 11753.0, 11897.940510297392], "value": 10014.61041200121, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.765682177208, 1430.7353139669162, 1447.2835946206628, 1451.1003178029623, 1458.3510337899631, 8188.672453101876, 8586.957065214681, 8596.3122950164, 8599.570021498923, 8612.0, 7566.810829729259, 7848.843023139548, 7849.68601255949, 8123.796905077376, 8305.875411868827, 2256.909723611054, 2299.632058870581, 2302.6661134135625, 2302.9193978210765, 2306.5848147333472, 2055.219016773624, 2331.1374791327235, 2347.8239132065078, 2367.183321753992, 2370.905163793455, 1788.1238193285326, 1974.99012504938, 2235.6087684655204, 2323.9535209295805, 2342.636891281854, 2296.0815673730476, 2344.7420783713865, 2350.5651454480976, 2352.4001379648253, 2353.070537137821, 1984.811442912921, 2323.326235391751, 2379.464620460383, 2393.56915755164, 2395.5208958208254, 8440.240378365976, 8493.023302320189, 8495.490270583785, 8514.872276915852, 8519.53142577158, 5091.287219789232, 5266.7629956652045, 5273.815416460444, 5281.577473802086, 5294.338207724035, 3386.508956201337, 3504.351694936445, 3520.9119772005906, 3553.591336996227, 3612.638736126393, 1182.2020136407975, 1195.0678470792795, 1250.7123361626786, 1261.4449642157422, 1270.4056409206387, 10535.420551869644, 10753.301035432673, 10778.892211077946, 10810.945945270223, 10940.507677154546, 4584.610308123847, 4676.111538807616, 4750.358701575243, 4800.423949126058, 4800.655816371422, 9609.375390599589, 9616.615335386647, 9621.08599683029, 9631.759206019906, 9641.566129524048, 5300.549453296513, 5315.6279060465395, 5320.281761962163, 5324.92012619811, 5328.094223981932, 4278.978605106954, 4337.436133302651, 4559.566841150086, 4762.404699412574, 4817.855464336076, 3469.774464659789, 3808.8666896658483, 3934.370500719871, 3979.721419500607, 4028.7179897407486, 1261.9682311478512, 1284.2679672586537, 1286.1382873474795, 1295.164618820874, 1299.4152631315947, 792.6868886789686, 883.1830556735123, 883.3860466975519, 905.8550631898864, 910.0671811393374, 5490.945090549123, 5660.603757736919, 5715.485606295453, 5885.852258809491, 5903.321118071477, 868.7828042989253, 1005.8893521712606, 1010.9090181883665, 1023.5854478936043, 1056.9418681972566, 3459.3427248822645, 3716.479692843004, 3883.456316115746, 3977.244323578511, 3999.260136874629, 9591.376560523544, 9600.75998100039, 9983.051610097174, 10023.198144148451, 10166.694999150037, 10071.496425178859, 10138.188944884392, 10141.087302142843, 10152.898471015194, 10162.136218421369, 7536.585487798224, 7813.335866451415, 7859.017622797151, 7953.2842044216295, 7966.203379661987, 5633.211350410864, 5656.23640808502, 5695.231143795535, 5892.145638882424, 5974.820755377345, 9128.49793261377, 9194.31042671789, 9273.0, 9371.969083400683, 9383.483908385104, 9175.587098580447, 9337.953310233406, 9413.341066125306, 9468.47923364194, 9597.808043839224, 7050.25972272904, 7193.064901562763, 7195.244499327705, 7284.307990740871, 7361.043064401593, 8033.55815430157, 8119.837603247784, 8122.187781221831, 8122.918770812216, 8138.145494723206, 6259.217597800275, 7076.433885289268, 7162.355388015104, 7210.423166146591, 7231.819204519929, 6706.83232919181, 6735.764248251287, 6744.190697116377, 6748.6963086660235, 6767.661616919233, 6364.522660800366, 6463.353664633687, 6516.869662606816, 6517.967410162919, 6535.313792051957, 5028.220625803006, 5065.620078494201, 5077.416097148875, 5078.289039534542, 5128.256402821645, 4978.775955081957, 5034.244863270539, 5075.441701412916, 5163.8192663258105, 5169.560587350117], "value": 4453.109721626684, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.0785711079748, 360.6916086745832, 364.4769755401, 369.1730523627076, 372.0308596107139, 4241.766702831343, 4881.585065269452, 5026.798928042878, 5279.445658205891, 5387.299651045369, 4543.840965566206, 5182.896342073166, 5272.340957380327, 5284.260203571503, 5320.122179840331, 3536.8231588420604, 4222.957770422303, 4224.957750422487, 4231.4710661167355, 4242.278812601865, 3579.49887015818, 3737.4580685800543, 3961.3265744823448, 4024.8126802593306, 4241.0, 3991.42124391963, 4034.495688038995, 4035.334169861984, 4044.9797751011206, 4046.797660116997, 3382.391169589473, 3964.8215830287563, 4011.0, 4025.497816899287, 4033.193361327717, 3504.5093686883856, 3513.4905438711244, 3514.68367846895, 3517.4723791431234, 3518.3491054155065, 4570.451545814491, 4874.317595536628, 5136.486351364871, 5218.0693143536755, 5241.528262456359, 4600.263957766775, 4608.700434471749, 4631.768411579441, 4636.605888499482, 4639.976800115978, 4568.520305367955, 4575.290829921368, 5590.853874955625, 5617.831465056055, 5628.887422251573, 3242.3839470500766, 3812.694984401241, 3835.1946091320856, 3861.806909654534, 3866.6520013198665, 5206.401263854629, 5872.882542349172, 5904.202932604129, 5906.460222104493, 5925.614835035709, 3542.734294927891, 3709.9814500927323, 3851.768893866377, 3913.6477717005605, 3924.2151569686175, 3397.592288925295, 3633.1280492681567, 3775.7734535927384, 3967.107400834789, 3969.5236571611013, 4145.66834653227, 4602.3786788783755, 4624.543268870295, 4633.4671512775785, 4642.953570464252, 5226.210997027125, 5421.457854214547, 5619.904118696815, 5705.232962013421, 5766.654000759968, 1221.322166197751, 1239.6343078791779, 1242.863285038645, 1263.6651287408845, 1264.9747005059846, 852.8763329317214, 863.456022705704, 871.2333146830875, 876.7106854737921, 888.8977767556813, 4251.702380833374, 4410.6030457259, 4642.396488456479, 5000.999400359828, 5026.447090820006, 4747.406574178228, 5132.717700526432, 5291.867703307371, 5443.583634283834, 5446.863828404322, 4396.384506169139, 4809.687370320918, 5097.260897169889, 5341.946580534222, 5352.652077614943, 2517.433577445097, 2647.5234457797783, 2681.611166380864, 2783.1928740665385, 2830.448062627809, 5038.647294689336, 5340.492653198017, 5611.877624475122, 5845.444682755132, 5876.294844618673, 5019.899602007939, 5075.295034624744, 5552.668398960672, 5629.915551266734, 5683.374828768832, 5167.844964651066, 5220.425753167073, 5744.146196463981, 5771.499410153307, 5832.854178645568, 4406.625436837905, 4926.950730492649, 4944.925826112683, 5449.373322067854, 5466.867921510693, 5197.584193264605, 5393.1370980642905, 5431.83704488866, 5436.53789427903, 5497.6805566662915, 5123.0, 5297.390800058042, 5377.919331210113, 5499.0, 5822.883542329215, 2975.687552807011, 3737.346483996393, 3737.6822970046765, 3743.36362818327, 3767.3783825668456, 4886.853394398174, 5082.975629500442, 5508.338999320107, 5598.440155984532, 5598.832035038955, 4525.198832980313, 4809.567138957511, 4826.9244224983595, 5287.656302340336, 5364.46355364476, 4988.27669987857, 5042.084008076908, 5046.57104146137, 5361.839144825662, 5366.651167674088, 4692.6480513960905, 5208.348956380452, 5332.6000549958135, 5349.421920533374, 5354.705491197866, 5112.71880046601, 5462.726863656881, 5606.831795046155, 5611.597100724819, 5637.9718101409235, 4706.858794236178, 5176.0, 5449.618526703092, 5480.890382192413, 5493.560515158858], "value": 4001.8629500019997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.3280981497022, 742.4209116888821, 768.5043147170072, 836.4312267657994, 853.7705703786547, 14594.562163135097, 15409.537713868574, 15429.0, 15438.459653912116, 15550.533483995485, 14145.0, 14367.137971721679, 14371.78442323366, 14394.712105757879, 15653.0, 710.0591715976326, 729.2015243308595, 735.5513136986434, 873.9388242823005, 886.7738726624718, 841.8400503904269, 897.4391005621486, 909.6997990663066, 910.4855756497591, 913.9405938614002, 955.8614000969856, 957.3681370295607, 958.1281034258826, 960.2749923807515, 961.2166084640995, 737.7639155470251, 758.4956004257162, 915.2220612479406, 957.4877440569297, 961.3558915526579, 715.059696499102, 715.8854583266652, 716.4733920568378, 717.6304203335286, 718.3678363040491, 15384.615384615474, 15592.37630494779, 15618.9219053904, 15627.531174064796, 15628.0, 13917.512887049006, 14173.007889447743, 14292.785608215885, 14348.49780257686, 14487.348069336906, 11523.19337646365, 11674.073777826648, 11810.409479526075, 11820.172587918849, 11873.346965916871, 3715.294094122108, 3734.3278209922205, 3800.467934489174, 3931.803409829497, 4021.3565829467143, 104607.0, 106601.0, 107607.0, 108202.91797082007, 108938.45530772295, 11004.0, 11413.657590272305, 11454.599089031844, 11535.423228838525, 11850.525978960744, 23602.0, 23730.169444069375, 23885.402864928517, 24061.879690601436, 24082.7591724084, 7909.20907909216, 7934.484258523177, 7946.284834364819, 8071.838563228703, 8150.38872084596, 3886.2810380079777, 4071.531773845986, 4222.472190976128, 4296.183725092223, 4389.495208051051, 3646.4530320452145, 3739.495168152319, 3742.120601658608, 3742.7941463219786, 3749.981250093732, 572.86537663649, 660.0693022837776, 664.2726214794792, 679.9456043516507, 690.0511796280115, 683.1733602341222, 697.9965100174467, 700.849317396752, 705.6295444891473, 733.1751779248345, 9695.66065187715, 10477.0, 10494.108000819862, 10522.63170789034, 10785.676429707122, 684.7192651013061, 696.5159214345981, 707.8117399461931, 719.0939416335455, 719.830275801822, 5074.893919023564, 5077.672269283776, 5084.872878178076, 5133.435322114565, 5135.717535535581, 101092.49453752684, 102009.0, 102255.0, 102684.0, 104597.47701261444, 88409.55795220983, 89904.0, 91527.08472915318, 92655.0, 93262.0, 80228.0, 81831.0, 82185.356292875, 82564.58717706492, 83689.16310836814, 9748.02519748048, 10896.673099807018, 10919.235653504178, 11492.195546312012, 11517.25137866036, 43939.90150246269, 44611.77694111638, 49058.0, 49566.50433495619, 51432.485675144264, 52611.73694131505, 68162.0, 69844.56886007244, 70793.87618371457, 73361.53276934325, 13131.671708207372, 13144.211347319191, 13276.402561884544, 13678.110922790385, 13699.315034248048, 13834.446622135001, 14027.29863506841, 14463.710725785635, 14539.563813085624, 15822.367105315658, 12404.379781010733, 13776.448942042207, 14241.715165696422, 14270.429182832571, 14772.926135369255, 13293.268870211845, 13826.823299557816, 13902.652433689238, 14271.71456570842, 14314.212718300594, 12898.67753306175, 12945.09384343087, 13553.796693049415, 13799.51701690436, 13826.585202443943, 10167.644132455329, 10748.301360411548, 11368.261063030877, 11768.52925882955, 12246.0, 11089.778204436028, 11253.71865703364, 11285.43572821372, 11305.095592352427, 11306.434678265889], "value": 7693.553117662519, "unit": "score"}], "name": "dromaeo_css", "value": 7404.877282618497, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 118.0, 115.0, 116.0, 117.0, 114.0, 114.0, 114.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 109.0, 108.0, 156.0, 113.0, 112.0, 141.0, 133.0, 129.0, 110.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 184.0, 183.0, 186.0, 253.0, 238.0, 186.0, 187.0, 184.0], "value": 196.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 57.0, 88.0, 58.0, 58.0, 58.0, 59.0, 75.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 76.0, 94.0, 101.0, 115.0, 67.0, 69.0, 81.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 86.0, 92.0, 83.0, 89.0, 86.0, 88.0, 85.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 86.0, 87.0, 90.0, 85.0, 86.0, 87.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 53.0, 52.0, 55.0, 56.0, 57.0, 56.0, 57.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 72.0, 75.0, 71.0, 69.0, 69.0, 69.0, 70.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 82.0, 84.0, 84.0, 82.0, 83.0, 84.0, 87.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 145.0, 150.0, 137.0, 135.0, 141.0, 157.0, 154.0, 235.0, 149.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 211.0, 170.0, 167.0, 167.0, 168.0, 166.0, 166.0, 167.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 64.0, 67.0, 66.0, 66.0, 64.0, 63.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1458.1999999999998, "alertThreshold": 2.0}]} 12:47:44 INFO - Return code: 0 12:47:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:47:44 ERROR - # TBPL SUCCESS # 12:47:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:47:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:47:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:47:44 INFO - 2017-01-27 12:47:44.825 screenresolution[1659:9826] starting screenresolution argv=screenresolution get 12:47:44 INFO - 2017-01-27 12:47:44.828 screenresolution[1659:9826] Display 0: 1600x1200x32@60 12:47:44 INFO - 2017-01-27 12:47:44.834 screenresolution[1660:9829] starting screenresolution argv=screenresolution list 12:47:44 INFO - Available Modes on Display 0 12:47:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:47:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:47:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:47:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:47:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:47:45 INFO - Intel Iris: 12:47:45 INFO - Chipset Model: Intel Iris 12:47:45 INFO - Type: GPU 12:47:45 INFO - Bus: Built-In 12:47:45 INFO - VRAM (Dynamic, Max): 1536 MB 12:47:45 INFO - Vendor: Intel (0x8086) 12:47:45 INFO - Device ID: 0x0a2e 12:47:45 INFO - Revision ID: 0x0009 12:47:45 INFO - Displays: 12:47:45 INFO - Display: 12:47:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:47:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:47:45 INFO - Display Serial Number: 1600x1200 60 12:47:45 INFO - Main Display: Yes 12:47:45 INFO - Mirror: Off 12:47:45 INFO - Online: Yes 12:47:45 INFO - Rotation: Supported 12:47:45 INFO - Return code: 0 12:47:45 INFO - Running post-action listener: _resource_record_post_action 12:47:45 INFO - [mozharness: 2017-01-27 20:47:45.070051Z] Finished run-tests step (success) 12:47:45 INFO - Running post-run listener: _resource_record_post_run 12:47:45 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 36787200; Write bytes: 508323840; Read time: 384; Write time: 1768 12:47:45 INFO - TinderboxPrint: CPU usage
53.8% 12:47:45 INFO - TinderboxPrint: I/O read bytes / time
36,787,200 / 384 12:47:45 INFO - TinderboxPrint: I/O write bytes / time
508,323,840 / 1,768 12:47:45 INFO - TinderboxPrint: CPU idle
2,216.9 (46.2%) 12:47:45 INFO - TinderboxPrint: CPU system
958.7 (20.0%) 12:47:45 INFO - TinderboxPrint: CPU user
1,618.1 (33.8%) 12:47:45 INFO - TinderboxPrint: Swap in / out
244,334,592 / 0 12:47:45 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205275648; Write bytes: 200841216; Read time: 15654; Write time: 459 12:47:45 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34452480; Write bytes: 296398848; Read time: 360; Write time: 1274 12:47:45 INFO - Running post-run listener: _upload_blobber_files 12:47:45 INFO - Blob upload gear active. 12:47:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:47:45 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 12:47:45 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'] 12:47:45 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 12:47:45 INFO - (blobuploader) - INFO - Open directory for files ... 12:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:47:47 INFO - (blobuploader) - INFO - Done attempting. 12:47:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:47:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:47:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:47:48 INFO - (blobuploader) - INFO - Done attempting. 12:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:47:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:47:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:47:49 INFO - (blobuploader) - INFO - Done attempting. 12:47:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:47:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:47:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:47:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:47:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:47:51 INFO - (blobuploader) - INFO - Done attempting. 12:47:51 INFO - (blobuploader) - INFO - Iteration through files over. 12:47:51 INFO - Return code: 0 12:47:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:47:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:47:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d92657fcc9a6e85e78d24e535627c2da968bba92249c1f29ca933217ddc14e61cafcdf5bebee051bfba42ae9b950dace576e9b9a2a35f7e25be47aa2ee421c16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d10a700c094e1583921b5c1e2962195addcd7bc7408f4a3126dbb5761ae4d9d55189cf8e3fec51225959d6b705509150fe31ac3246f8be6ecdf6f9a303c387a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/236023b7c7b1b762f1790af0e9f73f6c0490bd5bf3d6d9372a55599e7a1d4afc4a74c335b85b938fb836967832dcf9fbc2e377aaf4a063622c6ebfc42b45e152", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70c004e3d5313b8d30a24acc2813189a8375c64babc6c72b1f2b7a13d7a9d0e4e8fae4b5739ad7b18d9b14c86c70b59890ce227525dd8f68507e241b29471483"} 12:47:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:47:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:47:51 INFO - Contents: 12:47:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d92657fcc9a6e85e78d24e535627c2da968bba92249c1f29ca933217ddc14e61cafcdf5bebee051bfba42ae9b950dace576e9b9a2a35f7e25be47aa2ee421c16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d10a700c094e1583921b5c1e2962195addcd7bc7408f4a3126dbb5761ae4d9d55189cf8e3fec51225959d6b705509150fe31ac3246f8be6ecdf6f9a303c387a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/236023b7c7b1b762f1790af0e9f73f6c0490bd5bf3d6d9372a55599e7a1d4afc4a74c335b85b938fb836967832dcf9fbc2e377aaf4a063622c6ebfc42b45e152", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70c004e3d5313b8d30a24acc2813189a8375c64babc6c72b1f2b7a13d7a9d0e4e8fae4b5739ad7b18d9b14c86c70b59890ce227525dd8f68507e241b29471483"} 12:47:51 INFO - Running post-run listener: copy_logs_to_upload_dir 12:47:51 INFO - Copying logs to upload dir... 12:47:51 INFO - mkdir: /builds/slave/test/build/upload/logs 12:47:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.418146 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-27 12:47:51.241241) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 12:47:51.245285) ========= 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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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/d92657fcc9a6e85e78d24e535627c2da968bba92249c1f29ca933217ddc14e61cafcdf5bebee051bfba42ae9b950dace576e9b9a2a35f7e25be47aa2ee421c16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d10a700c094e1583921b5c1e2962195addcd7bc7408f4a3126dbb5761ae4d9d55189cf8e3fec51225959d6b705509150fe31ac3246f8be6ecdf6f9a303c387a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/236023b7c7b1b762f1790af0e9f73f6c0490bd5bf3d6d9372a55599e7a1d4afc4a74c335b85b938fb836967832dcf9fbc2e377aaf4a063622c6ebfc42b45e152", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70c004e3d5313b8d30a24acc2813189a8375c64babc6c72b1f2b7a13d7a9d0e4e8fae4b5739ad7b18d9b14c86c70b59890ce227525dd8f68507e241b29471483"} build_url:https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010910 build_url: 'https://queue.taskcluster.net/v1/task/IExvesZ2QCy3GLPJsZwQIg/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/d92657fcc9a6e85e78d24e535627c2da968bba92249c1f29ca933217ddc14e61cafcdf5bebee051bfba42ae9b950dace576e9b9a2a35f7e25be47aa2ee421c16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d10a700c094e1583921b5c1e2962195addcd7bc7408f4a3126dbb5761ae4d9d55189cf8e3fec51225959d6b705509150fe31ac3246f8be6ecdf6f9a303c387a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/236023b7c7b1b762f1790af0e9f73f6c0490bd5bf3d6d9372a55599e7a1d4afc4a74c335b85b938fb836967832dcf9fbc2e377aaf4a063622c6ebfc42b45e152", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70c004e3d5313b8d30a24acc2813189a8375c64babc6c72b1f2b7a13d7a9d0e4e8fae4b5739ad7b18d9b14c86c70b59890ce227525dd8f68507e241b29471483"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 12:47:51.279663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 12:47:51.280196) ========= 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.d5kXwMh7nN/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.DpL1dCwz8V/Listeners TMPDIR=/var/folders/x3/802dh5md7_73wtzq6q6p6b0m00000w/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.005132 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 12:47:51.330919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 12:47:51.331458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 12:47:51.331827) ========= ========= Total master_lag: 0.18 =========