builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0274 starttime: 1488517114.58 results: success (0) buildid: 20170302192738 builduid: e0f33b03a7ff4064985a4f4dc924db78 revision: d21b59d7e732335ff1376ecde7d5b80c2b6b3c14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:34.579391) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:34.579830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:34.580113) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:34.607335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:34.607643) ========= 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.kKjnggJs0P/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.rTD9zfXmO0/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:58:34-- 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% 18.8M=0.001s 2017-03-02 20:58:34 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:34.782812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:34.783136) ========= 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.kKjnggJs0P/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.rTD9zfXmO0/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.025639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:34.835362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-02 20:58:34.835724) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d21b59d7e732335ff1376ecde7d5b80c2b6b3c14 --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 d21b59d7e732335ff1376ecde7d5b80c2b6b3c14 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kKjnggJs0P/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.rTD9zfXmO0/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:58:34,942 truncating revision to first 12 chars 2017-03-02 20:58:34,942 Setting DEBUG logging. 2017-03-02 20:58:34,942 attempt 1/10 2017-03-02 20:58:34,942 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d21b59d7e732?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 20:58:36,062 unpacking tar archive at: mozilla-aurora-d21b59d7e732/testing/mozharness/ program finished with exit code 0 elapsedTime=1.398669 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-02 20:58:36.258380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:36.258685) ========= script_repo_revision: d21b59d7e732335ff1376ecde7d5b80c2b6b3c14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:36.259165) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:36.259465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 20:58:36.279683) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-02 20:58:36.280105) ========= /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.kKjnggJs0P/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.rTD9zfXmO0/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:58:36 INFO - MultiFileLogger online at 20170302 20:58:36 in /builds/slave/test 20:58:36 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 20:58:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:58:36 INFO - {'append_to_log': False, 20:58:36 INFO - 'base_work_dir': '/builds/slave/test', 20:58:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:58:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:58:36 INFO - 'branch': 'Mozilla-Aurora', 20:58:36 INFO - 'buildbot_json_path': 'buildprops.json', 20:58:36 INFO - 'config_files': ('talos/mac_config.py',), 20:58:36 INFO - 'default_actions': ('clobber', 20:58:36 INFO - 'read-buildbot-config', 20:58:36 INFO - 'download-and-extract', 20:58:36 INFO - 'populate-webroot', 20:58:36 INFO - 'create-virtualenv', 20:58:36 INFO - 'install', 20:58:36 INFO - 'run-tests'), 20:58:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:58:36 INFO - 'download_minidump_stackwalk': True, 20:58:36 INFO - 'download_symbols': 'ondemand', 20:58:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:58:36 INFO - 'tooltool.py': '/tools/tooltool.py', 20:58:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:58:36 INFO - '/tools/misc-python/virtualenv.py')}, 20:58:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:58:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:58:36 INFO - 'installer_path': 'installer.exe', 20:58:36 INFO - 'log_level': 'info', 20:58:36 INFO - 'log_name': 'talos', 20:58:36 INFO - 'log_to_console': True, 20:58:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:58:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:58:36 INFO - 'opt_config_files': (), 20:58:36 INFO - 'pip_index': False, 20:58:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:58:36 INFO - 'cmd': ('bash', 20:58:36 INFO - '-c', 20:58:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:58:36 INFO - 'enabled': True, 20:58:36 INFO - 'halt_on_failure': False, 20:58:36 INFO - 'name': 'check_screen_resolution'},), 20:58:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:58:36 INFO - 'cmd': ('bash', 20:58:36 INFO - '-c', 20:58:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:58:36 INFO - 'enabled': True, 20:58:36 INFO - 'halt_on_failure': False, 20:58:36 INFO - 'name': 'check_screen_resolution'},), 20:58:36 INFO - 'run_cmd_checks_enabled': True, 20:58:36 INFO - 'sps_profile': False, 20:58:36 INFO - 'sps_profile_interval': 0, 20:58:36 INFO - 'suite': 'dromaeojs', 20:58:36 INFO - 'system_bits': '32', 20:58:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:58:36 INFO - 'title': 't-yosemite-r7-0274', 20:58:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:58:36 INFO - 'use_talos_json': True, 20:58:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:58:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:58:36 INFO - 'work_dir': 'build'} 20:58:36 INFO - [mozharness: 2017-03-03 04:58:36.489804Z] Running clobber step. 20:58:36 INFO - Running pre-action listener: _resource_record_pre_action 20:58:36 INFO - Running main action method: clobber 20:58:36 INFO - rmtree: /builds/slave/test/build 20:58:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:58:38 INFO - Running post-action listener: _resource_record_post_action 20:58:38 INFO - [mozharness: 2017-03-03 04:58:38.926149Z] Finished clobber step (success) 20:58:38 INFO - [mozharness: 2017-03-03 04:58:38.926301Z] Running read-buildbot-config step. 20:58:38 INFO - Running pre-action listener: _resource_record_pre_action 20:58:38 INFO - Running main action method: read_buildbot_config 20:58:38 INFO - Using buildbot properties: 20:58:38 INFO - { 20:58:38 INFO - "project": "", 20:58:38 INFO - "product": "firefox", 20:58:38 INFO - "script_repo_revision": "production", 20:58:38 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 20:58:38 INFO - "repository": "", 20:58:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 20:58:38 INFO - "buildid": "20170302192738", 20:58:38 INFO - "pgo_build": "False", 20:58:38 INFO - "basedir": "/builds/slave/test", 20:58:38 INFO - "buildnumber": 61, 20:58:38 INFO - "slavename": "t-yosemite-r7-0274", 20:58:38 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 20:58:38 INFO - "platform": "yosemite_r7", 20:58:38 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:58:38 INFO - "branch": "mozilla-aurora", 20:58:38 INFO - "repo_path": "releases/mozilla-aurora", 20:58:38 INFO - "revision": "d21b59d7e732335ff1376ecde7d5b80c2b6b3c14", 20:58:38 INFO - "stage_platform": "macosx64", 20:58:38 INFO - "builduid": "e0f33b03a7ff4064985a4f4dc924db78", 20:58:38 INFO - "slavebuilddir": "test" 20:58:38 INFO - } 20:58:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 20:58:38 INFO - Running post-action listener: _resource_record_post_action 20:58:38 INFO - [mozharness: 2017-03-03 04:58:38.929756Z] Finished read-buildbot-config step (success) 20:58:38 INFO - [mozharness: 2017-03-03 04:58:38.929856Z] Running download-and-extract step. 20:58:38 INFO - Running pre-action listener: _resource_record_pre_action 20:58:38 INFO - Running main action method: download_and_extract 20:58:38 INFO - mkdir: /builds/slave/test/build/tests 20:58:38 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')]} 20:58:38 INFO - trying https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 20:58:38 INFO - Downloading https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/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 20:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/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 20:58:40 INFO - Downloaded 1199 bytes. 20:58:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 20:58:40 INFO - Using the following test package requirements: 20:58:40 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:58:40 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:58:40 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 20:58:40 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:58:40 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 20:58:40 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:58:40 INFO - u'jsshell-mac.zip'], 20:58:40 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:58:40 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 20:58:40 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:58:40 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:58:40 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 20:58:40 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:58:40 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 20:58:40 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:58:40 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 20:58:40 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:58:40 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 20:58:40 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:58:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:58:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:58:40 INFO - Fetch https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:58:41 INFO - Expected file size: 16357817 20:58:41 INFO - Obtained file size: 16357817 20:58:48 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 20:58:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:58:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:58:48 INFO - Fetch https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:58:49 INFO - Expected file size: 16357817 20:58:49 INFO - Obtained file size: 16357817 20:58:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 20:58:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:58:55 INFO - Fetch https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 20:58:56 INFO - Expected file size: 14403650 20:58:56 INFO - Obtained file size: 14403650 20:58:56 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')]} 20:58:56 INFO - trying https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:58:56 INFO - Downloading https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 20:58:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/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 20:58:58 INFO - Downloaded 73908221 bytes. 20:58:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:58:58 INFO - mkdir: /builds/slave/test/properties 20:58:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:58:58 INFO - Writing to file /builds/slave/test/properties/build_url 20:58:58 INFO - Contents: 20:58:58 INFO - build_url:https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:58:59 INFO - Running post-action listener: _resource_record_post_action 20:58:59 INFO - Running post-action listener: set_extra_try_arguments 20:58:59 INFO - [mozharness: 2017-03-03 04:58:59.564462Z] Finished download-and-extract step (success) 20:58:59 INFO - [mozharness: 2017-03-03 04:58:59.564611Z] Running populate-webroot step. 20:58:59 INFO - Running pre-action listener: _resource_record_pre_action 20:58:59 INFO - Running main action method: populate_webroot 20:58:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:58:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:58:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:58:59 INFO - '--tppagecycles', 20:58:59 INFO - '7'], 20:58:59 INFO - 'tests': ['tsvgm']}}, 20:58:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:58:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:58:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:58:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:58:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:58:59 INFO - 'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:58:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:58:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:58:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:58:59 INFO - 'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['damp', 'tps']}, 20:58:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:58:59 INFO - 'tests': ['damp', 'tps']}, 20:58:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['dromaeo_dom']}, 20:58:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:58:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['basic_compositor_video']}, 20:58:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:58:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['a11yr', 20:58:59 INFO - 'ts_paint', 20:58:59 INFO - 'tpaint', 20:58:59 INFO - 'sessionrestore', 20:58:59 INFO - 'sessionrestore_no_auto_restore', 20:58:59 INFO - 'tabpaint']}, 20:58:59 INFO - 'other-e10s': {'tests': ['a11yr', 20:58:59 INFO - 'ts_paint', 20:58:59 INFO - 'tpaint', 20:58:59 INFO - 'sessionrestore', 20:58:59 INFO - 'sessionrestore_no_auto_restore', 20:58:59 INFO - 'tabpaint']}, 20:58:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:58:59 INFO - 'ts_paint', 20:58:59 INFO - 'tpaint', 20:58:59 INFO - 'sessionrestore', 20:58:59 INFO - 'sessionrestore_no_auto_restore', 20:58:59 INFO - 'tabpaint']}, 20:58:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:58:59 INFO - 'ts_paint', 20:58:59 INFO - 'tpaint', 20:58:59 INFO - 'sessionrestore', 20:58:59 INFO - 'sessionrestore_no_auto_restore', 20:58:59 INFO - 'tabpaint']}, 20:58:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['a11yr', 20:58:59 INFO - 'ts_paint', 20:58:59 INFO - 'tpaint', 20:58:59 INFO - 'sessionrestore', 20:58:59 INFO - 'sessionrestore_no_auto_restore', 20:58:59 INFO - 'tabpaint']}, 20:58:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['a11yr', 20:58:59 INFO - 'ts_paint', 20:58:59 INFO - 'tpaint', 20:58:59 INFO - 'sessionrestore', 20:58:59 INFO - 'sessionrestore_no_auto_restore', 20:58:59 INFO - 'tabpaint']}, 20:58:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['tsvgx', 20:58:59 INFO - 'tsvgr_opacity', 20:58:59 INFO - 'tart', 20:58:59 INFO - 'tscrollx', 20:58:59 INFO - 'cart', 20:58:59 INFO - 'tsvg_static']}, 20:58:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:58:59 INFO - 'tsvgr_opacity', 20:58:59 INFO - 'tart', 20:58:59 INFO - 'tscrollx', 20:58:59 INFO - 'cart', 20:58:59 INFO - 'tsvg_static']}, 20:58:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:58:59 INFO - 'talos_options': ['--disable-e10s'], 20:58:59 INFO - 'tests': ['tp5o']}, 20:58:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:58:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:58:59 INFO - 'talos_options': ['--disable-e10s', 20:58:59 INFO - '--xperf_path', 20:58:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:58:59 INFO - 'tests': ['tp5n']}, 20:58:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:58:59 INFO - 'talos_options': ['--xperf_path', 20:58:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:58:59 INFO - 'tests': ['tp5n']}}, 20:58:59 INFO - 'talos.zip': {'path': '', 20:58:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:58:59 INFO - Running post-action listener: _resource_record_post_action 20:58:59 INFO - [mozharness: 2017-03-03 04:58:59.582737Z] Finished populate-webroot step (success) 20:58:59 INFO - [mozharness: 2017-03-03 04:58:59.582844Z] Running create-virtualenv step. 20:58:59 INFO - Running pre-action listener: _resource_record_pre_action 20:58:59 INFO - Running main action method: create_virtualenv 20:58:59 INFO - Creating virtualenv /builds/slave/test/build/venv 20:58:59 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 20:58:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:58:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:58:59 INFO - Using real prefix '/tools/python27' 20:58:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:59:00 INFO - Installing distribute.............................................................................................................................................................................................done. 20:59:03 INFO - Installing pip.................done. 20:59:03 INFO - Return code: 0 20:59:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:59:03 INFO - Reading from file tmpfile_stdout 20:59:03 INFO - Output received: 20:59:03 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) 20:59:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:59:03 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')]} 20:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:03 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')]} 20:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:03 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 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:03 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 20:59:03 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 20:59:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:03 INFO - 'HOME': '/Users/cltbld', 20:59:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:03 INFO - 'LOGNAME': 'cltbld', 20:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:03 INFO - 'MOZ_NO_REMOTE': '1', 20:59:03 INFO - 'NO_EM_RESTART': '1', 20:59:03 INFO - 'PAGER': '/bin/cat', 20:59:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:03 INFO - 'PWD': '/builds/slave/test', 20:59:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:03 INFO - 'SHELL': '/bin/bash', 20:59:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:03 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:03 INFO - 'USER': 'cltbld', 20:59:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:03 INFO - 'XPC_FLAGS': '0x0', 20:59:03 INFO - 'XPC_SERVICE_NAME': '0', 20:59:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:03 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 20:59:03 INFO - Cleaning up... 20:59:03 INFO - Return code: 0 20:59:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:59:03 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')]} 20:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:03 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')]} 20:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:03 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 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:03 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 20:59:03 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 20:59:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:03 INFO - 'HOME': '/Users/cltbld', 20:59:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:03 INFO - 'LOGNAME': 'cltbld', 20:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:03 INFO - 'MOZ_NO_REMOTE': '1', 20:59:03 INFO - 'NO_EM_RESTART': '1', 20:59:03 INFO - 'PAGER': '/bin/cat', 20:59:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:03 INFO - 'PWD': '/builds/slave/test', 20:59:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:03 INFO - 'SHELL': '/bin/bash', 20:59:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:03 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:03 INFO - 'USER': 'cltbld', 20:59:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:03 INFO - 'XPC_FLAGS': '0x0', 20:59:03 INFO - 'XPC_SERVICE_NAME': '0', 20:59:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:04 INFO - Downloading/unpacking psutil>=3.1.1 20:59:04 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 20:59:04 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 20:59:04 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 20:59:04 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 20:59:04 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 20:59:04 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 20:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:59:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:59:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:59:08 INFO - Installing collected packages: psutil 20:59:08 INFO - Running setup.py install for psutil 20:59:08 INFO - building 'psutil._psutil_osx' extension 20:59:08 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 20:59:08 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 20:59:08 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 20:59:09 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 20:59:09 INFO - building 'psutil._psutil_posix' extension 20:59:09 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 20:59:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:59:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:59:09 INFO - ^ 20:59:09 INFO - 1 warning generated. 20:59:09 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 20:59:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:59:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:59:09 INFO - Successfully installed psutil 20:59:09 INFO - Cleaning up... 20:59:09 INFO - Return code: 0 20:59:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:59:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:09 INFO - 'HOME': '/Users/cltbld', 20:59:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:09 INFO - 'LOGNAME': 'cltbld', 20:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:09 INFO - 'MOZ_NO_REMOTE': '1', 20:59:09 INFO - 'NO_EM_RESTART': '1', 20:59:09 INFO - 'PAGER': '/bin/cat', 20:59:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:09 INFO - 'PWD': '/builds/slave/test', 20:59:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:09 INFO - 'SHELL': '/bin/bash', 20:59:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:09 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:09 INFO - 'USER': 'cltbld', 20:59:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:09 INFO - 'XPC_FLAGS': '0x0', 20:59:09 INFO - 'XPC_SERVICE_NAME': '0', 20:59:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:59:12 INFO - Installing collected packages: mozsystemmonitor 20:59:12 INFO - Running setup.py install for mozsystemmonitor 20:59:12 INFO - Successfully installed mozsystemmonitor 20:59:12 INFO - Cleaning up... 20:59:12 INFO - Return code: 0 20:59:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:12 INFO - 'HOME': '/Users/cltbld', 20:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:12 INFO - 'LOGNAME': 'cltbld', 20:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:12 INFO - 'MOZ_NO_REMOTE': '1', 20:59:12 INFO - 'NO_EM_RESTART': '1', 20:59:12 INFO - 'PAGER': '/bin/cat', 20:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:12 INFO - 'PWD': '/builds/slave/test', 20:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:12 INFO - 'SHELL': '/bin/bash', 20:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:12 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:12 INFO - 'USER': 'cltbld', 20:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:12 INFO - 'XPC_FLAGS': '0x0', 20:59:12 INFO - 'XPC_SERVICE_NAME': '0', 20:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:12 INFO - Downloading/unpacking jsonschema==2.5.1 20:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:59:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:15 INFO - Downloading functools32-3.2.3-2.tar.gz 20:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:59:16 INFO - warning: no files found matching '*.txt' 20:59:16 INFO - no previously-included directories found matching 'build' 20:59:16 INFO - no previously-included directories found matching 'dist' 20:59:16 INFO - no previously-included directories found matching '.git*' 20:59:16 INFO - Installing collected packages: jsonschema, functools32 20:59:16 INFO - Running setup.py install for functools32 20:59:16 INFO - warning: no files found matching '*.txt' 20:59:16 INFO - no previously-included directories found matching 'build' 20:59:16 INFO - no previously-included directories found matching 'dist' 20:59:16 INFO - no previously-included directories found matching '.git*' 20:59:16 INFO - Successfully installed jsonschema functools32 20:59:16 INFO - Cleaning up... 20:59:16 INFO - Return code: 0 20:59:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:59:16 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')]} 20:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:16 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')]} 20:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:16 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 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:16 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 20:59:16 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 20:59:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:16 INFO - 'HOME': '/Users/cltbld', 20:59:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:16 INFO - 'LOGNAME': 'cltbld', 20:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:16 INFO - 'MOZ_NO_REMOTE': '1', 20:59:16 INFO - 'NO_EM_RESTART': '1', 20:59:16 INFO - 'PAGER': '/bin/cat', 20:59:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:16 INFO - 'PWD': '/builds/slave/test', 20:59:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:16 INFO - 'SHELL': '/bin/bash', 20:59:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:16 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:16 INFO - 'USER': 'cltbld', 20:59:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:16 INFO - 'XPC_FLAGS': '0x0', 20:59:16 INFO - 'XPC_SERVICE_NAME': '0', 20:59:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:59:16 INFO - Cleaning up... 20:59:16 INFO - Return code: 0 20:59:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:59:16 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')]} 20:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:16 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')]} 20:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:16 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 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:16 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 20:59:16 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 20:59:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:16 INFO - 'HOME': '/Users/cltbld', 20:59:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:16 INFO - 'LOGNAME': 'cltbld', 20:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:16 INFO - 'MOZ_NO_REMOTE': '1', 20:59:16 INFO - 'NO_EM_RESTART': '1', 20:59:16 INFO - 'PAGER': '/bin/cat', 20:59:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:16 INFO - 'PWD': '/builds/slave/test', 20:59:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:16 INFO - 'SHELL': '/bin/bash', 20:59:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:16 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:16 INFO - 'USER': 'cltbld', 20:59:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:16 INFO - 'XPC_FLAGS': '0x0', 20:59:16 INFO - 'XPC_SERVICE_NAME': '0', 20:59:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:16 INFO - Downloading/unpacking blobuploader==1.2.4 20:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:19 INFO - Downloading blobuploader-1.2.4.tar.gz 20:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:59:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:59:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:59:20 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 20:59:20 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 20:59:20 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 20:59:20 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 20:59:20 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 20:59:20 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 20:59:20 INFO - Downloading docopt-0.6.1.tar.gz 20:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:59:20 INFO - Installing collected packages: blobuploader, requests, docopt 20:59:20 INFO - Running setup.py install for blobuploader 20:59:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:59:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:59:20 INFO - Running setup.py install for requests 20:59:21 INFO - Running setup.py install for docopt 20:59:21 INFO - Successfully installed blobuploader requests docopt 20:59:21 INFO - Cleaning up... 20:59:21 INFO - Return code: 0 20:59:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:21 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 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:21 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 20:59:21 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 20:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:21 INFO - 'HOME': '/Users/cltbld', 20:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:21 INFO - 'LOGNAME': 'cltbld', 20:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:21 INFO - 'MOZ_NO_REMOTE': '1', 20:59:21 INFO - 'NO_EM_RESTART': '1', 20:59:21 INFO - 'PAGER': '/bin/cat', 20:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:21 INFO - 'PWD': '/builds/slave/test', 20:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:21 INFO - 'SHELL': '/bin/bash', 20:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:21 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:21 INFO - 'USER': 'cltbld', 20:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:21 INFO - 'XPC_FLAGS': '0x0', 20:59:21 INFO - 'XPC_SERVICE_NAME': '0', 20:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:21 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-S0Pi7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:21 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-RHMNbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-S0lqxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-2nJzya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-7Bag1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-wASg23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-A8bn7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-WXznKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-05ypGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-vx7knA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-AJ7eEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:22 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-RhzxNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-LWMP0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-o7QCEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-dCi9h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-la14Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-N12wEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:59:23 INFO - Running setup.py install for manifestparser 20:59:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:59:23 INFO - Running setup.py install for mozcrash 20:59:23 INFO - Running setup.py install for mozdebug 20:59:24 INFO - Running setup.py install for mozdevice 20:59:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:59:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:59:24 INFO - Running setup.py install for mozfile 20:59:24 INFO - Running setup.py install for mozhttpd 20:59:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:59:24 INFO - Running setup.py install for mozinfo 20:59:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:59:24 INFO - Running setup.py install for mozInstall 20:59:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:59:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:59:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:59:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:59:24 INFO - Running setup.py install for mozleak 20:59:24 INFO - Running setup.py install for mozlog 20:59:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:59:25 INFO - Running setup.py install for moznetwork 20:59:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:59:25 INFO - Running setup.py install for mozprocess 20:59:25 INFO - Running setup.py install for mozprofile 20:59:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:59:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:59:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:59:25 INFO - Running setup.py install for mozrunner 20:59:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:59:25 INFO - Running setup.py install for mozscreenshot 20:59:25 INFO - Running setup.py install for moztest 20:59:26 INFO - Running setup.py install for mozversion 20:59:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:59:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:59:26 INFO - Cleaning up... 20:59:26 INFO - Return code: 0 20:59:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:26 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 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:26 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 20:59:26 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 20:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:26 INFO - 'HOME': '/Users/cltbld', 20:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:26 INFO - 'LOGNAME': 'cltbld', 20:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:26 INFO - 'MOZ_NO_REMOTE': '1', 20:59:26 INFO - 'NO_EM_RESTART': '1', 20:59:26 INFO - 'PAGER': '/bin/cat', 20:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:26 INFO - 'PWD': '/builds/slave/test', 20:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:26 INFO - 'SHELL': '/bin/bash', 20:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:26 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:26 INFO - 'USER': 'cltbld', 20:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:26 INFO - 'XPC_FLAGS': '0x0', 20:59:26 INFO - 'XPC_SERVICE_NAME': '0', 20:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:26 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-_xj_GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:26 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)) 20:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:26 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-9ziL7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:26 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)) 20:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:26 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ELTpEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:26 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)) 20:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:26 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-8V1y40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:26 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)) 20:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:26 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-SB9MMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:26 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)) 20:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:26 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-3WwR1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:27 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)) 20:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:27 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-IxGUjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:27 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)) 20:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:27 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-AXoPF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:27 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)) 20:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:27 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-VIO2zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:27 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)) 20:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:27 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-wj_Zep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:27 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)) 20:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:27 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-30ywNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:27 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)) 20:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:27 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ePmhn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:27 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)) 20:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:27 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-2sMO31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:27 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)) 20:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:27 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-zu25If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:27 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)) 20:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:27 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-j_zMdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:28 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)) 20:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:28 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-0gTE2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:28 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)) 20:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:28 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-0Yy4jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:28 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)) 20:59:28 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)) 20:59:28 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)) 20:59:28 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)) 20:59:28 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)) 20:59:28 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)) 20:59:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:30 INFO - Downloading blessings-1.6.tar.gz 20:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:59:30 INFO - Installing collected packages: blessings 20:59:30 INFO - Running setup.py install for blessings 20:59:31 INFO - Successfully installed blessings 20:59:31 INFO - Cleaning up... 20:59:31 INFO - Return code: 0 20:59:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:31 INFO - Reading from file tmpfile_stdout 20:59:31 INFO - Current package versions: 20:59:31 INFO - blessings == 1.6 20:59:31 INFO - blobuploader == 1.2.4 20:59:31 INFO - docopt == 0.6.1 20:59:31 INFO - functools32 == 3.2.3-2 20:59:31 INFO - jsonschema == 2.5.1 20:59:31 INFO - manifestparser == 1.1 20:59:31 INFO - mozInstall == 1.12 20:59:31 INFO - mozcrash == 1.0 20:59:31 INFO - mozdebug == 0.1 20:59:31 INFO - mozdevice == 0.49 20:59:31 INFO - mozfile == 1.2 20:59:31 INFO - mozhttpd == 0.7 20:59:31 INFO - mozinfo == 0.9 20:59:31 INFO - mozleak == 0.1 20:59:31 INFO - mozlog == 3.4 20:59:31 INFO - moznetwork == 0.27 20:59:31 INFO - mozprocess == 0.24 20:59:31 INFO - mozprofile == 0.28 20:59:31 INFO - mozrunner == 6.13 20:59:31 INFO - mozscreenshot == 0.1 20:59:31 INFO - mozsystemmonitor == 0.3 20:59:31 INFO - moztest == 0.8 20:59:31 INFO - mozversion == 1.4 20:59:31 INFO - psutil == 3.1.1 20:59:31 INFO - requests == 1.2.3 20:59:31 INFO - wsgiref == 0.1.2 20:59:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59:31 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')]} 20:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:31 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')]} 20:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:31 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 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:31 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 20:59:31 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 20:59:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:31 INFO - 'HOME': '/Users/cltbld', 20:59:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:31 INFO - 'LOGNAME': 'cltbld', 20:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:31 INFO - 'MOZ_NO_REMOTE': '1', 20:59:31 INFO - 'NO_EM_RESTART': '1', 20:59:31 INFO - 'PAGER': '/bin/cat', 20:59:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:31 INFO - 'PWD': '/builds/slave/test', 20:59:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:31 INFO - 'SHELL': '/bin/bash', 20:59:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:31 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:31 INFO - 'USER': 'cltbld', 20:59:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:31 INFO - 'XPC_FLAGS': '0x0', 20:59:31 INFO - 'XPC_SERVICE_NAME': '0', 20:59:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:31 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)) 20:59:31 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)) 20:59:31 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)) 20:59:31 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)) 20:59:31 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)) 20:59:31 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)) 20:59:31 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)) 20:59:31 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)) 20:59:31 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)) 20:59:31 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)) 20:59:31 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)) 20:59:31 INFO - Cleaning up... 20:59:31 INFO - Return code: 0 20:59:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:59:31 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')]} 20:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:31 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')]} 20:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:31 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 0x104fd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc422c5be90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, '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.kKjnggJs0P/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.rTD9zfXmO0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 20:59:31 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 20:59:31 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 20:59:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:31 INFO - 'HOME': '/Users/cltbld', 20:59:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:31 INFO - 'LOGNAME': 'cltbld', 20:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:31 INFO - 'MOZ_NO_REMOTE': '1', 20:59:31 INFO - 'NO_EM_RESTART': '1', 20:59:31 INFO - 'PAGER': '/bin/cat', 20:59:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:31 INFO - 'PWD': '/builds/slave/test', 20:59:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:31 INFO - 'SHELL': '/bin/bash', 20:59:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:31 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:31 INFO - 'USER': 'cltbld', 20:59:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:31 INFO - 'XPC_FLAGS': '0x0', 20:59:31 INFO - 'XPC_SERVICE_NAME': '0', 20:59:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:59:31 INFO - Cleaning up... 20:59:32 INFO - Return code: 0 20:59:32 INFO - Running post-action listener: _resource_record_post_action 20:59:32 INFO - Running post-action listener: _start_resource_monitoring 20:59:32 INFO - Starting resource monitoring. 20:59:32 INFO - [mozharness: 2017-03-03 04:59:32.044649Z] Finished create-virtualenv step (success) 20:59:32 INFO - [mozharness: 2017-03-03 04:59:32.045582Z] Running install step. 20:59:32 INFO - Running pre-action listener: _resource_record_pre_action 20:59:32 INFO - Running main action method: install 20:59:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:32 INFO - Reading from file tmpfile_stdout 20:59:32 INFO - Detecting whether we're running mozinstall >=1.0... 20:59:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:59:32 INFO - Reading from file tmpfile_stdout 20:59:32 INFO - Output received: 20:59:32 INFO - Usage: mozinstall [options] installer 20:59:32 INFO - Options: 20:59:32 INFO - -h, --help show this help message and exit 20:59:32 INFO - -d DEST, --destination=DEST 20:59:32 INFO - Directory to install application into. [default: 20:59:32 INFO - "/builds/slave/test"] 20:59:32 INFO - --app=APP Application being installed. [default: firefox] 20:59:32 INFO - mkdir: /builds/slave/test/build/application 20:59:32 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'] 20:59:32 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 20:59:52 INFO - Reading from file tmpfile_stdout 20:59:52 INFO - Output received: 20:59:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:59:52 INFO - Running post-action listener: _resource_record_post_action 20:59:52 INFO - [mozharness: 2017-03-03 04:59:52.273544Z] Finished install step (success) 20:59:52 INFO - [mozharness: 2017-03-03 04:59:52.273712Z] Running run-tests step. 20:59:52 INFO - Running pre-action listener: _resource_record_pre_action 20:59:52 INFO - Running main action method: run_tests 20:59:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:59:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:59:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:59:52 INFO - 2017-03-02 20:59:52.287 screenresolution[1637:8835] starting screenresolution argv=screenresolution get 20:59:52 INFO - 2017-03-02 20:59:52.290 screenresolution[1637:8835] Display 0: 1600x1200x32@60 20:59:52 INFO - 2017-03-02 20:59:52.296 screenresolution[1638:8838] starting screenresolution argv=screenresolution list 20:59:52 INFO - Available Modes on Display 0 20:59:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:59:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:59:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:59:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:59:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:59:52 INFO - Intel Iris: 20:59:52 INFO - Chipset Model: Intel Iris 20:59:52 INFO - Type: GPU 20:59:52 INFO - Bus: Built-In 20:59:52 INFO - VRAM (Dynamic, Max): 1536 MB 20:59:52 INFO - Vendor: Intel (0x8086) 20:59:52 INFO - Device ID: 0x0a2e 20:59:52 INFO - Revision ID: 0x0009 20:59:52 INFO - Displays: 20:59:52 INFO - Display: 20:59:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:59:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:59:52 INFO - Display Serial Number: 1600x1200 60 20:59:52 INFO - Main Display: Yes 20:59:52 INFO - Mirror: Off 20:59:52 INFO - Online: Yes 20:59:52 INFO - Rotation: Supported 20:59:52 INFO - Return code: 0 20:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:59:52 INFO - Python 2.7.3 20:59:52 INFO - Return code: 0 20:59:52 INFO - grabbing minidump binary from tooltool 20:59:52 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')]} 20:59:52 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 0x104db1d30>, '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 0x104cd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104da6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:59:52 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 20:59:52 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 20:59:52 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 20:59:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:59:52 INFO - Return code: 0 20:59:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:59:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:59:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:59:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:59:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:59:52 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/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 20:59:52 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/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --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 20:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kKjnggJs0P/Render', 20:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:52 INFO - 'HOME': '/Users/cltbld', 20:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:52 INFO - 'LOGNAME': 'cltbld', 20:59:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:59:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:52 INFO - 'MOZ_NO_REMOTE': '1', 20:59:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:59:52 INFO - 'NO_EM_RESTART': '1', 20:59:52 INFO - 'PAGER': '/bin/cat', 20:59:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:52 INFO - 'PWD': '/builds/slave/test', 20:59:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:52 INFO - 'SHELL': '/bin/bash', 20:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTD9zfXmO0/Listeners', 20:59:52 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 20:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:52 INFO - 'USER': 'cltbld', 20:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:52 INFO - 'XPC_FLAGS': '0x0', 20:59:52 INFO - 'XPC_SERVICE_NAME': '0', 20:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:52 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/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 20:59:52 INFO - mozversion application_buildid: 20170302192738 20:59:52 INFO - mozversion application_changeset: d21b59d7e732335ff1376ecde7d5b80c2b6b3c14 20:59:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:59:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:59:52 INFO - mozversion application_name: Firefox 20:59:52 INFO - mozversion application_remotingname: firefox-dev 20:59:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:59:52 INFO - mozversion application_vendor: Mozilla 20:59:52 INFO - mozversion application_version: 53.0a2 20:59:52 INFO - mozversion platform_buildid: 20170302192738 20:59:52 INFO - mozversion platform_changeset: d21b59d7e732335ff1376ecde7d5b80c2b6b3c14 20:59:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:59:52 INFO - mozversion platform_version: 53.0a2 20:59:52 INFO - using testdate: 1488517192 20:59:52 INFO - actual date: 1488517192 20:59:52 INFO - starting webserver on 'localhost:49236' 20:59:52 INFO - SUITE-START | Running 2 tests 20:59:52 INFO - TEST-START | dromaeo_css 20:59:52 INFO - operating with platform_type : mac_ 20:59:52 INFO - Initialising browser for dromaeo_css test... 20:59:52 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmp9JtAuF/profile http://localhost:49236/getInfo.html) 20:59:55 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 20:59:55 INFO - PROCESS | 1648 | colorDepth:24 20:59:55 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 20:59:55 INFO - PROCESS | 1648 | __metrics 20:59:55 INFO - PROCESS | 1648 | 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" 20:59:55 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:59:56 INFO - TEST-INFO | 1648: exit 0 20:59:56 INFO - Browser initialized. 20:59:56 INFO - Running cycle 1/1 for dromaeo_css test... 20:59:56 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmp9JtAuF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:00:08 INFO - PROCESS | 1651 | RSS: Main: 212766720 21:00:08 INFO - PROCESS | 1651 | 21:03:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 21:03:13 INFO - PROCESS | 1651 | RSS: Main: 351461376 21:03:13 INFO - PROCESS | 1651 | 21:04:57 INFO - PROCESS | 1651 | ************************* 21:04:57 INFO - PROCESS | 1651 | A coding exception was thrown and uncaught in a Task. 21:04:57 INFO - PROCESS | 1651 | 21:04:57 ERROR - PROCESS | 1651 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:04:57 INFO - PROCESS | 1651 | Full stack: 21:04:57 INFO - PROCESS | 1651 | ************************* 21:06:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 21:06:17 INFO - PROCESS | 1651 | RSS: Main: 353538048 21:06:17 INFO - PROCESS | 1651 | 21:09:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 21:09:20 INFO - PROCESS | 1651 | RSS: Main: 345624576 21:09:20 INFO - PROCESS | 1651 | 21:12:22 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 21:12:23 INFO - PROCESS | 1651 | RSS: Main: 329134080 21:12:23 INFO - PROCESS | 1651 | 21:15:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 21:15:27 INFO - PROCESS | 1651 | RSS: Main: 327950336 21:15:27 INFO - PROCESS | 1651 | 21:18:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 21:18:30 INFO - PROCESS | 1651 | RSS: Main: 500588544 21:18:30 INFO - PROCESS | 1651 | 21:18:30 INFO - PROCESS | 1651 | __start_tp_report 21:18:30 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 21:18:30 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 21:18:30 INFO - PROCESS | 1651 | |i|pagename|runs| 21:18:30 INFO - PROCESS | 1651 | |0;dojo.html;2883.2215301868496;3347.096284003319;3362.2266878617916;3375.864965401384;3422.0589337932065;5623.100303951369;5646.350669672989;5664.0937450007905;5667;5692.516136128429;5587.217789509472;5625.915611265835;5638.097904335307;5672.546196304296;5680.0627896397145;5129.666571672848;5162.767675454614;5189.948100519003;5190.2474141249495;5233.712145831978;5136.922946155811;5147.7426128693605;5167.379914410257;5264.473552644743;5282.603804714642;5217.739113044351;5247.86880327991;5248.21276808478;5275.024120537693;5312.867178320554;5268.236105764662;5268.710220937885;5276.762545685453;5291.920621190705;5297.761600727977;5082.440931497532;5116.820911268088;5202.817901373433;5219.399769026534;5264.631475796696;5603.495685388335;5603.663780173202;5627.2684551008515;5631.915521267184;5653.293338332708;6231.408016238495;6262.029385445263;6286.528510361742;6289.559730818844;6292.496600272013;6316.2736285326855;6333.651649159295;6354;6361.395667411589;6372.1397611322345;5599.076152434844;5699.373068962411;5709.172170035322;5792.247007888989;5828.271466066742;5282.947170528322;6300.968495157586;6302.621842689453;6303.243610766737;6305.022721478178;6195.16365290689;6198.380161983766;6203.131561581382;6215.378462153839;6233.1273621693;6146.6004709693725;6271.466925311308;6281.183446151971;6345.777897773556;6361.61830290184;6068.878622427526;6114.236541168587;6126.212334160686;6132.765133558579;6191.845203869849;6279.686015699197;6289.339619339995;6306.590071645328;6306.590071645328;6316.557840951181;4945.604351651859;4977.651564390458;4991.326170966873;4996.925046124311;5004.699718016931;3771.2268984858038;4400.273954797487;4425.601695847325;4481.775911204427;4497.392851964943;4857.708537487762;5785.016547186989;5860.619059761102;5896.528277737771;5917.526597872246;6124.441964285689;6139.461473530676;6176.011838105882;6239.313675495692;6303.968480157661;5746.881277746121;5767.596268261182;5833.67914764692;5869.618474799125;5873.089671100986;5480.616356854982;5488.7530061147345;5508.256385387921;5510.090835012178;5514.117741161395;5186.818461353834;6259.029850373199;6260.5930614509;6275.278342990432;6294.370562943669;6303.873922521616;6304.5271604628915;6305.148804911279;6306.968465157828;6307.211598550181;6295.055741638791;6308;6309.305976342691;6314.305426403183;6327.082573026793;6112.908306375319;6122.142899993915;6198.256209254918;6200;6205.410486003822;6302.086197501429;6338.366163383625;6340.207474065742;6344.080108384351;6363.236411630634;5036.748162591929;5994.850128746816;6207.131001659681;6218.968905155626;6234.2830574484515;5976.983912734759;5993.760249589967;6086.147939288591;6123.387661234019;6197.25632924052;5925.318588362394;5987.520998320211;6017.458428741435;6079.05774604937;6079.209702738615;6147.754089836357;6161.784337548164;6163.075538669235;6166;6202.689865506797;5709.771609135588;5786.4213578643485;6023.6385816851125;6032.698365081641;6038.84902877414 21:18:30 INFO - PROCESS | 1651 | |1;ext.html;465.39266257533916;507.12267776746205;521.1323146960311;529.7298377827308;544.8583368324234;30367.54448683269;39748.60251397485;41415.75752727419;41521.16957660845;43687.563124368746;42301.576984230145;42430;42823.57176428235;42917.7854110729;42936.57063429365;8360.331173506136;9251.953740231289;9446.85829712555;9454.054594540525;9456.621735130586;8525.786855328604;11107.611233606825;11317.83023254652;11364.999999999958;11514.309141451498;11344.43277836109;11376.203665743402;11402.657920262363;11420.428978551081;11449.25579837312;8388.664453421856;11287.266327688714;11367.97688208057;11397.316161030365;11403.030742386907;7526.548407095592;8407.24334809864;8563.828723425559;8567.186117318906;11020.724481887937;38640.613593863985;39094.43622255106;40294.79852600748;40382.39426408606;40434;3620.6198349173483;3833.769973801581;3980.980095099506;4009.1179940413062;4081.265372232997;27099.45801083987;27136.59295110555;27167.592486112724;27221.45557088867;28237;3042.8022178558545;3258.7881787683723;3329.6503867094093;3330.1841048943165;3330.467125259971;473151;474544;475226;475984;476760;55728.164077538866;56026;56130.87738245212;56176.71911640497;56302.43697563054;58029.80836054058;58035.54911127256;58149.70925145432;58251;58288.12567811486;15681.68636627261;15829.129397883227;15900.204989750466;15918.9204053979;15921.601959950862;9363.812723745486;11241.100711943025;12200.901918827349;12260.81608775869;12264.264144151379;15419;17518.737218941726;17838.5540361492;17850.5537361567;18116.547086322946;7384.815379615553;7826.373890088779;7859.4891332063235;7875.212478752079;7899.840063974341;857.1599832164513;864.9783755406039;880.9867851982225;890.1321211818555;912.5847739278612;28896.566551501743;29480.557791633142;29566.704332956826;30238.09285721432;30314.84842575773;781.5154604145466;1054.167207905746;1079.422508957704;1097.846301517788;1196.8204769284503;14766.92616536932;15249.6187595311;15366.846331536764;15682.921585392;15696.293666785023;664270;672401;674405;675133;675890;58061.4193858056;58867;59018.70490647519;59024.1146382796;59058;1396.8882489400823;1438.3886848089521;1453.128123126116;1464.7290251303543;1467.772495263236;28337.29156771097;29120.126396208147;29133.85433072821;29660;29743.553846691884;43785.56214437942;47032.99999999863;49038.50961490339;49542.75228623834;49690;460977.6951115223;461352;462137;462260;463268;26069.217923462325;26398;26428.0750173743;26435;26446.338841529116;45987;46651.066978660914;46790.532094678616;47198;47555;37350.439743404415;37357.6264237365;37582.43626345552;37679.869603911924;38931.02672433212;37641;38151.809240954724;38855;39028;39297.80351098226;36410.63589364073;36747.08132296714;37729.434058488594;37746.81126594349;38085.80957095197;32109.357812843144;32961.540380106555;33884.152896176805;33950.660493395735;33990.49014264838;22061.66907496421;24430.87784561137;24727.87636061808;24775.876120619283;25129.74870251274 21:18:30 INFO - PROCESS | 1651 | |2;jquery.html;379.32669511616893;400.8617027125642;402.3301203496181;409.9528554216265;430.5995424255443;13914.165150090988;16019.519414417571;18028.729569056457;19303.4208973731;21140.89429552854;20011.59976800463;21594.892025539888;21859.12563497458;21863;22240.887955602237;4896.55930966213;5771.422857714216;5974.910376344358;6001.069834175688;6072.2106126203535;6119.510439164878;6167.167432396614;6178.289496707891;6181.134641150243;6222.751089956397;3945.7237993340477;4128.2981893078095;6832.555883867532;8035.075966263867;8101.797455063612;7842.921570784276;7933.722319718811;7997.880031799527;8096;8103.10865804761;7616.8476630467085;7895.96052019742;7910.564918929456;7914.80212994674;7933.880991785128;29654.40356744708;29714.25714357137;29886.85056574725;30101.397972040657;30119.247018824484;2951.7048295170525;2964.273752930524;3028.258076771205;3037.726604605574;3078.1227350205086;17258.741118883227;17284.135793210287;17295.048772317645;17708.645827083386;17983.73024404635;1874.1659961317218;1945.367755479475;2044.2845004248543;2066.039291729353;2085.8227050700707;157687.42312576843;158194;160311;166314;172888;18918.90540547316;24202.87898560531;24544.509109817704;24625.13812016571;24834;42048.36927446091;44034.77982610066;44117.77941110338;44187.55812441899;44239.55760442354;11370.602028928948;11643.76712465746;11654.70863228426;11780.823287650692;11797.056235501139;9215.11090226502;9221.354505184572;9225.169734723908;9236.353455258068;9411.952940235255;9273.814523709489;9418.764530886783;10031.899681003242;11192.552297908156;11314.886851131549;4158.37624356349;4262.829486820555;4283.02980628908;4297.3768803523935;4307.353896915488;1038.2628333882876;1041.9010194031555;1052.3265110329396;1052.4474650808386;1055.2507719519074;21107;21163;21202.469938251666;21254.681179782314;21263.255786047415;1043.6921108273077;1059.0256963593513;1072.265498133781;1075.086176749772;1093.4587379247164;10236.795264094677;10887.020168184901;11045.28205666629;11050.778984420267;11079.224454288122;700603;721606;745589;755210.1751831329;756308;154497;156347;159695.40304597036;161730;165351;974.5176137811828;995.6316163019729;1011.9696409107738;1017.9949100254452;1024.36489376587;18193.818061819213;18433.446996590123;18684.719729204346;18702.345417910306;18827;38937;56652;58286.4171358298;58524.707376462844;58983.70508147432;62833.80081697118;82479;84009;86293;87146;7400.592967386845;8004.799880003046;8316.708915187939;8846.071162527842;8858.557072146496;11143.665690029313;11224.382658953837;13091.738165236451;13491.662708431975;13699.931500342434;11040.447977601249;11152.888471115184;11338.716532086433;11480.368579728196;11589.768204636028;10445.582176712845;11142.554297828321;11313.321200727984;11506.194566380607;11556.768864622829;11460.968512833884;11635.88364116348;12010.459529321377;12014.876132205514;12091.214071085351;6685.930251159791;7630.351420129351;7647.579383133759;7758.573278469513;7794.2205779423875;10765.623203187852;11088.611898583511;11256.558743094838;11397.373144477133;11581.536738530702 21:18:30 INFO - PROCESS | 1651 | |3;mootools.html;1420.5241244183198;1430.2634143416142;1440.265464613047;1448.717500087482;1455.1560095144814;8068.394870384723;8477.576121193932;8500.61747221375;8501.532415717133;8507.91492085079;7433.5911524866115;7678.769636910888;7682.884756728639;8048.557329346898;8280.130586288444;2290.6564015397657;2359.6578496118054;2361.669366288721;2362.456634973957;2362.6692263083182;2340.1458467659354;2377.8929948152377;2380.059876348841;2384.5707772600927;2394.114177754225;1886.368066697651;2053.5276886316155;2128.6274901892184;2301.390131615123;2336.1122773346187;2340.9063637454565;2354.1289722802503;2358.5282943411385;2364.243442098529;2366.538524987628;2290.599145149592;2345.319857241398;2355.8704271265074;2359.8112151027876;2361.846479978813;8404.957975210145;8451.197136272105;8456.957715211385;8465;8470.661173553111;5028.170351891933;5199.506046925536;5207.973960130175;5208.765605547722;5242.737863106868;3297.8186199759;3472.3923313420305;3474.6177920428986;3537.6992955598803;3541.3271478419274;1133.5692436874017;1185.63838029401;1212.7453234820698;1227.3311045480234;1230.4094034863226;10456.68629941103;10803.351798892092;10823.025927666547;10920.836187457195;10932.180086493545;3992.9001774955277;4397.912041759147;4406.9779651101535;4496.415465989466;4507.211238033331;8758.737237882746;8790.59350503929;8795.91204087951;8799.988001379796;8803.295736341077;5126.410462796752;5139.460356662571;5148.279240906276;5150.896982060338;5153.4073581538605;4737.59730422911;4747.192977193886;4812.278158276286;4867.367242258484;4872.244802055687;3618.3125206210734;3707.295613833363;3741.3639681254253;3778.8852288574385;3784.8864534064023;1158.9710257243469;1165.1494409081417;1165.825126231072;1173.5833779008328;1176.6764139861436;822.8066404394963;853.6030745703154;863.2619110660421;896.8475359188953;924.2098006204733;4939.333190019373;5070.391553013588;5147.819826306136;5319.654222475527;5427.9185812212845;484.7866938547028;541.8320320700595;543.0849019402319;561.2199043329775;574.9425057494217;2978.851057447119;3464.3244567309134;3486.8082255475683;3515.876944306937;3724.348239058208;9824.90175098254;9925.2059835213;10218;10245.077942985017;10251;9717.56270967808;9762.951185244028;10078.899211007943;10201.285909986229;10230.897691023143;7739;7950.602469876599;7987.121416644164;8002.799930001796;8018.077921039155;4963.8262660806695;5220.477952204749;5319.308489896289;5440.891182176413;5585.385607583244;8985.685501007434;9019.458832470073;9085.273178145864;9263.629454821732;9335.06649335061;9151.450912945245;9347.906520934703;9445.669401570913;9548.618055277711;9586.520673966414;7713.691452341844;7873.33076688465;7972.880406793786;7978.242067003625;7980.281774640311;7664.540127592362;7743;7851.528908265523;7857.174996625501;7890.053193616803;6907.34380233877;6972.755953541602;6997.300269972962;7011.088558487364;7026.929730702627;5361.142217245222;6261.5616906816085;6759.188897332351;6922.965385173042;7149.60677162761;6116.4495195430845;6347.301796802256;6429.099926010455;6432.00303952888;6438.742450302123;4638.652101092499;4705.411823522059;4740.691855029412;4766.380370551806;4857.077155340474;4626.334519573018;4686.203345431217;4757.405324334458;4811.903761924812;4882.7314497701545 21:18:30 INFO - PROCESS | 1651 | |4;prototype.html;329.3429607932175;332.85687154523544;361.7684681803646;367.23981358587724;377.886634009797;4610;4883.706977581343;4974.995128921221;4989.403390914908;5002.574781143602;4169.37459381093;4176.310908700061;4488.483824360192;4910.582600478954;5048.974755126219;3645.5235629570066;3789.9810500947456;3967.821448034845;4031.254217969685;4055.4930633670792;3826.521684789401;3835.539735231776;3922.1371298314466;4062.1266427718033;4067.4712287402594;3897.9805100974454;3978.264021156081;3989.601039896016;4004.2191772604356;4049.959500404988;3939.330313846653;3994.2211268802594;3995.880123596297;3999.0002499375155;4025.6376926076796;3411.761176717631;3432.9141771455666;3479.1128262292955;3512.8067956262394;3556.217632120955;4075.551689314173;4094.6314831664995;4833.492483289239;4921.286413470027;4938.851834444937;4592.425946756655;4608.216603177468;4608.976955115203;4620.861374158781;4645.535446455361;5245.793467502458;5426.565874730012;5435.22803370284;5448.210009548593;5479.438360067362;3406.267652454734;3911.2959667259884;3916.295066887959;3923.4114882767813;3985.163115745697;5269.314989051399;5654.021092617592;5655;5702.800401985952;5761.530809643556;3694.5751238607368;3863.3818589025623;4029.005642207126;4033.668889266535;4056.4320995060716;3420.572428446444;3641.817909104534;3996.322463949161;4093.3450647896193;4106.281400754856;4287.078278170146;4432.889177770581;4446.510883802779;4613.976930115328;4663.437748354339;4508.729476231437;5006.89986200274;5193.766280517386;5489.231507588941;5506.394296627368;1269.156011252525;1345.3340596404842;1350.8176396186586;1357.830271216098;1360.5442176870858;907.7322189953848;933.5612262236738;940.4686352211115;942.1803031362758;948.8244674735196;4694.906101878011;4746.264329029006;4755.429348478205;4770.666053376231;4837.274408838703;4270.530241673413;5228.2746693591025;5249.527542521191;5258.8159414420315;5300.04599172145;4109.876703698834;4293.162833247487;4459.302122216012;4460.821567137278;4683.531646835289;2388.6058800297756;2489.35276828026;2592.753688399599;2770.7783377329765;2778.7638050765913;4790.850195953016;5074.898502029939;5524.4199359067525;5530.751116199781;5543.085390910454;5078.435390128036;5374.811881584125;5417.052015897202;5441.428649991773;5466.9179962300595;4582.639940430681;5034.244863270539;5089.307560557854;5460.808871689551;5525.917111243415;4512.481064677604;4595.908081838412;4698.906021879611;5008.524190201925;5352.678839269501;4299.677524185636;4442.73343599385;4605.56247156533;4734.357599708329;4970.167004807226;4616.238320677051;4708.327504546459;5253.474652534716;5488.588355873246;5490.670559766427;3505.949019823432;3553.182767963435;3839.9616003839606;3844.4041173618134;3877.166409222031;4424.69027168108;4661.277501987197;4767.76161191946;5010.549050585465;5220.895582088413;4194.497594508497;4366.759828209479;4386.157813718182;5101.072174425745;5140.023395554833;4431.119772148129;4668.929966050444;4949.554540091409;5057.949420505748;5114.616403769806;4920.8769780755765;5029.711481276084;5037.748112594429;5057.949420505748;5305.363356397257;5103.897922041464;5338.145896656516;5421.674699518042;5422.15956526739;5452.972735136299;4738.763061846825;5257.768520322304;5410.75651595687;5426.782928682808;5436.782528698808 21:18:30 INFO - PROCESS | 1651 | |5;yui.html;693.37249788941;702.8032150997723;734.097060615443;772.5866661336187;807.870740681491;14598.635034124152;14698.706025879503;15623.3750649974;15631.765523517128;15679.216039198052;14306.427742890299;14319.92840035801;14340.996130270885;14471.638209044779;14528.491502797404;665.5474277491304;688.2154344047765;720.7045111504258;842.8230071684939;844.1347618690829;856.0497847389393;860.2644738748373;862.2799962031711;862.6980556805099;863.7667829685981;912.8721978922956;913.9543022848865;914.0219964637807;916.7478943290582;917.0325306801321;700.8072779985494;722.9240929702411;870.9390342676015;909.5679552212679;911.9361644684875;665.5008743442418;667.0494545272967;669.3607604737464;669.9531032827704;670.1656437735003;14597.927010364987;14932;14971.625709357244;14988.925055374762;14994.100353978687;13297;13307.667308317272;13326.733465330639;13583.320833958263;13696.246706431142;11893.762124757543;11971.22187057847;12161.574344897974;12184.451699673536;12395.690107747288;4384.3861859339395;4518.683692141552;4548.704334218299;4682.719036857799;4683.601893838993;97533.5123324393;105570.47214763876;106196;107370;107591;10696.893031069745;10814;10852.348859068481;11482.425878706032;11613.825792613117;22218.222362217246;22660.546789064127;22700.318990430314;22722.091116355492;22811.88594057019;7564.810879728051;7667.463277570628;7761.5731134787;7913.881291780628;7917.683292668229;4191.161767646483;4262.829486820555;4322.243607368698;4327.134573085333;4426.535213802569;3365.2764655598676;3443.0359499340225;3446.2590543032866;3448.3103379324234;3451.2924850405607;537.6881408782974;609.713434685697;611.5810669691276;627.5324882962223;632.0172132334172;525.90796610593;532.2973674749294;543.1879340386148;547.5811004581499;549.4148731600833;9415.811683766286;9585.520723963775;9811.607535698493;9847.852282215772;9907.554160062815;603.1947350287328;617.5368473644767;620.770314983459;633.2527617411407;661.8709351676376;4343.4136391586735;4349.521552629209;4402.911941761146;4717.790954424844;4819.397575303087;80522.19477805147;82608.58695706484;101546.49226753967;102992.97007029834;104538.4319235212;88873.55563222272;90127.54936225277;90340;91277.08722912818;91657.54171229101;72010.55978880498;73320.63339683268;76816;77368;80771.59614202009;10565.471726413802;10726.14760689427;10854.18593605467;11299.830502542303;11300.604478843201;50420.243696345315;50810.729731757005;51529;51670;52245;69389.9591506138;71239.28760712326;72057;73072.63463682648;74220.51558968898;13227.837077952852;13448.865511344762;13491.527796527467;14271.429142834171;14274.571762847132;14249.572512824632;14291.42834286617;14706.41174353014;14787.852121478647;15053.698926021638;12819.102662813513;12870.549530766379;13055;13324.133931294435;13351.198928064347;13142.802857956947;13241.602751917459;13487.190768553919;13656.248906310248;14121;12654.557090501788;12700.745985080432;13346.13250138738;13430.261335626634;13477.123986940818;10594.576216951236;10786;11009;11280.492377842853;11325.943370283096;10345;10920.23928215354;10955.616553420592;11099.778004439704;11111.166662500184 21:18:30 INFO - PROCESS | 1651 | __end_tp_report 21:18:30 INFO - PROCESS | 1651 | __start_cc_report 21:18:30 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1436 21:18:30 INFO - PROCESS | 1651 | __end_cc_report 21:18:30 INFO - PROCESS | 1651 | __startTimestamp1488518310924__endTimestamp 21:18:30 INFO - PROCESS | 1651 | 21:18:30 INFO - PROCESS | 1651 | ------- Summary: start ------- 21:18:30 INFO - PROCESS | 1651 | Number of tests: 6 21:18:30 INFO - PROCESS | 1651 | 21:18:30 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5740.43 Median:5987.52 stddev:670.21 (11.2%) stddev-sans-first:633.68 21:18:30 INFO - PROCESS | 1651 | Values: 2883.2 3347.1 3362.2 3375.9 3422.1 5623.1 5646.4 5664.1 5667.0 5692.5 5587.2 5625.9 5638.1 5672.5 5680.1 5129.7 5162.8 5189.9 5190.2 5233.7 5136.9 5147.7 5167.4 5264.5 5282.6 5217.7 5247.9 5248.2 5275.0 5312.9 5268.2 5268.7 5276.8 5291.9 5297.8 5082.4 5116.8 5202.8 5219.4 5264.6 5603.5 5603.7 5627.3 5631.9 5653.3 6231.4 6262.0 6286.5 6289.6 6292.5 6316.3 6333.7 6354.0 6361.4 6372.1 5599.1 5699.4 5709.2 5792.2 5828.3 5282.9 6301.0 6302.6 6303.2 6305.0 6195.2 6198.4 6203.1 6215.4 6233.1 6146.6 6271.5 6281.2 6345.8 6361.6 6068.9 6114.2 6126.2 6132.8 6191.8 6279.7 6289.3 6306.6 6306.6 6316.6 4945.6 4977.7 4991.3 4996.9 5004.7 3771.2 4400.3 4425.6 4481.8 4497.4 4857.7 5785.0 5860.6 5896.5 5917.5 6124.4 6139.5 6176.0 6239.3 6304.0 5746.9 5767.6 5833.7 5869.6 5873.1 5480.6 5488.8 5508.3 5510.1 5514.1 5186.8 6259.0 6260.6 6275.3 6294.4 6303.9 6304.5 6305.1 6307.0 6307.2 6295.1 6308.0 6309.3 6314.3 6327.1 6112.9 6122.1 6198.3 6200.0 6205.4 6302.1 6338.4 6340.2 6344.1 6363.2 5036.7 5994.9 6207.1 6219.0 6234.3 5977.0 5993.8 6086.1 6123.4 6197.3 5925.3 5987.5 6017.5 6079.1 6079.2 6147.8 6161.8 6163.1 6166.0 6202.7 5709.8 5786.4 6023.6 6032.7 6038.8 21:18:30 INFO - PROCESS | 1651 | 21:18:30 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:67021.12 Median:21237.19 stddev:145686.17 (686.0%) stddev-sans-first:146009.15 21:18:30 INFO - PROCESS | 1651 | Values: 465.4 507.1 521.1 529.7 544.9 30367.5 39748.6 41415.8 41521.2 43687.6 42301.6 42430.0 42823.6 42917.8 42936.6 8360.3 9252.0 9446.9 9454.1 9456.6 8525.8 11107.6 11317.8 11365.0 11514.3 11344.4 11376.2 11402.7 11420.4 11449.3 8388.7 11287.3 11368.0 11397.3 11403.0 7526.5 8407.2 8563.8 8567.2 11020.7 38640.6 39094.4 40294.8 40382.4 40434.0 3620.6 3833.8 3981.0 4009.1 4081.3 27099.5 27136.6 27167.6 27221.5 28237.0 3042.8 3258.8 3329.7 3330.2 3330.5 473151.0 474544.0 475226.0 475984.0 476760.0 55728.2 56026.0 56130.9 56176.7 56302.4 58029.8 58035.5 58149.7 58251.0 58288.1 15681.7 15829.1 15900.2 15918.9 15921.6 9363.8 11241.1 12200.9 12260.8 12264.3 15419.0 17518.7 17838.6 17850.6 18116.5 7384.8 7826.4 7859.5 7875.2 7899.8 857.2 865.0 881.0 890.1 912.6 28896.6 29480.6 29566.7 30238.1 30314.8 781.5 1054.2 1079.4 1097.8 1196.8 14766.9 15249.6 15366.8 15682.9 15696.3 664270.0 672401.0 674405.0 675133.0 675890.0 58061.4 58867.0 59018.7 59024.1 59058.0 1396.9 1438.4 1453.1 1464.7 1467.8 28337.3 29120.1 29133.9 29660.0 29743.6 43785.6 47033.0 49038.5 49542.8 49690.0 460977.7 461352.0 462137.0 462260.0 463268.0 26069.2 26398.0 26428.1 26435.0 26446.3 45987.0 46651.1 46790.5 47198.0 47555.0 37350.4 37357.6 37582.4 37679.9 38931.0 37641.0 38151.8 38855.0 39028.0 39297.8 36410.6 36747.1 37729.4 37746.8 38085.8 32109.4 32961.5 33884.2 33950.7 33990.5 22061.7 24430.9 24727.9 24775.9 25129.7 21:18:30 INFO - PROCESS | 1651 | 21:18:30 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:43041.59 Median:22051.94 stddev:123236.22 (558.8%) stddev-sans-first:123540.29 21:18:30 INFO - PROCESS | 1651 | Values: 379.3 400.9 402.3 410.0 430.6 13914.2 16019.5 18028.7 19303.4 21140.9 20011.6 21594.9 21859.1 21863.0 22240.9 4896.6 5771.4 5974.9 6001.1 6072.2 6119.5 6167.2 6178.3 6181.1 6222.8 3945.7 4128.3 6832.6 8035.1 8101.8 7842.9 7933.7 7997.9 8096.0 8103.1 7616.8 7896.0 7910.6 7914.8 7933.9 29654.4 29714.3 29886.9 30101.4 30119.2 2951.7 2964.3 3028.3 3037.7 3078.1 17258.7 17284.1 17295.0 17708.6 17983.7 1874.2 1945.4 2044.3 2066.0 2085.8 157687.4 158194.0 160311.0 166314.0 172888.0 18918.9 24202.9 24544.5 24625.1 24834.0 42048.4 44034.8 44117.8 44187.6 44239.6 11370.6 11643.8 11654.7 11780.8 11797.1 9215.1 9221.4 9225.2 9236.4 9412.0 9273.8 9418.8 10031.9 11192.6 11314.9 4158.4 4262.8 4283.0 4297.4 4307.4 1038.3 1041.9 1052.3 1052.4 1055.3 21107.0 21163.0 21202.5 21254.7 21263.3 1043.7 1059.0 1072.3 1075.1 1093.5 10236.8 10887.0 11045.3 11050.8 11079.2 700603.0 721606.0 745589.0 755210.2 756308.0 154497.0 156347.0 159695.4 161730.0 165351.0 974.5 995.6 1012.0 1018.0 1024.4 18193.8 18433.4 18684.7 18702.3 18827.0 38937.0 56652.0 58286.4 58524.7 58983.7 62833.8 82479.0 84009.0 86293.0 87146.0 7400.6 8004.8 8316.7 8846.1 8858.6 11143.7 11224.4 13091.7 13491.7 13699.9 11040.4 11152.9 11338.7 11480.4 11589.8 10445.6 11142.6 11313.3 11506.2 11556.8 11461.0 11635.9 12010.5 12014.9 12091.2 6685.9 7630.4 7647.6 7758.6 7794.2 10765.6 11088.6 11256.6 11397.4 11581.5 21:18:30 INFO - PROCESS | 1651 | 21:18:30 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5368.22 Median:5098.40 stddev:2980.23 (58.5%) stddev-sans-first:2973.83 21:18:30 INFO - PROCESS | 1651 | Values: 1420.5 1430.3 1440.3 1448.7 1455.2 8068.4 8477.6 8500.6 8501.5 8507.9 7433.6 7678.8 7682.9 8048.6 8280.1 2290.7 2359.7 2361.7 2362.5 2362.7 2340.1 2377.9 2380.1 2384.6 2394.1 1886.4 2053.5 2128.6 2301.4 2336.1 2340.9 2354.1 2358.5 2364.2 2366.5 2290.6 2345.3 2355.9 2359.8 2361.8 8405.0 8451.2 8457.0 8465.0 8470.7 5028.2 5199.5 5208.0 5208.8 5242.7 3297.8 3472.4 3474.6 3537.7 3541.3 1133.6 1185.6 1212.7 1227.3 1230.4 10456.7 10803.4 10823.0 10920.8 10932.2 3992.9 4397.9 4407.0 4496.4 4507.2 8758.7 8790.6 8795.9 8800.0 8803.3 5126.4 5139.5 5148.3 5150.9 5153.4 4737.6 4747.2 4812.3 4867.4 4872.2 3618.3 3707.3 3741.4 3778.9 3784.9 1159.0 1165.1 1165.8 1173.6 1176.7 822.8 853.6 863.3 896.8 924.2 4939.3 5070.4 5147.8 5319.7 5427.9 484.8 541.8 543.1 561.2 574.9 2978.9 3464.3 3486.8 3515.9 3724.3 9824.9 9925.2 10218.0 10245.1 10251.0 9717.6 9763.0 10078.9 10201.3 10230.9 7739.0 7950.6 7987.1 8002.8 8018.1 4963.8 5220.5 5319.3 5440.9 5585.4 8985.7 9019.5 9085.3 9263.6 9335.1 9151.5 9347.9 9445.7 9548.6 9586.5 7713.7 7873.3 7972.9 7978.2 7980.3 7664.5 7743.0 7851.5 7857.2 7890.1 6907.3 6972.8 6997.3 7011.1 7026.9 5361.1 6261.6 6759.2 6923.0 7149.6 6116.4 6347.3 6429.1 6432.0 6438.7 4638.7 4705.4 4740.7 4766.4 4857.1 4626.3 4686.2 4757.4 4811.9 4882.7 21:18:30 INFO - PROCESS | 1651 | 21:18:30 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4269.03 Median:4618.55 stddev:1235.27 (26.7%) stddev-sans-first:1202.82 21:18:30 INFO - PROCESS | 1651 | Values: 329.3 332.9 361.8 367.2 377.9 4610.0 4883.7 4975.0 4989.4 5002.6 4169.4 4176.3 4488.5 4910.6 5049.0 3645.5 3790.0 3967.8 4031.3 4055.5 3826.5 3835.5 3922.1 4062.1 4067.5 3898.0 3978.3 3989.6 4004.2 4050.0 3939.3 3994.2 3995.9 3999.0 4025.6 3411.8 3432.9 3479.1 3512.8 3556.2 4075.6 4094.6 4833.5 4921.3 4938.9 4592.4 4608.2 4609.0 4620.9 4645.5 5245.8 5426.6 5435.2 5448.2 5479.4 3406.3 3911.3 3916.3 3923.4 3985.2 5269.3 5654.0 5655.0 5702.8 5761.5 3694.6 3863.4 4029.0 4033.7 4056.4 3420.6 3641.8 3996.3 4093.3 4106.3 4287.1 4432.9 4446.5 4614.0 4663.4 4508.7 5006.9 5193.8 5489.2 5506.4 1269.2 1345.3 1350.8 1357.8 1360.5 907.7 933.6 940.5 942.2 948.8 4694.9 4746.3 4755.4 4770.7 4837.3 4270.5 5228.3 5249.5 5258.8 5300.0 4109.9 4293.2 4459.3 4460.8 4683.5 2388.6 2489.4 2592.8 2770.8 2778.8 4790.9 5074.9 5524.4 5530.8 5543.1 5078.4 5374.8 5417.1 5441.4 5466.9 4582.6 5034.2 5089.3 5460.8 5525.9 4512.5 4595.9 4698.9 5008.5 5352.7 4299.7 4442.7 4605.6 4734.4 4970.2 4616.2 4708.3 5253.5 5488.6 5490.7 3505.9 3553.2 3840.0 3844.4 3877.2 4424.7 4661.3 4767.8 5010.5 5220.9 4194.5 4366.8 4386.2 5101.1 5140.0 4431.1 4668.9 4949.6 5057.9 5114.6 4920.9 5029.7 5037.7 5057.9 5305.4 5103.9 5338.1 5421.7 5422.2 5453.0 4738.8 5257.8 5410.8 5426.8 5436.8 21:18:30 INFO - PROCESS | 1651 | 21:18:30 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20408.93 Median:4335.27 stddev:28942.44 (667.6%) stddev-sans-first:28985.77 21:18:30 INFO - PROCESS | 1651 | Values: 693.4 702.8 734.1 772.6 807.9 14598.6 14698.7 15623.4 15631.8 15679.2 14306.4 14319.9 14341.0 14471.6 14528.5 665.5 688.2 720.7 842.8 844.1 856.0 860.3 862.3 862.7 863.8 912.9 914.0 914.0 916.7 917.0 700.8 722.9 870.9 909.6 911.9 665.5 667.0 669.4 670.0 670.2 14597.9 14932.0 14971.6 14988.9 14994.1 13297.0 13307.7 13326.7 13583.3 13696.2 11893.8 11971.2 12161.6 12184.5 12395.7 4384.4 4518.7 4548.7 4682.7 4683.6 97533.5 105570.5 106196.0 107370.0 107591.0 10696.9 10814.0 10852.3 11482.4 11613.8 22218.2 22660.5 22700.3 22722.1 22811.9 7564.8 7667.5 7761.6 7913.9 7917.7 4191.2 4262.8 4322.2 4327.1 4426.5 3365.3 3443.0 3446.3 3448.3 3451.3 537.7 609.7 611.6 627.5 632.0 525.9 532.3 543.2 547.6 549.4 9415.8 9585.5 9811.6 9847.9 9907.6 603.2 617.5 620.8 633.3 661.9 4343.4 4349.5 4402.9 4717.8 4819.4 80522.2 82608.6 101546.5 102993.0 104538.4 88873.6 90127.5 90340.0 91277.1 91657.5 72010.6 73320.6 76816.0 77368.0 80771.6 10565.5 10726.1 10854.2 11299.8 11300.6 50420.2 50810.7 51529.0 51670.0 52245.0 69390.0 71239.3 72057.0 73072.6 74220.5 13227.8 13448.9 13491.5 14271.4 14274.6 14249.6 14291.4 14706.4 14787.9 15053.7 12819.1 12870.5 13055.0 13324.1 13351.2 13142.8 13241.6 13487.2 13656.2 14121.0 12654.6 12700.7 13346.1 13430.3 13477.1 10594.6 10786.0 11009.0 11280.5 11325.9 10345.0 10920.2 10955.6 11099.8 11111.2 21:18:30 INFO - PROCESS | 1651 | -------- Summary: end -------- 21:18:30 INFO - PROCESS | 1651 | 21:18:31 INFO - TEST-INFO | 1651: exit 0 21:18:31 INFO - TEST-OK | dromaeo_css | took 1118704ms 21:18:31 INFO - TEST-START | kraken 21:18:31 INFO - operating with platform_type : mac_ 21:18:31 INFO - Initialising browser for kraken test... 21:18:31 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpDHE_B2/profile http://localhost:49236/getInfo.html) 21:18:33 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 21:18:33 INFO - PROCESS | 1656 | colorDepth:24 21:18:33 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 21:18:33 INFO - PROCESS | 1656 | __metrics 21:18:34 INFO - PROCESS | 1656 | 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" 21:18:34 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:18:34 INFO - TEST-INFO | 1656: exit 0 21:18:34 INFO - Browser initialized. 21:18:34 INFO - Running cycle 1/1 for kraken test... 21:18:34 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpDHE_B2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:18:46 INFO - PROCESS | 1657 | RSS: Main: 212738048 21:18:46 INFO - PROCESS | 1657 | 21:18:49 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 21:18:50 INFO - PROCESS | 1657 | RSS: Main: 265879552 21:18:50 INFO - PROCESS | 1657 | 21:18:53 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 21:18:53 INFO - PROCESS | 1657 | RSS: Main: 274640896 21:18:53 INFO - PROCESS | 1657 | 21:18:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 21:18:57 INFO - PROCESS | 1657 | RSS: Main: 374214656 21:18:57 INFO - PROCESS | 1657 | 21:18:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 21:19:00 INFO - PROCESS | 1657 | RSS: Main: 275750912 21:19:00 INFO - PROCESS | 1657 | 21:19:02 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:19:02 INFO - PROCESS | 1657 | RSS: Main: 278568960 21:19:02 INFO - PROCESS | 1657 | 21:19:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 21:19:06 INFO - PROCESS | 1657 | RSS: Main: 319537152 21:19:06 INFO - PROCESS | 1657 | 21:19:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 21:19:09 INFO - PROCESS | 1657 | RSS: Main: 318402560 21:19:09 INFO - PROCESS | 1657 | 21:19:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 21:19:12 INFO - PROCESS | 1657 | RSS: Main: 316919808 21:19:12 INFO - PROCESS | 1657 | 21:19:14 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:19:15 INFO - PROCESS | 1657 | RSS: Main: 294834176 21:19:15 INFO - PROCESS | 1657 | 21:19:16 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:19:17 INFO - PROCESS | 1657 | RSS: Main: 298582016 21:19:17 INFO - PROCESS | 1657 | 21:19:19 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:19:20 INFO - PROCESS | 1657 | RSS: Main: 303460352 21:19:20 INFO - PROCESS | 1657 | 21:19:23 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:19:24 INFO - PROCESS | 1657 | RSS: Main: 314445824 21:19:24 INFO - PROCESS | 1657 | 21:19:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:19:27 INFO - PROCESS | 1657 | RSS: Main: 308092928 21:19:27 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 21:19:29 INFO - PROCESS | 1657 | RSS: Main: 352272384 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | __start_tp_report 21:19:29 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 21:19:29 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 21:19:29 INFO - PROCESS | 1657 | |i|pagename|runs| 21:19:29 INFO - PROCESS | 1657 | |0;ai-astar;115;114;114;112;113;113;111;113;113;114 21:19:29 INFO - PROCESS | 1657 | |1;audio-beat-detection;139;111;129;174;111;110;109;107;126;107 21:19:29 INFO - PROCESS | 1657 | |2;audio-dft;185;183;183;186;183;182;184;183;184;183 21:19:29 INFO - PROCESS | 1657 | |3;audio-fft;80;58;58;87;59;58;57;59;94;78 21:19:29 INFO - PROCESS | 1657 | |4;audio-oscillator;87;72;85;69;67;68;82;67;68;81 21:19:29 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;88;86;87;84;86;84;87;85;87;86 21:19:29 INFO - PROCESS | 1657 | |6;imaging-darkroom;94;94;95;95;99;93;94;93;94;93 21:19:29 INFO - PROCESS | 1657 | |7;imaging-desaturate;91;86;87;85;85;88;86;88;87;88 21:19:29 INFO - PROCESS | 1657 | |8;json-parse-financial;53;53;53;54;57;58;58;56;56;57 21:19:29 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;66;73;80;73;71;66;68;67;68;68 21:19:29 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;85;82;85;85;81;81;82;85;83;94 21:19:29 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;143;133;139;143;131;135;139;139;185;150 21:19:29 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;168;176;166;166;226;223;174;162;233;172 21:19:29 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;64;65;64;65;82;87;73;65;65;64 21:19:29 INFO - PROCESS | 1657 | __end_tp_report 21:19:29 INFO - PROCESS | 1657 | __start_cc_report 21:19:29 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,2037 21:19:29 INFO - PROCESS | 1657 | __end_cc_report 21:19:29 INFO - PROCESS | 1657 | __startTimestamp1488518369759__endTimestamp 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | ------- Summary: start ------- 21:19:29 INFO - PROCESS | 1657 | Number of tests: 14 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.14 (1.0%) stddev-sans-first:1.00 21:19:29 INFO - PROCESS | 1657 | Values: 115.0 114.0 114.0 112.0 113.0 113.0 111.0 113.0 113.0 114.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:118.50 stddev:21.24 (17.9%) stddev-sans-first:21.66 21:19:29 INFO - PROCESS | 1657 | Values: 139.0 111.0 129.0 174.0 111.0 110.0 109.0 107.0 126.0 107.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:183.60 Median:183.50 stddev:1.17 (0.6%) stddev-sans-first:1.13 21:19:29 INFO - PROCESS | 1657 | Values: 185.0 183.0 183.0 186.0 183.0 182.0 184.0 183.0 184.0 183.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:68.80 Median:68.50 stddev:14.37 (21.0%) stddev-sans-first:14.66 21:19:29 INFO - PROCESS | 1657 | Values: 80.0 58.0 58.0 87.0 59.0 58.0 57.0 59.0 94.0 78.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:76.50 stddev:8.15 (10.7%) stddev-sans-first:7.31 21:19:29 INFO - PROCESS | 1657 | Values: 87.0 72.0 85.0 69.0 67.0 68.0 82.0 67.0 68.0 81.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.50 stddev:1.33 (1.5%) stddev-sans-first:1.20 21:19:29 INFO - PROCESS | 1657 | Values: 88.0 86.0 87.0 84.0 86.0 84.0 87.0 85.0 87.0 86.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.00 stddev:1.78 (1.9%) stddev-sans-first:1.88 21:19:29 INFO - PROCESS | 1657 | Values: 94.0 94.0 95.0 95.0 99.0 93.0 94.0 93.0 94.0 93.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:87.10 Median:87.50 stddev:1.79 (2.0%) stddev-sans-first:1.22 21:19:29 INFO - PROCESS | 1657 | Values: 91.0 86.0 87.0 85.0 85.0 88.0 86.0 88.0 87.0 88.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.50 stddev:2.07 (3.7%) stddev-sans-first:1.99 21:19:29 INFO - PROCESS | 1657 | Values: 53.0 53.0 53.0 54.0 57.0 58.0 58.0 56.0 56.0 57.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:69.50 stddev:4.37 (6.3%) stddev-sans-first:4.39 21:19:29 INFO - PROCESS | 1657 | Values: 66.0 73.0 80.0 73.0 71.0 66.0 68.0 67.0 68.0 68.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:3.80 (4.5%) stddev-sans-first:4.02 21:19:29 INFO - PROCESS | 1657 | Values: 85.0 82.0 85.0 85.0 81.0 81.0 82.0 85.0 83.0 94.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:141.00 stddev:15.51 (11.0%) stddev-sans-first:16.45 21:19:29 INFO - PROCESS | 1657 | Values: 143.0 133.0 139.0 143.0 131.0 135.0 139.0 139.0 185.0 150.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.60 Median:175.00 stddev:28.51 (16.3%) stddev-sans-first:29.43 21:19:29 INFO - PROCESS | 1657 | Values: 168.0 176.0 166.0 166.0 226.0 223.0 174.0 162.0 233.0 172.0 21:19:29 INFO - PROCESS | 1657 | 21:19:29 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:65.00 stddev:8.47 (13.0%) stddev-sans-first:8.76 21:19:29 INFO - PROCESS | 1657 | Values: 64.0 65.0 64.0 65.0 82.0 87.0 73.0 65.0 65.0 64.0 21:19:29 INFO - PROCESS | 1657 | -------- Summary: end -------- 21:19:29 INFO - PROCESS | 1657 | 21:19:30 INFO - TEST-INFO | 1657: exit 0 21:19:30 INFO - TEST-OK | kraken | took 59031ms 21:19:30 INFO - SUITE-END | took 1177s 21:19:30 INFO - Completed test suite (00:19:38) 21:19:30 INFO - javascript benchmark 21:19:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2883.2215301868496, 3347.096284003319, 3362.2266878617916, 3375.864965401384, 3422.0589337932065, 5623.100303951369, 5646.350669672989, 5664.0937450007905, 5667.0, 5692.516136128429, 5587.217789509472, 5625.915611265835, 5638.097904335307, 5672.546196304296, 5680.0627896397145, 5129.666571672848, 5162.767675454614, 5189.948100519003, 5190.2474141249495, 5233.712145831978, 5136.922946155811, 5147.7426128693605, 5167.379914410257, 5264.473552644743, 5282.603804714642, 5217.739113044351, 5247.86880327991, 5248.21276808478, 5275.024120537693, 5312.867178320554, 5268.236105764662, 5268.710220937885, 5276.762545685453, 5291.920621190705, 5297.761600727977, 5082.440931497532, 5116.820911268088, 5202.817901373433, 5219.399769026534, 5264.631475796696, 5603.495685388335, 5603.663780173202, 5627.2684551008515, 5631.915521267184, 5653.293338332708, 6231.408016238495, 6262.029385445263, 6286.528510361742, 6289.559730818844, 6292.496600272013, 6316.2736285326855, 6333.651649159295, 6354.0, 6361.395667411589, 6372.1397611322345, 5599.076152434844, 5699.373068962411, 5709.172170035322, 5792.247007888989, 5828.271466066742, 5282.947170528322, 6300.968495157586, 6302.621842689453, 6303.243610766737, 6305.022721478178, 6195.16365290689, 6198.380161983766, 6203.131561581382, 6215.378462153839, 6233.1273621693, 6146.6004709693725, 6271.466925311308, 6281.183446151971, 6345.777897773556, 6361.61830290184, 6068.878622427526, 6114.236541168587, 6126.212334160686, 6132.765133558579, 6191.845203869849, 6279.686015699197, 6289.339619339995, 6306.590071645328, 6306.590071645328, 6316.557840951181, 4945.604351651859, 4977.651564390458, 4991.326170966873, 4996.925046124311, 5004.699718016931, 3771.2268984858038, 4400.273954797487, 4425.601695847325, 4481.775911204427, 4497.392851964943, 4857.708537487762, 5785.016547186989, 5860.619059761102, 5896.528277737771, 5917.526597872246, 6124.441964285689, 6139.461473530676, 6176.011838105882, 6239.313675495692, 6303.968480157661, 5746.881277746121, 5767.596268261182, 5833.67914764692, 5869.618474799125, 5873.089671100986, 5480.616356854982, 5488.7530061147345, 5508.256385387921, 5510.090835012178, 5514.117741161395, 5186.818461353834, 6259.029850373199, 6260.5930614509, 6275.278342990432, 6294.370562943669, 6303.873922521616, 6304.5271604628915, 6305.148804911279, 6306.968465157828, 6307.211598550181, 6295.055741638791, 6308.0, 6309.305976342691, 6314.305426403183, 6327.082573026793, 6112.908306375319, 6122.142899993915, 6198.256209254918, 6200.0, 6205.410486003822, 6302.086197501429, 6338.366163383625, 6340.207474065742, 6344.080108384351, 6363.236411630634, 5036.748162591929, 5994.850128746816, 6207.131001659681, 6218.968905155626, 6234.2830574484515, 5976.983912734759, 5993.760249589967, 6086.147939288591, 6123.387661234019, 6197.25632924052, 5925.318588362394, 5987.520998320211, 6017.458428741435, 6079.05774604937, 6079.209702738615, 6147.754089836357, 6161.784337548164, 6163.075538669235, 6166.0, 6202.689865506797, 5709.771609135588, 5786.4213578643485, 6023.6385816851125, 6032.698365081641, 6038.84902877414], "value": 5696.341119095432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.39266257533916, 507.12267776746205, 521.1323146960311, 529.7298377827308, 544.8583368324234, 30367.54448683269, 39748.60251397485, 41415.75752727419, 41521.16957660845, 43687.563124368746, 42301.576984230145, 42430.0, 42823.57176428235, 42917.7854110729, 42936.57063429365, 8360.331173506136, 9251.953740231289, 9446.85829712555, 9454.054594540525, 9456.621735130586, 8525.786855328604, 11107.611233606825, 11317.83023254652, 11364.999999999958, 11514.309141451498, 11344.43277836109, 11376.203665743402, 11402.657920262363, 11420.428978551081, 11449.25579837312, 8388.664453421856, 11287.266327688714, 11367.97688208057, 11397.316161030365, 11403.030742386907, 7526.548407095592, 8407.24334809864, 8563.828723425559, 8567.186117318906, 11020.724481887937, 38640.613593863985, 39094.43622255106, 40294.79852600748, 40382.39426408606, 40434.0, 3620.6198349173483, 3833.769973801581, 3980.980095099506, 4009.1179940413062, 4081.265372232997, 27099.45801083987, 27136.59295110555, 27167.592486112724, 27221.45557088867, 28237.0, 3042.8022178558545, 3258.7881787683723, 3329.6503867094093, 3330.1841048943165, 3330.467125259971, 473151.0, 474544.0, 475226.0, 475984.0, 476760.0, 55728.164077538866, 56026.0, 56130.87738245212, 56176.71911640497, 56302.43697563054, 58029.80836054058, 58035.54911127256, 58149.70925145432, 58251.0, 58288.12567811486, 15681.68636627261, 15829.129397883227, 15900.204989750466, 15918.9204053979, 15921.601959950862, 9363.812723745486, 11241.100711943025, 12200.901918827349, 12260.81608775869, 12264.264144151379, 15419.0, 17518.737218941726, 17838.5540361492, 17850.5537361567, 18116.547086322946, 7384.815379615553, 7826.373890088779, 7859.4891332063235, 7875.212478752079, 7899.840063974341, 857.1599832164513, 864.9783755406039, 880.9867851982225, 890.1321211818555, 912.5847739278612, 28896.566551501743, 29480.557791633142, 29566.704332956826, 30238.09285721432, 30314.84842575773, 781.5154604145466, 1054.167207905746, 1079.422508957704, 1097.846301517788, 1196.8204769284503, 14766.92616536932, 15249.6187595311, 15366.846331536764, 15682.921585392, 15696.293666785023, 664270.0, 672401.0, 674405.0, 675133.0, 675890.0, 58061.4193858056, 58867.0, 59018.70490647519, 59024.1146382796, 59058.0, 1396.8882489400823, 1438.3886848089521, 1453.128123126116, 1464.7290251303543, 1467.772495263236, 28337.29156771097, 29120.126396208147, 29133.85433072821, 29660.0, 29743.553846691884, 43785.56214437942, 47032.99999999863, 49038.50961490339, 49542.75228623834, 49690.0, 460977.6951115223, 461352.0, 462137.0, 462260.0, 463268.0, 26069.217923462325, 26398.0, 26428.0750173743, 26435.0, 26446.338841529116, 45987.0, 46651.066978660914, 46790.532094678616, 47198.0, 47555.0, 37350.439743404415, 37357.6264237365, 37582.43626345552, 37679.869603911924, 38931.02672433212, 37641.0, 38151.809240954724, 38855.0, 39028.0, 39297.80351098226, 36410.63589364073, 36747.08132296714, 37729.434058488594, 37746.81126594349, 38085.80957095197, 32109.357812843144, 32961.540380106555, 33884.152896176805, 33950.660493395735, 33990.49014264838, 22061.66907496421, 24430.87784561137, 24727.87636061808, 24775.876120619283, 25129.74870251274], "value": 19713.99145025794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.32669511616893, 400.8617027125642, 402.3301203496181, 409.9528554216265, 430.5995424255443, 13914.165150090988, 16019.519414417571, 18028.729569056457, 19303.4208973731, 21140.89429552854, 20011.59976800463, 21594.892025539888, 21859.12563497458, 21863.0, 22240.887955602237, 4896.55930966213, 5771.422857714216, 5974.910376344358, 6001.069834175688, 6072.2106126203535, 6119.510439164878, 6167.167432396614, 6178.289496707891, 6181.134641150243, 6222.751089956397, 3945.7237993340477, 4128.2981893078095, 6832.555883867532, 8035.075966263867, 8101.797455063612, 7842.921570784276, 7933.722319718811, 7997.880031799527, 8096.0, 8103.10865804761, 7616.8476630467085, 7895.96052019742, 7910.564918929456, 7914.80212994674, 7933.880991785128, 29654.40356744708, 29714.25714357137, 29886.85056574725, 30101.397972040657, 30119.247018824484, 2951.7048295170525, 2964.273752930524, 3028.258076771205, 3037.726604605574, 3078.1227350205086, 17258.741118883227, 17284.135793210287, 17295.048772317645, 17708.645827083386, 17983.73024404635, 1874.1659961317218, 1945.367755479475, 2044.2845004248543, 2066.039291729353, 2085.8227050700707, 157687.42312576843, 158194.0, 160311.0, 166314.0, 172888.0, 18918.90540547316, 24202.87898560531, 24544.509109817704, 24625.13812016571, 24834.0, 42048.36927446091, 44034.77982610066, 44117.77941110338, 44187.55812441899, 44239.55760442354, 11370.602028928948, 11643.76712465746, 11654.70863228426, 11780.823287650692, 11797.056235501139, 9215.11090226502, 9221.354505184572, 9225.169734723908, 9236.353455258068, 9411.952940235255, 9273.814523709489, 9418.764530886783, 10031.899681003242, 11192.552297908156, 11314.886851131549, 4158.37624356349, 4262.829486820555, 4283.02980628908, 4297.3768803523935, 4307.353896915488, 1038.2628333882876, 1041.9010194031555, 1052.3265110329396, 1052.4474650808386, 1055.2507719519074, 21107.0, 21163.0, 21202.469938251666, 21254.681179782314, 21263.255786047415, 1043.6921108273077, 1059.0256963593513, 1072.265498133781, 1075.086176749772, 1093.4587379247164, 10236.795264094677, 10887.020168184901, 11045.28205666629, 11050.778984420267, 11079.224454288122, 700603.0, 721606.0, 745589.0, 755210.1751831329, 756308.0, 154497.0, 156347.0, 159695.40304597036, 161730.0, 165351.0, 974.5176137811828, 995.6316163019729, 1011.9696409107738, 1017.9949100254452, 1024.36489376587, 18193.818061819213, 18433.446996590123, 18684.719729204346, 18702.345417910306, 18827.0, 38937.0, 56652.0, 58286.4171358298, 58524.707376462844, 58983.70508147432, 62833.80081697118, 82479.0, 84009.0, 86293.0, 87146.0, 7400.592967386845, 8004.799880003046, 8316.708915187939, 8846.071162527842, 8858.557072146496, 11143.665690029313, 11224.382658953837, 13091.738165236451, 13491.662708431975, 13699.931500342434, 11040.447977601249, 11152.888471115184, 11338.716532086433, 11480.368579728196, 11589.768204636028, 10445.582176712845, 11142.554297828321, 11313.321200727984, 11506.194566380607, 11556.768864622829, 11460.968512833884, 11635.88364116348, 12010.459529321377, 12014.876132205514, 12091.214071085351, 6685.930251159791, 7630.351420129351, 7647.579383133759, 7758.573278469513, 7794.2205779423875, 10765.623203187852, 11088.611898583511, 11256.558743094838, 11397.373144477133, 11581.536738530702], "value": 11537.406990268597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.5241244183198, 1430.2634143416142, 1440.265464613047, 1448.717500087482, 1455.1560095144814, 8068.394870384723, 8477.576121193932, 8500.61747221375, 8501.532415717133, 8507.91492085079, 7433.5911524866115, 7678.769636910888, 7682.884756728639, 8048.557329346898, 8280.130586288444, 2290.6564015397657, 2359.6578496118054, 2361.669366288721, 2362.456634973957, 2362.6692263083182, 2340.1458467659354, 2377.8929948152377, 2380.059876348841, 2384.5707772600927, 2394.114177754225, 1886.368066697651, 2053.5276886316155, 2128.6274901892184, 2301.390131615123, 2336.1122773346187, 2340.9063637454565, 2354.1289722802503, 2358.5282943411385, 2364.243442098529, 2366.538524987628, 2290.599145149592, 2345.319857241398, 2355.8704271265074, 2359.8112151027876, 2361.846479978813, 8404.957975210145, 8451.197136272105, 8456.957715211385, 8465.0, 8470.661173553111, 5028.170351891933, 5199.506046925536, 5207.973960130175, 5208.765605547722, 5242.737863106868, 3297.8186199759, 3472.3923313420305, 3474.6177920428986, 3537.6992955598803, 3541.3271478419274, 1133.5692436874017, 1185.63838029401, 1212.7453234820698, 1227.3311045480234, 1230.4094034863226, 10456.68629941103, 10803.351798892092, 10823.025927666547, 10920.836187457195, 10932.180086493545, 3992.9001774955277, 4397.912041759147, 4406.9779651101535, 4496.415465989466, 4507.211238033331, 8758.737237882746, 8790.59350503929, 8795.91204087951, 8799.988001379796, 8803.295736341077, 5126.410462796752, 5139.460356662571, 5148.279240906276, 5150.896982060338, 5153.4073581538605, 4737.59730422911, 4747.192977193886, 4812.278158276286, 4867.367242258484, 4872.244802055687, 3618.3125206210734, 3707.295613833363, 3741.3639681254253, 3778.8852288574385, 3784.8864534064023, 1158.9710257243469, 1165.1494409081417, 1165.825126231072, 1173.5833779008328, 1176.6764139861436, 822.8066404394963, 853.6030745703154, 863.2619110660421, 896.8475359188953, 924.2098006204733, 4939.333190019373, 5070.391553013588, 5147.819826306136, 5319.654222475527, 5427.9185812212845, 484.7866938547028, 541.8320320700595, 543.0849019402319, 561.2199043329775, 574.9425057494217, 2978.851057447119, 3464.3244567309134, 3486.8082255475683, 3515.876944306937, 3724.348239058208, 9824.90175098254, 9925.2059835213, 10218.0, 10245.077942985017, 10251.0, 9717.56270967808, 9762.951185244028, 10078.899211007943, 10201.285909986229, 10230.897691023143, 7739.0, 7950.602469876599, 7987.121416644164, 8002.799930001796, 8018.077921039155, 4963.8262660806695, 5220.477952204749, 5319.308489896289, 5440.891182176413, 5585.385607583244, 8985.685501007434, 9019.458832470073, 9085.273178145864, 9263.629454821732, 9335.06649335061, 9151.450912945245, 9347.906520934703, 9445.669401570913, 9548.618055277711, 9586.520673966414, 7713.691452341844, 7873.33076688465, 7972.880406793786, 7978.242067003625, 7980.281774640311, 7664.540127592362, 7743.0, 7851.528908265523, 7857.174996625501, 7890.053193616803, 6907.34380233877, 6972.755953541602, 6997.300269972962, 7011.088558487364, 7026.929730702627, 5361.142217245222, 6261.5616906816085, 6759.188897332351, 6922.965385173042, 7149.60677162761, 6116.4495195430845, 6347.301796802256, 6429.099926010455, 6432.00303952888, 6438.742450302123, 4638.652101092499, 4705.411823522059, 4740.691855029412, 4766.380370551806, 4857.077155340474, 4626.334519573018, 4686.203345431217, 4757.405324334458, 4811.903761924812, 4882.7314497701545], "value": 4296.967500054942, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.3429607932175, 332.85687154523544, 361.7684681803646, 367.23981358587724, 377.886634009797, 4610.0, 4883.706977581343, 4974.995128921221, 4989.403390914908, 5002.574781143602, 4169.37459381093, 4176.310908700061, 4488.483824360192, 4910.582600478954, 5048.974755126219, 3645.5235629570066, 3789.9810500947456, 3967.821448034845, 4031.254217969685, 4055.4930633670792, 3826.521684789401, 3835.539735231776, 3922.1371298314466, 4062.1266427718033, 4067.4712287402594, 3897.9805100974454, 3978.264021156081, 3989.601039896016, 4004.2191772604356, 4049.959500404988, 3939.330313846653, 3994.2211268802594, 3995.880123596297, 3999.0002499375155, 4025.6376926076796, 3411.761176717631, 3432.9141771455666, 3479.1128262292955, 3512.8067956262394, 3556.217632120955, 4075.551689314173, 4094.6314831664995, 4833.492483289239, 4921.286413470027, 4938.851834444937, 4592.425946756655, 4608.216603177468, 4608.976955115203, 4620.861374158781, 4645.535446455361, 5245.793467502458, 5426.565874730012, 5435.22803370284, 5448.210009548593, 5479.438360067362, 3406.267652454734, 3911.2959667259884, 3916.295066887959, 3923.4114882767813, 3985.163115745697, 5269.314989051399, 5654.021092617592, 5655.0, 5702.800401985952, 5761.530809643556, 3694.5751238607368, 3863.3818589025623, 4029.005642207126, 4033.668889266535, 4056.4320995060716, 3420.572428446444, 3641.817909104534, 3996.322463949161, 4093.3450647896193, 4106.281400754856, 4287.078278170146, 4432.889177770581, 4446.510883802779, 4613.976930115328, 4663.437748354339, 4508.729476231437, 5006.89986200274, 5193.766280517386, 5489.231507588941, 5506.394296627368, 1269.156011252525, 1345.3340596404842, 1350.8176396186586, 1357.830271216098, 1360.5442176870858, 907.7322189953848, 933.5612262236738, 940.4686352211115, 942.1803031362758, 948.8244674735196, 4694.906101878011, 4746.264329029006, 4755.429348478205, 4770.666053376231, 4837.274408838703, 4270.530241673413, 5228.2746693591025, 5249.527542521191, 5258.8159414420315, 5300.04599172145, 4109.876703698834, 4293.162833247487, 4459.302122216012, 4460.821567137278, 4683.531646835289, 2388.6058800297756, 2489.35276828026, 2592.753688399599, 2770.7783377329765, 2778.7638050765913, 4790.850195953016, 5074.898502029939, 5524.4199359067525, 5530.751116199781, 5543.085390910454, 5078.435390128036, 5374.811881584125, 5417.052015897202, 5441.428649991773, 5466.9179962300595, 4582.639940430681, 5034.244863270539, 5089.307560557854, 5460.808871689551, 5525.917111243415, 4512.481064677604, 4595.908081838412, 4698.906021879611, 5008.524190201925, 5352.678839269501, 4299.677524185636, 4442.73343599385, 4605.56247156533, 4734.357599708329, 4970.167004807226, 4616.238320677051, 4708.327504546459, 5253.474652534716, 5488.588355873246, 5490.670559766427, 3505.949019823432, 3553.182767963435, 3839.9616003839606, 3844.4041173618134, 3877.166409222031, 4424.69027168108, 4661.277501987197, 4767.76161191946, 5010.549050585465, 5220.895582088413, 4194.497594508497, 4366.759828209479, 4386.157813718182, 5101.072174425745, 5140.023395554833, 4431.119772148129, 4668.929966050444, 4949.554540091409, 5057.949420505748, 5114.616403769806, 4920.8769780755765, 5029.711481276084, 5037.748112594429, 5057.949420505748, 5305.363356397257, 5103.897922041464, 5338.145896656516, 5421.674699518042, 5422.15956526739, 5452.972735136299, 4738.763061846825, 5257.768520322304, 5410.75651595687, 5426.782928682808, 5436.782528698808], "value": 3899.824186899343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.37249788941, 702.8032150997723, 734.097060615443, 772.5866661336187, 807.870740681491, 14598.635034124152, 14698.706025879503, 15623.3750649974, 15631.765523517128, 15679.216039198052, 14306.427742890299, 14319.92840035801, 14340.996130270885, 14471.638209044779, 14528.491502797404, 665.5474277491304, 688.2154344047765, 720.7045111504258, 842.8230071684939, 844.1347618690829, 856.0497847389393, 860.2644738748373, 862.2799962031711, 862.6980556805099, 863.7667829685981, 912.8721978922956, 913.9543022848865, 914.0219964637807, 916.7478943290582, 917.0325306801321, 700.8072779985494, 722.9240929702411, 870.9390342676015, 909.5679552212679, 911.9361644684875, 665.5008743442418, 667.0494545272967, 669.3607604737464, 669.9531032827704, 670.1656437735003, 14597.927010364987, 14932.0, 14971.625709357244, 14988.925055374762, 14994.100353978687, 13297.0, 13307.667308317272, 13326.733465330639, 13583.320833958263, 13696.246706431142, 11893.762124757543, 11971.22187057847, 12161.574344897974, 12184.451699673536, 12395.690107747288, 4384.3861859339395, 4518.683692141552, 4548.704334218299, 4682.719036857799, 4683.601893838993, 97533.5123324393, 105570.47214763876, 106196.0, 107370.0, 107591.0, 10696.893031069745, 10814.0, 10852.348859068481, 11482.425878706032, 11613.825792613117, 22218.222362217246, 22660.546789064127, 22700.318990430314, 22722.091116355492, 22811.88594057019, 7564.810879728051, 7667.463277570628, 7761.5731134787, 7913.881291780628, 7917.683292668229, 4191.161767646483, 4262.829486820555, 4322.243607368698, 4327.134573085333, 4426.535213802569, 3365.2764655598676, 3443.0359499340225, 3446.2590543032866, 3448.3103379324234, 3451.2924850405607, 537.6881408782974, 609.713434685697, 611.5810669691276, 627.5324882962223, 632.0172132334172, 525.90796610593, 532.2973674749294, 543.1879340386148, 547.5811004581499, 549.4148731600833, 9415.811683766286, 9585.520723963775, 9811.607535698493, 9847.852282215772, 9907.554160062815, 603.1947350287328, 617.5368473644767, 620.770314983459, 633.2527617411407, 661.8709351676376, 4343.4136391586735, 4349.521552629209, 4402.911941761146, 4717.790954424844, 4819.397575303087, 80522.19477805147, 82608.58695706484, 101546.49226753967, 102992.97007029834, 104538.4319235212, 88873.55563222272, 90127.54936225277, 90340.0, 91277.08722912818, 91657.54171229101, 72010.55978880498, 73320.63339683268, 76816.0, 77368.0, 80771.59614202009, 10565.471726413802, 10726.14760689427, 10854.18593605467, 11299.830502542303, 11300.604478843201, 50420.243696345315, 50810.729731757005, 51529.0, 51670.0, 52245.0, 69389.9591506138, 71239.28760712326, 72057.0, 73072.63463682648, 74220.51558968898, 13227.837077952852, 13448.865511344762, 13491.527796527467, 14271.429142834171, 14274.571762847132, 14249.572512824632, 14291.42834286617, 14706.41174353014, 14787.852121478647, 15053.698926021638, 12819.102662813513, 12870.549530766379, 13055.0, 13324.133931294435, 13351.198928064347, 13142.802857956947, 13241.602751917459, 13487.190768553919, 13656.248906310248, 14121.0, 12654.557090501788, 12700.745985080432, 13346.13250138738, 13430.261335626634, 13477.123986940818, 10594.576216951236, 10786.0, 11009.0, 11280.492377842853, 11325.943370283096, 10345.0, 10920.23928215354, 10955.616553420592, 11099.778004439704, 11111.166662500184], "value": 7438.982625652506, "unit": "score"}], "name": "dromaeo_css", "value": 7379.758847768133, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 112.0, 113.0, 113.0, 111.0, 113.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 111.0, 129.0, 174.0, 111.0, 110.0, 109.0, 107.0, 126.0, 107.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 183.0, 186.0, 183.0, 182.0, 184.0, 183.0, 184.0, 183.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 87.0, 59.0, 58.0, 57.0, 59.0, 94.0, 78.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 85.0, 69.0, 67.0, 68.0, 82.0, 67.0, 68.0, 81.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 84.0, 86.0, 84.0, 87.0, 85.0, 87.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 99.0, 93.0, 94.0, 93.0, 94.0, 93.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 87.0, 85.0, 85.0, 88.0, 86.0, 88.0, 87.0, 88.0], "value": 87.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 57.0, 58.0, 58.0, 56.0, 56.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 80.0, 73.0, 71.0, 66.0, 68.0, 67.0, 68.0, 68.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 85.0, 81.0, 81.0, 82.0, 85.0, 83.0, 94.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 139.0, 143.0, 131.0, 135.0, 139.0, 139.0, 185.0, 150.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 176.0, 166.0, 166.0, 226.0, 223.0, 174.0, 162.0, 233.0, 172.0], "value": 186.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 82.0, 87.0, 73.0, 65.0, 65.0, 64.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1439.5, "alertThreshold": 2.0}]} 21:19:30 INFO - Return code: 0 21:19:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:19:31 ERROR - # TBPL SUCCESS # 21:19:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:19:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:19:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:19:31 INFO - 2017-03-02 21:19:31.055 screenresolution[1661:10998] starting screenresolution argv=screenresolution get 21:19:31 INFO - 2017-03-02 21:19:31.059 screenresolution[1661:10998] Display 0: 1600x1200x32@60 21:19:31 INFO - 2017-03-02 21:19:31.065 screenresolution[1662:11001] starting screenresolution argv=screenresolution list 21:19:31 INFO - Available Modes on Display 0 21:19:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:19:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:19:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:19:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:19:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:19:31 INFO - Intel Iris: 21:19:31 INFO - Chipset Model: Intel Iris 21:19:31 INFO - Type: GPU 21:19:31 INFO - Bus: Built-In 21:19:31 INFO - VRAM (Dynamic, Max): 1536 MB 21:19:31 INFO - Vendor: Intel (0x8086) 21:19:31 INFO - Device ID: 0x0a2e 21:19:31 INFO - Revision ID: 0x0009 21:19:31 INFO - Displays: 21:19:31 INFO - Display: 21:19:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:19:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:19:31 INFO - Display Serial Number: 1600x1200 60 21:19:31 INFO - Main Display: Yes 21:19:31 INFO - Mirror: Off 21:19:31 INFO - Online: Yes 21:19:31 INFO - Rotation: Supported 21:19:31 INFO - Return code: 0 21:19:31 INFO - Running post-action listener: _resource_record_post_action 21:19:31 INFO - [mozharness: 2017-03-03 05:19:31.301657Z] Finished run-tests step (success) 21:19:31 INFO - Running post-run listener: _resource_record_post_run 21:19:31 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 32467968; Write bytes: 507763200; Read time: 195; Write time: 1625 21:19:31 INFO - TinderboxPrint: CPU usage
53.7% 21:19:31 INFO - TinderboxPrint: I/O read bytes / time
32,467,968 / 195 21:19:31 INFO - TinderboxPrint: I/O write bytes / time
507,763,200 / 1,625 21:19:31 INFO - TinderboxPrint: CPU idle
2,217.2 (46.3%) 21:19:31 INFO - TinderboxPrint: CPU system
956.1 (19.9%) 21:19:31 INFO - TinderboxPrint: CPU user
1,620.5 (33.8%) 21:19:31 INFO - TinderboxPrint: Swap in / out
236,126,208 / 0 21:19:31 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 205582848; Write bytes: 201064448; Read time: 15650; Write time: 453 21:19:31 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 28838912; Write bytes: 295586304; Read time: 173; Write time: 1135 21:19:31 INFO - Running post-run listener: _upload_blobber_files 21:19:31 INFO - Blob upload gear active. 21:19:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:19:31 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 21:19:31 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'] 21:19:31 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 21:19:32 INFO - (blobuploader) - INFO - Open directory for files ... 21:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:32 INFO - (blobuploader) - INFO - Done attempting. 21:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:19:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:33 INFO - (blobuploader) - INFO - Done attempting. 21:19:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:19:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:34 INFO - (blobuploader) - INFO - Done attempting. 21:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:19:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:36 INFO - (blobuploader) - INFO - Done attempting. 21:19:36 INFO - (blobuploader) - INFO - Iteration through files over. 21:19:36 INFO - Return code: 0 21:19:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:19:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:19:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dea5e370f4c39218b1e101db81361e915e13b3f1e0c26a314cd6a3b2a7b97cc1a2399c5a75fd63adbce6aabbd4ceab7647d2636cb0b0fc71a5677c34938214ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d19749bb2af34f0242594752de450337251a516cf5632213e797f197237041c3c293befdf77c4267ca3fa0c1efe56c3a1e4d99a9f5eeaa05312210cba80608c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9216783f9c4ab931bf99c9d9894e3f5448cc63870fa27e1451afb7853c1eb844a7967601269bc133d3563d2150056279ab9231c2bda84f6ea9a963378ae666cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e93ef15d13639cbfb61faf34363d52f446f0c993af7ffdb7ced27a6da713d2c5eb74080a0a65743c338efe4c2a5de760c5c4c70bf421372f8c5fca24545311"} 21:19:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:19:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:19:36 INFO - Contents: 21:19:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dea5e370f4c39218b1e101db81361e915e13b3f1e0c26a314cd6a3b2a7b97cc1a2399c5a75fd63adbce6aabbd4ceab7647d2636cb0b0fc71a5677c34938214ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d19749bb2af34f0242594752de450337251a516cf5632213e797f197237041c3c293befdf77c4267ca3fa0c1efe56c3a1e4d99a9f5eeaa05312210cba80608c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9216783f9c4ab931bf99c9d9894e3f5448cc63870fa27e1451afb7853c1eb844a7967601269bc133d3563d2150056279ab9231c2bda84f6ea9a963378ae666cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e93ef15d13639cbfb61faf34363d52f446f0c993af7ffdb7ced27a6da713d2c5eb74080a0a65743c338efe4c2a5de760c5c4c70bf421372f8c5fca24545311"} 21:19:36 INFO - Running post-run listener: copy_logs_to_upload_dir 21:19:36 INFO - Copying logs to upload dir... 21:19:36 INFO - mkdir: /builds/slave/test/build/upload/logs 21:19:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.481681 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-02 21:19:36.819998) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 21:19:36.827431) ========= 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.kKjnggJs0P/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.rTD9zfXmO0/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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/dea5e370f4c39218b1e101db81361e915e13b3f1e0c26a314cd6a3b2a7b97cc1a2399c5a75fd63adbce6aabbd4ceab7647d2636cb0b0fc71a5677c34938214ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d19749bb2af34f0242594752de450337251a516cf5632213e797f197237041c3c293befdf77c4267ca3fa0c1efe56c3a1e4d99a9f5eeaa05312210cba80608c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9216783f9c4ab931bf99c9d9894e3f5448cc63870fa27e1451afb7853c1eb844a7967601269bc133d3563d2150056279ab9231c2bda84f6ea9a963378ae666cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e93ef15d13639cbfb61faf34363d52f446f0c993af7ffdb7ced27a6da713d2c5eb74080a0a65743c338efe4c2a5de760c5c4c70bf421372f8c5fca24545311"} build_url:https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010857 build_url: 'https://queue.taskcluster.net/v1/task/O8R9qT76TvewxrG85qotMw/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/dea5e370f4c39218b1e101db81361e915e13b3f1e0c26a314cd6a3b2a7b97cc1a2399c5a75fd63adbce6aabbd4ceab7647d2636cb0b0fc71a5677c34938214ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d19749bb2af34f0242594752de450337251a516cf5632213e797f197237041c3c293befdf77c4267ca3fa0c1efe56c3a1e4d99a9f5eeaa05312210cba80608c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9216783f9c4ab931bf99c9d9894e3f5448cc63870fa27e1451afb7853c1eb844a7967601269bc133d3563d2150056279ab9231c2bda84f6ea9a963378ae666cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e93ef15d13639cbfb61faf34363d52f446f0c993af7ffdb7ced27a6da713d2c5eb74080a0a65743c338efe4c2a5de760c5c4c70bf421372f8c5fca24545311"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 21:19:36.864585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 21:19:36.864953) ========= 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.kKjnggJs0P/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.rTD9zfXmO0/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.005185 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 21:19:36.914098) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 21:19:36.914440) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 21:19:36.914821) ========= ========= Total master_lag: 0.20 =========