builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0065 starttime: 1488461977.98 results: success (0) buildid: 20170302044322 builduid: d62d06a6725b4691ad59d6d62598654b revision: 0da8d305ce0072bf900c6d17d5372b907ec72c34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:37.984340) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:37.984814) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:37.985090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:38.103386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:38.103822) ========= 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.tVjQtCKcOg/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.aRMg31nbIT/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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-03-02 05:39:38-- 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% 13.6M=0.001s 2017-03-02 05:39:38 (13.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.581812 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:38.747388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:38.747692) ========= 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.tVjQtCKcOg/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.aRMg31nbIT/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.027838 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:38.830874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:38.831313) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0da8d305ce0072bf900c6d17d5372b907ec72c34 --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 0da8d305ce0072bf900c6d17d5372b907ec72c34 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tVjQtCKcOg/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.aRMg31nbIT/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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-03-02 05:39:38,931 truncating revision to first 12 chars 2017-03-02 05:39:38,931 Setting DEBUG logging. 2017-03-02 05:39:38,931 attempt 1/10 2017-03-02 05:39:38,931 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0da8d305ce00?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 05:39:39,243 unpacking tar archive at: mozilla-aurora-0da8d305ce00/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583567 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:39.445715) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:39.446029) ========= script_repo_revision: 0da8d305ce0072bf900c6d17d5372b907ec72c34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:39.446400) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:39.446676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 05:39:39.483518) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-02 05:39:39.483874) ========= /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.tVjQtCKcOg/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.aRMg31nbIT/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:39:39 INFO - MultiFileLogger online at 20170302 05:39:39 in /builds/slave/test 05:39:39 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 05:39:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:39 INFO - {'append_to_log': False, 05:39:39 INFO - 'base_work_dir': '/builds/slave/test', 05:39:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:39:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:39 INFO - 'branch': 'Mozilla-Aurora', 05:39:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:39 INFO - 'config_files': ('talos/mac_config.py',), 05:39:39 INFO - 'default_actions': ('clobber', 05:39:39 INFO - 'read-buildbot-config', 05:39:39 INFO - 'download-and-extract', 05:39:39 INFO - 'populate-webroot', 05:39:39 INFO - 'create-virtualenv', 05:39:39 INFO - 'install', 05:39:39 INFO - 'run-tests'), 05:39:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:39 INFO - 'download_minidump_stackwalk': True, 05:39:39 INFO - 'download_symbols': 'ondemand', 05:39:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:39 INFO - 'installer_path': 'installer.exe', 05:39:39 INFO - 'log_level': 'info', 05:39:39 INFO - 'log_name': 'talos', 05:39:39 INFO - 'log_to_console': True, 05:39:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:39:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:39:39 INFO - 'opt_config_files': (), 05:39:39 INFO - 'pip_index': False, 05:39:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:39:39 INFO - 'cmd': ('bash', 05:39:39 INFO - '-c', 05:39:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:39:39 INFO - 'enabled': True, 05:39:39 INFO - 'halt_on_failure': False, 05:39:39 INFO - 'name': 'check_screen_resolution'},), 05:39:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:39:39 INFO - 'cmd': ('bash', 05:39:39 INFO - '-c', 05:39:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:39:39 INFO - 'enabled': True, 05:39:39 INFO - 'halt_on_failure': False, 05:39:39 INFO - 'name': 'check_screen_resolution'},), 05:39:39 INFO - 'run_cmd_checks_enabled': True, 05:39:39 INFO - 'sps_profile': False, 05:39:39 INFO - 'sps_profile_interval': 0, 05:39:39 INFO - 'suite': 'dromaeojs', 05:39:39 INFO - 'system_bits': '32', 05:39:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:39 INFO - 'title': 't-yosemite-r7-0065', 05:39:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:39 INFO - 'use_talos_json': True, 05:39:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:39 INFO - 'work_dir': 'build'} 05:39:39 INFO - [mozharness: 2017-03-02 13:39:39.697042Z] Running clobber step. 05:39:39 INFO - Running pre-action listener: _resource_record_pre_action 05:39:39 INFO - Running main action method: clobber 05:39:39 INFO - rmtree: /builds/slave/test/build 05:39:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:42 INFO - Running post-action listener: _resource_record_post_action 05:39:42 INFO - [mozharness: 2017-03-02 13:39:42.350039Z] Finished clobber step (success) 05:39:42 INFO - [mozharness: 2017-03-02 13:39:42.350171Z] Running read-buildbot-config step. 05:39:42 INFO - Running pre-action listener: _resource_record_pre_action 05:39:42 INFO - Running main action method: read_buildbot_config 05:39:42 INFO - Using buildbot properties: 05:39:42 INFO - { 05:39:42 INFO - "project": "", 05:39:42 INFO - "product": "firefox", 05:39:42 INFO - "script_repo_revision": "production", 05:39:42 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:39:42 INFO - "repository": "", 05:39:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:39:42 INFO - "buildid": "20170302044322", 05:39:42 INFO - "pgo_build": "False", 05:39:42 INFO - "basedir": "/builds/slave/test", 05:39:42 INFO - "buildnumber": 72, 05:39:42 INFO - "slavename": "t-yosemite-r7-0065", 05:39:42 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:39:42 INFO - "platform": "yosemite_r7", 05:39:42 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:39:42 INFO - "branch": "mozilla-aurora", 05:39:42 INFO - "repo_path": "releases/mozilla-aurora", 05:39:42 INFO - "revision": "0da8d305ce0072bf900c6d17d5372b907ec72c34", 05:39:42 INFO - "stage_platform": "macosx64", 05:39:42 INFO - "builduid": "d62d06a6725b4691ad59d6d62598654b", 05:39:42 INFO - "slavebuilddir": "test" 05:39:42 INFO - } 05:39:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 05:39:42 INFO - Running post-action listener: _resource_record_post_action 05:39:42 INFO - [mozharness: 2017-03-02 13:39:42.353734Z] Finished read-buildbot-config step (success) 05:39:42 INFO - [mozharness: 2017-03-02 13:39:42.353873Z] Running download-and-extract step. 05:39:42 INFO - Running pre-action listener: _resource_record_pre_action 05:39:42 INFO - Running main action method: download_and_extract 05:39:42 INFO - mkdir: /builds/slave/test/build/tests 05:39:42 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')]} 05:39:42 INFO - trying https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 05:39:42 INFO - Downloading https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/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 05:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/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 05:39:43 INFO - Downloaded 1199 bytes. 05:39:43 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 05:39:43 INFO - Using the following test package requirements: 05:39:43 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 05:39:43 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:43 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 05:39:43 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:43 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 05:39:43 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:43 INFO - u'jsshell-mac.zip'], 05:39:43 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:43 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 05:39:43 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 05:39:43 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:43 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 05:39:43 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:43 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 05:39:43 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:43 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 05:39:43 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:43 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 05:39:43 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:39:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 05:39:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:39:43 INFO - Fetch https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 05:39:44 INFO - Expected file size: 16357795 05:39:44 INFO - Obtained file size: 16357795 05:39:51 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 05:39:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 05:39:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:39:51 INFO - Fetch https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 05:39:53 INFO - Expected file size: 16357795 05:39:53 INFO - Obtained file size: 16357795 05:40:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 05:40:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:40:00 INFO - Fetch https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 05:40:00 INFO - Expected file size: 14403472 05:40:00 INFO - Obtained file size: 14403472 05:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:01 INFO - trying https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:40:01 INFO - Downloading https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 05:40:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/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 05:40:03 INFO - Downloaded 73900684 bytes. 05:40:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:40:03 INFO - mkdir: /builds/slave/test/properties 05:40:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:40:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:40:03 INFO - Contents: 05:40:03 INFO - build_url:https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:40:04 INFO - Running post-action listener: _resource_record_post_action 05:40:04 INFO - Running post-action listener: set_extra_try_arguments 05:40:04 INFO - [mozharness: 2017-03-02 13:40:04.207031Z] Finished download-and-extract step (success) 05:40:04 INFO - [mozharness: 2017-03-02 13:40:04.207152Z] Running populate-webroot step. 05:40:04 INFO - Running pre-action listener: _resource_record_pre_action 05:40:04 INFO - Running main action method: populate_webroot 05:40:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:04 INFO - '--tppagecycles', 05:40:04 INFO - '7'], 05:40:04 INFO - 'tests': ['tsvgm']}}, 05:40:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:40:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:40:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:40:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:40:04 INFO - 'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:40:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:40:04 INFO - 'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['damp', 'tps']}, 05:40:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:40:04 INFO - 'tests': ['damp', 'tps']}, 05:40:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['dromaeo_dom']}, 05:40:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['basic_compositor_video']}, 05:40:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:40:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['a11yr', 05:40:04 INFO - 'ts_paint', 05:40:04 INFO - 'tpaint', 05:40:04 INFO - 'sessionrestore', 05:40:04 INFO - 'sessionrestore_no_auto_restore', 05:40:04 INFO - 'tabpaint']}, 05:40:04 INFO - 'other-e10s': {'tests': ['a11yr', 05:40:04 INFO - 'ts_paint', 05:40:04 INFO - 'tpaint', 05:40:04 INFO - 'sessionrestore', 05:40:04 INFO - 'sessionrestore_no_auto_restore', 05:40:04 INFO - 'tabpaint']}, 05:40:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:40:04 INFO - 'ts_paint', 05:40:04 INFO - 'tpaint', 05:40:04 INFO - 'sessionrestore', 05:40:04 INFO - 'sessionrestore_no_auto_restore', 05:40:04 INFO - 'tabpaint']}, 05:40:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:40:04 INFO - 'ts_paint', 05:40:04 INFO - 'tpaint', 05:40:04 INFO - 'sessionrestore', 05:40:04 INFO - 'sessionrestore_no_auto_restore', 05:40:04 INFO - 'tabpaint']}, 05:40:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['a11yr', 05:40:04 INFO - 'ts_paint', 05:40:04 INFO - 'tpaint', 05:40:04 INFO - 'sessionrestore', 05:40:04 INFO - 'sessionrestore_no_auto_restore', 05:40:04 INFO - 'tabpaint']}, 05:40:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['a11yr', 05:40:04 INFO - 'ts_paint', 05:40:04 INFO - 'tpaint', 05:40:04 INFO - 'sessionrestore', 05:40:04 INFO - 'sessionrestore_no_auto_restore', 05:40:04 INFO - 'tabpaint']}, 05:40:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['tsvgx', 05:40:04 INFO - 'tsvgr_opacity', 05:40:04 INFO - 'tart', 05:40:04 INFO - 'tscrollx', 05:40:04 INFO - 'cart', 05:40:04 INFO - 'tsvg_static']}, 05:40:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:40:04 INFO - 'tsvgr_opacity', 05:40:04 INFO - 'tart', 05:40:04 INFO - 'tscrollx', 05:40:04 INFO - 'cart', 05:40:04 INFO - 'tsvg_static']}, 05:40:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:40:04 INFO - 'talos_options': ['--disable-e10s'], 05:40:04 INFO - 'tests': ['tp5o']}, 05:40:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:40:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:40:04 INFO - 'talos_options': ['--disable-e10s', 05:40:04 INFO - '--xperf_path', 05:40:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:04 INFO - 'tests': ['tp5n']}, 05:40:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:40:04 INFO - 'talos_options': ['--xperf_path', 05:40:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:04 INFO - 'tests': ['tp5n']}}, 05:40:04 INFO - 'talos.zip': {'path': '', 05:40:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:04 INFO - Running post-action listener: _resource_record_post_action 05:40:04 INFO - [mozharness: 2017-03-02 13:40:04.225880Z] Finished populate-webroot step (success) 05:40:04 INFO - [mozharness: 2017-03-02 13:40:04.226012Z] Running create-virtualenv step. 05:40:04 INFO - Running pre-action listener: _resource_record_pre_action 05:40:04 INFO - Running main action method: create_virtualenv 05:40:04 INFO - Creating virtualenv /builds/slave/test/build/venv 05:40:04 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 05:40:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:40:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:04 INFO - Using real prefix '/tools/python27' 05:40:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:40:05 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:07 INFO - Installing pip.................done. 05:40:07 INFO - Return code: 0 05:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:40:08 INFO - Reading from file tmpfile_stdout 05:40:08 INFO - Output received: 05:40:08 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) 05:40:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:40: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')]} 05:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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')]} 05:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40: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', 'pip>=1.5'] in /builds/slave/test/build 05:40: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 pip>=1.5 05:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:08 INFO - 'HOME': '/Users/cltbld', 05:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:08 INFO - 'LOGNAME': 'cltbld', 05:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:08 INFO - 'MOZ_NO_REMOTE': '1', 05:40:08 INFO - 'NO_EM_RESTART': '1', 05:40:08 INFO - 'PAGER': '/bin/cat', 05:40:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:08 INFO - 'PWD': '/builds/slave/test', 05:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:08 INFO - 'SHELL': '/bin/bash', 05:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:08 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:08 INFO - 'USER': 'cltbld', 05:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:08 INFO - 'XPC_FLAGS': '0x0', 05:40:08 INFO - 'XPC_SERVICE_NAME': '0', 05:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:08 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 05:40:08 INFO - Cleaning up... 05:40:08 INFO - Return code: 0 05:40:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:40: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')]} 05:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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')]} 05:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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', '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 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:40: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 psutil>=3.1.1 05:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:08 INFO - 'HOME': '/Users/cltbld', 05:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:08 INFO - 'LOGNAME': 'cltbld', 05:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:08 INFO - 'MOZ_NO_REMOTE': '1', 05:40:08 INFO - 'NO_EM_RESTART': '1', 05:40:08 INFO - 'PAGER': '/bin/cat', 05:40:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:08 INFO - 'PWD': '/builds/slave/test', 05:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:08 INFO - 'SHELL': '/bin/bash', 05:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:08 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:08 INFO - 'USER': 'cltbld', 05:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:08 INFO - 'XPC_FLAGS': '0x0', 05:40:08 INFO - 'XPC_SERVICE_NAME': '0', 05:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:08 INFO - Downloading/unpacking psutil>=3.1.1 05:40:08 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 05:40:08 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 05:40:08 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 05:40:08 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 05:40:08 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 05:40:08 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 05:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:12 INFO - Installing collected packages: psutil 05:40:12 INFO - Running setup.py install for psutil 05:40:12 INFO - building 'psutil._psutil_osx' extension 05:40:12 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 05:40:13 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 05:40:13 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 05:40:13 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 05:40:13 INFO - building 'psutil._psutil_posix' extension 05:40:13 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 05:40:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:40:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:40:13 INFO - ^ 05:40:13 INFO - 1 warning generated. 05:40:13 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 05:40:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:13 INFO - Successfully installed psutil 05:40:13 INFO - Cleaning up... 05:40:13 INFO - Return code: 0 05:40:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:40:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:13 INFO - 'HOME': '/Users/cltbld', 05:40:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:13 INFO - 'LOGNAME': 'cltbld', 05:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:13 INFO - 'MOZ_NO_REMOTE': '1', 05:40:13 INFO - 'NO_EM_RESTART': '1', 05:40:13 INFO - 'PAGER': '/bin/cat', 05:40:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:13 INFO - 'PWD': '/builds/slave/test', 05:40:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:13 INFO - 'SHELL': '/bin/bash', 05:40:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:13 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:13 INFO - 'USER': 'cltbld', 05:40:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:13 INFO - 'XPC_FLAGS': '0x0', 05:40:13 INFO - 'XPC_SERVICE_NAME': '0', 05:40:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:40:16 INFO - Installing collected packages: mozsystemmonitor 05:40:16 INFO - Running setup.py install for mozsystemmonitor 05:40:17 INFO - Successfully installed mozsystemmonitor 05:40:17 INFO - Cleaning up... 05:40:17 INFO - Return code: 0 05:40:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:40: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')]} 05:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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')]} 05:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:40:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:17 INFO - 'HOME': '/Users/cltbld', 05:40:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:17 INFO - 'LOGNAME': 'cltbld', 05:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:17 INFO - 'MOZ_NO_REMOTE': '1', 05:40:17 INFO - 'NO_EM_RESTART': '1', 05:40:17 INFO - 'PAGER': '/bin/cat', 05:40:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:17 INFO - 'PWD': '/builds/slave/test', 05:40:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:17 INFO - 'SHELL': '/bin/bash', 05:40:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:17 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:17 INFO - 'USER': 'cltbld', 05:40:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:17 INFO - 'XPC_FLAGS': '0x0', 05:40:17 INFO - 'XPC_SERVICE_NAME': '0', 05:40:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:17 INFO - Downloading/unpacking jsonschema==2.5.1 05:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:40:19 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 05:40:19 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 05:40:19 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 05:40:19 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 05:40:19 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 05:40:19 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 05:40:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:20 INFO - warning: no files found matching '*.txt' 05:40:20 INFO - no previously-included directories found matching 'build' 05:40:20 INFO - no previously-included directories found matching 'dist' 05:40:20 INFO - no previously-included directories found matching '.git*' 05:40:20 INFO - Installing collected packages: jsonschema, functools32 05:40:20 INFO - Running setup.py install for functools32 05:40:20 INFO - warning: no files found matching '*.txt' 05:40:20 INFO - no previously-included directories found matching 'build' 05:40:20 INFO - no previously-included directories found matching 'dist' 05:40:20 INFO - no previously-included directories found matching '.git*' 05:40:20 INFO - Successfully installed jsonschema functools32 05:40:20 INFO - Cleaning up... 05:40:20 INFO - Return code: 0 05:40:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:20 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 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40:20 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 05:40:20 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 05:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:20 INFO - 'HOME': '/Users/cltbld', 05:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:20 INFO - 'LOGNAME': 'cltbld', 05:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:20 INFO - 'MOZ_NO_REMOTE': '1', 05:40:20 INFO - 'NO_EM_RESTART': '1', 05:40:20 INFO - 'PAGER': '/bin/cat', 05:40:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:20 INFO - 'PWD': '/builds/slave/test', 05:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:20 INFO - 'SHELL': '/bin/bash', 05:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:20 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:20 INFO - 'USER': 'cltbld', 05:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:20 INFO - 'XPC_FLAGS': '0x0', 05:40:20 INFO - 'XPC_SERVICE_NAME': '0', 05:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:40:20 INFO - Cleaning up... 05:40:21 INFO - Return code: 0 05:40:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:40:21 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')]} 05:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:21 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')]} 05:40:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:21 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 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40:21 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 05:40:21 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 05:40:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:21 INFO - 'HOME': '/Users/cltbld', 05:40:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:21 INFO - 'LOGNAME': 'cltbld', 05:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:21 INFO - 'MOZ_NO_REMOTE': '1', 05:40:21 INFO - 'NO_EM_RESTART': '1', 05:40:21 INFO - 'PAGER': '/bin/cat', 05:40:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:21 INFO - 'PWD': '/builds/slave/test', 05:40:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:21 INFO - 'SHELL': '/bin/bash', 05:40:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:21 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:21 INFO - 'USER': 'cltbld', 05:40:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:21 INFO - 'XPC_FLAGS': '0x0', 05:40:21 INFO - 'XPC_SERVICE_NAME': '0', 05:40:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 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 05:40:21 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 05:40:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:23 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 05:40:23 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 05:40:23 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 05:40:23 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 05:40:23 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 05:40:23 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 05:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:40:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:25 INFO - Downloading docopt-0.6.1.tar.gz 05:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:25 INFO - Running setup.py install for blobuploader 05:40:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:40:25 INFO - Running setup.py install for requests 05:40:25 INFO - Running setup.py install for docopt 05:40:25 INFO - Successfully installed blobuploader requests docopt 05:40:25 INFO - Cleaning up... 05:40:26 INFO - Return code: 0 05:40:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:26 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')]} 05:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:26 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')]} 05:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:26 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 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40:26 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 05:40:26 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 05:40:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:26 INFO - 'HOME': '/Users/cltbld', 05:40:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:26 INFO - 'LOGNAME': 'cltbld', 05:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:26 INFO - 'MOZ_NO_REMOTE': '1', 05:40:26 INFO - 'NO_EM_RESTART': '1', 05:40:26 INFO - 'PAGER': '/bin/cat', 05:40:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:26 INFO - 'PWD': '/builds/slave/test', 05:40:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:26 INFO - 'SHELL': '/bin/bash', 05:40:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:26 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:26 INFO - 'USER': 'cltbld', 05:40:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:26 INFO - 'XPC_FLAGS': '0x0', 05:40:26 INFO - 'XPC_SERVICE_NAME': '0', 05:40:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-GJ2YB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-9J4bVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-6mF2Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-nSAYve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-9e2VhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-FGZ3nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Z26IdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-UeyQI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-fj6wgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-twiQU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-xlmurz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-dZhXCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-oSLMsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-hpNqq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-2t1bM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-nTUqme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:27 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-pWqz2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:28 INFO - Running setup.py install for manifestparser 05:40:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:40:28 INFO - Running setup.py install for mozcrash 05:40:28 INFO - Running setup.py install for mozdebug 05:40:28 INFO - Running setup.py install for mozdevice 05:40:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:40:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:40:28 INFO - Running setup.py install for mozfile 05:40:28 INFO - Running setup.py install for mozhttpd 05:40:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:40:28 INFO - Running setup.py install for mozinfo 05:40:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Running setup.py install for mozInstall 05:40:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Running setup.py install for mozleak 05:40:29 INFO - Running setup.py install for mozlog 05:40:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Running setup.py install for moznetwork 05:40:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Running setup.py install for mozprocess 05:40:29 INFO - Running setup.py install for mozprofile 05:40:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Running setup.py install for mozrunner 05:40:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Running setup.py install for mozscreenshot 05:40:30 INFO - Running setup.py install for moztest 05:40:30 INFO - Running setup.py install for mozversion 05:40:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:30 INFO - Cleaning up... 05:40:30 INFO - Return code: 0 05:40:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:30 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')]} 05:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:30 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')]} 05:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:30 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 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40:30 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 05:40:30 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 05:40:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:30 INFO - 'HOME': '/Users/cltbld', 05:40:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:30 INFO - 'LOGNAME': 'cltbld', 05:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:30 INFO - 'MOZ_NO_REMOTE': '1', 05:40:30 INFO - 'NO_EM_RESTART': '1', 05:40:30 INFO - 'PAGER': '/bin/cat', 05:40:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:30 INFO - 'PWD': '/builds/slave/test', 05:40:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:30 INFO - 'SHELL': '/bin/bash', 05:40:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:30 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:30 INFO - 'USER': 'cltbld', 05:40:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:30 INFO - 'XPC_FLAGS': '0x0', 05:40:30 INFO - 'XPC_SERVICE_NAME': '0', 05:40:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-0ToWR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:31 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)) 05:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-qe4vvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:31 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)) 05:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-e02HNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:31 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)) 05:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-fStfzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:31 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)) 05:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-dnIlHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:31 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)) 05:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-blzpnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:31 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)) 05:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-P9ZjR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:31 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)) 05:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Umq41Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:31 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)) 05:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-mAOqVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:31 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)) 05:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Em_0KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-LdoMhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-W4DUxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-R4Oiwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-7AoV1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-_JLtYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-JFl0q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:32 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-R_cG27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:32 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)) 05:40:32 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)) 05:40:32 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)) 05:40:32 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)) 05:40:32 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)) 05:40:32 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)) 05:40:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:35 INFO - Downloading blessings-1.6.tar.gz 05:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:35 INFO - Installing collected packages: blessings 05:40:35 INFO - Running setup.py install for blessings 05:40:35 INFO - Successfully installed blessings 05:40:35 INFO - Cleaning up... 05:40:35 INFO - Return code: 0 05:40:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:36 INFO - Reading from file tmpfile_stdout 05:40:36 INFO - Current package versions: 05:40:36 INFO - blessings == 1.6 05:40:36 INFO - blobuploader == 1.2.4 05:40:36 INFO - docopt == 0.6.1 05:40:36 INFO - functools32 == 3.2.3-2 05:40:36 INFO - jsonschema == 2.5.1 05:40:36 INFO - manifestparser == 1.1 05:40:36 INFO - mozInstall == 1.12 05:40:36 INFO - mozcrash == 1.0 05:40:36 INFO - mozdebug == 0.1 05:40:36 INFO - mozdevice == 0.49 05:40:36 INFO - mozfile == 1.2 05:40:36 INFO - mozhttpd == 0.7 05:40:36 INFO - mozinfo == 0.9 05:40:36 INFO - mozleak == 0.1 05:40:36 INFO - mozlog == 3.4 05:40:36 INFO - moznetwork == 0.27 05:40:36 INFO - mozprocess == 0.24 05:40:36 INFO - mozprofile == 0.28 05:40:36 INFO - mozrunner == 6.13 05:40:36 INFO - mozscreenshot == 0.1 05:40:36 INFO - mozsystemmonitor == 0.3 05:40:36 INFO - moztest == 0.8 05:40:36 INFO - mozversion == 1.4 05:40:36 INFO - psutil == 3.1.1 05:40:36 INFO - requests == 1.2.3 05:40:36 INFO - wsgiref == 0.1.2 05:40:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:36 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 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40:36 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 05:40:36 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 05:40:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:36 INFO - 'HOME': '/Users/cltbld', 05:40:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:36 INFO - 'LOGNAME': 'cltbld', 05:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:36 INFO - 'MOZ_NO_REMOTE': '1', 05:40:36 INFO - 'NO_EM_RESTART': '1', 05:40:36 INFO - 'PAGER': '/bin/cat', 05:40:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:36 INFO - 'PWD': '/builds/slave/test', 05:40:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:36 INFO - 'SHELL': '/bin/bash', 05:40:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:36 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:36 INFO - 'USER': 'cltbld', 05:40:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:36 INFO - 'XPC_FLAGS': '0x0', 05:40:36 INFO - 'XPC_SERVICE_NAME': '0', 05:40:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:36 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)) 05:40:36 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)) 05:40:36 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)) 05:40:36 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)) 05:40:36 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)) 05:40:36 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)) 05:40:36 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)) 05:40:36 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)) 05:40:36 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)) 05:40:36 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)) 05:40:36 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)) 05:40:36 INFO - Cleaning up... 05:40:36 INFO - Return code: 0 05:40:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ecb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ef768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da4a69e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, '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.tVjQtCKcOg/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.aRMg31nbIT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 05:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:40:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:36 INFO - 'HOME': '/Users/cltbld', 05:40:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:36 INFO - 'LOGNAME': 'cltbld', 05:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:36 INFO - 'MOZ_NO_REMOTE': '1', 05:40:36 INFO - 'NO_EM_RESTART': '1', 05:40:36 INFO - 'PAGER': '/bin/cat', 05:40:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:36 INFO - 'PWD': '/builds/slave/test', 05:40:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:36 INFO - 'SHELL': '/bin/bash', 05:40:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:36 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:36 INFO - 'USER': 'cltbld', 05:40:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:36 INFO - 'XPC_FLAGS': '0x0', 05:40:36 INFO - 'XPC_SERVICE_NAME': '0', 05:40:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:40:36 INFO - Cleaning up... 05:40:36 INFO - Return code: 0 05:40:36 INFO - Running post-action listener: _resource_record_post_action 05:40:36 INFO - Running post-action listener: _start_resource_monitoring 05:40:36 INFO - Starting resource monitoring. 05:40:36 INFO - [mozharness: 2017-03-02 13:40:36.612874Z] Finished create-virtualenv step (success) 05:40:36 INFO - [mozharness: 2017-03-02 13:40:36.613840Z] Running install step. 05:40:36 INFO - Running pre-action listener: _resource_record_pre_action 05:40:36 INFO - Running main action method: install 05:40:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:36 INFO - Reading from file tmpfile_stdout 05:40:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:40:36 INFO - Reading from file tmpfile_stdout 05:40:36 INFO - Output received: 05:40:36 INFO - Usage: mozinstall [options] installer 05:40:36 INFO - Options: 05:40:36 INFO - -h, --help show this help message and exit 05:40:36 INFO - -d DEST, --destination=DEST 05:40:36 INFO - Directory to install application into. [default: 05:40:36 INFO - "/builds/slave/test"] 05:40:36 INFO - --app=APP Application being installed. [default: firefox] 05:40:36 INFO - mkdir: /builds/slave/test/build/application 05:40:36 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'] 05:40:36 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 05:40:56 INFO - Reading from file tmpfile_stdout 05:40:56 INFO - Output received: 05:40:56 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:40:56 INFO - Running post-action listener: _resource_record_post_action 05:40:56 INFO - [mozharness: 2017-03-02 13:40:56.876494Z] Finished install step (success) 05:40:56 INFO - [mozharness: 2017-03-02 13:40:56.876660Z] Running run-tests step. 05:40:56 INFO - Running pre-action listener: _resource_record_pre_action 05:40:56 INFO - Running main action method: run_tests 05:40:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:40:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:40:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:40:56 INFO - 2017-03-02 05:40:56.891 screenresolution[1632:9328] starting screenresolution argv=screenresolution get 05:40:56 INFO - 2017-03-02 05:40:56.893 screenresolution[1632:9328] Display 0: 1600x1200x32@60 05:40:56 INFO - 2017-03-02 05:40:56.899 screenresolution[1633:9331] starting screenresolution argv=screenresolution list 05:40:56 INFO - Available Modes on Display 0 05:40:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:40:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:40:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:40:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:40:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:40:57 INFO - Intel Iris: 05:40:57 INFO - Chipset Model: Intel Iris 05:40:57 INFO - Type: GPU 05:40:57 INFO - Bus: Built-In 05:40:57 INFO - VRAM (Dynamic, Max): 1536 MB 05:40:57 INFO - Vendor: Intel (0x8086) 05:40:57 INFO - Device ID: 0x0a2e 05:40:57 INFO - Revision ID: 0x0009 05:40:57 INFO - Displays: 05:40:57 INFO - Display: 05:40:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:40:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:40:57 INFO - Display Serial Number: 1600x1200 60 05:40:57 INFO - Main Display: Yes 05:40:57 INFO - Mirror: Off 05:40:57 INFO - Online: Yes 05:40:57 INFO - Rotation: Supported 05:40:57 INFO - Return code: 0 05:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:57 INFO - Python 2.7.3 05:40:57 INFO - Return code: 0 05:40:57 INFO - grabbing minidump binary from tooltool 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:57 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 0x10e5cad30>, '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 0x10e4f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5bfbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:57 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 05:40:57 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 05:40:57 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 05:40:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:57 INFO - Return code: 0 05:40:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:40:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:40:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:57 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/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 05:40:57 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/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0065 --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 05:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tVjQtCKcOg/Render', 05:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:57 INFO - 'HOME': '/Users/cltbld', 05:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:57 INFO - 'LOGNAME': 'cltbld', 05:40:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:57 INFO - 'MOZ_NO_REMOTE': '1', 05:40:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:57 INFO - 'NO_EM_RESTART': '1', 05:40:57 INFO - 'PAGER': '/bin/cat', 05:40:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:57 INFO - 'PWD': '/builds/slave/test', 05:40:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:57 INFO - 'SHELL': '/bin/bash', 05:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aRMg31nbIT/Listeners', 05:40:57 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 05:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:57 INFO - 'USER': 'cltbld', 05:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:57 INFO - 'XPC_FLAGS': '0x0', 05:40:57 INFO - 'XPC_SERVICE_NAME': '0', 05:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:57 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/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 05:40:57 INFO - mozversion application_buildid: 20170302044322 05:40:57 INFO - mozversion application_changeset: 0da8d305ce0072bf900c6d17d5372b907ec72c34 05:40:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:40:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:57 INFO - mozversion application_name: Firefox 05:40:57 INFO - mozversion application_remotingname: firefox-dev 05:40:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:40:57 INFO - mozversion application_vendor: Mozilla 05:40:57 INFO - mozversion application_version: 53.0a2 05:40:57 INFO - mozversion platform_buildid: 20170302044322 05:40:57 INFO - mozversion platform_changeset: 0da8d305ce0072bf900c6d17d5372b907ec72c34 05:40:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:40:57 INFO - mozversion platform_version: 53.0a2 05:40:57 INFO - using testdate: 1488462057 05:40:57 INFO - actual date: 1488462057 05:40:57 INFO - starting webserver on 'localhost:49241' 05:40:57 INFO - SUITE-START | Running 2 tests 05:40:57 INFO - TEST-START | dromaeo_css 05:40:57 INFO - operating with platform_type : mac_ 05:40:57 INFO - Initialising browser for dromaeo_css test... 05:40:57 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp5_nxsY/profile http://localhost:49241/getInfo.html) 05:41:00 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 05:41:00 INFO - PROCESS | 1643 | colorDepth:24 05:41:00 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 05:41:00 INFO - PROCESS | 1643 | __metrics 05:41:00 INFO - PROCESS | 1643 | 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" 05:41:00 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:00 INFO - TEST-INFO | 1643: exit 0 05:41:00 INFO - Browser initialized. 05:41:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:00 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp5_nxsY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:13 INFO - PROCESS | 1646 | RSS: Main: 212508672 05:41:13 INFO - PROCESS | 1646 | 05:44:16 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:44:18 INFO - PROCESS | 1646 | RSS: Main: 351911936 05:44:18 INFO - PROCESS | 1646 | 05:46:02 INFO - PROCESS | 1646 | ************************* 05:46:02 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 05:46:02 INFO - PROCESS | 1646 | 05:46:02 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:46:02 INFO - PROCESS | 1646 | Full stack: 05:46:02 INFO - PROCESS | 1646 | ************************* 05:47:21 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:47:22 INFO - PROCESS | 1646 | RSS: Main: 354934784 05:47:22 INFO - PROCESS | 1646 | 05:50:24 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:50:25 INFO - PROCESS | 1646 | RSS: Main: 323194880 05:50:25 INFO - PROCESS | 1646 | 05:53:27 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:53:27 INFO - PROCESS | 1646 | RSS: Main: 336596992 05:53:27 INFO - PROCESS | 1646 | 05:56:31 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:56:32 INFO - PROCESS | 1646 | RSS: Main: 316510208 05:56:32 INFO - PROCESS | 1646 | 05:59:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:59:35 INFO - PROCESS | 1646 | RSS: Main: 548016128 05:59:35 INFO - PROCESS | 1646 | 05:59:35 INFO - PROCESS | 1646 | __start_tp_report 05:59:35 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 05:59:35 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 05:59:35 INFO - PROCESS | 1646 | |i|pagename|runs| 05:59:35 INFO - PROCESS | 1646 | |0;dojo.html;3302.950455743164;3306.305675808081;3358.3786999405097;3361.680640339167;3410.727141828654;5707.086866101425;5717.2281741964825;5733.684647344405;5739.25389699339;5746.396628354026;5722.313322401307;5746.396628354026;5761.962846687605;5768.538516918647;5802.506786923106;5213.530782229599;5233.816816411427;5240.528352448279;5266.605004624649;5306.867328316804;5173;5188.7146206958605;5189.584833213353;5295.682259064469;5321.201819727053;5226.909236305471;5228.215767634866;5246.973765131169;5247.685138891659;5335.0663633864115;5257.421683614799;5308.548773354231;5318.840434786963;5322.787088516455;5331.466853314676;5200.687958722451;5245.606579506514;5279.181726832308;5279.366476022863;5305.1776974569;5593.133064374988;5614.971925140389;5638.802641907555;5653.717314134276;5716.371199168088;6232.781852635181;6243;6297.33877942814;6302.9369706302805;6314.084457753646;6220.782272620482;6262.091996660504;6284.2458904931245;6303.149074874925;6304.968475157595;5674.546036317085;5708.40061793514;5734.799282025109;5804.187413762077;5869.7652093916195;6185.350538193515;6251.6561589112125;6283.277423096311;6283.560150789401;6289.182406287245;5643;5723.713814309268;6173.259208894961;6196.659183744938;6207.937920620826;6195.4424101831055;6207.782727604512;6246.406591373812;6251.437370636664;6270.811875643647;6104.908426373608;6121.483458747687;6133.346641381322;6144.648177400964;6198.318184999646;6250.9062364064575;6264.154339164245;6267.310595834455;6279.811605651837;6282.748690052346;4919.87700307488;5007.84976450707;5008.323876276656;5022.924656130161;5035.194368901031;4416.646668266531;4448.154850578379;4450.5104438511735;4486.59620634138;4486.932696009562;5758.712064396764;5803.245578074823;5803.82588522345;5825.126231065374;5858.50202732764;6124.808163753463;6154.599951003171;6170.10533472644;6202.34875338092;6256.249250090018;5756.683382413924;5776.075827867521;5788.884222315614;5872.559558033165;5890.410958904161;5303.098473259555;5463.399026107125;5467.015937131355;5471.7264136793;5479.4520547944885;6210.472109870621;6226.470749986121;6231.9688401557705;6276.968615156895;6355.618662880057;6246.281677607133;6258.030005349178;6274.686265686606;6274.937250627618;6295.370462953668;6327.240731112296;6332.936670633235;6334.619922804646;6345.206849143857;6346.7461301549265;6081.695915204134;6106.915739268716;6118.4668989547035;6139.26328840542;6151.800398922167;6144.293406258159;6149.169862068564;6228.906566401417;6240.375962403723;6252.062190671436;5723.942760572341;5913.5564832636865;6097.32929377777;6125.693715314305;6179.969100154471;5984.401559843981;6018.488428483628;6038.275406951194;6081.847953801191;6086.756529738938;5996.160537524837;6008.699565021819;6030.366811484906;6044.90932636002;6057.939420605914;6125.326214116354;6151.661658608819;6158.983767678283;6162.506999440124;6166.691665416801;5764.106563482667;5804.1874137619925;5928.081147422156;5962.4633782959745;5963.970180149072 05:59:35 INFO - PROCESS | 1646 | |1;ext.html;447.9328100784883;483.1327766658845;502.8793089658483;511.1846604665557;532.1379365428007;30878.845605771967;31203.219919502022;42767.78616106923;42856.785716071376;42877.92805179872;44081.77959110208;44393.77803110988;44414.77792611041;44501.554984450144;44563.885902852446;8484.703035393763;9273.582688779004;9472.66845660402;9490.430574165537;9511.904880951206;8438.746837594881;11223.214374993753;11462.484188211509;11475.196736228467;11646.767064658745;11490.540378384854;11578.710532236719;11590.710232244177;11600.535978560847;11627.6511704649;8492.320614350838;8685.782855428602;11414.429278536081;11495.1378646601;11506.539738410496;8561.315094792402;8655.567221638892;11091.057260132899;11340.206185567014;11366.545338186463;41718.58281417208;42118.578814211774;42132;42231.7888410559;42251;3899.395593682984;3919.2161567686294;3929.764214147132;3956.8219430125714;4024.5371782245124;30280.54579181314;30287.365516138205;30331.393372132654;30936.845315773502;31191.064268071994;3055.587495688098;3073.3545955349405;3234.32079263355;3305.9504107438406;3308.6856748608843;455884;455932;456043;457288.7135564334;457824;63465;63983;64055.35944640494;64057.03914441287;64106.71786564336;66973;67023;67067.66466167638;67088.6645566769;67234;16547.503574892773;16580.336786528645;16755;17023.48929532116;17030;11770.470328835223;12017.33904635236;12914.741705165845;13043.739125217633;13046.086773925734;15658.608534786721;17492.562685932953;17810.5547361317;17895.926244425376;18197.63517736175;6588.703508342136;6981.301869812978;7398.519096258726;7428.517146385468;7462.85074298511;873.4540911930044;885.4687187687337;899.2940541674753;907.5326207003399;921.502388710089;29962.25094372658;30214.624730102347;30348.089557313317;30599.847000765298;31117.8444107778;961.6393852305386;1015.827309357411;1051.7475805806705;1152.4122697424207;1206.8129439936824;13223.00827437946;14541.636459088608;14546.781798273034;14696.779548306784;14883.776743348859;400042;400451;402133;402726.98636507214;404887;56185.71907140438;56384.71807640936;56440.43559564434;56457.717711412;56572.71713641405;1402.3689339797131;1436.7485690004207;1440.6614445605273;1443.8267407910698;1446.0167086381573;21690.783092168876;21847.344579662637;27518.862405687843;28190.731417086692;28215;46246.30630540612;46619;46649.06701866011;46742.76628616971;46749.065018700116;342894;343319;343771;343824;344604;25664.61503077418;26095.08667196639;26097.347566310993;45969.31046034245;47398.526014739415;34158.487622685185;41999.1600168001;45727.77136114298;49186;55138.72430637821;40021.79989100036;41968.370474442294;42749.35875961801;43570.34644480399;44040;41411.7929410351;41894.790526047174;42143.789281053396;43171.9207019827;43249.135017300105;39984;40398.39402408907;40835.59164408318;40855.1828963425;40906.79546602248;33892.83053584716;36754.63245367619;36838.89483315505;36895.44656830203;36956;24787.752122478545;25992.35019124537;26273.686315683757;26412.603810942466;26936.730632693423 05:59:35 INFO - PROCESS | 1646 | |2;jquery.html;394.10538078561666;394.14077311461006;396.84919730502406;403.4130340354783;424.9511306199786;13978.720425591482;19864.006799660012;20133.496662583442;21203.151873925042;21231.363059108215;16172.514824555254;16692.41576544821;20333.898330508327;20854.582908341825;21034.78965210351;5720.856978575527;6045.03279475284;6045.244344456943;6045.576809623328;6045.909311360333;5598.300212473441;5713.885722285552;5878.118282257653;5937.139114828347;5965.373635768247;5743.224664670258;5743.684097374643;5746.252987111669;5746.885062298751;5759.049756790125;5572.721363931808;5715.571332150105;5739.885202295952;5747.568932330071;5790.68151251681;5166.07010738067;5170.3278573785165;5173.275741396207;5173.586113110942;5178.508041736067;21090.789092109037;25123.24630261095;25541.74458255412;25993.870030649916;26573.335666608295;2783.4293969736154;2822.6048353230562;2829.221963959907;2830;2830.731080547345;14833.184174870377;15423.768643470357;15497.225138743017;16133.83866161335;16275.348986040544;1597.2333280025653;1654.13984727942;1712.6812354486976;1737.0533059482611;1741.3905133203405;98599;124943.37528312301;126035.36982315121;127713;131147.34426327902;9722.562484688206;11344.489497972447;11872.821907671392;11884.465199066062;12053.276803391824;15992.440264590916;15995.280212390471;16025.439109631106;16045.277962491482;16045.839541604435;7738.922610773933;8076.27313541784;8093.878591821127;8415.242628163494;8650.567471626393;8667.609957551926;8682.131786821268;8775.254103401156;8780.473171609723;8928.464292142493;3964.077422450167;4837.637177211724;4837.95162048375;4838.371011768448;4925;1806.8893267815824;1887.6413481438483;2024.230792298917;2025.5037515808426;2074.0666699985068;997.755549890267;1014.2342531388754;1018.0707559175469;1031.2214278220047;1070.8929107089384;19813.405597832087;21498.387620928494;21699.78300217009;21799.891000544896;21943.122275108817;1034.1623285139062;1043.1498328862106;1072.6299426697776;1079.3254216114929;1089.2212068371152;10586.52360643773;10595.84106238407;10605.409188621768;11225.270357426742;11396.088312934946;560651;584915;592334;600927;745969;117408.41295793466;124548;137244;146729;151538;841.4446465332851;1022.6216299969208;1062.5696592879897;1062.6015244283394;1065.9786804263872;18914;19397.4180774577;19826.40520784379;19828.206871724968;19829;55697.721511392185;57272.71363643155;57765.422345776;57816.71091644515;59393;81646.59176704078;82584.58707706424;83472.90480308999;86180.13819861972;89030.10969890218;7808.258215469521;8245.876311855207;8343.290820280345;8467.49195048299;8544.786380340542;9088.454692718458;10608.840867386842;11534.769304614028;12562.685932851751;12661.74676506483;8806.647734090564;10722.410267435365;10798.136149107895;11123.94438027837;11214.887851121384;9385.483798391155;10145.543450544596;10863.891361086287;11109.50007249692;11174.608888688857;10907.563697452331;10960.177986650873;10973.23187376876;11022.559097636326;11103.082971651718;7269.382102521345;7569.848603028019;8155.673773049011;8261.958690206511;8564.785880352792;9305.813883722423;10875.238733288594;11040.779184416106;11208.887911120784;11344.092472602337 05:59:35 INFO - PROCESS | 1646 | |3;mootools.html;1421.5095791951774;1450.9637259068522;1460.591034510337;1469.77953307004;1473.1014081410342;8125.146859579748;8529.78675533112;8530.616122274498;8531.189536993976;8533.104024077467;7525.322720955113;7714.305712485875;7726.266004729542;8085.474444161126;8324.62539185738;2244.7979681828633;2292.90828366866;2294.2314324701247;2294.5755035318434;2300.5053913408615;2235.575240704261;2258.841881068326;2271.3640180749335;2273.329367836492;2273.4998300373973;2301.620232661609;2312.1791763923816;2318.4435735423463;2345.003373566236;2346.9530609387803;2268.126771193094;2295;2306.342692332677;2314.93055208344;2320.037184568402;1935.7193206985048;2282.2468585366955;2339.157903154863;2344.6834677318684;2346.0498498108295;8357;8441;8443.282321002722;8450.19723126302;8455.492670439793;4974.7512624369;5143.588512918957;5146.8934179151665;5148.124818780816;5148.150555158394;2860.5137126688514;3305.7190138838228;3329.6681327468964;3442.6901578858024;3500.527428797105;999.6001599360242;1183.1836033137108;1192.749522600255;1219.1039585904352;1232.3591732299244;10694.946525267324;10738.516766745515;10857.782844343148;10890.455477226107;10912.181586381053;4425.955740442554;4546;4637.350770892078;4643.187442197602;4696.553827386393;9499.810003800023;9519.666811661558;9532.046795320552;9532.999035101353;9543.713688589354;5194.662346947436;5197.58419326453;5200.843974680765;5205.531502164823;5205.6616319939085;3886.455896174538;4204.096119334296;4579.862604121881;4651.720896746206;4729.787159577827;3879.650831425185;3890.96109038906;3962.623550762673;3980.7810570418906;3998.2203470323007;1259.1689484939895;1271.3261971155302;1271.9300438475786;1286.041898785411;1286.8455785305823;864.39223045136;887.9200871921429;889.1597440418742;901.9864702029474;905.8958219804807;4058.370952502367;4991.627302491844;5294.152935530374;5610.438956104438;5622.803201887996;549.1022178737712;562.8142712904731;568.0371769850148;568.0853825341197;570.589175793428;3662.6154253802965;3666.7066634669695;3683.594804571495;3687.483752274684;3785.905352366158;9820.705378838646;10048.949755251177;10181.694549163536;10184.898151018544;10188.541515631814;9866.851997220047;9967.501624918725;10018.899811001942;10158.39049657023;10165.288429809842;7836.608169591497;7838.804029899298;7899.644515996794;8154.796130096795;8168.264856162974;5006.824761133343;5132.5124113209185;5141.7686204120155;5183.792648294026;5331.573474121983;9069.956954950001;9203.539823008956;9240.95379523098;9315.161635452841;9337.57980890848;9075.954620226856;9309.348345615741;9391.107844754737;9496.762580935532;9638;6709.832254193684;6916.066331045245;6917.688704008231;7148.606826624586;7436.516626419266;7747.2640099190485;7917.366610671248;7953.761387158394;8047.758567242992;8055.476394034369;6799.694013769294;7007.544509606859;7129.0751497096535;7191.065161528968;7220.602866842374;6972.4073453757;6989.405900498311;6996.720131194696;7023.297670232936;7131.144262688511;6373.362663733589;6379.553431259767;6475.514336424692;6477.125588045554;6478.5141114415665;4917.385326834145;4960.30555722192;4972.5027497249985;4990.875228119181;5024.598032157345;4861.465238823797;4907.2393778964315;4941.555260026471;5063.620228482952;5188.092083885381 05:59:35 INFO - PROCESS | 1646 | |4;prototype.html;314.5706111158267;349.11151120398586;356.0813102196334;364.56616626214793;374.9906252343693;4945.554900058994;5007.798128449173;5042.924356134657;5246.7638956246965;5273.730287221923;4284.978575107128;4497.685162038659;5043.117454445466;5186.910748742768;5229.568250763395;3350.782199157059;3815.8855234343014;4021.155557332964;4023.476947996771;4023.8189281482405;3279.3930973822894;3700.5761226396753;3960.3663413853787;3987.461692671481;4034.9798251008706;3771.1514909145358;3930.724849260553;3931.095847954972;3965.286248475273;3985.442038114652;3347.7656564040526;3518.9120271993147;3959.2873282809082;4001.199760048002;4008.7594744315143;2862.7137286271413;3293.5883014623173;3366.73066154707;3423.3666771647077;3442.913927151816;4033.3546632538946;4216.831326746927;5010.448850626464;5118.513741194581;5127.6154288428515;3622.728295377831;3864.1498870248784;4193;4553.453585569753;4587;4849.884526558912;5231;5467.890642187134;5497.367802702701;5562.888742225133;3754.699624030071;3756.492873462075;3768.773873567595;3769.1896242308035;3784.7161462890117;4411.448568928884;5282.366116066097;5569.916451253234;5796.782785554015;5856;3720.311742327678;3814.408766641175;3842.769433833979;3876.7673939563715;3881;3533.911652208715;3641.8725344612812;3863.199180594047;3899;3913.3542965410957;4383.101464199832;4507.5267096955;4513.435820522434;4513.661475389359;4525.818967241339;4881.707097574157;4893.926591101136;5068.493150684902;5570.108782594765;5595.63628364155;1189.7798907202196;1253.5361916091106;1265.7405231927432;1266.7395941038542;1273.7898246789362;740.8110931712379;755.2372104174823;830.4933990265932;865.264525153627;867.8240983467437;4879.414470263591;4888.242322440027;4906.165951788204;4937.753112344369;4937.851864444073;5330.908073317467;5490.6431081979545;5500.50495455411;5582.190582365534;5637.577181711388;4954.331165292711;5160.819371322061;5168.3539557555305;5178.766955487012;5205.9219111713355;2202.6233603997503;2567.833090849089;2715.022591866926;2812.4953150064616;2900.9564856527168;5096.904165604413;5400.297961265011;5504.284443022381;5616.943830561724;5617.073182924853;5095.949040509621;5111.233315002779;5171.50870667286;5185.274061631375;5553.278073850454;4583.708145927037;4996.075725990703;5265.894162225899;5307.734613269321;5583.35791383996;4493.528179541232;4518.977405112953;4930.728809915489;5019.824306149413;5348.582625604296;4467.955320446754;5344;5384.703841288767;5385.299911011543;5397.867842202387;4612.769361531977;4649.604783593432;4657.86026419208;5570.387257401763;5617.719114044363;3195.66445523226;3598.028532296213;3630.8729194478065;3648.726345524043;3657.6159503251774;4747.548982846624;4788.515560176356;5036.924446133385;5392.973035134799;5472.753726082416;4407.955920440754;4560.931586026146;4910.82812101589;5017.899642007066;5234.414426118121;4685.6017238535105;4705.1885024266585;5055.368078990126;5231.346081739783;5317.175837745156;4738.644601654959;4960.72716000609;5133.435322114489;5144.202648589475;5148.97425512885;4614.561616646413;4867.269909513601;5040.5967522597375;5253.973730131325;5286.81496147633;4596.793144308581;4652.953470465252;4863.367762191034;5084.771185296597;5268.6575372600655 05:59:35 INFO - PROCESS | 1646 | |5;yui.html;702.9771980483918;710.9004739336491;754.5849782619562;769.5421224371498;853.4452605806223;14000.299985000747;14784.039037462557;14792.704145917076;14955.850441495582;14969.10185388876;13498.92008639309;13620.795688064687;13626.727465450685;13667.316634168277;15010.324535395906;819.2053707903324;841.9579021048954;847.8643417053273;848.5248260973874;848.749618862437;843.9873401898976;845.5729856422529;846.272205902923;846.5555583318745;847.3560094328324;897.4391005621486;898.4160295807744;899.2176806178601;899.8335307968014;899.9865002024975;894.8344556257081;895.3419236860902;895.7491902267376;897.0580890065405;897.0804924951912;663.5786275714908;663.9933600663979;665.0888283052201;665.3845193196274;665.7203974330793;14808.925955370261;14840.554783356409;14848.183349915751;14849.851501484954;14865.628359290997;13650.385732642055;13663.521776737767;13853.046327649901;13919.30403479832;14109.576712698636;11376.886231137665;11412.258203216765;11562.826557601642;11569.710757231136;11667.45653637972;3631.1285291529844;3634.182308980485;3678.503402040717;3701.5188025556504;3815.7138214634015;73800.63099684467;85565;112370;112837;113685;10160.390376577428;10293.43386113771;10298.588056477807;10453.21600879937;10591.470426478645;22068;22248.110075596796;22375.881205939637;22408.43978900508;22484.213052543084;7305.4155667546465;7504.437167212372;7551.962240188764;7693.884591731128;7801.531908085533;4120.196561670446;4313.547077556874;4313.9137217255475;4324.308110702273;4428.446444194476;3438.2263990601914;3485.721142308609;3487.05849420655;3487.494313324554;3494.930101397958;612.0788213738384;617.6232498176109;630.196499463179;641.1280658304702;644.4264604501997;664.8271449423185;690.3338278561213;697.0728930522394;704.5350068954466;731.3856360657073;8736.213740763362;9448.433094014244;9867.30928834989;10225.488725563691;10308;560.201712559601;580.9390014048548;582.2140110850319;582.3419535924378;586.2642383808293;4603.286490593963;4886.120498310338;4892.8532144035735;4895.681780684244;4898.387701537308;84594.5770271157;93656;104177;105874.47062764637;107042;61770.69114654488;64543;65489.67255163693;80381.59809201033;87279;77108.61445692736;79720;79765;81056.9735756599;83865.58067209747;10572.41851698164;10663.758459447017;10716.19628527848;10858.294210876267;11042.33745975244;43372.34941475943;50749.492505075956;51021.48978510316;51314.71728112948;52457;63333;67463;69643;69735;71433;12621.242725436503;12659.177153484994;12756.425960831599;12889.935550322189;13344.599662010156;13942.58172254834;14039.578812635636;14105.365258563184;14431.556844315484;14996.025258358171;12785.48858045705;13224.669383265495;13486;13520.459181632625;13626.523071692443;12536.435860386122;12580.748385032066;12960.481580737041;13380.93309533485;13519.932400337935;13079.738405231652;13133.737325253633;13187.472501100232;13285.601431957057;13655.907527397983;10623.415712135908;10670.946645266724;11136.610218642309;11153.776924461303;11222.88777112251;9258.629654814002;9539.618415263312;9871.753206169904;10911.781764364827;11086.778264434504 05:59:35 INFO - PROCESS | 1646 | __end_tp_report 05:59:35 INFO - PROCESS | 1646 | __start_cc_report 05:59:35 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1537 05:59:35 INFO - PROCESS | 1646 | __end_cc_report 05:59:35 INFO - PROCESS | 1646 | __startTimestamp1488463175373__endTimestamp 05:59:35 INFO - PROCESS | 1646 | 05:59:35 INFO - PROCESS | 1646 | ------- Summary: start ------- 05:59:35 INFO - PROCESS | 1646 | Number of tests: 6 05:59:35 INFO - PROCESS | 1646 | 05:59:35 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5757.68 Median:5962.46 stddev:624.53 (10.5%) stddev-sans-first:596.02 05:59:35 INFO - PROCESS | 1646 | Values: 3303.0 3306.3 3358.4 3361.7 3410.7 5707.1 5717.2 5733.7 5739.3 5746.4 5722.3 5746.4 5762.0 5768.5 5802.5 5213.5 5233.8 5240.5 5266.6 5306.9 5173.0 5188.7 5189.6 5295.7 5321.2 5226.9 5228.2 5247.0 5247.7 5335.1 5257.4 5308.5 5318.8 5322.8 5331.5 5200.7 5245.6 5279.2 5279.4 5305.2 5593.1 5615.0 5638.8 5653.7 5716.4 6232.8 6243.0 6297.3 6302.9 6314.1 6220.8 6262.1 6284.2 6303.1 6305.0 5674.5 5708.4 5734.8 5804.2 5869.8 6185.4 6251.7 6283.3 6283.6 6289.2 5643.0 5723.7 6173.3 6196.7 6207.9 6195.4 6207.8 6246.4 6251.4 6270.8 6104.9 6121.5 6133.3 6144.6 6198.3 6250.9 6264.2 6267.3 6279.8 6282.7 4919.9 5007.8 5008.3 5022.9 5035.2 4416.6 4448.2 4450.5 4486.6 4486.9 5758.7 5803.2 5803.8 5825.1 5858.5 6124.8 6154.6 6170.1 6202.3 6256.2 5756.7 5776.1 5788.9 5872.6 5890.4 5303.1 5463.4 5467.0 5471.7 5479.5 6210.5 6226.5 6232.0 6277.0 6355.6 6246.3 6258.0 6274.7 6274.9 6295.4 6327.2 6332.9 6334.6 6345.2 6346.7 6081.7 6106.9 6118.5 6139.3 6151.8 6144.3 6149.2 6228.9 6240.4 6252.1 5723.9 5913.6 6097.3 6125.7 6180.0 5984.4 6018.5 6038.3 6081.8 6086.8 5996.2 6008.7 6030.4 6044.9 6057.9 6125.3 6151.7 6159.0 6162.5 6166.7 5764.1 5804.2 5928.1 5962.5 5964.0 05:59:35 INFO - PROCESS | 1646 | 05:59:35 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:56842.05 Median:220031.90 stddev:106469.99 (48.4%) stddev-sans-first:106684.47 05:59:35 INFO - PROCESS | 1646 | Values: 447.9 483.1 502.9 511.2 532.1 30878.8 31203.2 42767.8 42856.8 42877.9 44081.8 44393.8 44414.8 44501.6 44563.9 8484.7 9273.6 9472.7 9490.4 9511.9 8438.7 11223.2 11462.5 11475.2 11646.8 11490.5 11578.7 11590.7 11600.5 11627.7 8492.3 8685.8 11414.4 11495.1 11506.5 8561.3 8655.6 11091.1 11340.2 11366.5 41718.6 42118.6 42132.0 42231.8 42251.0 3899.4 3919.2 3929.8 3956.8 4024.5 30280.5 30287.4 30331.4 30936.8 31191.1 3055.6 3073.4 3234.3 3306.0 3308.7 455884.0 455932.0 456043.0 457288.7 457824.0 63465.0 63983.0 64055.4 64057.0 64106.7 66973.0 67023.0 67067.7 67088.7 67234.0 16547.5 16580.3 16755.0 17023.5 17030.0 11770.5 12017.3 12914.7 13043.7 13046.1 15658.6 17492.6 17810.6 17895.9 18197.6 6588.7 6981.3 7398.5 7428.5 7462.9 873.5 885.5 899.3 907.5 921.5 29962.3 30214.6 30348.1 30599.8 31117.8 961.6 1015.8 1051.7 1152.4 1206.8 13223.0 14541.6 14546.8 14696.8 14883.8 400042.0 400451.0 402133.0 402727.0 404887.0 56185.7 56384.7 56440.4 56457.7 56572.7 1402.4 1436.7 1440.7 1443.8 1446.0 21690.8 21847.3 27518.9 28190.7 28215.0 46246.3 46619.0 46649.1 46742.8 46749.1 342894.0 343319.0 343771.0 343824.0 344604.0 25664.6 26095.1 26097.3 45969.3 47398.5 34158.5 41999.2 45727.8 49186.0 55138.7 40021.8 41968.4 42749.4 43570.3 44040.0 41411.8 41894.8 42143.8 43171.9 43249.1 39984.0 40398.4 40835.6 40855.2 40906.8 33892.8 36754.6 36838.9 36895.4 36956.0 24787.8 25992.4 26273.7 26412.6 26936.7 05:59:35 INFO - PROCESS | 1646 | 05:59:35 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:36241.74 Median:21749.84 stddev:103792.57 (477.2%) stddev-sans-first:104048.83 05:59:35 INFO - PROCESS | 1646 | Values: 394.1 394.1 396.8 403.4 425.0 13978.7 19864.0 20133.5 21203.2 21231.4 16172.5 16692.4 20333.9 20854.6 21034.8 5720.9 6045.0 6045.2 6045.6 6045.9 5598.3 5713.9 5878.1 5937.1 5965.4 5743.2 5743.7 5746.3 5746.9 5759.0 5572.7 5715.6 5739.9 5747.6 5790.7 5166.1 5170.3 5173.3 5173.6 5178.5 21090.8 25123.2 25541.7 25993.9 26573.3 2783.4 2822.6 2829.2 2830.0 2830.7 14833.2 15423.8 15497.2 16133.8 16275.3 1597.2 1654.1 1712.7 1737.1 1741.4 98599.0 124943.4 126035.4 127713.0 131147.3 9722.6 11344.5 11872.8 11884.5 12053.3 15992.4 15995.3 16025.4 16045.3 16045.8 7738.9 8076.3 8093.9 8415.2 8650.6 8667.6 8682.1 8775.3 8780.5 8928.5 3964.1 4837.6 4838.0 4838.4 4925.0 1806.9 1887.6 2024.2 2025.5 2074.1 997.8 1014.2 1018.1 1031.2 1070.9 19813.4 21498.4 21699.8 21799.9 21943.1 1034.2 1043.1 1072.6 1079.3 1089.2 10586.5 10595.8 10605.4 11225.3 11396.1 560651.0 584915.0 592334.0 600927.0 745969.0 117408.4 124548.0 137244.0 146729.0 151538.0 841.4 1022.6 1062.6 1062.6 1066.0 18914.0 19397.4 19826.4 19828.2 19829.0 55697.7 57272.7 57765.4 57816.7 59393.0 81646.6 82584.6 83472.9 86180.1 89030.1 7808.3 8245.9 8343.3 8467.5 8544.8 9088.5 10608.8 11534.8 12562.7 12661.7 8806.6 10722.4 10798.1 11123.9 11214.9 9385.5 10145.5 10863.9 11109.5 11174.6 10907.6 10960.2 10973.2 11022.6 11103.1 7269.4 7569.8 8155.7 8262.0 8564.8 9305.8 10875.2 11040.8 11208.9 11344.1 05:59:35 INFO - PROCESS | 1646 | 05:59:35 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5404.65 Median:5142.68 stddev:3002.01 (58.4%) stddev-sans-first:2995.51 05:59:35 INFO - PROCESS | 1646 | Values: 1421.5 1451.0 1460.6 1469.8 1473.1 8125.1 8529.8 8530.6 8531.2 8533.1 7525.3 7714.3 7726.3 8085.5 8324.6 2244.8 2292.9 2294.2 2294.6 2300.5 2235.6 2258.8 2271.4 2273.3 2273.5 2301.6 2312.2 2318.4 2345.0 2347.0 2268.1 2295.0 2306.3 2314.9 2320.0 1935.7 2282.2 2339.2 2344.7 2346.0 8357.0 8441.0 8443.3 8450.2 8455.5 4974.8 5143.6 5146.9 5148.1 5148.2 2860.5 3305.7 3329.7 3442.7 3500.5 999.6 1183.2 1192.7 1219.1 1232.4 10694.9 10738.5 10857.8 10890.5 10912.2 4426.0 4546.0 4637.4 4643.2 4696.6 9499.8 9519.7 9532.0 9533.0 9543.7 5194.7 5197.6 5200.8 5205.5 5205.7 3886.5 4204.1 4579.9 4651.7 4729.8 3879.7 3891.0 3962.6 3980.8 3998.2 1259.2 1271.3 1271.9 1286.0 1286.8 864.4 887.9 889.2 902.0 905.9 4058.4 4991.6 5294.2 5610.4 5622.8 549.1 562.8 568.0 568.1 570.6 3662.6 3666.7 3683.6 3687.5 3785.9 9820.7 10048.9 10181.7 10184.9 10188.5 9866.9 9967.5 10018.9 10158.4 10165.3 7836.6 7838.8 7899.6 8154.8 8168.3 5006.8 5132.5 5141.8 5183.8 5331.6 9070.0 9203.5 9241.0 9315.2 9337.6 9076.0 9309.3 9391.1 9496.8 9638.0 6709.8 6916.1 6917.7 7148.6 7436.5 7747.3 7917.4 7953.8 8047.8 8055.5 6799.7 7007.5 7129.1 7191.1 7220.6 6972.4 6989.4 6996.7 7023.3 7131.1 6373.4 6379.6 6475.5 6477.1 6478.5 4917.4 4960.3 4972.5 4990.9 5024.6 4861.5 4907.2 4941.6 5063.6 5188.1 05:59:35 INFO - PROCESS | 1646 | 05:59:35 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4279.78 Median:4768.03 stddev:1289.75 (27.1%) stddev-sans-first:1258.57 05:59:35 INFO - PROCESS | 1646 | Values: 314.6 349.1 356.1 364.6 375.0 4945.6 5007.8 5042.9 5246.8 5273.7 4285.0 4497.7 5043.1 5186.9 5229.6 3350.8 3815.9 4021.2 4023.5 4023.8 3279.4 3700.6 3960.4 3987.5 4035.0 3771.2 3930.7 3931.1 3965.3 3985.4 3347.8 3518.9 3959.3 4001.2 4008.8 2862.7 3293.6 3366.7 3423.4 3442.9 4033.4 4216.8 5010.4 5118.5 5127.6 3622.7 3864.1 4193.0 4553.5 4587.0 4849.9 5231.0 5467.9 5497.4 5562.9 3754.7 3756.5 3768.8 3769.2 3784.7 4411.4 5282.4 5569.9 5796.8 5856.0 3720.3 3814.4 3842.8 3876.8 3881.0 3533.9 3641.9 3863.2 3899.0 3913.4 4383.1 4507.5 4513.4 4513.7 4525.8 4881.7 4893.9 5068.5 5570.1 5595.6 1189.8 1253.5 1265.7 1266.7 1273.8 740.8 755.2 830.5 865.3 867.8 4879.4 4888.2 4906.2 4937.8 4937.9 5330.9 5490.6 5500.5 5582.2 5637.6 4954.3 5160.8 5168.4 5178.8 5205.9 2202.6 2567.8 2715.0 2812.5 2901.0 5096.9 5400.3 5504.3 5616.9 5617.1 5095.9 5111.2 5171.5 5185.3 5553.3 4583.7 4996.1 5265.9 5307.7 5583.4 4493.5 4519.0 4930.7 5019.8 5348.6 4468.0 5344.0 5384.7 5385.3 5397.9 4612.8 4649.6 4657.9 5570.4 5617.7 3195.7 3598.0 3630.9 3648.7 3657.6 4747.5 4788.5 5036.9 5393.0 5472.8 4408.0 4560.9 4910.8 5017.9 5234.4 4685.6 4705.2 5055.4 5231.3 5317.2 4738.6 4960.7 5133.4 5144.2 5149.0 4614.6 4867.3 5040.6 5254.0 5286.8 4596.8 4653.0 4863.4 5084.8 5268.7 05:59:35 INFO - PROCESS | 1646 | 05:59:35 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19708.42 Median:4216.87 stddev:27977.05 (663.5%) stddev-sans-first:28019.14 05:59:35 INFO - PROCESS | 1646 | Values: 703.0 710.9 754.6 769.5 853.4 14000.3 14784.0 14792.7 14955.9 14969.1 13498.9 13620.8 13626.7 13667.3 15010.3 819.2 842.0 847.9 848.5 848.7 844.0 845.6 846.3 846.6 847.4 897.4 898.4 899.2 899.8 900.0 894.8 895.3 895.7 897.1 897.1 663.6 664.0 665.1 665.4 665.7 14808.9 14840.6 14848.2 14849.9 14865.6 13650.4 13663.5 13853.0 13919.3 14109.6 11376.9 11412.3 11562.8 11569.7 11667.5 3631.1 3634.2 3678.5 3701.5 3815.7 73800.6 85565.0 112370.0 112837.0 113685.0 10160.4 10293.4 10298.6 10453.2 10591.5 22068.0 22248.1 22375.9 22408.4 22484.2 7305.4 7504.4 7552.0 7693.9 7801.5 4120.2 4313.5 4313.9 4324.3 4428.4 3438.2 3485.7 3487.1 3487.5 3494.9 612.1 617.6 630.2 641.1 644.4 664.8 690.3 697.1 704.5 731.4 8736.2 9448.4 9867.3 10225.5 10308.0 560.2 580.9 582.2 582.3 586.3 4603.3 4886.1 4892.9 4895.7 4898.4 84594.6 93656.0 104177.0 105874.5 107042.0 61770.7 64543.0 65489.7 80381.6 87279.0 77108.6 79720.0 79765.0 81057.0 83865.6 10572.4 10663.8 10716.2 10858.3 11042.3 43372.3 50749.5 51021.5 51314.7 52457.0 63333.0 67463.0 69643.0 69735.0 71433.0 12621.2 12659.2 12756.4 12889.9 13344.6 13942.6 14039.6 14105.4 14431.6 14996.0 12785.5 13224.7 13486.0 13520.5 13626.5 12536.4 12580.7 12960.5 13380.9 13519.9 13079.7 13133.7 13187.5 13285.6 13655.9 10623.4 10670.9 11136.6 11153.8 11222.9 9258.6 9539.6 9871.8 10911.8 11086.8 05:59:35 INFO - PROCESS | 1646 | -------- Summary: end -------- 05:59:35 INFO - PROCESS | 1646 | 05:59:36 INFO - TEST-INFO | 1646: exit 0 05:59:36 INFO - TEST-OK | dromaeo_css | took 1118540ms 05:59:36 INFO - TEST-START | kraken 05:59:36 INFO - operating with platform_type : mac_ 05:59:36 INFO - Initialising browser for kraken test... 05:59:36 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpkwF2g3/profile http://localhost:49241/getInfo.html) 05:59:38 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 05:59:38 INFO - PROCESS | 1651 | colorDepth:24 05:59:38 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 05:59:38 INFO - PROCESS | 1651 | __metrics 05:59:38 INFO - PROCESS | 1651 | 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" 05:59:38 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:39 INFO - TEST-INFO | 1651: exit 0 05:59:39 INFO - Browser initialized. 05:59:39 INFO - Running cycle 1/1 for kraken test... 05:59:39 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpkwF2g3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:51 INFO - PROCESS | 1652 | RSS: Main: 212566016 05:59:51 INFO - PROCESS | 1652 | 05:59:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:54 INFO - PROCESS | 1652 | RSS: Main: 265056256 05:59:54 INFO - PROCESS | 1652 | 05:59:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:59:58 INFO - PROCESS | 1652 | RSS: Main: 274202624 05:59:58 INFO - PROCESS | 1652 | 06:00:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 06:00:01 INFO - PROCESS | 1652 | RSS: Main: 370413568 06:00:01 INFO - PROCESS | 1652 | 06:00:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 06:00:04 INFO - PROCESS | 1652 | RSS: Main: 275206144 06:00:04 INFO - PROCESS | 1652 | 06:00:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:07 INFO - PROCESS | 1652 | RSS: Main: 276537344 06:00:07 INFO - PROCESS | 1652 | 06:00:09 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:10 INFO - PROCESS | 1652 | RSS: Main: 317591552 06:00:10 INFO - PROCESS | 1652 | 06:00:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:14 INFO - PROCESS | 1652 | RSS: Main: 317550592 06:00:14 INFO - PROCESS | 1652 | 06:00:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 06:00:17 INFO - PROCESS | 1652 | RSS: Main: 316956672 06:00:17 INFO - PROCESS | 1652 | 06:00:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:19 INFO - PROCESS | 1652 | RSS: Main: 294293504 06:00:19 INFO - PROCESS | 1652 | 06:00:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:22 INFO - PROCESS | 1652 | RSS: Main: 297299968 06:00:22 INFO - PROCESS | 1652 | 06:00:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:25 INFO - PROCESS | 1652 | RSS: Main: 302235648 06:00:25 INFO - PROCESS | 1652 | 06:00:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:28 INFO - PROCESS | 1652 | RSS: Main: 308457472 06:00:28 INFO - PROCESS | 1652 | 06:00:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:32 INFO - PROCESS | 1652 | RSS: Main: 309727232 06:00:32 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 06:00:34 INFO - PROCESS | 1652 | RSS: Main: 353947648 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | __start_tp_report 06:00:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 06:00:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 06:00:34 INFO - PROCESS | 1652 | |i|pagename|runs| 06:00:34 INFO - PROCESS | 1652 | |0;ai-astar;114;114;113;113;112;112;114;112;113;113 06:00:34 INFO - PROCESS | 1652 | |1;audio-beat-detection;146;130;144;144;110;123;108;110;129;109 06:00:34 INFO - PROCESS | 1652 | |2;audio-dft;185;186;182;185;186;182;183;182;184;183 06:00:34 INFO - PROCESS | 1652 | |3;audio-fft;83;58;58;89;59;58;58;61;88;80 06:00:34 INFO - PROCESS | 1652 | |4;audio-oscillator;86;69;83;66;67;71;82;68;69;82 06:00:34 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;87;84;87;87;93;84;87;85;88;84 06:00:34 INFO - PROCESS | 1652 | |6;imaging-darkroom;93;93;113;159;146;94;94;94;94;93 06:00:34 INFO - PROCESS | 1652 | |7;imaging-desaturate;88;87;86;86;85;93;130;123;88;88 06:00:34 INFO - PROCESS | 1652 | |8;json-parse-financial;57;54;54;54;54;56;58;57;58;57 06:00:34 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;67;72;83;64;68;70;97;108;70;70 06:00:34 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;83;84;86;86;86;82;87;83;89;109 06:00:34 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;138;137;137;149;146;131;137;150;156;139 06:00:34 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;188;228;183;162;169;167;166;166;164;165 06:00:34 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;66;67;66;65;66;65;64;65;64;64 06:00:34 INFO - PROCESS | 1652 | __end_tp_report 06:00:34 INFO - PROCESS | 1652 | __start_cc_report 06:00:34 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1965 06:00:34 INFO - PROCESS | 1652 | __end_cc_report 06:00:34 INFO - PROCESS | 1652 | __startTimestamp1488463234317__endTimestamp 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | ------- Summary: start ------- 06:00:34 INFO - PROCESS | 1652 | Number of tests: 14 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 06:00:34 INFO - PROCESS | 1652 | Values: 114.0 114.0 113.0 113.0 112.0 112.0 114.0 112.0 113.0 113.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:129.50 stddev:15.64 (12.1%) stddev-sans-first:14.69 06:00:34 INFO - PROCESS | 1652 | Values: 146.0 130.0 144.0 144.0 110.0 123.0 108.0 110.0 129.0 109.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.62 (0.9%) stddev-sans-first:1.66 06:00:34 INFO - PROCESS | 1652 | Values: 185.0 186.0 182.0 185.0 186.0 182.0 183.0 182.0 184.0 183.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:69.20 Median:70.50 stddev:13.85 (19.6%) stddev-sans-first:13.76 06:00:34 INFO - PROCESS | 1652 | Values: 83.0 58.0 58.0 89.0 59.0 58.0 58.0 61.0 88.0 80.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:74.30 Median:76.50 stddev:7.89 (10.3%) stddev-sans-first:7.14 06:00:34 INFO - PROCESS | 1652 | Values: 86.0 69.0 83.0 66.0 67.0 71.0 82.0 68.0 69.0 82.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:2.72 (3.1%) stddev-sans-first:2.88 06:00:34 INFO - PROCESS | 1652 | Values: 87.0 84.0 87.0 87.0 93.0 84.0 87.0 85.0 88.0 84.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:107.30 Median:93.50 stddev:24.77 (26.5%) stddev-sans-first:25.73 06:00:34 INFO - PROCESS | 1652 | Values: 93.0 93.0 113.0 159.0 146.0 94.0 94.0 94.0 94.0 93.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:87.50 stddev:16.61 (19.0%) stddev-sans-first:17.41 06:00:34 INFO - PROCESS | 1652 | Values: 88.0 87.0 86.0 86.0 85.0 93.0 130.0 123.0 88.0 88.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:1.73 (3.0%) stddev-sans-first:1.79 06:00:34 INFO - PROCESS | 1652 | Values: 57.0 54.0 54.0 54.0 54.0 56.0 58.0 57.0 58.0 57.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:70.00 stddev:14.60 (20.9%) stddev-sans-first:15.04 06:00:34 INFO - PROCESS | 1652 | Values: 67.0 72.0 83.0 64.0 68.0 70.0 97.0 108.0 70.0 70.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:86.00 stddev:7.85 (9.1%) stddev-sans-first:8.15 06:00:34 INFO - PROCESS | 1652 | Values: 83.0 84.0 86.0 86.0 86.0 82.0 87.0 83.0 89.0 109.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:142.50 stddev:7.79 (5.5%) stddev-sans-first:8.13 06:00:34 INFO - PROCESS | 1652 | Values: 138.0 137.0 137.0 149.0 146.0 131.0 137.0 150.0 156.0 139.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:168.00 stddev:20.24 (12.0%) stddev-sans-first:20.98 06:00:34 INFO - PROCESS | 1652 | Values: 188.0 228.0 183.0 162.0 169.0 167.0 166.0 166.0 164.0 165.0 06:00:34 INFO - PROCESS | 1652 | 06:00:34 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.05 06:00:34 INFO - PROCESS | 1652 | Values: 66.0 67.0 66.0 65.0 66.0 65.0 64.0 65.0 64.0 64.0 06:00:34 INFO - PROCESS | 1652 | -------- Summary: end -------- 06:00:34 INFO - PROCESS | 1652 | 06:00:35 INFO - TEST-INFO | 1652: exit 0 06:00:35 INFO - TEST-OK | kraken | took 59189ms 06:00:35 INFO - SUITE-END | took 1177s 06:00:35 INFO - Completed test suite (00:19:37) 06:00:35 INFO - javascript benchmark 06:00:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.950455743164, 3306.305675808081, 3358.3786999405097, 3361.680640339167, 3410.727141828654, 5707.086866101425, 5717.2281741964825, 5733.684647344405, 5739.25389699339, 5746.396628354026, 5722.313322401307, 5746.396628354026, 5761.962846687605, 5768.538516918647, 5802.506786923106, 5213.530782229599, 5233.816816411427, 5240.528352448279, 5266.605004624649, 5306.867328316804, 5173.0, 5188.7146206958605, 5189.584833213353, 5295.682259064469, 5321.201819727053, 5226.909236305471, 5228.215767634866, 5246.973765131169, 5247.685138891659, 5335.0663633864115, 5257.421683614799, 5308.548773354231, 5318.840434786963, 5322.787088516455, 5331.466853314676, 5200.687958722451, 5245.606579506514, 5279.181726832308, 5279.366476022863, 5305.1776974569, 5593.133064374988, 5614.971925140389, 5638.802641907555, 5653.717314134276, 5716.371199168088, 6232.781852635181, 6243.0, 6297.33877942814, 6302.9369706302805, 6314.084457753646, 6220.782272620482, 6262.091996660504, 6284.2458904931245, 6303.149074874925, 6304.968475157595, 5674.546036317085, 5708.40061793514, 5734.799282025109, 5804.187413762077, 5869.7652093916195, 6185.350538193515, 6251.6561589112125, 6283.277423096311, 6283.560150789401, 6289.182406287245, 5643.0, 5723.713814309268, 6173.259208894961, 6196.659183744938, 6207.937920620826, 6195.4424101831055, 6207.782727604512, 6246.406591373812, 6251.437370636664, 6270.811875643647, 6104.908426373608, 6121.483458747687, 6133.346641381322, 6144.648177400964, 6198.318184999646, 6250.9062364064575, 6264.154339164245, 6267.310595834455, 6279.811605651837, 6282.748690052346, 4919.87700307488, 5007.84976450707, 5008.323876276656, 5022.924656130161, 5035.194368901031, 4416.646668266531, 4448.154850578379, 4450.5104438511735, 4486.59620634138, 4486.932696009562, 5758.712064396764, 5803.245578074823, 5803.82588522345, 5825.126231065374, 5858.50202732764, 6124.808163753463, 6154.599951003171, 6170.10533472644, 6202.34875338092, 6256.249250090018, 5756.683382413924, 5776.075827867521, 5788.884222315614, 5872.559558033165, 5890.410958904161, 5303.098473259555, 5463.399026107125, 5467.015937131355, 5471.7264136793, 5479.4520547944885, 6210.472109870621, 6226.470749986121, 6231.9688401557705, 6276.968615156895, 6355.618662880057, 6246.281677607133, 6258.030005349178, 6274.686265686606, 6274.937250627618, 6295.370462953668, 6327.240731112296, 6332.936670633235, 6334.619922804646, 6345.206849143857, 6346.7461301549265, 6081.695915204134, 6106.915739268716, 6118.4668989547035, 6139.26328840542, 6151.800398922167, 6144.293406258159, 6149.169862068564, 6228.906566401417, 6240.375962403723, 6252.062190671436, 5723.942760572341, 5913.5564832636865, 6097.32929377777, 6125.693715314305, 6179.969100154471, 5984.401559843981, 6018.488428483628, 6038.275406951194, 6081.847953801191, 6086.756529738938, 5996.160537524837, 6008.699565021819, 6030.366811484906, 6044.90932636002, 6057.939420605914, 6125.326214116354, 6151.661658608819, 6158.983767678283, 6162.506999440124, 6166.691665416801, 5764.106563482667, 5804.1874137619925, 5928.081147422156, 5962.4633782959745, 5963.970180149072], "value": 5717.506889858945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.9328100784883, 483.1327766658845, 502.8793089658483, 511.1846604665557, 532.1379365428007, 30878.845605771967, 31203.219919502022, 42767.78616106923, 42856.785716071376, 42877.92805179872, 44081.77959110208, 44393.77803110988, 44414.77792611041, 44501.554984450144, 44563.885902852446, 8484.703035393763, 9273.582688779004, 9472.66845660402, 9490.430574165537, 9511.904880951206, 8438.746837594881, 11223.214374993753, 11462.484188211509, 11475.196736228467, 11646.767064658745, 11490.540378384854, 11578.710532236719, 11590.710232244177, 11600.535978560847, 11627.6511704649, 8492.320614350838, 8685.782855428602, 11414.429278536081, 11495.1378646601, 11506.539738410496, 8561.315094792402, 8655.567221638892, 11091.057260132899, 11340.206185567014, 11366.545338186463, 41718.58281417208, 42118.578814211774, 42132.0, 42231.7888410559, 42251.0, 3899.395593682984, 3919.2161567686294, 3929.764214147132, 3956.8219430125714, 4024.5371782245124, 30280.54579181314, 30287.365516138205, 30331.393372132654, 30936.845315773502, 31191.064268071994, 3055.587495688098, 3073.3545955349405, 3234.32079263355, 3305.9504107438406, 3308.6856748608843, 455884.0, 455932.0, 456043.0, 457288.7135564334, 457824.0, 63465.0, 63983.0, 64055.35944640494, 64057.03914441287, 64106.71786564336, 66973.0, 67023.0, 67067.66466167638, 67088.6645566769, 67234.0, 16547.503574892773, 16580.336786528645, 16755.0, 17023.48929532116, 17030.0, 11770.470328835223, 12017.33904635236, 12914.741705165845, 13043.739125217633, 13046.086773925734, 15658.608534786721, 17492.562685932953, 17810.5547361317, 17895.926244425376, 18197.63517736175, 6588.703508342136, 6981.301869812978, 7398.519096258726, 7428.517146385468, 7462.85074298511, 873.4540911930044, 885.4687187687337, 899.2940541674753, 907.5326207003399, 921.502388710089, 29962.25094372658, 30214.624730102347, 30348.089557313317, 30599.847000765298, 31117.8444107778, 961.6393852305386, 1015.827309357411, 1051.7475805806705, 1152.4122697424207, 1206.8129439936824, 13223.00827437946, 14541.636459088608, 14546.781798273034, 14696.779548306784, 14883.776743348859, 400042.0, 400451.0, 402133.0, 402726.98636507214, 404887.0, 56185.71907140438, 56384.71807640936, 56440.43559564434, 56457.717711412, 56572.71713641405, 1402.3689339797131, 1436.7485690004207, 1440.6614445605273, 1443.8267407910698, 1446.0167086381573, 21690.783092168876, 21847.344579662637, 27518.862405687843, 28190.731417086692, 28215.0, 46246.30630540612, 46619.0, 46649.06701866011, 46742.76628616971, 46749.065018700116, 342894.0, 343319.0, 343771.0, 343824.0, 344604.0, 25664.61503077418, 26095.08667196639, 26097.347566310993, 45969.31046034245, 47398.526014739415, 34158.487622685185, 41999.1600168001, 45727.77136114298, 49186.0, 55138.72430637821, 40021.79989100036, 41968.370474442294, 42749.35875961801, 43570.34644480399, 44040.0, 41411.7929410351, 41894.790526047174, 42143.789281053396, 43171.9207019827, 43249.135017300105, 39984.0, 40398.39402408907, 40835.59164408318, 40855.1828963425, 40906.79546602248, 33892.83053584716, 36754.63245367619, 36838.89483315505, 36895.44656830203, 36956.0, 24787.752122478545, 25992.35019124537, 26273.686315683757, 26412.603810942466, 26936.730632693423], "value": 19844.841725484606, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.10538078561666, 394.14077311461006, 396.84919730502406, 403.4130340354783, 424.9511306199786, 13978.720425591482, 19864.006799660012, 20133.496662583442, 21203.151873925042, 21231.363059108215, 16172.514824555254, 16692.41576544821, 20333.898330508327, 20854.582908341825, 21034.78965210351, 5720.856978575527, 6045.03279475284, 6045.244344456943, 6045.576809623328, 6045.909311360333, 5598.300212473441, 5713.885722285552, 5878.118282257653, 5937.139114828347, 5965.373635768247, 5743.224664670258, 5743.684097374643, 5746.252987111669, 5746.885062298751, 5759.049756790125, 5572.721363931808, 5715.571332150105, 5739.885202295952, 5747.568932330071, 5790.68151251681, 5166.07010738067, 5170.3278573785165, 5173.275741396207, 5173.586113110942, 5178.508041736067, 21090.789092109037, 25123.24630261095, 25541.74458255412, 25993.870030649916, 26573.335666608295, 2783.4293969736154, 2822.6048353230562, 2829.221963959907, 2830.0, 2830.731080547345, 14833.184174870377, 15423.768643470357, 15497.225138743017, 16133.83866161335, 16275.348986040544, 1597.2333280025653, 1654.13984727942, 1712.6812354486976, 1737.0533059482611, 1741.3905133203405, 98599.0, 124943.37528312301, 126035.36982315121, 127713.0, 131147.34426327902, 9722.562484688206, 11344.489497972447, 11872.821907671392, 11884.465199066062, 12053.276803391824, 15992.440264590916, 15995.280212390471, 16025.439109631106, 16045.277962491482, 16045.839541604435, 7738.922610773933, 8076.27313541784, 8093.878591821127, 8415.242628163494, 8650.567471626393, 8667.609957551926, 8682.131786821268, 8775.254103401156, 8780.473171609723, 8928.464292142493, 3964.077422450167, 4837.637177211724, 4837.95162048375, 4838.371011768448, 4925.0, 1806.8893267815824, 1887.6413481438483, 2024.230792298917, 2025.5037515808426, 2074.0666699985068, 997.755549890267, 1014.2342531388754, 1018.0707559175469, 1031.2214278220047, 1070.8929107089384, 19813.405597832087, 21498.387620928494, 21699.78300217009, 21799.891000544896, 21943.122275108817, 1034.1623285139062, 1043.1498328862106, 1072.6299426697776, 1079.3254216114929, 1089.2212068371152, 10586.52360643773, 10595.84106238407, 10605.409188621768, 11225.270357426742, 11396.088312934946, 560651.0, 584915.0, 592334.0, 600927.0, 745969.0, 117408.41295793466, 124548.0, 137244.0, 146729.0, 151538.0, 841.4446465332851, 1022.6216299969208, 1062.5696592879897, 1062.6015244283394, 1065.9786804263872, 18914.0, 19397.4180774577, 19826.40520784379, 19828.206871724968, 19829.0, 55697.721511392185, 57272.71363643155, 57765.422345776, 57816.71091644515, 59393.0, 81646.59176704078, 82584.58707706424, 83472.90480308999, 86180.13819861972, 89030.10969890218, 7808.258215469521, 8245.876311855207, 8343.290820280345, 8467.49195048299, 8544.786380340542, 9088.454692718458, 10608.840867386842, 11534.769304614028, 12562.685932851751, 12661.74676506483, 8806.647734090564, 10722.410267435365, 10798.136149107895, 11123.94438027837, 11214.887851121384, 9385.483798391155, 10145.543450544596, 10863.891361086287, 11109.50007249692, 11174.608888688857, 10907.563697452331, 10960.177986650873, 10973.23187376876, 11022.559097636326, 11103.082971651718, 7269.382102521345, 7569.848603028019, 8155.673773049011, 8261.958690206511, 8564.785880352792, 9305.813883722423, 10875.238733288594, 11040.779184416106, 11208.887911120784, 11344.092472602337], "value": 9795.220332791032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.5095791951774, 1450.9637259068522, 1460.591034510337, 1469.77953307004, 1473.1014081410342, 8125.146859579748, 8529.78675533112, 8530.616122274498, 8531.189536993976, 8533.104024077467, 7525.322720955113, 7714.305712485875, 7726.266004729542, 8085.474444161126, 8324.62539185738, 2244.7979681828633, 2292.90828366866, 2294.2314324701247, 2294.5755035318434, 2300.5053913408615, 2235.575240704261, 2258.841881068326, 2271.3640180749335, 2273.329367836492, 2273.4998300373973, 2301.620232661609, 2312.1791763923816, 2318.4435735423463, 2345.003373566236, 2346.9530609387803, 2268.126771193094, 2295.0, 2306.342692332677, 2314.93055208344, 2320.037184568402, 1935.7193206985048, 2282.2468585366955, 2339.157903154863, 2344.6834677318684, 2346.0498498108295, 8357.0, 8441.0, 8443.282321002722, 8450.19723126302, 8455.492670439793, 4974.7512624369, 5143.588512918957, 5146.8934179151665, 5148.124818780816, 5148.150555158394, 2860.5137126688514, 3305.7190138838228, 3329.6681327468964, 3442.6901578858024, 3500.527428797105, 999.6001599360242, 1183.1836033137108, 1192.749522600255, 1219.1039585904352, 1232.3591732299244, 10694.946525267324, 10738.516766745515, 10857.782844343148, 10890.455477226107, 10912.181586381053, 4425.955740442554, 4546.0, 4637.350770892078, 4643.187442197602, 4696.553827386393, 9499.810003800023, 9519.666811661558, 9532.046795320552, 9532.999035101353, 9543.713688589354, 5194.662346947436, 5197.58419326453, 5200.843974680765, 5205.531502164823, 5205.6616319939085, 3886.455896174538, 4204.096119334296, 4579.862604121881, 4651.720896746206, 4729.787159577827, 3879.650831425185, 3890.96109038906, 3962.623550762673, 3980.7810570418906, 3998.2203470323007, 1259.1689484939895, 1271.3261971155302, 1271.9300438475786, 1286.041898785411, 1286.8455785305823, 864.39223045136, 887.9200871921429, 889.1597440418742, 901.9864702029474, 905.8958219804807, 4058.370952502367, 4991.627302491844, 5294.152935530374, 5610.438956104438, 5622.803201887996, 549.1022178737712, 562.8142712904731, 568.0371769850148, 568.0853825341197, 570.589175793428, 3662.6154253802965, 3666.7066634669695, 3683.594804571495, 3687.483752274684, 3785.905352366158, 9820.705378838646, 10048.949755251177, 10181.694549163536, 10184.898151018544, 10188.541515631814, 9866.851997220047, 9967.501624918725, 10018.899811001942, 10158.39049657023, 10165.288429809842, 7836.608169591497, 7838.804029899298, 7899.644515996794, 8154.796130096795, 8168.264856162974, 5006.824761133343, 5132.5124113209185, 5141.7686204120155, 5183.792648294026, 5331.573474121983, 9069.956954950001, 9203.539823008956, 9240.95379523098, 9315.161635452841, 9337.57980890848, 9075.954620226856, 9309.348345615741, 9391.107844754737, 9496.762580935532, 9638.0, 6709.832254193684, 6916.066331045245, 6917.688704008231, 7148.606826624586, 7436.516626419266, 7747.2640099190485, 7917.366610671248, 7953.761387158394, 8047.758567242992, 8055.476394034369, 6799.694013769294, 7007.544509606859, 7129.0751497096535, 7191.065161528968, 7220.602866842374, 6972.4073453757, 6989.405900498311, 6996.720131194696, 7023.297670232936, 7131.144262688511, 6373.362663733589, 6379.553431259767, 6475.514336424692, 6477.125588045554, 6478.5141114415665, 4917.385326834145, 4960.30555722192, 4972.5027497249985, 4990.875228119181, 5024.598032157345, 4861.465238823797, 4907.2393778964315, 4941.555260026471, 5063.620228482952, 5188.092083885381], "value": 4330.900289389901, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.5706111158267, 349.11151120398586, 356.0813102196334, 364.56616626214793, 374.9906252343693, 4945.554900058994, 5007.798128449173, 5042.924356134657, 5246.7638956246965, 5273.730287221923, 4284.978575107128, 4497.685162038659, 5043.117454445466, 5186.910748742768, 5229.568250763395, 3350.782199157059, 3815.8855234343014, 4021.155557332964, 4023.476947996771, 4023.8189281482405, 3279.3930973822894, 3700.5761226396753, 3960.3663413853787, 3987.461692671481, 4034.9798251008706, 3771.1514909145358, 3930.724849260553, 3931.095847954972, 3965.286248475273, 3985.442038114652, 3347.7656564040526, 3518.9120271993147, 3959.2873282809082, 4001.199760048002, 4008.7594744315143, 2862.7137286271413, 3293.5883014623173, 3366.73066154707, 3423.3666771647077, 3442.913927151816, 4033.3546632538946, 4216.831326746927, 5010.448850626464, 5118.513741194581, 5127.6154288428515, 3622.728295377831, 3864.1498870248784, 4193.0, 4553.453585569753, 4587.0, 4849.884526558912, 5231.0, 5467.890642187134, 5497.367802702701, 5562.888742225133, 3754.699624030071, 3756.492873462075, 3768.773873567595, 3769.1896242308035, 3784.7161462890117, 4411.448568928884, 5282.366116066097, 5569.916451253234, 5796.782785554015, 5856.0, 3720.311742327678, 3814.408766641175, 3842.769433833979, 3876.7673939563715, 3881.0, 3533.911652208715, 3641.8725344612812, 3863.199180594047, 3899.0, 3913.3542965410957, 4383.101464199832, 4507.5267096955, 4513.435820522434, 4513.661475389359, 4525.818967241339, 4881.707097574157, 4893.926591101136, 5068.493150684902, 5570.108782594765, 5595.63628364155, 1189.7798907202196, 1253.5361916091106, 1265.7405231927432, 1266.7395941038542, 1273.7898246789362, 740.8110931712379, 755.2372104174823, 830.4933990265932, 865.264525153627, 867.8240983467437, 4879.414470263591, 4888.242322440027, 4906.165951788204, 4937.753112344369, 4937.851864444073, 5330.908073317467, 5490.6431081979545, 5500.50495455411, 5582.190582365534, 5637.577181711388, 4954.331165292711, 5160.819371322061, 5168.3539557555305, 5178.766955487012, 5205.9219111713355, 2202.6233603997503, 2567.833090849089, 2715.022591866926, 2812.4953150064616, 2900.9564856527168, 5096.904165604413, 5400.297961265011, 5504.284443022381, 5616.943830561724, 5617.073182924853, 5095.949040509621, 5111.233315002779, 5171.50870667286, 5185.274061631375, 5553.278073850454, 4583.708145927037, 4996.075725990703, 5265.894162225899, 5307.734613269321, 5583.35791383996, 4493.528179541232, 4518.977405112953, 4930.728809915489, 5019.824306149413, 5348.582625604296, 4467.955320446754, 5344.0, 5384.703841288767, 5385.299911011543, 5397.867842202387, 4612.769361531977, 4649.604783593432, 4657.86026419208, 5570.387257401763, 5617.719114044363, 3195.66445523226, 3598.028532296213, 3630.8729194478065, 3648.726345524043, 3657.6159503251774, 4747.548982846624, 4788.515560176356, 5036.924446133385, 5392.973035134799, 5472.753726082416, 4407.955920440754, 4560.931586026146, 4910.82812101589, 5017.899642007066, 5234.414426118121, 4685.6017238535105, 4705.1885024266585, 5055.368078990126, 5231.346081739783, 5317.175837745156, 4738.644601654959, 4960.72716000609, 5133.435322114489, 5144.202648589475, 5148.97425512885, 4614.561616646413, 4867.269909513601, 5040.5967522597375, 5253.973730131325, 5286.81496147633, 4596.793144308581, 4652.953470465252, 4863.367762191034, 5084.771185296597, 5268.6575372600655], "value": 3883.299061177104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.9771980483918, 710.9004739336491, 754.5849782619562, 769.5421224371498, 853.4452605806223, 14000.299985000747, 14784.039037462557, 14792.704145917076, 14955.850441495582, 14969.10185388876, 13498.92008639309, 13620.795688064687, 13626.727465450685, 13667.316634168277, 15010.324535395906, 819.2053707903324, 841.9579021048954, 847.8643417053273, 848.5248260973874, 848.749618862437, 843.9873401898976, 845.5729856422529, 846.272205902923, 846.5555583318745, 847.3560094328324, 897.4391005621486, 898.4160295807744, 899.2176806178601, 899.8335307968014, 899.9865002024975, 894.8344556257081, 895.3419236860902, 895.7491902267376, 897.0580890065405, 897.0804924951912, 663.5786275714908, 663.9933600663979, 665.0888283052201, 665.3845193196274, 665.7203974330793, 14808.925955370261, 14840.554783356409, 14848.183349915751, 14849.851501484954, 14865.628359290997, 13650.385732642055, 13663.521776737767, 13853.046327649901, 13919.30403479832, 14109.576712698636, 11376.886231137665, 11412.258203216765, 11562.826557601642, 11569.710757231136, 11667.45653637972, 3631.1285291529844, 3634.182308980485, 3678.503402040717, 3701.5188025556504, 3815.7138214634015, 73800.63099684467, 85565.0, 112370.0, 112837.0, 113685.0, 10160.390376577428, 10293.43386113771, 10298.588056477807, 10453.21600879937, 10591.470426478645, 22068.0, 22248.110075596796, 22375.881205939637, 22408.43978900508, 22484.213052543084, 7305.4155667546465, 7504.437167212372, 7551.962240188764, 7693.884591731128, 7801.531908085533, 4120.196561670446, 4313.547077556874, 4313.9137217255475, 4324.308110702273, 4428.446444194476, 3438.2263990601914, 3485.721142308609, 3487.05849420655, 3487.494313324554, 3494.930101397958, 612.0788213738384, 617.6232498176109, 630.196499463179, 641.1280658304702, 644.4264604501997, 664.8271449423185, 690.3338278561213, 697.0728930522394, 704.5350068954466, 731.3856360657073, 8736.213740763362, 9448.433094014244, 9867.30928834989, 10225.488725563691, 10308.0, 560.201712559601, 580.9390014048548, 582.2140110850319, 582.3419535924378, 586.2642383808293, 4603.286490593963, 4886.120498310338, 4892.8532144035735, 4895.681780684244, 4898.387701537308, 84594.5770271157, 93656.0, 104177.0, 105874.47062764637, 107042.0, 61770.69114654488, 64543.0, 65489.67255163693, 80381.59809201033, 87279.0, 77108.61445692736, 79720.0, 79765.0, 81056.9735756599, 83865.58067209747, 10572.41851698164, 10663.758459447017, 10716.19628527848, 10858.294210876267, 11042.33745975244, 43372.34941475943, 50749.492505075956, 51021.48978510316, 51314.71728112948, 52457.0, 63333.0, 67463.0, 69643.0, 69735.0, 71433.0, 12621.242725436503, 12659.177153484994, 12756.425960831599, 12889.935550322189, 13344.599662010156, 13942.58172254834, 14039.578812635636, 14105.365258563184, 14431.556844315484, 14996.025258358171, 12785.48858045705, 13224.669383265495, 13486.0, 13520.459181632625, 13626.523071692443, 12536.435860386122, 12580.748385032066, 12960.481580737041, 13380.93309533485, 13519.932400337935, 13079.738405231652, 13133.737325253633, 13187.472501100232, 13285.601431957057, 13655.907527397983, 10623.415712135908, 10670.946645266724, 11136.610218642309, 11153.776924461303, 11222.88777112251, 9258.629654814002, 9539.618415263312, 9871.753206169904, 10911.781764364827, 11086.778264434504], "value": 7357.370190908167, "unit": "score"}], "name": "dromaeo_css", "value": 7184.614435134864, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 112.0, 112.0, 114.0, 112.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 130.0, 144.0, 144.0, 110.0, 123.0, 108.0, 110.0, 129.0, 109.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 182.0, 185.0, 186.0, 182.0, 183.0, 182.0, 184.0, 183.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 58.0, 89.0, 59.0, 58.0, 58.0, 61.0, 88.0, 80.0], "value": 69.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 83.0, 66.0, 67.0, 71.0, 82.0, 68.0, 69.0, 82.0], "value": 74.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 87.0, 93.0, 84.0, 87.0, 85.0, 88.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 113.0, 159.0, 146.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 107.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 86.0, 85.0, 93.0, 130.0, 123.0, 88.0, 88.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 54.0, 54.0, 56.0, 58.0, 57.0, 58.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 83.0, 64.0, 68.0, 70.0, 97.0, 108.0, 70.0, 70.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 86.0, 86.0, 82.0, 87.0, 83.0, 89.0, 109.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 137.0, 149.0, 146.0, 131.0, 137.0, 150.0, 156.0, 139.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 228.0, 183.0, 162.0, 169.0, 167.0, 166.0, 166.0, 164.0, 165.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1458.1999999999998, "alertThreshold": 2.0}]} 06:00:35 INFO - Return code: 0 06:00:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:00:35 ERROR - # TBPL SUCCESS # 06:00:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:00:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:00:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:00:35 INFO - 2017-03-02 06:00:35.665 screenresolution[1656:11625] starting screenresolution argv=screenresolution get 06:00:35 INFO - 2017-03-02 06:00:35.668 screenresolution[1656:11625] Display 0: 1600x1200x32@60 06:00:35 INFO - 2017-03-02 06:00:35.674 screenresolution[1657:11629] starting screenresolution argv=screenresolution list 06:00:35 INFO - Available Modes on Display 0 06:00:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:00:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:00:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:00:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:00:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:00:35 INFO - Intel Iris: 06:00:35 INFO - Chipset Model: Intel Iris 06:00:35 INFO - Type: GPU 06:00:35 INFO - Bus: Built-In 06:00:35 INFO - VRAM (Dynamic, Max): 1536 MB 06:00:35 INFO - Vendor: Intel (0x8086) 06:00:35 INFO - Device ID: 0x0a2e 06:00:35 INFO - Revision ID: 0x0009 06:00:35 INFO - Displays: 06:00:35 INFO - Display: 06:00:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:00:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:00:35 INFO - Display Serial Number: 1600x1200 60 06:00:35 INFO - Main Display: Yes 06:00:35 INFO - Mirror: Off 06:00:35 INFO - Online: Yes 06:00:35 INFO - Rotation: Supported 06:00:35 INFO - Return code: 0 06:00:35 INFO - Running post-action listener: _resource_record_post_action 06:00:35 INFO - [mozharness: 2017-03-02 14:00:35.907127Z] Finished run-tests step (success) 06:00:35 INFO - Running post-run listener: _resource_record_post_run 06:00:35 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 33590272; Write bytes: 509721088; Read time: 306; Write time: 1577 06:00:35 INFO - TinderboxPrint: CPU usage
53.5% 06:00:35 INFO - TinderboxPrint: I/O read bytes / time
33,590,272 / 306 06:00:35 INFO - TinderboxPrint: I/O write bytes / time
509,721,088 / 1,577 06:00:35 INFO - TinderboxPrint: CPU idle
2,228.4 (46.5%) 06:00:35 INFO - TinderboxPrint: CPU system
954.7 (19.9%) 06:00:35 INFO - TinderboxPrint: CPU user
1,610.6 (33.6%) 06:00:35 INFO - TinderboxPrint: Swap in / out
237,092,864 / 0 06:00:35 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205603328; Write bytes: 200545792; Read time: 15728; Write time: 428 06:00:35 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29264896; Write bytes: 298075136; Read time: 276; Write time: 1116 06:00:36 INFO - Running post-run listener: _upload_blobber_files 06:00:36 INFO - Blob upload gear active. 06:00:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:00:36 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 06:00:36 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'] 06:00:36 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 06:00:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:00:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:00:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:37 INFO - (blobuploader) - INFO - Done attempting. 06:00:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:00:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:00:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:38 INFO - (blobuploader) - INFO - Done attempting. 06:00:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:00:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:00:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:39 INFO - (blobuploader) - INFO - Done attempting. 06:00:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:00:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:41 INFO - (blobuploader) - INFO - Done attempting. 06:00:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:41 INFO - Return code: 0 06:00:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:00:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7548423c2540050b13c17731d1840c3cceea6cc10af8960a0013111895461a309eee65f89fa3e050937828eb8a713923e99c37e78a2051d50ff9bad9881339bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b43965a71fdd4b4be44f881fe686cb30f77b5b449fa59a0f40d3c15640a79905cddfd3092592c4974974705630d655b7cefcc83fb6411fe9fd216fb876198f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d97c1e44d5d06aefb64a51f6137bb35b70f01533a7c3102592750cffad591e8df2e62db8ea9100dcca3fd886c48b8a13a2c3f2fdbdf0d99870625bee9d2d5ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0b20fe9a51e89b63e6b4de87f848018a15fd1cb78120342e6e20f3d797a2caf89652a1a1aa25f461b11921b49236baf6fc621afab0634a3d7a94b9043a968f5"} 06:00:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:00:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:00:41 INFO - Contents: 06:00:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7548423c2540050b13c17731d1840c3cceea6cc10af8960a0013111895461a309eee65f89fa3e050937828eb8a713923e99c37e78a2051d50ff9bad9881339bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b43965a71fdd4b4be44f881fe686cb30f77b5b449fa59a0f40d3c15640a79905cddfd3092592c4974974705630d655b7cefcc83fb6411fe9fd216fb876198f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d97c1e44d5d06aefb64a51f6137bb35b70f01533a7c3102592750cffad591e8df2e62db8ea9100dcca3fd886c48b8a13a2c3f2fdbdf0d99870625bee9d2d5ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0b20fe9a51e89b63e6b4de87f848018a15fd1cb78120342e6e20f3d797a2caf89652a1a1aa25f461b11921b49236baf6fc621afab0634a3d7a94b9043a968f5"} 06:00:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:41 INFO - Copying logs to upload dir... 06:00:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:00:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.244154 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-02 06:00:41.780999) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 06:00:41.784554) ========= 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.tVjQtCKcOg/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.aRMg31nbIT/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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/7548423c2540050b13c17731d1840c3cceea6cc10af8960a0013111895461a309eee65f89fa3e050937828eb8a713923e99c37e78a2051d50ff9bad9881339bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b43965a71fdd4b4be44f881fe686cb30f77b5b449fa59a0f40d3c15640a79905cddfd3092592c4974974705630d655b7cefcc83fb6411fe9fd216fb876198f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d97c1e44d5d06aefb64a51f6137bb35b70f01533a7c3102592750cffad591e8df2e62db8ea9100dcca3fd886c48b8a13a2c3f2fdbdf0d99870625bee9d2d5ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0b20fe9a51e89b63e6b4de87f848018a15fd1cb78120342e6e20f3d797a2caf89652a1a1aa25f461b11921b49236baf6fc621afab0634a3d7a94b9043a968f5"} build_url:https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/F9rI_FOPQV-G6LGIBZ86Jg/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/7548423c2540050b13c17731d1840c3cceea6cc10af8960a0013111895461a309eee65f89fa3e050937828eb8a713923e99c37e78a2051d50ff9bad9881339bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b43965a71fdd4b4be44f881fe686cb30f77b5b449fa59a0f40d3c15640a79905cddfd3092592c4974974705630d655b7cefcc83fb6411fe9fd216fb876198f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d97c1e44d5d06aefb64a51f6137bb35b70f01533a7c3102592750cffad591e8df2e62db8ea9100dcca3fd886c48b8a13a2c3f2fdbdf0d99870625bee9d2d5ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0b20fe9a51e89b63e6b4de87f848018a15fd1cb78120342e6e20f3d797a2caf89652a1a1aa25f461b11921b49236baf6fc621afab0634a3d7a94b9043a968f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 06:00:41.820684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 06:00:41.821070) ========= 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.tVjQtCKcOg/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.aRMg31nbIT/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.005149 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 06:00:41.870904) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 06:00:41.871303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 06:00:41.871722) ========= ========= Total master_lag: 0.27 =========