builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1487013992.85 results: success (0) buildid: 20170213101040 builduid: a8f404cffbeb43c68b0d51d9cf0571b6 revision: 08243c8a96514bb8de3e655170c023790af54549 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:32.850554) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:32.851062) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:32.851378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:32.877186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:32.877502) ========= 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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-13 11:26:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 41.2M=0s 2017-02-13 11:26:32 (41.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083284 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:32.985687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:32.986090) ========= 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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.020063 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:33.034950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:33.035327) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08243c8a96514bb8de3e655170c023790af54549 --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 08243c8a96514bb8de3e655170c023790af54549 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qqymPT6jWh/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.dNQPfSWpNZ/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-13 11:26:33,123 truncating revision to first 12 chars 2017-02-13 11:26:33,123 Setting DEBUG logging. 2017-02-13 11:26:33,123 attempt 1/10 2017-02-13 11:26:33,123 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/08243c8a9651?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 11:26:33,462 unpacking tar archive at: mozilla-aurora-08243c8a9651/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583122 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:33.646272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:33.646981) ========= script_repo_revision: 08243c8a96514bb8de3e655170c023790af54549 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:33.647691) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:33.647995) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 11:26:33.668875) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-13 11:26:33.669590) ========= /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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:26:33 INFO - MultiFileLogger online at 20170213 11:26:33 in /builds/slave/test 11:26:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:26:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:33 INFO - {'append_to_log': False, 11:26:33 INFO - 'base_work_dir': '/builds/slave/test', 11:26:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:26:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:33 INFO - 'branch': 'Mozilla-Aurora', 11:26:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:33 INFO - 'config_files': ('talos/mac_config.py',), 11:26:33 INFO - 'default_actions': ('clobber', 11:26:33 INFO - 'read-buildbot-config', 11:26:33 INFO - 'download-and-extract', 11:26:33 INFO - 'populate-webroot', 11:26:33 INFO - 'create-virtualenv', 11:26:33 INFO - 'install', 11:26:33 INFO - 'run-tests'), 11:26:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:33 INFO - 'download_minidump_stackwalk': True, 11:26:33 INFO - 'download_symbols': 'ondemand', 11:26:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:33 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:33 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:33 INFO - 'installer_path': 'installer.exe', 11:26:33 INFO - 'log_level': 'info', 11:26:33 INFO - 'log_name': 'talos', 11:26:33 INFO - 'log_to_console': True, 11:26:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:26:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:26:33 INFO - 'opt_config_files': (), 11:26:33 INFO - 'pip_index': False, 11:26:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:26:33 INFO - 'cmd': ('bash', 11:26:33 INFO - '-c', 11:26:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:26:33 INFO - 'enabled': True, 11:26:33 INFO - 'halt_on_failure': False, 11:26:33 INFO - 'name': 'check_screen_resolution'},), 11:26:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:26:33 INFO - 'cmd': ('bash', 11:26:33 INFO - '-c', 11:26:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:26:33 INFO - 'enabled': True, 11:26:33 INFO - 'halt_on_failure': False, 11:26:33 INFO - 'name': 'check_screen_resolution'},), 11:26:33 INFO - 'run_cmd_checks_enabled': True, 11:26:33 INFO - 'sps_profile': False, 11:26:33 INFO - 'sps_profile_interval': 0, 11:26:33 INFO - 'suite': 'dromaeojs', 11:26:33 INFO - 'system_bits': '32', 11:26:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:33 INFO - 'title': 't-yosemite-r7-0191', 11:26:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:33 INFO - 'use_talos_json': True, 11:26:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:33 INFO - 'work_dir': 'build'} 11:26:33 INFO - [mozharness: 2017-02-13 19:26:33.888609Z] Running clobber step. 11:26:33 INFO - Running pre-action listener: _resource_record_pre_action 11:26:33 INFO - Running main action method: clobber 11:26:33 INFO - rmtree: /builds/slave/test/build 11:26:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:35 INFO - Running post-action listener: _resource_record_post_action 11:26:35 INFO - [mozharness: 2017-02-13 19:26:35.571651Z] Finished clobber step (success) 11:26:35 INFO - [mozharness: 2017-02-13 19:26:35.571803Z] Running read-buildbot-config step. 11:26:35 INFO - Running pre-action listener: _resource_record_pre_action 11:26:35 INFO - Running main action method: read_buildbot_config 11:26:35 INFO - Using buildbot properties: 11:26:35 INFO - { 11:26:35 INFO - "project": "", 11:26:35 INFO - "product": "firefox", 11:26:35 INFO - "script_repo_revision": "production", 11:26:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:26:35 INFO - "repository": "", 11:26:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:26:35 INFO - "buildid": "20170213101040", 11:26:35 INFO - "pgo_build": "False", 11:26:35 INFO - "basedir": "/builds/slave/test", 11:26:35 INFO - "buildnumber": 0, 11:26:35 INFO - "slavename": "t-yosemite-r7-0191", 11:26:35 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:26:35 INFO - "platform": "yosemite_r7", 11:26:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:26:35 INFO - "branch": "mozilla-aurora", 11:26:35 INFO - "repo_path": "releases/mozilla-aurora", 11:26:35 INFO - "revision": "08243c8a96514bb8de3e655170c023790af54549", 11:26:35 INFO - "stage_platform": "macosx64", 11:26:35 INFO - "builduid": "a8f404cffbeb43c68b0d51d9cf0571b6", 11:26:35 INFO - "slavebuilddir": "test" 11:26:35 INFO - } 11:26:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 11:26:35 INFO - Running post-action listener: _resource_record_post_action 11:26:35 INFO - [mozharness: 2017-02-13 19:26:35.575093Z] Finished read-buildbot-config step (success) 11:26:35 INFO - [mozharness: 2017-02-13 19:26:35.575216Z] Running download-and-extract step. 11:26:35 INFO - Running pre-action listener: _resource_record_pre_action 11:26:35 INFO - Running main action method: download_and_extract 11:26:35 INFO - mkdir: /builds/slave/test/build/tests 11:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:35 INFO - trying https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 11:26:35 INFO - Downloading https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/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 11:26:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/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 11:26:36 INFO - Downloaded 1199 bytes. 11:26:36 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:26:36 INFO - Using the following test package requirements: 11:26:36 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:26:36 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:26:36 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 11:26:36 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:26:36 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 11:26:36 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:26:36 INFO - u'jsshell-mac.zip'], 11:26:36 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:26:36 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 11:26:36 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:26:36 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:26:36 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 11:26:36 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:26:36 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 11:26:36 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:26:36 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 11:26:36 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:26:36 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 11:26:36 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:26:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:26:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:26:36 INFO - Fetch https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:26:37 INFO - Expected file size: 16358332 11:26:37 INFO - Obtained file size: 16358332 11:26:44 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 11:26:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:26:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:26:44 INFO - Fetch https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:26:45 INFO - Expected file size: 16358332 11:26:45 INFO - Obtained file size: 16358332 11:26:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 11:26:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:26:52 INFO - Fetch https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 11:26:53 INFO - Expected file size: 14403485 11:26:53 INFO - Obtained file size: 14403485 11: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')]} 11:26:53 INFO - trying https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:26:53 INFO - Downloading https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 11:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/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 11:26:56 INFO - Downloaded 73958710 bytes. 11:26:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:26:56 INFO - mkdir: /builds/slave/test/properties 11:26:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:56 INFO - Contents: 11:26:56 INFO - build_url:https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:26:56 INFO - Running post-action listener: _resource_record_post_action 11:26:56 INFO - Running post-action listener: set_extra_try_arguments 11:26:56 INFO - [mozharness: 2017-02-13 19:26:56.687573Z] Finished download-and-extract step (success) 11:26:56 INFO - [mozharness: 2017-02-13 19:26:56.687716Z] Running populate-webroot step. 11:26:56 INFO - Running pre-action listener: _resource_record_pre_action 11:26:56 INFO - Running main action method: populate_webroot 11:26:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:26:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:26:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:26:56 INFO - '--tppagecycles', 11:26:56 INFO - '7'], 11:26:56 INFO - 'tests': ['tsvgm']}}, 11:26:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:26:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:26:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:26:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:26:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:26:56 INFO - 'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:26:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:26:56 INFO - 'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['damp', 'tps']}, 11:26:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:26:56 INFO - 'tests': ['damp', 'tps']}, 11:26:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['dromaeo_dom']}, 11:26:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['basic_compositor_video']}, 11:26:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:26:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['a11yr', 11:26:56 INFO - 'ts_paint', 11:26:56 INFO - 'tpaint', 11:26:56 INFO - 'sessionrestore', 11:26:56 INFO - 'sessionrestore_no_auto_restore', 11:26:56 INFO - 'tabpaint']}, 11:26:56 INFO - 'other-e10s': {'tests': ['a11yr', 11:26:56 INFO - 'ts_paint', 11:26:56 INFO - 'tpaint', 11:26:56 INFO - 'sessionrestore', 11:26:56 INFO - 'sessionrestore_no_auto_restore', 11:26:56 INFO - 'tabpaint']}, 11:26:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:26:56 INFO - 'ts_paint', 11:26:56 INFO - 'tpaint', 11:26:56 INFO - 'sessionrestore', 11:26:56 INFO - 'sessionrestore_no_auto_restore', 11:26:56 INFO - 'tabpaint']}, 11:26:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:26:56 INFO - 'ts_paint', 11:26:56 INFO - 'tpaint', 11:26:56 INFO - 'sessionrestore', 11:26:56 INFO - 'sessionrestore_no_auto_restore', 11:26:56 INFO - 'tabpaint']}, 11:26:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['a11yr', 11:26:56 INFO - 'ts_paint', 11:26:56 INFO - 'tpaint', 11:26:56 INFO - 'sessionrestore', 11:26:56 INFO - 'sessionrestore_no_auto_restore', 11:26:56 INFO - 'tabpaint']}, 11:26:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['a11yr', 11:26:56 INFO - 'ts_paint', 11:26:56 INFO - 'tpaint', 11:26:56 INFO - 'sessionrestore', 11:26:56 INFO - 'sessionrestore_no_auto_restore', 11:26:56 INFO - 'tabpaint']}, 11:26:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['tsvgx', 11:26:56 INFO - 'tsvgr_opacity', 11:26:56 INFO - 'tart', 11:26:56 INFO - 'tscrollx', 11:26:56 INFO - 'cart', 11:26:56 INFO - 'tsvg_static']}, 11:26:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:26:56 INFO - 'tsvgr_opacity', 11:26:56 INFO - 'tart', 11:26:56 INFO - 'tscrollx', 11:26:56 INFO - 'cart', 11:26:56 INFO - 'tsvg_static']}, 11:26:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:26:56 INFO - 'talos_options': ['--disable-e10s'], 11:26:56 INFO - 'tests': ['tp5o']}, 11:26:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:26:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:26:56 INFO - 'talos_options': ['--disable-e10s', 11:26:56 INFO - '--xperf_path', 11:26:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:56 INFO - 'tests': ['tp5n']}, 11:26:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:26:56 INFO - 'talos_options': ['--xperf_path', 11:26:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:56 INFO - 'tests': ['tp5n']}}, 11:26:56 INFO - 'talos.zip': {'path': '', 11:26:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:26:56 INFO - Running post-action listener: _resource_record_post_action 11:26:56 INFO - [mozharness: 2017-02-13 19:26:56.706043Z] Finished populate-webroot step (success) 11:26:56 INFO - [mozharness: 2017-02-13 19:26:56.706149Z] Running create-virtualenv step. 11:26:56 INFO - Running pre-action listener: _resource_record_pre_action 11:26:56 INFO - Running main action method: create_virtualenv 11:26:56 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:26:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:26:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:56 INFO - Using real prefix '/tools/python27' 11:26:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:57 INFO - Installing distribute.............................................................................................................................................................................................done. 11:27:00 INFO - Installing pip.................done. 11:27:00 INFO - Return code: 0 11:27:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:27:00 INFO - Reading from file tmpfile_stdout 11:27:00 INFO - Output received: 11:27:00 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) 11:27:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:00 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 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:27:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:00 INFO - 'HOME': '/Users/cltbld', 11:27:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:00 INFO - 'LOGNAME': 'cltbld', 11:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:00 INFO - 'MOZ_NO_REMOTE': '1', 11:27:00 INFO - 'NO_EM_RESTART': '1', 11:27:00 INFO - 'PAGER': '/bin/cat', 11:27:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:00 INFO - 'PWD': '/builds/slave/test', 11:27:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:00 INFO - 'SHELL': '/bin/bash', 11:27:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:00 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:00 INFO - 'USER': 'cltbld', 11:27:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:00 INFO - 'XPC_FLAGS': '0x0', 11:27:00 INFO - 'XPC_SERVICE_NAME': '0', 11:27:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:27:00 INFO - Cleaning up... 11:27:00 INFO - Return code: 0 11:27:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:00 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 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:27:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:00 INFO - 'HOME': '/Users/cltbld', 11:27:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:00 INFO - 'LOGNAME': 'cltbld', 11:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:00 INFO - 'MOZ_NO_REMOTE': '1', 11:27:00 INFO - 'NO_EM_RESTART': '1', 11:27:00 INFO - 'PAGER': '/bin/cat', 11:27:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:00 INFO - 'PWD': '/builds/slave/test', 11:27:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:00 INFO - 'SHELL': '/bin/bash', 11:27:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:00 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:00 INFO - 'USER': 'cltbld', 11:27:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:00 INFO - 'XPC_FLAGS': '0x0', 11:27:00 INFO - 'XPC_SERVICE_NAME': '0', 11:27:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:01 INFO - Downloading/unpacking psutil>=3.1.1 11:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:27:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:04 INFO - Installing collected packages: psutil 11:27:04 INFO - Running setup.py install for psutil 11:27:04 INFO - building 'psutil._psutil_osx' extension 11:27:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:27:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:27:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:27:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:27:05 INFO - building 'psutil._psutil_posix' extension 11:27:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:27:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:27:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:27:05 INFO - ^ 11:27:05 INFO - 1 warning generated. 11:27:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:27:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:05 INFO - Successfully installed psutil 11:27:05 INFO - Cleaning up... 11:27:05 INFO - Return code: 0 11:27:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:05 INFO - 'HOME': '/Users/cltbld', 11:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:05 INFO - 'LOGNAME': 'cltbld', 11:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:05 INFO - 'MOZ_NO_REMOTE': '1', 11:27:05 INFO - 'NO_EM_RESTART': '1', 11:27:05 INFO - 'PAGER': '/bin/cat', 11:27:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:05 INFO - 'PWD': '/builds/slave/test', 11:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:05 INFO - 'SHELL': '/bin/bash', 11:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:05 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:05 INFO - 'USER': 'cltbld', 11:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:05 INFO - 'XPC_FLAGS': '0x0', 11:27:05 INFO - 'XPC_SERVICE_NAME': '0', 11:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:27:08 INFO - Installing collected packages: mozsystemmonitor 11:27:08 INFO - Running setup.py install for mozsystemmonitor 11:27:08 INFO - Successfully installed mozsystemmonitor 11:27:08 INFO - Cleaning up... 11:27:08 INFO - Return code: 0 11:27:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:08 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 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:08 INFO - 'HOME': '/Users/cltbld', 11:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:08 INFO - 'LOGNAME': 'cltbld', 11:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:08 INFO - 'MOZ_NO_REMOTE': '1', 11:27:08 INFO - 'NO_EM_RESTART': '1', 11:27:08 INFO - 'PAGER': '/bin/cat', 11:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:08 INFO - 'PWD': '/builds/slave/test', 11:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:08 INFO - 'SHELL': '/bin/bash', 11:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:08 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:08 INFO - 'USER': 'cltbld', 11:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:08 INFO - 'XPC_FLAGS': '0x0', 11:27:08 INFO - 'XPC_SERVICE_NAME': '0', 11:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:09 INFO - Downloading/unpacking jsonschema==2.5.1 11:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:27:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:12 INFO - Downloading functools32-3.2.3-2.tar.gz 11:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:27:12 INFO - warning: no files found matching '*.txt' 11:27:12 INFO - no previously-included directories found matching 'build' 11:27:12 INFO - no previously-included directories found matching 'dist' 11:27:12 INFO - no previously-included directories found matching '.git*' 11:27:12 INFO - Installing collected packages: jsonschema, functools32 11:27:12 INFO - Running setup.py install for functools32 11:27:12 INFO - warning: no files found matching '*.txt' 11:27:12 INFO - no previously-included directories found matching 'build' 11:27:12 INFO - no previously-included directories found matching 'dist' 11:27:12 INFO - no previously-included directories found matching '.git*' 11:27:12 INFO - Successfully installed jsonschema functools32 11:27:12 INFO - Cleaning up... 11:27:12 INFO - Return code: 0 11:27:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:12 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 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:27:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:12 INFO - 'HOME': '/Users/cltbld', 11:27:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:12 INFO - 'LOGNAME': 'cltbld', 11:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:12 INFO - 'MOZ_NO_REMOTE': '1', 11:27:12 INFO - 'NO_EM_RESTART': '1', 11:27:12 INFO - 'PAGER': '/bin/cat', 11:27:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:12 INFO - 'PWD': '/builds/slave/test', 11:27:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:12 INFO - 'SHELL': '/bin/bash', 11:27:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:12 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:12 INFO - 'USER': 'cltbld', 11:27:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:12 INFO - 'XPC_FLAGS': '0x0', 11:27:12 INFO - 'XPC_SERVICE_NAME': '0', 11:27:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:27:12 INFO - Cleaning up... 11:27:12 INFO - Return code: 0 11:27:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:12 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 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:27:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:12 INFO - 'HOME': '/Users/cltbld', 11:27:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:12 INFO - 'LOGNAME': 'cltbld', 11:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:12 INFO - 'MOZ_NO_REMOTE': '1', 11:27:12 INFO - 'NO_EM_RESTART': '1', 11:27:12 INFO - 'PAGER': '/bin/cat', 11:27:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:12 INFO - 'PWD': '/builds/slave/test', 11:27:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:12 INFO - 'SHELL': '/bin/bash', 11:27:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:12 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:12 INFO - 'USER': 'cltbld', 11:27:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:12 INFO - 'XPC_FLAGS': '0x0', 11:27:12 INFO - 'XPC_SERVICE_NAME': '0', 11:27:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:12 INFO - Downloading/unpacking blobuploader==1.2.4 11:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:15 INFO - Downloading blobuploader-1.2.4.tar.gz 11:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:27:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:27:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:16 INFO - Downloading docopt-0.6.1.tar.gz 11:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:27:16 INFO - Installing collected packages: blobuploader, requests, docopt 11:27:16 INFO - Running setup.py install for blobuploader 11:27:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:27:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:27:16 INFO - Running setup.py install for requests 11:27:17 INFO - Running setup.py install for docopt 11:27:17 INFO - Successfully installed blobuploader requests docopt 11:27:17 INFO - Cleaning up... 11:27:17 INFO - Return code: 0 11:27:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11: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')]} 11:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:17 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 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:17 INFO - 'HOME': '/Users/cltbld', 11:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:17 INFO - 'LOGNAME': 'cltbld', 11:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:17 INFO - 'MOZ_NO_REMOTE': '1', 11:27:17 INFO - 'NO_EM_RESTART': '1', 11:27:17 INFO - 'PAGER': '/bin/cat', 11:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:17 INFO - 'PWD': '/builds/slave/test', 11:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:17 INFO - 'SHELL': '/bin/bash', 11:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:17 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:17 INFO - 'USER': 'cltbld', 11:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:17 INFO - 'XPC_FLAGS': '0x0', 11:27:17 INFO - 'XPC_SERVICE_NAME': '0', 11:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:17 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-asTOfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ynQqna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-JOI_lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-UjbQBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Opwtkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-7vEXeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-tXzGac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-c3a6XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-tdnLgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:18 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-CJAgKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-vFmeha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-lqSPXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-t2Vs5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-E7HST2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-jKk_Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-g3B1Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:19 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-uPsDXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:27:19 INFO - Running setup.py install for manifestparser 11:27:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:27:19 INFO - Running setup.py install for mozcrash 11:27:20 INFO - Running setup.py install for mozdebug 11:27:20 INFO - Running setup.py install for mozdevice 11:27:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Running setup.py install for mozfile 11:27:20 INFO - Running setup.py install for mozhttpd 11:27:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Running setup.py install for mozinfo 11:27:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Running setup.py install for mozInstall 11:27:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Running setup.py install for mozleak 11:27:21 INFO - Running setup.py install for mozlog 11:27:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Running setup.py install for moznetwork 11:27:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Running setup.py install for mozprocess 11:27:21 INFO - Running setup.py install for mozprofile 11:27:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Running setup.py install for mozrunner 11:27:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Running setup.py install for mozscreenshot 11:27:22 INFO - Running setup.py install for moztest 11:27:22 INFO - Running setup.py install for mozversion 11:27:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:27:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:27:22 INFO - Cleaning up... 11:27:22 INFO - Return code: 0 11:27:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11: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')]} 11:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:22 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 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:22 INFO - 'HOME': '/Users/cltbld', 11:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:22 INFO - 'LOGNAME': 'cltbld', 11:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:22 INFO - 'MOZ_NO_REMOTE': '1', 11:27:22 INFO - 'NO_EM_RESTART': '1', 11:27:22 INFO - 'PAGER': '/bin/cat', 11:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:22 INFO - 'PWD': '/builds/slave/test', 11:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:22 INFO - 'SHELL': '/bin/bash', 11:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:22 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:22 INFO - 'USER': 'cltbld', 11:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:22 INFO - 'XPC_FLAGS': '0x0', 11:27:22 INFO - 'XPC_SERVICE_NAME': '0', 11:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:22 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-66BcOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:22 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iFzqOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:22 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)) 11:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:22 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-xi_ymz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:22 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-9sUVcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-eIc12d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-UONhIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-sWOG8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-RYdzl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-SC4q1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-y9SAFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-M2dJ0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-sioqBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-9dhV4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:23 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Fpad8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:24 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)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:24 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-XC2EIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:24 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-fRfZhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:24 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)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:24 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-msDYGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:27:24 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)) 11:27:24 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)) 11:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:27:24 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)) 11:27:24 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)) 11:27:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:27 INFO - Downloading blessings-1.6.tar.gz 11:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:27:27 INFO - Installing collected packages: blessings 11:27:27 INFO - Running setup.py install for blessings 11:27:27 INFO - Successfully installed blessings 11:27:27 INFO - Cleaning up... 11:27:27 INFO - Return code: 0 11:27:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:27 INFO - Reading from file tmpfile_stdout 11:27:27 INFO - Current package versions: 11:27:27 INFO - blessings == 1.6 11:27:27 INFO - blobuploader == 1.2.4 11:27:27 INFO - docopt == 0.6.1 11:27:27 INFO - functools32 == 3.2.3-2 11:27:27 INFO - jsonschema == 2.5.1 11:27:27 INFO - manifestparser == 1.1 11:27:27 INFO - mozInstall == 1.12 11:27:27 INFO - mozcrash == 1.0 11:27:27 INFO - mozdebug == 0.1 11:27:27 INFO - mozdevice == 0.49 11:27:27 INFO - mozfile == 1.2 11:27:27 INFO - mozhttpd == 0.7 11:27:27 INFO - mozinfo == 0.9 11:27:27 INFO - mozleak == 0.1 11:27:27 INFO - mozlog == 3.4 11:27:27 INFO - moznetwork == 0.27 11:27:27 INFO - mozprocess == 0.24 11:27:27 INFO - mozprofile == 0.28 11:27:27 INFO - mozrunner == 6.13 11:27:27 INFO - mozscreenshot == 0.1 11:27:27 INFO - mozsystemmonitor == 0.3 11:27:27 INFO - moztest == 0.8 11:27:27 INFO - mozversion == 1.4 11:27:27 INFO - psutil == 3.1.1 11:27:27 INFO - requests == 1.2.3 11:27:27 INFO - wsgiref == 0.1.2 11:27:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:27 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 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:27 INFO - 'HOME': '/Users/cltbld', 11:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:27 INFO - 'LOGNAME': 'cltbld', 11:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:27 INFO - 'MOZ_NO_REMOTE': '1', 11:27:27 INFO - 'NO_EM_RESTART': '1', 11:27:27 INFO - 'PAGER': '/bin/cat', 11:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:27 INFO - 'PWD': '/builds/slave/test', 11:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:27 INFO - 'SHELL': '/bin/bash', 11:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:27 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:27 INFO - 'USER': 'cltbld', 11:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:27 INFO - 'XPC_FLAGS': '0x0', 11:27:27 INFO - 'XPC_SERVICE_NAME': '0', 11:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:27:27 INFO - Cleaning up... 11:27:27 INFO - Return code: 0 11:27:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:27 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 0x1097e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9824b4c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, '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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:27 INFO - 'HOME': '/Users/cltbld', 11:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:27 INFO - 'LOGNAME': 'cltbld', 11:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:27 INFO - 'MOZ_NO_REMOTE': '1', 11:27:27 INFO - 'NO_EM_RESTART': '1', 11:27:27 INFO - 'PAGER': '/bin/cat', 11:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:27 INFO - 'PWD': '/builds/slave/test', 11:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:27 INFO - 'SHELL': '/bin/bash', 11:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:27 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:27 INFO - 'USER': 'cltbld', 11:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:27 INFO - 'XPC_FLAGS': '0x0', 11:27:27 INFO - 'XPC_SERVICE_NAME': '0', 11:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:27:28 INFO - Cleaning up... 11:27:28 INFO - Return code: 0 11:27:28 INFO - Running post-action listener: _resource_record_post_action 11:27:28 INFO - Running post-action listener: _start_resource_monitoring 11:27:28 INFO - Starting resource monitoring. 11:27:28 INFO - [mozharness: 2017-02-13 19:27:28.272886Z] Finished create-virtualenv step (success) 11:27:28 INFO - [mozharness: 2017-02-13 19:27:28.273906Z] Running install step. 11:27:28 INFO - Running pre-action listener: _resource_record_pre_action 11:27:28 INFO - Running main action method: install 11:27:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:28 INFO - Reading from file tmpfile_stdout 11:27:28 INFO - Detecting whether we're running mozinstall >=1.0... 11:27:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:27:28 INFO - Reading from file tmpfile_stdout 11:27:28 INFO - Output received: 11:27:28 INFO - Usage: mozinstall [options] installer 11:27:28 INFO - Options: 11:27:28 INFO - -h, --help show this help message and exit 11:27:28 INFO - -d DEST, --destination=DEST 11:27:28 INFO - Directory to install application into. [default: 11:27:28 INFO - "/builds/slave/test"] 11:27:28 INFO - --app=APP Application being installed. [default: firefox] 11:27:28 INFO - mkdir: /builds/slave/test/build/application 11:27:28 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'] 11:27:28 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 11:27:48 INFO - Reading from file tmpfile_stdout 11:27:48 INFO - Output received: 11:27:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:27:48 INFO - Running post-action listener: _resource_record_post_action 11:27:48 INFO - [mozharness: 2017-02-13 19:27:48.753750Z] Finished install step (success) 11:27:48 INFO - [mozharness: 2017-02-13 19:27:48.753944Z] Running run-tests step. 11:27:48 INFO - Running pre-action listener: _resource_record_pre_action 11:27:48 INFO - Running main action method: run_tests 11:27:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:27:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:27:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:27:48 INFO - 2017-02-13 11:27:48.768 screenresolution[1898:18419] starting screenresolution argv=screenresolution get 11:27:48 INFO - 2017-02-13 11:27:48.771 screenresolution[1898:18419] Display 0: 1600x1200x32@60 11:27:48 INFO - 2017-02-13 11:27:48.777 screenresolution[1899:18422] starting screenresolution argv=screenresolution list 11:27:48 INFO - Available Modes on Display 0 11:27:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:27:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:27:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:27:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:27:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:27:49 INFO - Intel Iris: 11:27:49 INFO - Chipset Model: Intel Iris 11:27:49 INFO - Type: GPU 11:27:49 INFO - Bus: Built-In 11:27:49 INFO - VRAM (Dynamic, Max): 1536 MB 11:27:49 INFO - Vendor: Intel (0x8086) 11:27:49 INFO - Device ID: 0x0a2e 11:27:49 INFO - Revision ID: 0x0009 11:27:49 INFO - Displays: 11:27:49 INFO - Display: 11:27:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:27:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:27:49 INFO - Display Serial Number: 1600x1200 60 11:27:49 INFO - Main Display: Yes 11:27:49 INFO - Mirror: Off 11:27:49 INFO - Online: Yes 11:27:49 INFO - Rotation: Supported 11:27:49 INFO - Return code: 0 11:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:27:49 INFO - Python 2.7.3 11:27:49 INFO - Return code: 0 11:27:49 INFO - grabbing minidump binary from tooltool 11:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:49 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095c7d30>, '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 0x1094eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095bcbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:27:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:27:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:27:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:27:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:49 INFO - Return code: 0 11:27:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:27:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:27:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:27:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:27:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:27:49 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/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:27:49 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/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:27:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qqymPT6jWh/Render', 11:27:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:49 INFO - 'HOME': '/Users/cltbld', 11:27:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:49 INFO - 'LOGNAME': 'cltbld', 11:27:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:49 INFO - 'MOZ_NO_REMOTE': '1', 11:27:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:49 INFO - 'NO_EM_RESTART': '1', 11:27:49 INFO - 'PAGER': '/bin/cat', 11:27:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:49 INFO - 'PWD': '/builds/slave/test', 11:27:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:49 INFO - 'SHELL': '/bin/bash', 11:27:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQPfSWpNZ/Listeners', 11:27:49 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:27:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:49 INFO - 'USER': 'cltbld', 11:27:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:49 INFO - 'XPC_FLAGS': '0x0', 11:27:49 INFO - 'XPC_SERVICE_NAME': '0', 11:27:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:49 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/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:27:49 INFO - mozversion application_buildid: 20170213101040 11:27:49 INFO - mozversion application_changeset: 08243c8a96514bb8de3e655170c023790af54549 11:27:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:27:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:49 INFO - mozversion application_name: Firefox 11:27:49 INFO - mozversion application_remotingname: firefox-dev 11:27:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:27:49 INFO - mozversion application_vendor: Mozilla 11:27:49 INFO - mozversion application_version: 53.0a2 11:27:49 INFO - mozversion platform_buildid: 20170213101040 11:27:49 INFO - mozversion platform_changeset: 08243c8a96514bb8de3e655170c023790af54549 11:27:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:27:49 INFO - mozversion platform_version: 53.0a2 11:27:49 INFO - using testdate: 1487014069 11:27:49 INFO - actual date: 1487014069 11:27:49 INFO - starting webserver on 'localhost:54346' 11:27:49 INFO - SUITE-START | Running 2 tests 11:27:49 INFO - TEST-START | dromaeo_css 11:27:49 INFO - operating with platform_type : mac_ 11:27:49 INFO - Initialising browser for dromaeo_css test... 11:27:49 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpVbMrej/profile http://localhost:54346/getInfo.html) 11:27:51 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 11:27:51 INFO - PROCESS | 1909 | colorDepth:24 11:27:51 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 11:27:51 INFO - PROCESS | 1909 | __metrics 11:27:51 INFO - PROCESS | 1909 | 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" 11:27:51 INFO - PROCESS | 1909 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:27:52 INFO - TEST-INFO | 1909: exit 0 11:27:52 INFO - Browser initialized. 11:27:52 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:52 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpVbMrej/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:04 INFO - PROCESS | 1911 | RSS: Main: 213389312 11:28:04 INFO - PROCESS | 1911 | 11:31:08 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54346/tests/dromaeo/cssquery-ext.html) 11:31:10 INFO - PROCESS | 1911 | RSS: Main: 337448960 11:31:10 INFO - PROCESS | 1911 | 11:32:54 INFO - PROCESS | 1911 | ************************* 11:32:54 INFO - PROCESS | 1911 | A coding exception was thrown and uncaught in a Task. 11:32:54 INFO - PROCESS | 1911 | 11:32:54 ERROR - PROCESS | 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:32:54 INFO - PROCESS | 1911 | Full stack: 11:32:54 INFO - PROCESS | 1911 | ************************* 11:34:13 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-ext.html (next: http://localhost:54346/tests/dromaeo/cssquery-jquery.html) 11:34:13 INFO - PROCESS | 1911 | RSS: Main: 350715904 11:34:13 INFO - PROCESS | 1911 | 11:37:16 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54346/tests/dromaeo/cssquery-mootools.html) 11:37:16 INFO - PROCESS | 1911 | RSS: Main: 309268480 11:37:16 INFO - PROCESS | 1911 | 11:40:18 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54346/tests/dromaeo/cssquery-prototype.html) 11:40:19 INFO - PROCESS | 1911 | RSS: Main: 319315968 11:40:19 INFO - PROCESS | 1911 | 11:43:23 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54346/tests/dromaeo/cssquery-yui.html) 11:43:23 INFO - PROCESS | 1911 | RSS: Main: 306016256 11:43:23 INFO - PROCESS | 1911 | 11:46:27 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54346/tests/dromaeo/cssquery-yui.html (next: http://localhost:54346/tests/dromaeo/cssquery-dojo.html) 11:46:27 INFO - PROCESS | 1911 | RSS: Main: 368533504 11:46:27 INFO - PROCESS | 1911 | 11:46:27 INFO - PROCESS | 1911 | __start_tp_report 11:46:27 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 11:46:27 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 11:46:27 INFO - PROCESS | 1911 | |i|pagename|runs| 11:46:27 INFO - PROCESS | 1911 | |0;dojo.html;2840.9573856392158;3301.224212310107;3308.3052558962618;3335.399628066947;3361.3109312590923;5527.281453411051;5548.944510554893;5551.333839939208;5562.221289019535;5568.638038527492;5510.338759348873;5576.609637325379;5597.216389705444;5597.972010139953;5620.325560932683;5061.519155680214;5080.41575218849;5101.081805275049;5174.223866420049;5228.294180285669;4099.405586190001;5050.217216331474;5051.393832740058;5110.770015349318;5125.256837758523;4195.5175154857125;5159.509846564571;5189.403218629849;5199.610029247802;5215.348081489814;5202.687838729688;5212.400573933989;5216.26972223889;5227.372715274191;5249.1338929076655;4969.950300497021;4988.276699878497;5141.15170996785;5145.099607568698;5160.587153027749;5473.452654734495;5517.917231241535;5542.5565954723925;5544.500994910478;5553.555715542747;6171.382861713838;6181.876362472725;6183.938160618426;6196.690165491753;6199.845003874939;6098.939010609882;6130.203073600448;6145.201123853915;6156.353582873779;6159.630422174684;5621.18492818539;5687.658740475585;5777.480026797566;5835.416458354215;5877.206577112121;6111.287884814209;6119.533019689859;6140.854922927007;6180.938190618126;6190.690465476709;6121.521692455981;6128.4790792783115;6136.662483563447;6137.202163718688;6149.96925015372;6130.846728831815;6144.221303898071;6151.876962460726;6165.229346331708;6183.165272688219;6049.1833602463985;6067.787627433018;6100.908486372708;6105.588426705604;6122.448979591858;6110.4980065817745;6134.467201660938;6184.876302474016;6188.257409110935;6211.782587609412;4935.383077115361;4939.160342741742;4942.57988071018;4949.282354058641;4958.454569997298;4346.717463364935;4347.195768782785;4363.978180109079;4399.824007039747;4409.867703968886;5628.831135065954;5657.632253903483;5659.292588426447;5695.914561281584;5714.828555143353;6060.030395136845;6112.777056696867;6133.26400831903;6175.320714721377;6185.319614842364;5647.689377084218;5689.630174038757;5701.515371193495;5727.198192253088;5771.5671324649975;5388.38033626138;5401.162819762864;5403.918941215885;5414.512693857571;5414.998225328327;6157.4458298753325;6226.657533835682;6238.812835614939;6257.155284036688;6283.214598175228;6126.884121540821;6143.112737013596;6204.348543402878;6215.782447614311;6229.03449965238;6268.52986026059;6271.843203919939;6279.277883043508;6287.276963149114;6294.370562943852;5908.468237858613;6136.5090792737365;6149.784757533644;6164.445199931848;6168.0439531872635;4776.450708168605;6120.510359171167;6123.038605230386;6147.907781383194;6159.322474527708;6042.456178943916;6047.758089676364;6050.2437195350585;6061.121137435135;6064.302605200459;6005.699715014319;6015.308239552332;6042.90935635957;6047.0929360596265;6058.969705151446;4250.532441431378;5640.746166422438;5732.140178973187;5741.712914354182;5753.827385178452;5020.598352131894;5958.5828991971875;5958.791442299499;5963.671998040149;6006.459418652343;5747.1379293106365;5792.884142317046;5796.884062318814;5810.331811841692;5818.2436283282905 11:46:27 INFO - PROCESS | 1911 | |1;ext.html;453.6484224725837;499.72819175199135;499.96500244982855;504.2109099259656;507.2062222621596;30620.387592248142;39505.60494395055;41767.79116104419;41893.371599426035;44038;42945.355819662655;43300;43329.7001089967;43365.34951975723;43438.782806085925;8367.159224970497;9150.313726470507;9330.206932410752;9341.346105772598;9342;8526.829463410728;11076.612318568852;11282.492287847066;11303.321800691985;11468.139889508278;11056.613018544353;11092.889071109306;11093.168012399063;11133.332000079981;11210.383428911407;8388.412811103226;8603;11232.887671123306;11291.266067705574;11345.659630211107;10945;11187.888121118765;11252.26860254081;11375.488103035383;11396.145289103268;40638;41024.76925692234;41025.1794964099;41124.58875411267;41152;3880.980595097035;3941.5613301145163;4013.7993100345157;4025.255327764373;4062.6343629073526;29113.854430727923;29187;29188.832446702105;29292.267693307625;30287.394252114835;3064.509678451437;3226.56441380413;3320.169957510622;3343.8328083595966;3347.6652334766572;479096;479542;480029;482153;482317.9999999965;61714.69142654258;61933.69033154805;62238.75522489525;62262.68868655628;62413.375866241666;60588.69705651444;60765;60786.39213607807;60901;61029;16153.4346297879;16172.83827161737;16385.50843474698;16417.42539011129;16439.849210555145;11512.94243528777;11754.471048802825;11767.411629418666;12863.742725145445;12906.548270810477;18742.821042958858;21961.67057494139;22098.22656207025;22639.434014149778;22682.88658556697;7227.927720722831;7285.344319011208;8388.664453421918;8529.872051919227;8747.781305467286;855.7133360324361;856.4304737349718;878.4509681449094;887.87683580271;901.4456109492614;29720.40559188804;30441.847790760905;30516.38967220643;30628;31065.223369415944;1005.5475036233724;1015.0002247785925;1060.6635639094795;1098.81869491533;1209.6492017315056;15714.685706286038;15737.370505179664;15822.841771582136;15936.442224522087;16228.837711622733;571637;574772;577724.2227577671;580231.098844503;580561;61555;62160.68919655373;62208;62214;62566.0615090774;1427.3006226948928;1446.8914831387688;1474.1818290848682;1476.158589603937;1480.5780352599672;27643.621181851213;29862.954796582017;30029;30259.394812104074;30576.388472230876;51772;52109.69725756735;52136.47863521468;52243.21635175552;52353.47646523638;541214;544518;544882;545454;547077;35671.92984210478;36084.09789755277;40487.797561012005;43736;44162.55837441584;44976.77511612552;46863.765681171375;47527.762361187975;47626.76186619183;48030.279545806145;38047.61952380441;38365.61634383732;39182.2163556733;39256.411153832145;40175;38627.6137238624;38695.03262418462;38726.6127338723;38797.41803872888;39519;36279.45580816237;38146.809265953496;38280;38355.61644383632;38399.80800095982;29141.688624011545;33895.15262118368;34282.14294642654;34465.79369722048;34558.65441345655;24811.50376992486;24959.75040249574;25067.87466062658;25453.618195726707;25499.87250063738 11:46:27 INFO - PROCESS | 1911 | |2;jquery.html;371.57825867640224;388.14026930349286;394.97827619480915;398.5436675007117;420.5878239325461;13572.93213533931;19848.404547863553;20269.290574829884;21177.152913883445;21220.04509797059;19751.111199995998;20031.59936801263;21041.368758937217;21109.894450527765;21341.253056143;5826.621269617472;6042.909356359636;6091.2690477142805;6105.847353816146;6110.755569777203;5182.637215394924;5913.940860591382;6059.333473317932;6073.845969265847;6739.1239138912115;6733.192016957972;6760.594364338131;6762.154730658668;6772.221194562614;6780.321967803205;5777.711114444282;6042.667653279068;6100.145979562864;6149.754009839601;6700.597964122144;5812.302523697141;5934.554908381889;5976.551758618078;6008.279006519246;6011.458968692838;13101.868981310161;13441.66395840102;13602.115862469007;13769.31153442324;13823.723525529433;2528.4311030018284;2554.770070693628;2597.9740202597923;2609.021616893665;2612.2163350994815;10025.348352357074;10047.296689231756;10134.239932005055;10597.152227821833;10629.362238265729;1777.4045694692293;1870.2705944681586;1874.2034635280088;1875.5311172206948;1876.587150826816;120984.79015209823;138667.30666346705;141224.29387853097;146848;147058;10018.248631352677;11634.324105455793;11770.941145294219;11959.40202989847;11964;13737.107088039245;14404.567862964128;15563.299651515708;15566.22168891551;15616.609584760472;7872.425514896929;8057.959710201411;8097.554634495159;8586.22723954847;8639.95680021596;8339.749807505785;8512.957435212784;8606.26846718036;8624;8632.827343453097;4133.966508372907;4593.517680643485;4761.7142971421135;4767.523247675204;4841.8547443576745;1716.7596536484903;1966.921323147058;2028.7725925814964;2054.5377290109604;2064.5251592133895;850.4132148817296;990.5790039233441;1022.6369638778275;1033.8604288421118;1038.1020417338948;21563.353099407042;21737.152342051104;21844.229157055586;21845.533112500438;21977.560448790933;1034.4569101221919;1039.6465201831413;1045.5242864496636;1065.3181963543338;1080.6325849211148;10729.356238625707;11223.270487418291;11249.43752812356;11255.549778008788;11309.886901130883;712615;759500;776572;785839;789823.0508847419;117040.41479792546;125511.37244313903;141622;151726.24136879467;157853.2107339456;999.645125980281;1001.9699409017741;1024.7130803374919;1029.1818004686293;1031.5976769060073;18195.272189112817;18546.44360669182;18969.810301896803;19127.704675439036;19147.52475247525;53611;57418.425815741306;61600.07599886095;62227.44431389251;64410;74028;90563.0943690581;92121;93810.59284110607;94219.5867061981;5731.713414329351;5920.970395147997;7799.5320280783335;8185.75442736695;8663.95668021656;11496.597619083292;12990.285534295705;13027.088103833019;13096.803547946978;13235.3382330885;11129.220954533428;11198.496067676811;11259.98660120593;11338.886611134112;11654.475548600503;10861.40262285582;11035.61375351891;11083.72290692739;11211.327320360804;11240.55037798479;8966.193042626195;10069.89930100719;11619.709507262387;11710.824337635113;11828;7138.607376594337;7308.451866109956;7397.111499698527;7426.92309615092;7726.3818894487185;10772.730681733019;11053.613123540637;11219.887801121884;11269.549218031187;11500.194986350874 11:46:27 INFO - PROCESS | 1911 | |3;mootools.html;1435.7272118297524;1439.6904665496916;1444.3283872999054;1459.3946658675459;1465.6848777512832;8080.626293530099;8521.872171917426;8522.872156917643;8527.445716028455;8536.231739143475;7491.7003319867135;7674.386049116071;7675.270849269325;8128.715494957678;8345.082040975487;2301.838871279007;2345.2495201535517;2350.7296660884044;2353.223436266028;2353.6940197774265;2334.5447637710654;2350.189184731265;2363.72817126031;2375.03810956562;2376.809855211579;2317.629179331307;2320.5938960681897;2331.3705299569106;2365.6096744037213;2371.9169829055986;2290.9083636654514;2294.8737819419925;2319.362175401778;2320.037184568402;2324.8023917966993;2293.9655905161435;2365.562370961378;2371.395294199968;2373.098222675372;2373.584622691022;8426.578671066483;8500.914990850075;8506.021807492094;8510.74467765968;8530.530820804854;5070.188769796851;5181.35233095863;5229.424763276036;5241.449647786965;5264.184051472028;3261.8532166052582;3343.0806528204694;3467.6705712957228;3509.0350153707677;3509.543759311299;1217.4278089298016;1219.286717270398;1434.5337765226343;1727.1536946896056;1828.890266583996;9195.816083678355;9424.821897262842;10932.398718070423;10956.780864382747;10968;3914.2758589661003;4394.274944634163;4454.22051141049;4545.954540454553;4586.059857729158;8596.613152408032;8756.51839148853;8765;8767.868481972775;8771.298296136294;5105.412877519058;5167.509086636764;5186.688798672092;5195.3246078009615;5211.661242019257;4655;4760.904781904343;4761.050659651652;4771.427428708577;4869.318295438641;3690.520232369775;3725.981370093132;3785.1861849702445;3786.9017984784655;3796.6962642989047;1162.1748558523543;1164.772869290497;1171.8359429679851;1172.7595842852195;1182.184292837939;764.8890910817901;782.8316911863976;883.4919921045296;898.2185498616116;917.0187898948195;5578.721063946787;5615.466530679579;5799.797007104731;5829.242198514251;5882.001612598195;987.4124895687055;992.8262554053011;1001.8296889528798;1005.7737009172878;1046.6964580271788;3471.3577988071784;3715.294094122108;3716.7212459065677;3798.582155962842;3850.7304488685522;9884.159846413135;10033.698989030341;10257.640982565574;10265.640702575523;10270.33242839228;10049.095581397709;10223;10226.488675566192;10237.590496380062;10245.180385569136;7711.151773304932;7869.48848324857;7921.089074756477;8053.033635963605;8062.355011599058;4442.511323754449;5352.223927530564;5415.431379705232;5510.779568817203;5544.667319960815;7672.654730537028;8893.155150260714;9062.818743625223;9158;9217.723468295962;7935.682572697027;9345.112214339626;9353.25173986093;9491.762705932408;9628.518574071128;7202.783916482514;7341.77974660761;7347.375473084848;7350.19147893742;7363.7422690205585;7690.6154692264045;7885.5662938538935;7940.920590794018;7943.4439589230515;7955.403344749051;7069.117055560944;7140.000399943908;7194.6042967635185;7208.026916366223;7310.378617817332;7033.683484243119;7066.540674856118;7081.114860642419;7083.82290442743;7122.465815063994;6182.196314479269;6345.428911397997;6406.615603063831;6447.6453795041725;6481.287058423664;4981.327520784647;5016.1221786188;5020.899582008266;5037.219231019198;5061.468545802638;4943.307936888767;4951.603871690184;4963.131451995959;5113.284140220298;5115.232715092766 11:46:27 INFO - PROCESS | 1911 | |4;prototype.html;328.11900048370114;351.66767404802465;354.7747180540356;361.9963800361997;372.34281493164553;3913.5303763548377;4188.895277618061;4417.845375411861;4943.283223932528;4967.130752118378;4766.856994290169;5192.974035129829;5217.973910130453;5245.134552798783;5257.526822585966;4029.576894426087;4075.2460794753065;4078.755979426274;4094.488188976378;4130.793460326987;3923.411488276767;3977.9204415911663;4066.6136717011836;4084.775337356444;4108.397724887296;3559.857605695769;3863.343231650626;4030.5364883038533;4052.635262826345;4093.570175131613;3914.902127446808;4067.4712287402745;4088.89777755557;4089.3661482470266;4107.178564287125;3465.3069386122625;3481.4933248061357;3577.3560759063357;3649.981750091259;3666.431703086026;4716.764161791931;5045.243213517965;5048.444671086178;5059.747012649353;5059.924101138449;4024.637782599551;4722.220833562458;4745.193317136095;4755.0489902019735;4769.928451073237;5211.838557962867;5446.972765136188;5513.751881165317;5514.779408823642;5602.859928501779;3420.6237313895454;4030.435738996543;4030.979845100785;4039.151778126597;4050.521559630743;5669.1496275558175;5799.797007104773;5805.88388232233;5812.651240925516;5852.67810270435;3884.8446062157764;3933.3903244997073;4105.507339119325;4111.376006477425;4119.9176016480105;4230.259704551691;4249.766262855511;4251.384473899899;4267.231898258281;4293.5706429356815;3827.961720382816;4362.1678894864235;4483.529229430863;4775.346859652369;4852.951470485321;5664.51851592611;5669.234653321749;5685.630434021776;5693.943060569424;5720.1991721159075;1255.811628255769;1263.91784534005;1374.5120482228865;1375.2642336350004;1399.7130588229388;920.5777074419904;944;945.6548359848606;979.7648564344506;996.4021587047713;4302.698056539736;4372.956270437318;4404;4965.634450526062;4996.70019798806;4730.810767569327;5351.919721204185;5474.5894057945015;5480;5530.096699232935;4492.550744925481;4684.906301873943;4920.532549407801;4974.602031837444;4979.825706100269;2350.130451732836;2627.605859121147;2711.945761084767;2753.3529620539157;2897.4643438977378;4901.926471102936;5053.01466214092;5129.820456284012;5685.3177618685195;5687.744051517609;4747.477777444478;5228.568715547212;5549.500544950974;5594.832155035356;5662.678301896202;5259.842834576387;5568.805091821767;5626.887462250732;5666.744996475086;5673.489385955284;4781.521847815191;4790.5568160237835;4925.704457732548;5050.444451110448;5473.151661492475;4788.784504697227;5220.895582088261;5260;5617.241672374177;5663.612414958362;5587.469190426903;5745.511631511201;5817;5857.531397488276;5872.559558033079;3374.835681689813;3667.651573100551;3668.871589494355;3865.1303456723135;3888.766673999569;4823.469418363907;5236.9738151309;5508.614396992172;5611.691356975405;5836.562257830595;4835.8065677372515;5380.950714610613;5529.474699903502;5582.213691618806;5586.636868603528;5241.951609678156;5483.890322193613;5544.972275138599;5564.805231816867;5615.831525054255;4598.609118224988;4735.692180008288;4763.3807605011125;5160.864609785841;5462.672239665632;4522.834016188747;5094.471658502509;5277.366715994105;5538.676793923774;5555.194496798023;5011.649184557046;5421.132618780976;5424.972875135599;5442.4285450028765;5478.972605136949 11:46:27 INFO - PROCESS | 1911 | |5;yui.html;681.111149949316;686.8969654551817;702.641652757094;743.3235755462526;817.125675527186;14731;15628.531144065697;15714.999999999985;15720.135392553419;15729.842701572981;13403.59789206323;14022.439102435916;14232.288385580705;14256.572302830906;14262.714745705105;706.2760670312919;830.8047608811925;839.9874001889976;842.1283971089892;843.5613480989881;659.14969689101;673.4141297071554;821.4291067707945;849.3332733803965;854.2439940652537;883.4434306387;884.3544212724682;884.7743825324566;885.5926273914007;889.1508609278123;878.7890906182535;880.7049638371153;881.0572687224673;881.0880738435752;881.0968757024037;514.4700958013252;521.7652056574518;642.1427394428443;650.1190886348976;659.6635715784936;15318.693626127526;15338.156401397919;15358.539243822703;15363.308651110616;15363.385464581403;13559.59321220365;13599.388027538784;13710.52013179544;13715.862841371558;13734;12119.878801212051;12128.636140915787;12370.711418387536;12525.812112818316;13140.211587304697;3450.3271861986923;4266.679999000056;4561.247394179956;4610.492845786961;4615.192341340286;106670;111019;111047;114992;117392;10398.948005260077;10703;10857.67426977192;10891.891081089247;10936.617218397318;20337.389878303675;20777.896110519352;20866.47833804167;21073;21882.562348752937;7656.272654097852;7835.882461763078;7915.16890726477;7915.287624113857;8051.35589152878;4174.519930208065;4260.765657888784;4345.868604760508;4353.869383918487;4399.076193999232;3559.982200088983;3624.7462677612843;3638.181409182913;3646.2889736501656;3656.305301992613;641.2113100885937;647.0972992675191;654.1267408010359;656.5108993799649;658.6114192626374;577.6707276852154;680.3366717450447;683.2143035509105;695.3498478922224;699.7375984005997;9400.576974036185;10006.69979900604;10155.289129760993;10186.949065254626;10359.63741269052;547.6303495140764;577.261105784588;586.2144726067005;598.8772301678233;704.6195054670522;4474.530174331713;4899;4911.7298548580175;4921.458639549646;4925.285833554115;102943;105289.47355263175;105529.94470055355;109156.4542177284;110067.44966275117;89341.10658893328;92526;92620;94932.57601135988;95033.95986426069;63907;75364.24635753682;75537.48925021579;76221;76247.85628215582;9091.318151138823;9095;9098.954505227432;9124.680636177702;9208.815823683623;51140.46578602648;51649;52185.7390713044;52876.735616321675;53704.73147634237;60248.69875650769;69221.61556768937;70152.94770578548;71437.6428117877;73065;11193.733100047575;11643.417829108681;12028.977536909111;12549.560765373168;12679.239245644922;13886.72226555443;14603.926980365455;14907.254637267877;15236.466723664618;15503.14732689713;13545;13589.32053397346;13654.795178072138;13877.959153063359;14422.06256593318;13696.931515342758;13813.240271784747;13944.093633913762;14407.207603581484;14473.131612103307;13210.735785284432;13219.47122115143;13388.397522111723;13529.18824870511;14165.504207352693;9896.356736812084;10586.311889727143;10905.073068789241;11570.768584628091;11967.64097077089;10385.221108416748;11409.429528523375;11430.942845285721;11666.475008624462;11707.2975621463 11:46:27 INFO - PROCESS | 1911 | __end_tp_report 11:46:27 INFO - PROCESS | 1911 | __start_cc_report 11:46:27 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,1257 11:46:27 INFO - PROCESS | 1911 | __end_cc_report 11:46:27 INFO - PROCESS | 1911 | __startTimestamp1487015187540__endTimestamp 11:46:27 INFO - PROCESS | 1911 | 11:46:27 INFO - PROCESS | 1911 | ------- Summary: start ------- 11:46:27 INFO - PROCESS | 1911 | Number of tests: 6 11:46:27 INFO - PROCESS | 1911 | 11:46:27 INFO - PROCESS | 1911 | [#0] dojo.html Cycles:165 Average:5635.33 Median:5796.88 stddev:669.39 (11.5%) stddev-sans-first:634.54 11:46:27 INFO - PROCESS | 1911 | Values: 2841.0 3301.2 3308.3 3335.4 3361.3 5527.3 5548.9 5551.3 5562.2 5568.6 5510.3 5576.6 5597.2 5598.0 5620.3 5061.5 5080.4 5101.1 5174.2 5228.3 4099.4 5050.2 5051.4 5110.8 5125.3 4195.5 5159.5 5189.4 5199.6 5215.3 5202.7 5212.4 5216.3 5227.4 5249.1 4970.0 4988.3 5141.2 5145.1 5160.6 5473.5 5517.9 5542.6 5544.5 5553.6 6171.4 6181.9 6183.9 6196.7 6199.8 6098.9 6130.2 6145.2 6156.4 6159.6 5621.2 5687.7 5777.5 5835.4 5877.2 6111.3 6119.5 6140.9 6180.9 6190.7 6121.5 6128.5 6136.7 6137.2 6150.0 6130.8 6144.2 6151.9 6165.2 6183.2 6049.2 6067.8 6100.9 6105.6 6122.4 6110.5 6134.5 6184.9 6188.3 6211.8 4935.4 4939.2 4942.6 4949.3 4958.5 4346.7 4347.2 4364.0 4399.8 4409.9 5628.8 5657.6 5659.3 5695.9 5714.8 6060.0 6112.8 6133.3 6175.3 6185.3 5647.7 5689.6 5701.5 5727.2 5771.6 5388.4 5401.2 5403.9 5414.5 5415.0 6157.4 6226.7 6238.8 6257.2 6283.2 6126.9 6143.1 6204.3 6215.8 6229.0 6268.5 6271.8 6279.3 6287.3 6294.4 5908.5 6136.5 6149.8 6164.4 6168.0 4776.5 6120.5 6123.0 6147.9 6159.3 6042.5 6047.8 6050.2 6061.1 6064.3 6005.7 6015.3 6042.9 6047.1 6059.0 4250.5 5640.7 5732.1 5741.7 5753.8 5020.6 5958.6 5958.8 5963.7 6006.5 5747.1 5792.9 5796.9 5810.3 5818.2 11:46:27 INFO - PROCESS | 1911 | 11:46:27 INFO - PROCESS | 1911 | [#1] ext.html Cycles:180 Average:68099.88 Median:21339.20 stddev:142540.54 (668.0%) stddev-sans-first:142849.92 11:46:27 INFO - PROCESS | 1911 | Values: 453.6 499.7 500.0 504.2 507.2 30620.4 39505.6 41767.8 41893.4 44038.0 42945.4 43300.0 43329.7 43365.3 43438.8 8367.2 9150.3 9330.2 9341.3 9342.0 8526.8 11076.6 11282.5 11303.3 11468.1 11056.6 11092.9 11093.2 11133.3 11210.4 8388.4 8603.0 11232.9 11291.3 11345.7 10945.0 11187.9 11252.3 11375.5 11396.1 40638.0 41024.8 41025.2 41124.6 41152.0 3881.0 3941.6 4013.8 4025.3 4062.6 29113.9 29187.0 29188.8 29292.3 30287.4 3064.5 3226.6 3320.2 3343.8 3347.7 479096.0 479542.0 480029.0 482153.0 482318.0 61714.7 61933.7 62238.8 62262.7 62413.4 60588.7 60765.0 60786.4 60901.0 61029.0 16153.4 16172.8 16385.5 16417.4 16439.8 11512.9 11754.5 11767.4 12863.7 12906.5 18742.8 21961.7 22098.2 22639.4 22682.9 7227.9 7285.3 8388.7 8529.9 8747.8 855.7 856.4 878.5 887.9 901.4 29720.4 30441.8 30516.4 30628.0 31065.2 1005.5 1015.0 1060.7 1098.8 1209.6 15714.7 15737.4 15822.8 15936.4 16228.8 571637.0 574772.0 577724.2 580231.1 580561.0 61555.0 62160.7 62208.0 62214.0 62566.1 1427.3 1446.9 1474.2 1476.2 1480.6 27643.6 29863.0 30029.0 30259.4 30576.4 51772.0 52109.7 52136.5 52243.2 52353.5 541214.0 544518.0 544882.0 545454.0 547077.0 35671.9 36084.1 40487.8 43736.0 44162.6 44976.8 46863.8 47527.8 47626.8 48030.3 38047.6 38365.6 39182.2 39256.4 40175.0 38627.6 38695.0 38726.6 38797.4 39519.0 36279.5 38146.8 38280.0 38355.6 38399.8 29141.7 33895.2 34282.1 34465.8 34558.7 24811.5 24959.8 25067.9 25453.6 25499.9 11:46:27 INFO - PROCESS | 1911 | 11:46:27 INFO - PROCESS | 1911 | [#2] jquery.html Cycles:180 Average:40757.57 Median:11552.95 stddev:127285.09 (1101.8%) stddev-sans-first:127606.03 11:46:27 INFO - PROCESS | 1911 | Values: 371.6 388.1 395.0 398.5 420.6 13572.9 19848.4 20269.3 21177.2 21220.0 19751.1 20031.6 21041.4 21109.9 21341.3 5826.6 6042.9 6091.3 6105.8 6110.8 5182.6 5913.9 6059.3 6073.8 6739.1 6733.2 6760.6 6762.2 6772.2 6780.3 5777.7 6042.7 6100.1 6149.8 6700.6 5812.3 5934.6 5976.6 6008.3 6011.5 13101.9 13441.7 13602.1 13769.3 13823.7 2528.4 2554.8 2598.0 2609.0 2612.2 10025.3 10047.3 10134.2 10597.2 10629.4 1777.4 1870.3 1874.2 1875.5 1876.6 120984.8 138667.3 141224.3 146848.0 147058.0 10018.2 11634.3 11770.9 11959.4 11964.0 13737.1 14404.6 15563.3 15566.2 15616.6 7872.4 8058.0 8097.6 8586.2 8640.0 8339.7 8513.0 8606.3 8624.0 8632.8 4134.0 4593.5 4761.7 4767.5 4841.9 1716.8 1966.9 2028.8 2054.5 2064.5 850.4 990.6 1022.6 1033.9 1038.1 21563.4 21737.2 21844.2 21845.5 21977.6 1034.5 1039.6 1045.5 1065.3 1080.6 10729.4 11223.3 11249.4 11255.5 11309.9 712615.0 759500.0 776572.0 785839.0 789823.1 117040.4 125511.4 141622.0 151726.2 157853.2 999.6 1002.0 1024.7 1029.2 1031.6 18195.3 18546.4 18969.8 19127.7 19147.5 53611.0 57418.4 61600.1 62227.4 64410.0 74028.0 90563.1 92121.0 93810.6 94219.6 5731.7 5921.0 7799.5 8185.8 8664.0 11496.6 12990.3 13027.1 13096.8 13235.3 11129.2 11198.5 11260.0 11338.9 11654.5 10861.4 11035.6 11083.7 11211.3 11240.6 8966.2 10069.9 11619.7 11710.8 11828.0 7138.6 7308.5 7397.1 7426.9 7726.4 10772.7 11053.6 11219.9 11269.5 11500.2 11:46:27 INFO - PROCESS | 1911 | 11:46:27 INFO - PROCESS | 1911 | [#3] mootools.html Cycles:180 Average:5416.07 Median:5109.35 stddev:2910.27 (57.0%) stddev-sans-first:2903.06 11:46:27 INFO - PROCESS | 1911 | Values: 1435.7 1439.7 1444.3 1459.4 1465.7 8080.6 8521.9 8522.9 8527.4 8536.2 7491.7 7674.4 7675.3 8128.7 8345.1 2301.8 2345.2 2350.7 2353.2 2353.7 2334.5 2350.2 2363.7 2375.0 2376.8 2317.6 2320.6 2331.4 2365.6 2371.9 2290.9 2294.9 2319.4 2320.0 2324.8 2294.0 2365.6 2371.4 2373.1 2373.6 8426.6 8500.9 8506.0 8510.7 8530.5 5070.2 5181.4 5229.4 5241.4 5264.2 3261.9 3343.1 3467.7 3509.0 3509.5 1217.4 1219.3 1434.5 1727.2 1828.9 9195.8 9424.8 10932.4 10956.8 10968.0 3914.3 4394.3 4454.2 4546.0 4586.1 8596.6 8756.5 8765.0 8767.9 8771.3 5105.4 5167.5 5186.7 5195.3 5211.7 4655.0 4760.9 4761.1 4771.4 4869.3 3690.5 3726.0 3785.2 3786.9 3796.7 1162.2 1164.8 1171.8 1172.8 1182.2 764.9 782.8 883.5 898.2 917.0 5578.7 5615.5 5799.8 5829.2 5882.0 987.4 992.8 1001.8 1005.8 1046.7 3471.4 3715.3 3716.7 3798.6 3850.7 9884.2 10033.7 10257.6 10265.6 10270.3 10049.1 10223.0 10226.5 10237.6 10245.2 7711.2 7869.5 7921.1 8053.0 8062.4 4442.5 5352.2 5415.4 5510.8 5544.7 7672.7 8893.2 9062.8 9158.0 9217.7 7935.7 9345.1 9353.3 9491.8 9628.5 7202.8 7341.8 7347.4 7350.2 7363.7 7690.6 7885.6 7940.9 7943.4 7955.4 7069.1 7140.0 7194.6 7208.0 7310.4 7033.7 7066.5 7081.1 7083.8 7122.5 6182.2 6345.4 6406.6 6447.6 6481.3 4981.3 5016.1 5020.9 5037.2 5061.5 4943.3 4951.6 4963.1 5113.3 5115.2 11:46:27 INFO - PROCESS | 1911 | 11:46:27 INFO - PROCESS | 1911 | [#4] prototype.html Cycles:180 Average:4452.08 Median:4877.44 stddev:1319.53 (27.1%) stddev-sans-first:1286.41 11:46:27 INFO - PROCESS | 1911 | Values: 328.1 351.7 354.8 362.0 372.3 3913.5 4188.9 4417.8 4943.3 4967.1 4766.9 5193.0 5218.0 5245.1 5257.5 4029.6 4075.2 4078.8 4094.5 4130.8 3923.4 3977.9 4066.6 4084.8 4108.4 3559.9 3863.3 4030.5 4052.6 4093.6 3914.9 4067.5 4088.9 4089.4 4107.2 3465.3 3481.5 3577.4 3650.0 3666.4 4716.8 5045.2 5048.4 5059.7 5059.9 4024.6 4722.2 4745.2 4755.0 4769.9 5211.8 5447.0 5513.8 5514.8 5602.9 3420.6 4030.4 4031.0 4039.2 4050.5 5669.1 5799.8 5805.9 5812.7 5852.7 3884.8 3933.4 4105.5 4111.4 4119.9 4230.3 4249.8 4251.4 4267.2 4293.6 3828.0 4362.2 4483.5 4775.3 4853.0 5664.5 5669.2 5685.6 5693.9 5720.2 1255.8 1263.9 1374.5 1375.3 1399.7 920.6 944.0 945.7 979.8 996.4 4302.7 4373.0 4404.0 4965.6 4996.7 4730.8 5351.9 5474.6 5480.0 5530.1 4492.6 4684.9 4920.5 4974.6 4979.8 2350.1 2627.6 2711.9 2753.4 2897.5 4901.9 5053.0 5129.8 5685.3 5687.7 4747.5 5228.6 5549.5 5594.8 5662.7 5259.8 5568.8 5626.9 5666.7 5673.5 4781.5 4790.6 4925.7 5050.4 5473.2 4788.8 5220.9 5260.0 5617.2 5663.6 5587.5 5745.5 5817.0 5857.5 5872.6 3374.8 3667.7 3668.9 3865.1 3888.8 4823.5 5237.0 5508.6 5611.7 5836.6 4835.8 5381.0 5529.5 5582.2 5586.6 5242.0 5483.9 5545.0 5564.8 5615.8 4598.6 4735.7 4763.4 5160.9 5462.7 4522.8 5094.5 5277.4 5538.7 5555.2 5011.6 5421.1 5425.0 5442.4 5479.0 11:46:27 INFO - PROCESS | 1911 | 11:46:27 INFO - PROCESS | 1911 | [#5] yui.html Cycles:180 Average:20840.92 Median:4263.72 stddev:30346.92 (711.7%) stddev-sans-first:30394.30 11:46:27 INFO - PROCESS | 1911 | Values: 681.1 686.9 702.6 743.3 817.1 14731.0 15628.5 15715.0 15720.1 15729.8 13403.6 14022.4 14232.3 14256.6 14262.7 706.3 830.8 840.0 842.1 843.6 659.1 673.4 821.4 849.3 854.2 883.4 884.4 884.8 885.6 889.2 878.8 880.7 881.1 881.1 881.1 514.5 521.8 642.1 650.1 659.7 15318.7 15338.2 15358.5 15363.3 15363.4 13559.6 13599.4 13710.5 13715.9 13734.0 12119.9 12128.6 12370.7 12525.8 13140.2 3450.3 4266.7 4561.2 4610.5 4615.2 106670.0 111019.0 111047.0 114992.0 117392.0 10398.9 10703.0 10857.7 10891.9 10936.6 20337.4 20777.9 20866.5 21073.0 21882.6 7656.3 7835.9 7915.2 7915.3 8051.4 4174.5 4260.8 4345.9 4353.9 4399.1 3560.0 3624.7 3638.2 3646.3 3656.3 641.2 647.1 654.1 656.5 658.6 577.7 680.3 683.2 695.3 699.7 9400.6 10006.7 10155.3 10186.9 10359.6 547.6 577.3 586.2 598.9 704.6 4474.5 4899.0 4911.7 4921.5 4925.3 102943.0 105289.5 105529.9 109156.5 110067.4 89341.1 92526.0 92620.0 94932.6 95034.0 63907.0 75364.2 75537.5 76221.0 76247.9 9091.3 9095.0 9099.0 9124.7 9208.8 51140.5 51649.0 52185.7 52876.7 53704.7 60248.7 69221.6 70152.9 71437.6 73065.0 11193.7 11643.4 12029.0 12549.6 12679.2 13886.7 14603.9 14907.3 15236.5 15503.1 13545.0 13589.3 13654.8 13878.0 14422.1 13696.9 13813.2 13944.1 14407.2 14473.1 13210.7 13219.5 13388.4 13529.2 14165.5 9896.4 10586.3 10905.1 11570.8 11967.6 10385.2 11409.4 11430.9 11666.5 11707.3 11:46:27 INFO - PROCESS | 1911 | -------- Summary: end -------- 11:46:27 INFO - PROCESS | 1911 | 11:46:28 INFO - TEST-INFO | 1911: exit 0 11:46:28 INFO - TEST-OK | dromaeo_css | took 1118884ms 11:46:28 INFO - TEST-START | kraken 11:46:28 INFO - operating with platform_type : mac_ 11:46:28 INFO - Initialising browser for kraken test... 11:46:28 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp1P6KxM/profile http://localhost:54346/getInfo.html) 11:46:30 INFO - PROCESS | 1915 | __metrics Screen width/height:1600/1200 11:46:30 INFO - PROCESS | 1915 | colorDepth:24 11:46:30 INFO - PROCESS | 1915 | Browser inner width/height: 1024/689 11:46:30 INFO - PROCESS | 1915 | __metrics 11:46:30 INFO - PROCESS | 1915 | 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" 11:46:30 INFO - PROCESS | 1915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:46:31 INFO - TEST-INFO | 1915: exit 0 11:46:31 INFO - Browser initialized. 11:46:31 INFO - Running cycle 1/1 for kraken test... 11:46:31 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp1P6KxM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:43 INFO - PROCESS | 1916 | RSS: Main: 213786624 11:46:43 INFO - PROCESS | 1916 | 11:46:46 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54346/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:47 INFO - PROCESS | 1916 | RSS: Main: 266276864 11:46:47 INFO - PROCESS | 1916 | 11:46:49 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54346/tests/kraken/driver.html?testName=audio-dft) 11:46:50 INFO - PROCESS | 1916 | RSS: Main: 275173376 11:46:50 INFO - PROCESS | 1916 | 11:46:53 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54346/tests/kraken/driver.html?testName=audio-fft) 11:46:54 INFO - PROCESS | 1916 | RSS: Main: 371929088 11:46:54 INFO - PROCESS | 1916 | 11:46:56 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54346/tests/kraken/driver.html?testName=audio-oscillator) 11:46:56 INFO - PROCESS | 1916 | RSS: Main: 276439040 11:46:56 INFO - PROCESS | 1916 | 11:46:58 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:59 INFO - PROCESS | 1916 | RSS: Main: 277499904 11:46:59 INFO - PROCESS | 1916 | 11:47:02 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54346/tests/kraken/driver.html?testName=imaging-darkroom) 11:47:02 INFO - PROCESS | 1916 | RSS: Main: 318750720 11:47:02 INFO - PROCESS | 1916 | 11:47:05 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54346/tests/kraken/driver.html?testName=imaging-desaturate) 11:47:06 INFO - PROCESS | 1916 | RSS: Main: 318124032 11:47:06 INFO - PROCESS | 1916 | 11:47:09 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54346/tests/kraken/driver.html?testName=json-parse-financial) 11:47:09 INFO - PROCESS | 1916 | RSS: Main: 317321216 11:47:09 INFO - PROCESS | 1916 | 11:47:11 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:47:12 INFO - PROCESS | 1916 | RSS: Main: 295424000 11:47:12 INFO - PROCESS | 1916 | 11:47:14 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:47:14 INFO - PROCESS | 1916 | RSS: Main: 296300544 11:47:14 INFO - PROCESS | 1916 | 11:47:16 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:47:17 INFO - PROCESS | 1916 | RSS: Main: 299081728 11:47:17 INFO - PROCESS | 1916 | 11:47:20 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:47:21 INFO - PROCESS | 1916 | RSS: Main: 316137472 11:47:21 INFO - PROCESS | 1916 | 11:47:24 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:47:24 INFO - PROCESS | 1916 | RSS: Main: 310009856 11:47:24 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54346/tests/kraken/driver.html?testName=ai-astar) 11:47:26 INFO - PROCESS | 1916 | RSS: Main: 354770944 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | __start_tp_report 11:47:26 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 11:47:26 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 11:47:26 INFO - PROCESS | 1916 | |i|pagename|runs| 11:47:26 INFO - PROCESS | 1916 | |0;ai-astar;117;116;114;115;117;116;115;114;115;116 11:47:26 INFO - PROCESS | 1916 | |1;audio-beat-detection;135;110;108;130;125;136;133;110;128;110 11:47:26 INFO - PROCESS | 1916 | |2;audio-dft;180;185;185;183;188;186;193;186;184;183 11:47:26 INFO - PROCESS | 1916 | |3;audio-fft;81;58;59;90;61;61;59;58;74;59 11:47:26 INFO - PROCESS | 1916 | |4;audio-oscillator;88;71;86;70;69;68;79;89;95;107 11:47:26 INFO - PROCESS | 1916 | |5;imaging-gaussian-blur;90;87;91;87;89;87;90;87;90;86 11:47:26 INFO - PROCESS | 1916 | |6;imaging-darkroom;94;97;96;96;95;104;154;120;95;96 11:47:26 INFO - PROCESS | 1916 | |7;imaging-desaturate;88;86;86;85;85;87;85;86;88;88 11:47:26 INFO - PROCESS | 1916 | |8;json-parse-financial;58;55;53;54;56;58;57;57;57;57 11:47:26 INFO - PROCESS | 1916 | |9;json-stringify-tinderbox;65;74;71;77;73;70;69;72;71;73 11:47:26 INFO - PROCESS | 1916 | |10;stanford-crypto-aes;85;86;91;81;100;78;82;87;84;83 11:47:26 INFO - PROCESS | 1916 | |11;stanford-crypto-ccm;132;146;142;146;131;141;142;143;178;145 11:47:26 INFO - PROCESS | 1916 | |12;stanford-crypto-pbkdf2;168;170;175;168;169;169;167;171;182;221 11:47:26 INFO - PROCESS | 1916 | |13;stanford-crypto-sha256-iterative;65;62;85;68;65;67;65;65;65;65 11:47:26 INFO - PROCESS | 1916 | __end_tp_report 11:47:26 INFO - PROCESS | 1916 | __start_cc_report 11:47:26 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,2093 11:47:26 INFO - PROCESS | 1916 | __end_cc_report 11:47:26 INFO - PROCESS | 1916 | __startTimestamp1487015246835__endTimestamp 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | ------- Summary: start ------- 11:47:26 INFO - PROCESS | 1916 | Number of tests: 14 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:1.08 (0.9%) stddev-sans-first:1.00 11:47:26 INFO - PROCESS | 1916 | Values: 117.0 116.0 114.0 115.0 117.0 116.0 115.0 114.0 115.0 116.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:129.00 stddev:11.65 (9.0%) stddev-sans-first:11.44 11:47:26 INFO - PROCESS | 1916 | Values: 135.0 110.0 108.0 130.0 125.0 136.0 133.0 110.0 128.0 110.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#2] audio-dft Cycles:10 Average:185.30 Median:185.50 stddev:3.47 (1.9%) stddev-sans-first:3.10 11:47:26 INFO - PROCESS | 1916 | Values: 180.0 185.0 185.0 183.0 188.0 186.0 193.0 186.0 184.0 183.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#3] audio-fft Cycles:10 Average:66.00 Median:61.00 stddev:11.50 (18.9%) stddev-sans-first:10.84 11:47:26 INFO - PROCESS | 1916 | Values: 81.0 58.0 59.0 90.0 61.0 61.0 59.0 58.0 74.0 59.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#4] audio-oscillator Cycles:10 Average:82.20 Median:82.50 stddev:13.05 (15.8%) stddev-sans-first:13.68 11:47:26 INFO - PROCESS | 1916 | Values: 88.0 71.0 86.0 70.0 69.0 68.0 79.0 89.0 95.0 107.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.50 stddev:1.78 (2.0%) stddev-sans-first:1.79 11:47:26 INFO - PROCESS | 1916 | Values: 90.0 87.0 91.0 87.0 89.0 87.0 90.0 87.0 90.0 86.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:95.50 stddev:19.01 (19.9%) stddev-sans-first:19.77 11:47:26 INFO - PROCESS | 1916 | Values: 94.0 97.0 96.0 96.0 95.0 104.0 154.0 120.0 95.0 96.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:86.50 stddev:1.26 (1.5%) stddev-sans-first:1.20 11:47:26 INFO - PROCESS | 1916 | Values: 88.0 86.0 86.0 85.0 85.0 87.0 85.0 86.0 88.0 88.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.69 (3.0%) stddev-sans-first:1.66 11:47:26 INFO - PROCESS | 1916 | Values: 58.0 55.0 53.0 54.0 56.0 58.0 57.0 57.0 57.0 57.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.50 stddev:3.21 (4.4%) stddev-sans-first:2.39 11:47:26 INFO - PROCESS | 1916 | Values: 65.0 74.0 71.0 77.0 73.0 70.0 69.0 72.0 71.0 73.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:6.15 (7.3%) stddev-sans-first:6.51 11:47:26 INFO - PROCESS | 1916 | Values: 85.0 86.0 91.0 81.0 100.0 78.0 82.0 87.0 84.0 83.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:144.00 stddev:12.88 (8.9%) stddev-sans-first:12.83 11:47:26 INFO - PROCESS | 1916 | Values: 132.0 146.0 142.0 146.0 131.0 141.0 142.0 143.0 178.0 145.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:170.50 stddev:16.43 (9.6%) stddev-sans-first:17.17 11:47:26 INFO - PROCESS | 1916 | Values: 168.0 170.0 175.0 168.0 169.0 169.0 167.0 171.0 182.0 221.0 11:47:26 INFO - PROCESS | 1916 | 11:47:26 INFO - PROCESS | 1916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:65.00 stddev:6.44 (9.9%) stddev-sans-first:6.78 11:47:26 INFO - PROCESS | 1916 | Values: 65.0 62.0 85.0 68.0 65.0 67.0 65.0 65.0 65.0 65.0 11:47:26 INFO - PROCESS | 1916 | -------- Summary: end -------- 11:47:26 INFO - PROCESS | 1916 | 11:47:27 INFO - TEST-INFO | 1916: exit 0 11:47:27 INFO - TEST-OK | kraken | took 59512ms 11:47:27 INFO - SUITE-END | took 1178s 11:47:27 INFO - Completed test suite (00:19:38) 11:47:27 INFO - javascript benchmark 11:47:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2840.9573856392158, 3301.224212310107, 3308.3052558962618, 3335.399628066947, 3361.3109312590923, 5527.281453411051, 5548.944510554893, 5551.333839939208, 5562.221289019535, 5568.638038527492, 5510.338759348873, 5576.609637325379, 5597.216389705444, 5597.972010139953, 5620.325560932683, 5061.519155680214, 5080.41575218849, 5101.081805275049, 5174.223866420049, 5228.294180285669, 4099.405586190001, 5050.217216331474, 5051.393832740058, 5110.770015349318, 5125.256837758523, 4195.5175154857125, 5159.509846564571, 5189.403218629849, 5199.610029247802, 5215.348081489814, 5202.687838729688, 5212.400573933989, 5216.26972223889, 5227.372715274191, 5249.1338929076655, 4969.950300497021, 4988.276699878497, 5141.15170996785, 5145.099607568698, 5160.587153027749, 5473.452654734495, 5517.917231241535, 5542.5565954723925, 5544.500994910478, 5553.555715542747, 6171.382861713838, 6181.876362472725, 6183.938160618426, 6196.690165491753, 6199.845003874939, 6098.939010609882, 6130.203073600448, 6145.201123853915, 6156.353582873779, 6159.630422174684, 5621.18492818539, 5687.658740475585, 5777.480026797566, 5835.416458354215, 5877.206577112121, 6111.287884814209, 6119.533019689859, 6140.854922927007, 6180.938190618126, 6190.690465476709, 6121.521692455981, 6128.4790792783115, 6136.662483563447, 6137.202163718688, 6149.96925015372, 6130.846728831815, 6144.221303898071, 6151.876962460726, 6165.229346331708, 6183.165272688219, 6049.1833602463985, 6067.787627433018, 6100.908486372708, 6105.588426705604, 6122.448979591858, 6110.4980065817745, 6134.467201660938, 6184.876302474016, 6188.257409110935, 6211.782587609412, 4935.383077115361, 4939.160342741742, 4942.57988071018, 4949.282354058641, 4958.454569997298, 4346.717463364935, 4347.195768782785, 4363.978180109079, 4399.824007039747, 4409.867703968886, 5628.831135065954, 5657.632253903483, 5659.292588426447, 5695.914561281584, 5714.828555143353, 6060.030395136845, 6112.777056696867, 6133.26400831903, 6175.320714721377, 6185.319614842364, 5647.689377084218, 5689.630174038757, 5701.515371193495, 5727.198192253088, 5771.5671324649975, 5388.38033626138, 5401.162819762864, 5403.918941215885, 5414.512693857571, 5414.998225328327, 6157.4458298753325, 6226.657533835682, 6238.812835614939, 6257.155284036688, 6283.214598175228, 6126.884121540821, 6143.112737013596, 6204.348543402878, 6215.782447614311, 6229.03449965238, 6268.52986026059, 6271.843203919939, 6279.277883043508, 6287.276963149114, 6294.370562943852, 5908.468237858613, 6136.5090792737365, 6149.784757533644, 6164.445199931848, 6168.0439531872635, 4776.450708168605, 6120.510359171167, 6123.038605230386, 6147.907781383194, 6159.322474527708, 6042.456178943916, 6047.758089676364, 6050.2437195350585, 6061.121137435135, 6064.302605200459, 6005.699715014319, 6015.308239552332, 6042.90935635957, 6047.0929360596265, 6058.969705151446, 4250.532441431378, 5640.746166422438, 5732.140178973187, 5741.712914354182, 5753.827385178452, 5020.598352131894, 5958.5828991971875, 5958.791442299499, 5963.671998040149, 6006.459418652343, 5747.1379293106365, 5792.884142317046, 5796.884062318814, 5810.331811841692, 5818.2436283282905], "value": 5591.901450994335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.6484224725837, 499.72819175199135, 499.96500244982855, 504.2109099259656, 507.2062222621596, 30620.387592248142, 39505.60494395055, 41767.79116104419, 41893.371599426035, 44038.0, 42945.355819662655, 43300.0, 43329.7001089967, 43365.34951975723, 43438.782806085925, 8367.159224970497, 9150.313726470507, 9330.206932410752, 9341.346105772598, 9342.0, 8526.829463410728, 11076.612318568852, 11282.492287847066, 11303.321800691985, 11468.139889508278, 11056.613018544353, 11092.889071109306, 11093.168012399063, 11133.332000079981, 11210.383428911407, 8388.412811103226, 8603.0, 11232.887671123306, 11291.266067705574, 11345.659630211107, 10945.0, 11187.888121118765, 11252.26860254081, 11375.488103035383, 11396.145289103268, 40638.0, 41024.76925692234, 41025.1794964099, 41124.58875411267, 41152.0, 3880.980595097035, 3941.5613301145163, 4013.7993100345157, 4025.255327764373, 4062.6343629073526, 29113.854430727923, 29187.0, 29188.832446702105, 29292.267693307625, 30287.394252114835, 3064.509678451437, 3226.56441380413, 3320.169957510622, 3343.8328083595966, 3347.6652334766572, 479096.0, 479542.0, 480029.0, 482153.0, 482317.9999999965, 61714.69142654258, 61933.69033154805, 62238.75522489525, 62262.68868655628, 62413.375866241666, 60588.69705651444, 60765.0, 60786.39213607807, 60901.0, 61029.0, 16153.4346297879, 16172.83827161737, 16385.50843474698, 16417.42539011129, 16439.849210555145, 11512.94243528777, 11754.471048802825, 11767.411629418666, 12863.742725145445, 12906.548270810477, 18742.821042958858, 21961.67057494139, 22098.22656207025, 22639.434014149778, 22682.88658556697, 7227.927720722831, 7285.344319011208, 8388.664453421918, 8529.872051919227, 8747.781305467286, 855.7133360324361, 856.4304737349718, 878.4509681449094, 887.87683580271, 901.4456109492614, 29720.40559188804, 30441.847790760905, 30516.38967220643, 30628.0, 31065.223369415944, 1005.5475036233724, 1015.0002247785925, 1060.6635639094795, 1098.81869491533, 1209.6492017315056, 15714.685706286038, 15737.370505179664, 15822.841771582136, 15936.442224522087, 16228.837711622733, 571637.0, 574772.0, 577724.2227577671, 580231.098844503, 580561.0, 61555.0, 62160.68919655373, 62208.0, 62214.0, 62566.0615090774, 1427.3006226948928, 1446.8914831387688, 1474.1818290848682, 1476.158589603937, 1480.5780352599672, 27643.621181851213, 29862.954796582017, 30029.0, 30259.394812104074, 30576.388472230876, 51772.0, 52109.69725756735, 52136.47863521468, 52243.21635175552, 52353.47646523638, 541214.0, 544518.0, 544882.0, 545454.0, 547077.0, 35671.92984210478, 36084.09789755277, 40487.797561012005, 43736.0, 44162.55837441584, 44976.77511612552, 46863.765681171375, 47527.762361187975, 47626.76186619183, 48030.279545806145, 38047.61952380441, 38365.61634383732, 39182.2163556733, 39256.411153832145, 40175.0, 38627.6137238624, 38695.03262418462, 38726.6127338723, 38797.41803872888, 39519.0, 36279.45580816237, 38146.809265953496, 38280.0, 38355.61644383632, 38399.80800095982, 29141.688624011545, 33895.15262118368, 34282.14294642654, 34465.79369722048, 34558.65441345655, 24811.50376992486, 24959.75040249574, 25067.87466062658, 25453.618195726707, 25499.87250063738], "value": 20568.325369601087, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.57825867640224, 388.14026930349286, 394.97827619480915, 398.5436675007117, 420.5878239325461, 13572.93213533931, 19848.404547863553, 20269.290574829884, 21177.152913883445, 21220.04509797059, 19751.111199995998, 20031.59936801263, 21041.368758937217, 21109.894450527765, 21341.253056143, 5826.621269617472, 6042.909356359636, 6091.2690477142805, 6105.847353816146, 6110.755569777203, 5182.637215394924, 5913.940860591382, 6059.333473317932, 6073.845969265847, 6739.1239138912115, 6733.192016957972, 6760.594364338131, 6762.154730658668, 6772.221194562614, 6780.321967803205, 5777.711114444282, 6042.667653279068, 6100.145979562864, 6149.754009839601, 6700.597964122144, 5812.302523697141, 5934.554908381889, 5976.551758618078, 6008.279006519246, 6011.458968692838, 13101.868981310161, 13441.66395840102, 13602.115862469007, 13769.31153442324, 13823.723525529433, 2528.4311030018284, 2554.770070693628, 2597.9740202597923, 2609.021616893665, 2612.2163350994815, 10025.348352357074, 10047.296689231756, 10134.239932005055, 10597.152227821833, 10629.362238265729, 1777.4045694692293, 1870.2705944681586, 1874.2034635280088, 1875.5311172206948, 1876.587150826816, 120984.79015209823, 138667.30666346705, 141224.29387853097, 146848.0, 147058.0, 10018.248631352677, 11634.324105455793, 11770.941145294219, 11959.40202989847, 11964.0, 13737.107088039245, 14404.567862964128, 15563.299651515708, 15566.22168891551, 15616.609584760472, 7872.425514896929, 8057.959710201411, 8097.554634495159, 8586.22723954847, 8639.95680021596, 8339.749807505785, 8512.957435212784, 8606.26846718036, 8624.0, 8632.827343453097, 4133.966508372907, 4593.517680643485, 4761.7142971421135, 4767.523247675204, 4841.8547443576745, 1716.7596536484903, 1966.921323147058, 2028.7725925814964, 2054.5377290109604, 2064.5251592133895, 850.4132148817296, 990.5790039233441, 1022.6369638778275, 1033.8604288421118, 1038.1020417338948, 21563.353099407042, 21737.152342051104, 21844.229157055586, 21845.533112500438, 21977.560448790933, 1034.4569101221919, 1039.6465201831413, 1045.5242864496636, 1065.3181963543338, 1080.6325849211148, 10729.356238625707, 11223.270487418291, 11249.43752812356, 11255.549778008788, 11309.886901130883, 712615.0, 759500.0, 776572.0, 785839.0, 789823.0508847419, 117040.41479792546, 125511.37244313903, 141622.0, 151726.24136879467, 157853.2107339456, 999.645125980281, 1001.9699409017741, 1024.7130803374919, 1029.1818004686293, 1031.5976769060073, 18195.272189112817, 18546.44360669182, 18969.810301896803, 19127.704675439036, 19147.52475247525, 53611.0, 57418.425815741306, 61600.07599886095, 62227.44431389251, 64410.0, 74028.0, 90563.0943690581, 92121.0, 93810.59284110607, 94219.5867061981, 5731.713414329351, 5920.970395147997, 7799.5320280783335, 8185.75442736695, 8663.95668021656, 11496.597619083292, 12990.285534295705, 13027.088103833019, 13096.803547946978, 13235.3382330885, 11129.220954533428, 11198.496067676811, 11259.98660120593, 11338.886611134112, 11654.475548600503, 10861.40262285582, 11035.61375351891, 11083.72290692739, 11211.327320360804, 11240.55037798479, 8966.193042626195, 10069.89930100719, 11619.709507262387, 11710.824337635113, 11828.0, 7138.607376594337, 7308.451866109956, 7397.111499698527, 7426.92309615092, 7726.3818894487185, 10772.730681733019, 11053.613123540637, 11219.887801121884, 11269.549218031187, 11500.194986350874], "value": 9754.806602790857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.7272118297524, 1439.6904665496916, 1444.3283872999054, 1459.3946658675459, 1465.6848777512832, 8080.626293530099, 8521.872171917426, 8522.872156917643, 8527.445716028455, 8536.231739143475, 7491.7003319867135, 7674.386049116071, 7675.270849269325, 8128.715494957678, 8345.082040975487, 2301.838871279007, 2345.2495201535517, 2350.7296660884044, 2353.223436266028, 2353.6940197774265, 2334.5447637710654, 2350.189184731265, 2363.72817126031, 2375.03810956562, 2376.809855211579, 2317.629179331307, 2320.5938960681897, 2331.3705299569106, 2365.6096744037213, 2371.9169829055986, 2290.9083636654514, 2294.8737819419925, 2319.362175401778, 2320.037184568402, 2324.8023917966993, 2293.9655905161435, 2365.562370961378, 2371.395294199968, 2373.098222675372, 2373.584622691022, 8426.578671066483, 8500.914990850075, 8506.021807492094, 8510.74467765968, 8530.530820804854, 5070.188769796851, 5181.35233095863, 5229.424763276036, 5241.449647786965, 5264.184051472028, 3261.8532166052582, 3343.0806528204694, 3467.6705712957228, 3509.0350153707677, 3509.543759311299, 1217.4278089298016, 1219.286717270398, 1434.5337765226343, 1727.1536946896056, 1828.890266583996, 9195.816083678355, 9424.821897262842, 10932.398718070423, 10956.780864382747, 10968.0, 3914.2758589661003, 4394.274944634163, 4454.22051141049, 4545.954540454553, 4586.059857729158, 8596.613152408032, 8756.51839148853, 8765.0, 8767.868481972775, 8771.298296136294, 5105.412877519058, 5167.509086636764, 5186.688798672092, 5195.3246078009615, 5211.661242019257, 4655.0, 4760.904781904343, 4761.050659651652, 4771.427428708577, 4869.318295438641, 3690.520232369775, 3725.981370093132, 3785.1861849702445, 3786.9017984784655, 3796.6962642989047, 1162.1748558523543, 1164.772869290497, 1171.8359429679851, 1172.7595842852195, 1182.184292837939, 764.8890910817901, 782.8316911863976, 883.4919921045296, 898.2185498616116, 917.0187898948195, 5578.721063946787, 5615.466530679579, 5799.797007104731, 5829.242198514251, 5882.001612598195, 987.4124895687055, 992.8262554053011, 1001.8296889528798, 1005.7737009172878, 1046.6964580271788, 3471.3577988071784, 3715.294094122108, 3716.7212459065677, 3798.582155962842, 3850.7304488685522, 9884.159846413135, 10033.698989030341, 10257.640982565574, 10265.640702575523, 10270.33242839228, 10049.095581397709, 10223.0, 10226.488675566192, 10237.590496380062, 10245.180385569136, 7711.151773304932, 7869.48848324857, 7921.089074756477, 8053.033635963605, 8062.355011599058, 4442.511323754449, 5352.223927530564, 5415.431379705232, 5510.779568817203, 5544.667319960815, 7672.654730537028, 8893.155150260714, 9062.818743625223, 9158.0, 9217.723468295962, 7935.682572697027, 9345.112214339626, 9353.25173986093, 9491.762705932408, 9628.518574071128, 7202.783916482514, 7341.77974660761, 7347.375473084848, 7350.19147893742, 7363.7422690205585, 7690.6154692264045, 7885.5662938538935, 7940.920590794018, 7943.4439589230515, 7955.403344749051, 7069.117055560944, 7140.000399943908, 7194.6042967635185, 7208.026916366223, 7310.378617817332, 7033.683484243119, 7066.540674856118, 7081.114860642419, 7083.82290442743, 7122.465815063994, 6182.196314479269, 6345.428911397997, 6406.615603063831, 6447.6453795041725, 6481.287058423664, 4981.327520784647, 5016.1221786188, 5020.899582008266, 5037.219231019198, 5061.468545802638, 4943.307936888767, 4951.603871690184, 4963.131451995959, 5113.284140220298, 5115.232715092766], "value": 4434.37078644683, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.11900048370114, 351.66767404802465, 354.7747180540356, 361.9963800361997, 372.34281493164553, 3913.5303763548377, 4188.895277618061, 4417.845375411861, 4943.283223932528, 4967.130752118378, 4766.856994290169, 5192.974035129829, 5217.973910130453, 5245.134552798783, 5257.526822585966, 4029.576894426087, 4075.2460794753065, 4078.755979426274, 4094.488188976378, 4130.793460326987, 3923.411488276767, 3977.9204415911663, 4066.6136717011836, 4084.775337356444, 4108.397724887296, 3559.857605695769, 3863.343231650626, 4030.5364883038533, 4052.635262826345, 4093.570175131613, 3914.902127446808, 4067.4712287402745, 4088.89777755557, 4089.3661482470266, 4107.178564287125, 3465.3069386122625, 3481.4933248061357, 3577.3560759063357, 3649.981750091259, 3666.431703086026, 4716.764161791931, 5045.243213517965, 5048.444671086178, 5059.747012649353, 5059.924101138449, 4024.637782599551, 4722.220833562458, 4745.193317136095, 4755.0489902019735, 4769.928451073237, 5211.838557962867, 5446.972765136188, 5513.751881165317, 5514.779408823642, 5602.859928501779, 3420.6237313895454, 4030.435738996543, 4030.979845100785, 4039.151778126597, 4050.521559630743, 5669.1496275558175, 5799.797007104773, 5805.88388232233, 5812.651240925516, 5852.67810270435, 3884.8446062157764, 3933.3903244997073, 4105.507339119325, 4111.376006477425, 4119.9176016480105, 4230.259704551691, 4249.766262855511, 4251.384473899899, 4267.231898258281, 4293.5706429356815, 3827.961720382816, 4362.1678894864235, 4483.529229430863, 4775.346859652369, 4852.951470485321, 5664.51851592611, 5669.234653321749, 5685.630434021776, 5693.943060569424, 5720.1991721159075, 1255.811628255769, 1263.91784534005, 1374.5120482228865, 1375.2642336350004, 1399.7130588229388, 920.5777074419904, 944.0, 945.6548359848606, 979.7648564344506, 996.4021587047713, 4302.698056539736, 4372.956270437318, 4404.0, 4965.634450526062, 4996.70019798806, 4730.810767569327, 5351.919721204185, 5474.5894057945015, 5480.0, 5530.096699232935, 4492.550744925481, 4684.906301873943, 4920.532549407801, 4974.602031837444, 4979.825706100269, 2350.130451732836, 2627.605859121147, 2711.945761084767, 2753.3529620539157, 2897.4643438977378, 4901.926471102936, 5053.01466214092, 5129.820456284012, 5685.3177618685195, 5687.744051517609, 4747.477777444478, 5228.568715547212, 5549.500544950974, 5594.832155035356, 5662.678301896202, 5259.842834576387, 5568.805091821767, 5626.887462250732, 5666.744996475086, 5673.489385955284, 4781.521847815191, 4790.5568160237835, 4925.704457732548, 5050.444451110448, 5473.151661492475, 4788.784504697227, 5220.895582088261, 5260.0, 5617.241672374177, 5663.612414958362, 5587.469190426903, 5745.511631511201, 5817.0, 5857.531397488276, 5872.559558033079, 3374.835681689813, 3667.651573100551, 3668.871589494355, 3865.1303456723135, 3888.766673999569, 4823.469418363907, 5236.9738151309, 5508.614396992172, 5611.691356975405, 5836.562257830595, 4835.8065677372515, 5380.950714610613, 5529.474699903502, 5582.213691618806, 5586.636868603528, 5241.951609678156, 5483.890322193613, 5544.972275138599, 5564.805231816867, 5615.831525054255, 4598.609118224988, 4735.692180008288, 4763.3807605011125, 5160.864609785841, 5462.672239665632, 4522.834016188747, 5094.471658502509, 5277.366715994105, 5538.676793923774, 5555.194496798023, 5011.649184557046, 5421.132618780976, 5424.972875135599, 5442.4285450028765, 5478.972605136949], "value": 4050.632612060376, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.111149949316, 686.8969654551817, 702.641652757094, 743.3235755462526, 817.125675527186, 14731.0, 15628.531144065697, 15714.999999999985, 15720.135392553419, 15729.842701572981, 13403.59789206323, 14022.439102435916, 14232.288385580705, 14256.572302830906, 14262.714745705105, 706.2760670312919, 830.8047608811925, 839.9874001889976, 842.1283971089892, 843.5613480989881, 659.14969689101, 673.4141297071554, 821.4291067707945, 849.3332733803965, 854.2439940652537, 883.4434306387, 884.3544212724682, 884.7743825324566, 885.5926273914007, 889.1508609278123, 878.7890906182535, 880.7049638371153, 881.0572687224673, 881.0880738435752, 881.0968757024037, 514.4700958013252, 521.7652056574518, 642.1427394428443, 650.1190886348976, 659.6635715784936, 15318.693626127526, 15338.156401397919, 15358.539243822703, 15363.308651110616, 15363.385464581403, 13559.59321220365, 13599.388027538784, 13710.52013179544, 13715.862841371558, 13734.0, 12119.878801212051, 12128.636140915787, 12370.711418387536, 12525.812112818316, 13140.211587304697, 3450.3271861986923, 4266.679999000056, 4561.247394179956, 4610.492845786961, 4615.192341340286, 106670.0, 111019.0, 111047.0, 114992.0, 117392.0, 10398.948005260077, 10703.0, 10857.67426977192, 10891.891081089247, 10936.617218397318, 20337.389878303675, 20777.896110519352, 20866.47833804167, 21073.0, 21882.562348752937, 7656.272654097852, 7835.882461763078, 7915.16890726477, 7915.287624113857, 8051.35589152878, 4174.519930208065, 4260.765657888784, 4345.868604760508, 4353.869383918487, 4399.076193999232, 3559.982200088983, 3624.7462677612843, 3638.181409182913, 3646.2889736501656, 3656.305301992613, 641.2113100885937, 647.0972992675191, 654.1267408010359, 656.5108993799649, 658.6114192626374, 577.6707276852154, 680.3366717450447, 683.2143035509105, 695.3498478922224, 699.7375984005997, 9400.576974036185, 10006.69979900604, 10155.289129760993, 10186.949065254626, 10359.63741269052, 547.6303495140764, 577.261105784588, 586.2144726067005, 598.8772301678233, 704.6195054670522, 4474.530174331713, 4899.0, 4911.7298548580175, 4921.458639549646, 4925.285833554115, 102943.0, 105289.47355263175, 105529.94470055355, 109156.4542177284, 110067.44966275117, 89341.10658893328, 92526.0, 92620.0, 94932.57601135988, 95033.95986426069, 63907.0, 75364.24635753682, 75537.48925021579, 76221.0, 76247.85628215582, 9091.318151138823, 9095.0, 9098.954505227432, 9124.680636177702, 9208.815823683623, 51140.46578602648, 51649.0, 52185.7390713044, 52876.735616321675, 53704.73147634237, 60248.69875650769, 69221.61556768937, 70152.94770578548, 71437.6428117877, 73065.0, 11193.733100047575, 11643.417829108681, 12028.977536909111, 12549.560765373168, 12679.239245644922, 13886.72226555443, 14603.926980365455, 14907.254637267877, 15236.466723664618, 15503.14732689713, 13545.0, 13589.32053397346, 13654.795178072138, 13877.959153063359, 14422.06256593318, 13696.931515342758, 13813.240271784747, 13944.093633913762, 14407.207603581484, 14473.131612103307, 13210.735785284432, 13219.47122115143, 13388.397522111723, 13529.18824870511, 14165.504207352693, 9896.356736812084, 10586.311889727143, 10905.073068789241, 11570.768584628091, 11967.64097077089, 10385.221108416748, 11409.429528523375, 11430.942845285721, 11666.475008624462, 11707.2975621463], "value": 7479.17953159862, "unit": "score"}], "name": "dromaeo_css", "value": 7295.233677788236, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 114.0, 115.0, 117.0, 116.0, 115.0, 114.0, 115.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 110.0, 108.0, 130.0, 125.0, 136.0, 133.0, 110.0, 128.0, 110.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 185.0, 185.0, 183.0, 188.0, 186.0, 193.0, 186.0, 184.0, 183.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 90.0, 61.0, 61.0, 59.0, 58.0, 74.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 86.0, 70.0, 69.0, 68.0, 79.0, 89.0, 95.0, 107.0], "value": 82.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 87.0, 89.0, 87.0, 90.0, 87.0, 90.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 96.0, 96.0, 95.0, 104.0, 154.0, 120.0, 95.0, 96.0], "value": 104.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 85.0, 85.0, 87.0, 85.0, 86.0, 88.0, 88.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 53.0, 54.0, 56.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 71.0, 77.0, 73.0, 70.0, 69.0, 72.0, 71.0, 73.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 91.0, 81.0, 100.0, 78.0, 82.0, 87.0, 84.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 146.0, 142.0, 146.0, 131.0, 141.0, 142.0, 143.0, 178.0, 145.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 175.0, 168.0, 169.0, 169.0, 167.0, 171.0, 182.0, 221.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 85.0, 68.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1452.2, "alertThreshold": 2.0}]} 11:47:28 INFO - Return code: 0 11:47:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:47:28 ERROR - # TBPL SUCCESS # 11:47:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:47:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:47:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:47:28 INFO - 2017-02-13 11:47:28.164 screenresolution[1920:20446] starting screenresolution argv=screenresolution get 11:47:28 INFO - 2017-02-13 11:47:28.167 screenresolution[1920:20446] Display 0: 1600x1200x32@60 11:47:28 INFO - 2017-02-13 11:47:28.173 screenresolution[1921:20449] starting screenresolution argv=screenresolution list 11:47:28 INFO - Available Modes on Display 0 11:47:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:47:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:47:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:47:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:47:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:47:28 INFO - Intel Iris: 11:47:28 INFO - Chipset Model: Intel Iris 11:47:28 INFO - Type: GPU 11:47:28 INFO - Bus: Built-In 11:47:28 INFO - VRAM (Dynamic, Max): 1536 MB 11:47:28 INFO - Vendor: Intel (0x8086) 11:47:28 INFO - Device ID: 0x0a2e 11:47:28 INFO - Revision ID: 0x0009 11:47:28 INFO - Displays: 11:47:28 INFO - Display: 11:47:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:47:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:47:28 INFO - Display Serial Number: 1600x1200 60 11:47:28 INFO - Main Display: Yes 11:47:28 INFO - Mirror: Off 11:47:28 INFO - Online: Yes 11:47:28 INFO - Rotation: Supported 11:47:28 INFO - Return code: 0 11:47:28 INFO - Running post-action listener: _resource_record_post_action 11:47:28 INFO - [mozharness: 2017-02-13 19:47:28.407815Z] Finished run-tests step (success) 11:47:28 INFO - Running post-run listener: _resource_record_post_run 11:47:28 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 679936; Write bytes: 507435008; Read time: 7; Write time: 1686 11:47:28 INFO - TinderboxPrint: CPU usage
53.8% 11:47:28 INFO - TinderboxPrint: I/O read bytes / time
679,936 / 7 11:47:28 INFO - TinderboxPrint: I/O write bytes / time
507,435,008 / 1,686 11:47:28 INFO - TinderboxPrint: CPU idle
2,214.1 (46.2%) 11:47:28 INFO - TinderboxPrint: CPU system
963.3 (20.1%) 11:47:28 INFO - TinderboxPrint: CPU user
1,620.2 (33.8%) 11:47:28 INFO - TinderboxPrint: Swap in / out
208,162,816 / 0 11:47:28 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203237888; Write bytes: 198959104; Read time: 15667; Write time: 406 11:47:28 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 679936; Write bytes: 297682944; Read time: 7; Write time: 1249 11:47:28 INFO - Running post-run listener: _upload_blobber_files 11:47:28 INFO - Blob upload gear active. 11:47:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:47:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:47:29 INFO - (blobuploader) - INFO - Open directory for files ... 11:47:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:47:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:47:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:30 INFO - (blobuploader) - INFO - Done attempting. 11:47:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:47:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:47:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:31 INFO - (blobuploader) - INFO - Done attempting. 11:47:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:47:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:47:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:32 INFO - (blobuploader) - INFO - Done attempting. 11:47:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:47:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:47:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:34 INFO - (blobuploader) - INFO - Done attempting. 11:47:34 INFO - (blobuploader) - INFO - Iteration through files over. 11:47:34 INFO - Return code: 0 11:47:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:47:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:47:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19b88a8b27dda3025b39b714c40b412b87056503a70f16ce30af3224aa043a502ac6a0a33cc9d4513b361843e27ca170e0e17befbf4914b34a9a175b330ae49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44d8b7dbefbd727eaa37a0bec30d57dc1e0272e4a881e87bdc0d381331ca5d4b509acfff8bbbf828c51f7cb34f75280782c3f38b703fc07b183c23ad52016485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4544838e542f30822cb8c8d07d68980220e9c08ce182534d4620fd0c497ec006a48783a09ac7a6290fd4f0e7123a0504da6b94e4a6060bc95c3bea87426ca7bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9cb92024b538def47b505f450c8b17fcc027c9b0be7b165a55ef2a874d4d40f82a666db0b97ef8c7e7b256558c9a4649142ddc58f14db937164a3b9aae2c9830"} 11:47:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:47:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:47:34 INFO - Contents: 11:47:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19b88a8b27dda3025b39b714c40b412b87056503a70f16ce30af3224aa043a502ac6a0a33cc9d4513b361843e27ca170e0e17befbf4914b34a9a175b330ae49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44d8b7dbefbd727eaa37a0bec30d57dc1e0272e4a881e87bdc0d381331ca5d4b509acfff8bbbf828c51f7cb34f75280782c3f38b703fc07b183c23ad52016485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4544838e542f30822cb8c8d07d68980220e9c08ce182534d4620fd0c497ec006a48783a09ac7a6290fd4f0e7123a0504da6b94e4a6060bc95c3bea87426ca7bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9cb92024b538def47b505f450c8b17fcc027c9b0be7b165a55ef2a874d4d40f82a666db0b97ef8c7e7b256558c9a4649142ddc58f14db937164a3b9aae2c9830"} 11:47:34 INFO - Running post-run listener: copy_logs_to_upload_dir 11:47:34 INFO - Copying logs to upload dir... 11:47:34 INFO - mkdir: /builds/slave/test/build/upload/logs 11:47:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.972436 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-13 11:47:34.682025) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 11:47:34.685536) ========= 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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/19b88a8b27dda3025b39b714c40b412b87056503a70f16ce30af3224aa043a502ac6a0a33cc9d4513b361843e27ca170e0e17befbf4914b34a9a175b330ae49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44d8b7dbefbd727eaa37a0bec30d57dc1e0272e4a881e87bdc0d381331ca5d4b509acfff8bbbf828c51f7cb34f75280782c3f38b703fc07b183c23ad52016485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4544838e542f30822cb8c8d07d68980220e9c08ce182534d4620fd0c497ec006a48783a09ac7a6290fd4f0e7123a0504da6b94e4a6060bc95c3bea87426ca7bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9cb92024b538def47b505f450c8b17fcc027c9b0be7b165a55ef2a874d4d40f82a666db0b97ef8c7e7b256558c9a4649142ddc58f14db937164a3b9aae2c9830"} build_url:https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011104 build_url: 'https://queue.taskcluster.net/v1/task/TllbZbN6Tzy_32kqYu17Sg/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/19b88a8b27dda3025b39b714c40b412b87056503a70f16ce30af3224aa043a502ac6a0a33cc9d4513b361843e27ca170e0e17befbf4914b34a9a175b330ae49e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44d8b7dbefbd727eaa37a0bec30d57dc1e0272e4a881e87bdc0d381331ca5d4b509acfff8bbbf828c51f7cb34f75280782c3f38b703fc07b183c23ad52016485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4544838e542f30822cb8c8d07d68980220e9c08ce182534d4620fd0c497ec006a48783a09ac7a6290fd4f0e7123a0504da6b94e4a6060bc95c3bea87426ca7bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9cb92024b538def47b505f450c8b17fcc027c9b0be7b165a55ef2a874d4d40f82a666db0b97ef8c7e7b256558c9a4649142ddc58f14db937164a3b9aae2c9830"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 11:47:34.719779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 11:47:34.720137) ========= 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.qqymPT6jWh/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.dNQPfSWpNZ/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005285 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 11:47:34.769125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 11:47:34.769438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 11:47:34.769788) ========= ========= Total master_lag: 0.19 =========