builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0338 starttime: 1480721087.69 results: success (0) buildid: 20161202130744 builduid: ea432fef198b4a989b57c5728acb9d76 revision: 633e960e72dbd3006a2d0325416e50a19a7e1838 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:47.694580) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:47.694998) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:47.695274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:47.719381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:47.719641) ========= 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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 --2016-12-02 15:24:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 74.0M=0s 2016-12-02 15:24:47 (74.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132843 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:47.875419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:47.878730) ========= 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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.020426 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:47.926078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:47.926387) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 633e960e72dbd3006a2d0325416e50a19a7e1838 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 633e960e72dbd3006a2d0325416e50a19a7e1838 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 2016-12-02 15:24:48,011 truncating revision to first 12 chars 2016-12-02 15:24:48,011 Setting DEBUG logging. 2016-12-02 15:24:48,011 attempt 1/10 2016-12-02 15:24:48,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/633e960e72db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 15:24:48,479 unpacking tar archive at: mozilla-central-633e960e72db/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733692 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:48.686043) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:48.686346) ========= script_repo_revision: 633e960e72dbd3006a2d0325416e50a19a7e1838 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:48.687784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:48.688055) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 15:24:48.708759) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-12-02 15:24:48.709038) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:24:48 INFO - MultiFileLogger online at 20161202 15:24:48 in /builds/slave/test 15:24:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:24:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:48 INFO - {'append_to_log': False, 15:24:48 INFO - 'base_work_dir': '/builds/slave/test', 15:24:48 INFO - 'blob_upload_branch': 'Firefox', 15:24:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:48 INFO - 'branch': 'Firefox', 15:24:48 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:48 INFO - 'config_files': ('talos/mac_config.py',), 15:24:48 INFO - 'default_actions': ('clobber', 15:24:48 INFO - 'read-buildbot-config', 15:24:48 INFO - 'download-and-extract', 15:24:48 INFO - 'populate-webroot', 15:24:48 INFO - 'create-virtualenv', 15:24:48 INFO - 'install', 15:24:48 INFO - 'run-tests'), 15:24:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:48 INFO - 'download_minidump_stackwalk': True, 15:24:48 INFO - 'download_symbols': 'ondemand', 15:24:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:24:48 INFO - 'tooltool.py': '/tools/tooltool.py', 15:24:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:24:48 INFO - '/tools/misc-python/virtualenv.py')}, 15:24:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:48 INFO - 'installer_path': 'installer.exe', 15:24:48 INFO - 'log_level': 'info', 15:24:48 INFO - 'log_name': 'talos', 15:24:48 INFO - 'log_to_console': True, 15:24:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:24:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:24:48 INFO - 'opt_config_files': (), 15:24:48 INFO - 'pip_index': False, 15:24:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:24:48 INFO - 'cmd': ('bash', 15:24:48 INFO - '-c', 15:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:24:48 INFO - 'enabled': True, 15:24:48 INFO - 'halt_on_failure': False, 15:24:48 INFO - 'name': 'check_screen_resolution'},), 15:24:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:24:48 INFO - 'cmd': ('bash', 15:24:48 INFO - '-c', 15:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:24:48 INFO - 'enabled': True, 15:24:48 INFO - 'halt_on_failure': False, 15:24:48 INFO - 'name': 'check_screen_resolution'},), 15:24:48 INFO - 'run_cmd_checks_enabled': True, 15:24:48 INFO - 'sps_profile': False, 15:24:48 INFO - 'sps_profile_interval': 0, 15:24:48 INFO - 'suite': 'dromaeojs', 15:24:48 INFO - 'system_bits': '32', 15:24:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:48 INFO - 'title': 't-yosemite-r7-0338', 15:24:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:48 INFO - 'use_talos_json': True, 15:24:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:48 INFO - 'work_dir': 'build'} 15:24:48 INFO - [mozharness: 2016-12-02 23:24:48.910801Z] Running clobber step. 15:24:48 INFO - Running pre-action listener: _resource_record_pre_action 15:24:48 INFO - Running main action method: clobber 15:24:48 INFO - rmtree: /builds/slave/test/build 15:24:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:50 INFO - Running post-action listener: _resource_record_post_action 15:24:50 INFO - [mozharness: 2016-12-02 23:24:50.550015Z] Finished clobber step (success) 15:24:50 INFO - [mozharness: 2016-12-02 23:24:50.550263Z] Running read-buildbot-config step. 15:24:50 INFO - Running pre-action listener: _resource_record_pre_action 15:24:50 INFO - Running main action method: read_buildbot_config 15:24:50 INFO - Using buildbot properties: 15:24:50 INFO - { 15:24:50 INFO - "project": "", 15:24:50 INFO - "product": "firefox", 15:24:50 INFO - "script_repo_revision": "production", 15:24:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:24:50 INFO - "repository": "", 15:24:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:24:50 INFO - "buildid": "20161202130744", 15:24:50 INFO - "pgo_build": "False", 15:24:50 INFO - "basedir": "/builds/slave/test", 15:24:50 INFO - "buildnumber": 30, 15:24:50 INFO - "slavename": "t-yosemite-r7-0338", 15:24:50 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:24:50 INFO - "platform": "yosemite_r7", 15:24:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:24:50 INFO - "branch": "mozilla-central", 15:24:50 INFO - "repo_path": "mozilla-central", 15:24:50 INFO - "revision": "633e960e72dbd3006a2d0325416e50a19a7e1838", 15:24:50 INFO - "stage_platform": "macosx64", 15:24:50 INFO - "builduid": "ea432fef198b4a989b57c5728acb9d76", 15:24:50 INFO - "slavebuilddir": "test" 15:24:50 INFO - } 15:24:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 15:24:50 INFO - Running post-action listener: _resource_record_post_action 15:24:50 INFO - [mozharness: 2016-12-02 23:24:50.555715Z] Finished read-buildbot-config step (success) 15:24:50 INFO - [mozharness: 2016-12-02 23:24:50.555897Z] Running download-and-extract step. 15:24:50 INFO - Running pre-action listener: _resource_record_pre_action 15:24:50 INFO - Running main action method: download_and_extract 15:24:50 INFO - mkdir: /builds/slave/test/build/tests 15:24:50 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')]} 15:24:50 INFO - trying https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 15:24:50 INFO - Downloading https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 15:24:51 INFO - Downloaded 1199 bytes. 15:24:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:24:51 INFO - Using the following test package requirements: 15:24:51 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:24:51 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:24:51 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 15:24:51 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:24:51 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 15:24:51 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:24:51 INFO - u'jsshell-mac.zip'], 15:24:51 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:24:51 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 15:24:51 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:24:51 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:24:51 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 15:24:51 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:24:51 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 15:24:51 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:24:51 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 15:24:51 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:24:51 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 15:24:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:24:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:24:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:24:51 INFO - Fetch https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:24:52 INFO - Expected file size: 16274886 15:24:52 INFO - Obtained file size: 16274886 15:24:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:24:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:24:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:24:59 INFO - Fetch https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:25:00 INFO - Expected file size: 16274886 15:25:00 INFO - Obtained file size: 16274886 15:25:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 15:25:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:25:06 INFO - Fetch https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 15:25:08 INFO - Expected file size: 14409734 15:25:08 INFO - Obtained file size: 14409734 15:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:08 INFO - trying https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:25:08 INFO - Downloading https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 15:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 15:25:11 INFO - Downloaded 107618717 bytes. 15:25:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:25:11 INFO - mkdir: /builds/slave/test/properties 15:25:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:25:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:25:11 INFO - Contents: 15:25:11 INFO - build_url:https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:25:12 INFO - Running post-action listener: _resource_record_post_action 15:25:12 INFO - Running post-action listener: set_extra_try_arguments 15:25:12 INFO - [mozharness: 2016-12-02 23:25:12.257774Z] Finished download-and-extract step (success) 15:25:12 INFO - [mozharness: 2016-12-02 23:25:12.257936Z] Running populate-webroot step. 15:25:12 INFO - Running pre-action listener: _resource_record_pre_action 15:25:12 INFO - Running main action method: populate_webroot 15:25:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:25:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:25:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:25:12 INFO - '--tppagecycles', 15:25:12 INFO - '7'], 15:25:12 INFO - 'tests': ['tsvgm']}}, 15:25:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:25:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:25:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:25:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:25:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:25:12 INFO - 'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:25:12 INFO - 'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['damp', 'tps']}, 15:25:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:25:12 INFO - 'tests': ['damp', 'tps']}, 15:25:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['dromaeo_dom']}, 15:25:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:25:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['basic_compositor_video']}, 15:25:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:25:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['a11yr', 15:25:12 INFO - 'ts_paint', 15:25:12 INFO - 'tpaint', 15:25:12 INFO - 'sessionrestore', 15:25:12 INFO - 'sessionrestore_no_auto_restore', 15:25:12 INFO - 'tabpaint']}, 15:25:12 INFO - 'other-e10s': {'tests': ['a11yr', 15:25:12 INFO - 'ts_paint', 15:25:12 INFO - 'tpaint', 15:25:12 INFO - 'sessionrestore', 15:25:12 INFO - 'sessionrestore_no_auto_restore', 15:25:12 INFO - 'tabpaint']}, 15:25:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:25:12 INFO - 'ts_paint', 15:25:12 INFO - 'tpaint', 15:25:12 INFO - 'sessionrestore', 15:25:12 INFO - 'sessionrestore_no_auto_restore', 15:25:12 INFO - 'tabpaint']}, 15:25:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:25:12 INFO - 'ts_paint', 15:25:12 INFO - 'tpaint', 15:25:12 INFO - 'sessionrestore', 15:25:12 INFO - 'sessionrestore_no_auto_restore', 15:25:12 INFO - 'tabpaint']}, 15:25:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['a11yr', 15:25:12 INFO - 'ts_paint', 15:25:12 INFO - 'tpaint', 15:25:12 INFO - 'sessionrestore', 15:25:12 INFO - 'sessionrestore_no_auto_restore', 15:25:12 INFO - 'tabpaint']}, 15:25:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['a11yr', 15:25:12 INFO - 'ts_paint', 15:25:12 INFO - 'tpaint', 15:25:12 INFO - 'sessionrestore', 15:25:12 INFO - 'sessionrestore_no_auto_restore', 15:25:12 INFO - 'tabpaint']}, 15:25:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['tsvgx', 15:25:12 INFO - 'tsvgr_opacity', 15:25:12 INFO - 'tart', 15:25:12 INFO - 'tscrollx', 15:25:12 INFO - 'cart', 15:25:12 INFO - 'tsvg_static']}, 15:25:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:25:12 INFO - 'tsvgr_opacity', 15:25:12 INFO - 'tart', 15:25:12 INFO - 'tscrollx', 15:25:12 INFO - 'cart', 15:25:12 INFO - 'tsvg_static']}, 15:25:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:25:12 INFO - 'talos_options': ['--disable-e10s'], 15:25:12 INFO - 'tests': ['tp5o']}, 15:25:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:25:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:25:12 INFO - 'talos_options': ['--disable-e10s', 15:25:12 INFO - '--xperf_path', 15:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:12 INFO - 'tests': ['tp5n']}, 15:25:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:25:12 INFO - 'talos_options': ['--xperf_path', 15:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:12 INFO - 'tests': ['tp5n']}}, 15:25:12 INFO - 'talos.zip': {'path': '', 15:25:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:25:12 INFO - Running post-action listener: _resource_record_post_action 15:25:12 INFO - [mozharness: 2016-12-02 23:25:12.277059Z] Finished populate-webroot step (success) 15:25:12 INFO - [mozharness: 2016-12-02 23:25:12.277214Z] Running create-virtualenv step. 15:25:12 INFO - Running pre-action listener: _resource_record_pre_action 15:25:12 INFO - Running main action method: create_virtualenv 15:25:12 INFO - Creating virtualenv /builds/slave/test/build/venv 15:25:12 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 15:25:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:25:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:25:12 INFO - Using real prefix '/tools/python27' 15:25:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:25:13 INFO - Installing distribute.............................................................................................................................................................................................done. 15:25:15 INFO - Installing pip.................done. 15:25:15 INFO - Return code: 0 15:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:25:16 INFO - Reading from file tmpfile_stdout 15:25:16 INFO - Output received: 15:25:16 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) 15:25:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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')]} 15:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25: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', 'pip>=1.5'] in /builds/slave/test/build 15:25: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 pip>=1.5 15:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:16 INFO - 'HOME': '/Users/cltbld', 15:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:16 INFO - 'LOGNAME': 'cltbld', 15:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:16 INFO - 'MOZ_NO_REMOTE': '1', 15:25:16 INFO - 'NO_EM_RESTART': '1', 15:25:16 INFO - 'PAGER': '/bin/cat', 15:25:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:16 INFO - 'PWD': '/builds/slave/test', 15:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:16 INFO - 'SHELL': '/bin/bash', 15:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:16 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:16 INFO - 'USER': 'cltbld', 15:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:16 INFO - 'XPC_FLAGS': '0x0', 15:25:16 INFO - 'XPC_SERVICE_NAME': '0', 15:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:16 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 15:25:16 INFO - Cleaning up... 15:25:16 INFO - Return code: 0 15:25:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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')]} 15:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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', '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 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:25: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 psutil>=3.1.1 15:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:16 INFO - 'HOME': '/Users/cltbld', 15:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:16 INFO - 'LOGNAME': 'cltbld', 15:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:16 INFO - 'MOZ_NO_REMOTE': '1', 15:25:16 INFO - 'NO_EM_RESTART': '1', 15:25:16 INFO - 'PAGER': '/bin/cat', 15:25:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:16 INFO - 'PWD': '/builds/slave/test', 15:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:16 INFO - 'SHELL': '/bin/bash', 15:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:16 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:16 INFO - 'USER': 'cltbld', 15:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:16 INFO - 'XPC_FLAGS': '0x0', 15:25:16 INFO - 'XPC_SERVICE_NAME': '0', 15:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:16 INFO - Downloading/unpacking psutil>=3.1.1 15:25: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 15:25: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 15:25: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 15:25: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 15:25: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 15:25: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 15:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:20 INFO - Installing collected packages: psutil 15:25:20 INFO - Running setup.py install for psutil 15:25:20 INFO - building 'psutil._psutil_osx' extension 15:25:20 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 15:25:20 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 15:25:20 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 15:25:20 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 15:25:20 INFO - building 'psutil._psutil_posix' extension 15:25:20 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 15:25:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:25:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:25:21 INFO - ^ 15:25:21 INFO - 1 warning generated. 15:25:21 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 15:25:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:21 INFO - Successfully installed psutil 15:25:21 INFO - Cleaning up... 15:25:21 INFO - Return code: 0 15:25:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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')]} 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:21 INFO - 'HOME': '/Users/cltbld', 15:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:21 INFO - 'LOGNAME': 'cltbld', 15:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:21 INFO - 'MOZ_NO_REMOTE': '1', 15:25:21 INFO - 'NO_EM_RESTART': '1', 15:25:21 INFO - 'PAGER': '/bin/cat', 15:25:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:21 INFO - 'PWD': '/builds/slave/test', 15:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:21 INFO - 'SHELL': '/bin/bash', 15:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:21 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:21 INFO - 'USER': 'cltbld', 15:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:21 INFO - 'XPC_FLAGS': '0x0', 15:25:21 INFO - 'XPC_SERVICE_NAME': '0', 15:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:25:24 INFO - Installing collected packages: mozsystemmonitor 15:25:24 INFO - Running setup.py install for mozsystemmonitor 15:25:24 INFO - Successfully installed mozsystemmonitor 15:25:24 INFO - Cleaning up... 15:25:24 INFO - Return code: 0 15:25:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:25:24 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')]} 15:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:24 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')]} 15:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:24 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 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25:24 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 15:25:24 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 15:25:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:24 INFO - 'HOME': '/Users/cltbld', 15:25:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:24 INFO - 'LOGNAME': 'cltbld', 15:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:24 INFO - 'MOZ_NO_REMOTE': '1', 15:25:24 INFO - 'NO_EM_RESTART': '1', 15:25:24 INFO - 'PAGER': '/bin/cat', 15:25:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:24 INFO - 'PWD': '/builds/slave/test', 15:25:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:24 INFO - 'SHELL': '/bin/bash', 15:25:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:24 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:24 INFO - 'USER': 'cltbld', 15:25:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:24 INFO - 'XPC_FLAGS': '0x0', 15:25:24 INFO - 'XPC_SERVICE_NAME': '0', 15:25:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:24 INFO - Downloading/unpacking jsonschema==2.5.1 15:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:25:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:25:27 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 15:25:27 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 15:25:27 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 15:25:27 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 15:25:27 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 15:25:27 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 15:25:27 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:27 INFO - warning: no files found matching '*.txt' 15:25:27 INFO - no previously-included directories found matching 'build' 15:25:27 INFO - no previously-included directories found matching 'dist' 15:25:27 INFO - no previously-included directories found matching '.git*' 15:25:27 INFO - Installing collected packages: jsonschema, functools32 15:25:27 INFO - Running setup.py install for functools32 15:25:27 INFO - warning: no files found matching '*.txt' 15:25:27 INFO - no previously-included directories found matching 'build' 15:25:27 INFO - no previously-included directories found matching 'dist' 15:25:27 INFO - no previously-included directories found matching '.git*' 15:25:27 INFO - Successfully installed jsonschema functools32 15:25:27 INFO - Cleaning up... 15:25:27 INFO - Return code: 0 15:25:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:25:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:27 INFO - 'HOME': '/Users/cltbld', 15:25:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:27 INFO - 'LOGNAME': 'cltbld', 15:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:27 INFO - 'MOZ_NO_REMOTE': '1', 15:25:27 INFO - 'NO_EM_RESTART': '1', 15:25:27 INFO - 'PAGER': '/bin/cat', 15:25:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:27 INFO - 'PWD': '/builds/slave/test', 15:25:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:27 INFO - 'SHELL': '/bin/bash', 15:25:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:27 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:27 INFO - 'USER': 'cltbld', 15:25:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:27 INFO - 'XPC_FLAGS': '0x0', 15:25:27 INFO - 'XPC_SERVICE_NAME': '0', 15:25:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:25:28 INFO - Cleaning up... 15:25:28 INFO - Return code: 0 15:25:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:28 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 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25:28 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 15:25:28 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 15:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:28 INFO - 'HOME': '/Users/cltbld', 15:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:28 INFO - 'LOGNAME': 'cltbld', 15:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:28 INFO - 'MOZ_NO_REMOTE': '1', 15:25:28 INFO - 'NO_EM_RESTART': '1', 15:25:28 INFO - 'PAGER': '/bin/cat', 15:25:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:28 INFO - 'PWD': '/builds/slave/test', 15:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:28 INFO - 'SHELL': '/bin/bash', 15:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:28 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:28 INFO - 'USER': 'cltbld', 15:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:28 INFO - 'XPC_FLAGS': '0x0', 15:25:28 INFO - 'XPC_SERVICE_NAME': '0', 15:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:28 INFO - Downloading/unpacking blobuploader==1.2.4 15:25: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 15:25: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 15:25: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 15:25: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 15:25: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 15:25: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 15:25:30 INFO - Downloading blobuploader-1.2.4.tar.gz 15:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:25:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:25:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 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 15:25:32 INFO - Downloading docopt-0.6.1.tar.gz 15:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:25:32 INFO - Installing collected packages: blobuploader, requests, docopt 15:25:32 INFO - Running setup.py install for blobuploader 15:25:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:25:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:25:32 INFO - Running setup.py install for requests 15:25:32 INFO - Running setup.py install for docopt 15:25:33 INFO - Successfully installed blobuploader requests docopt 15:25:33 INFO - Cleaning up... 15:25:33 INFO - Return code: 0 15:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:33 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')]} 15:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:33 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')]} 15:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:33 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 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25:33 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 15:25:33 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 15:25:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:33 INFO - 'HOME': '/Users/cltbld', 15:25:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:33 INFO - 'LOGNAME': 'cltbld', 15:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:33 INFO - 'MOZ_NO_REMOTE': '1', 15:25:33 INFO - 'NO_EM_RESTART': '1', 15:25:33 INFO - 'PAGER': '/bin/cat', 15:25:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:33 INFO - 'PWD': '/builds/slave/test', 15:25:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:33 INFO - 'SHELL': '/bin/bash', 15:25:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:33 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:33 INFO - 'USER': 'cltbld', 15:25:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:33 INFO - 'XPC_FLAGS': '0x0', 15:25:33 INFO - 'XPC_SERVICE_NAME': '0', 15:25:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:33 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-v2SX72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:33 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-vBrPwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:33 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-FPMI7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:33 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ElYTpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:33 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-J3AYlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-jjKyWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-_k5hOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-C6gyOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ywjthh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-kF8W0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Y7Dl5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-TtQEUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-PDAKP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-OTPO9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-7mGpRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-r_gHCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-aMWa6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:35 INFO - Running setup.py install for manifestparser 15:25:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Running setup.py install for mozcrash 15:25:35 INFO - Running setup.py install for mozdebug 15:25:35 INFO - Running setup.py install for mozdevice 15:25:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Running setup.py install for mozfile 15:25:36 INFO - Running setup.py install for mozhttpd 15:25:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Running setup.py install for mozinfo 15:25:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Running setup.py install for mozInstall 15:25:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Running setup.py install for mozleak 15:25:36 INFO - Running setup.py install for mozlog 15:25:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Running setup.py install for moznetwork 15:25:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Running setup.py install for mozprocess 15:25:37 INFO - Running setup.py install for mozprofile 15:25:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:37 INFO - Running setup.py install for mozrunner 15:25:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:37 INFO - Running setup.py install for mozscreenshot 15:25:37 INFO - Running setup.py install for moztest 15:25:37 INFO - Running setup.py install for mozversion 15:25:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:37 INFO - Cleaning up... 15:25:37 INFO - Return code: 0 15:25:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:37 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')]} 15:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:37 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')]} 15:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:37 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 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25:37 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 15:25:37 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 15:25:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:37 INFO - 'HOME': '/Users/cltbld', 15:25:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:37 INFO - 'LOGNAME': 'cltbld', 15:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:37 INFO - 'MOZ_NO_REMOTE': '1', 15:25:37 INFO - 'NO_EM_RESTART': '1', 15:25:37 INFO - 'PAGER': '/bin/cat', 15:25:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:37 INFO - 'PWD': '/builds/slave/test', 15:25:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:37 INFO - 'SHELL': '/bin/bash', 15:25:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:37 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:37 INFO - 'USER': 'cltbld', 15:25:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:37 INFO - 'XPC_FLAGS': '0x0', 15:25:37 INFO - 'XPC_SERVICE_NAME': '0', 15:25:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-EYApSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:38 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)) 15:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-xOex89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:38 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)) 15:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-DBjJxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:38 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)) 15:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Zb7AkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:38 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)) 15:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-8AyZyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:38 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)) 15:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-iFZBxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:38 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)) 15:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-gCVmxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:38 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)) 15:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-lbcEfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:39 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)) 15:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:39 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-PjfD69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:39 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)) 15:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:39 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ww6ka9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:39 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)) 15:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:39 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-vvp4a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:39 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)) 15:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:39 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-KGYt5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:39 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-IljE_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:39 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)) 15:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:39 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-JyyEfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:39 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)) 15:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:39 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-MgPxHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:39 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)) 15:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:39 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Q6QZoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 15:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:39 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-gdzz4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:40 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 15:25:40 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 15:25:40 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 15:25:40 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 15:25:40 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 15:25:40 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 15:25:42 INFO - Downloading blessings-1.6.tar.gz 15:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:42 INFO - Installing collected packages: blessings 15:25:42 INFO - Running setup.py install for blessings 15:25:42 INFO - Successfully installed blessings 15:25:42 INFO - Cleaning up... 15:25:42 INFO - Return code: 0 15:25:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:43 INFO - Reading from file tmpfile_stdout 15:25:43 INFO - Current package versions: 15:25:43 INFO - blessings == 1.6 15:25:43 INFO - blobuploader == 1.2.4 15:25:43 INFO - docopt == 0.6.1 15:25:43 INFO - functools32 == 3.2.3-2 15:25:43 INFO - jsonschema == 2.5.1 15:25:43 INFO - manifestparser == 1.1 15:25:43 INFO - mozInstall == 1.12 15:25:43 INFO - mozcrash == 1.0 15:25:43 INFO - mozdebug == 0.1 15:25:43 INFO - mozdevice == 0.49 15:25:43 INFO - mozfile == 1.2 15:25:43 INFO - mozhttpd == 0.7 15:25:43 INFO - mozinfo == 0.9 15:25:43 INFO - mozleak == 0.1 15:25:43 INFO - mozlog == 3.4 15:25:43 INFO - moznetwork == 0.27 15:25:43 INFO - mozprocess == 0.23 15:25:43 INFO - mozprofile == 0.28 15:25:43 INFO - mozrunner == 6.13 15:25:43 INFO - mozscreenshot == 0.1 15:25:43 INFO - mozsystemmonitor == 0.3 15:25:43 INFO - moztest == 0.7 15:25:43 INFO - mozversion == 1.4 15:25:43 INFO - psutil == 3.1.1 15:25:43 INFO - requests == 1.2.3 15:25:43 INFO - wsgiref == 0.1.2 15:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:43 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')]} 15:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:43 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')]} 15:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:44 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 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25:44 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 15:25:44 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 15:25:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:44 INFO - 'HOME': '/Users/cltbld', 15:25:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:44 INFO - 'LOGNAME': 'cltbld', 15:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:44 INFO - 'MOZ_NO_REMOTE': '1', 15:25:44 INFO - 'NO_EM_RESTART': '1', 15:25:44 INFO - 'PAGER': '/bin/cat', 15:25:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:44 INFO - 'PWD': '/builds/slave/test', 15:25:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:44 INFO - 'SHELL': '/bin/bash', 15:25:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:44 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:44 INFO - 'USER': 'cltbld', 15:25:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:44 INFO - 'XPC_FLAGS': '0x0', 15:25:44 INFO - 'XPC_SERVICE_NAME': '0', 15:25:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:44 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)) 15:25:44 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)) 15:25:44 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)) 15:25:44 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)) 15:25:44 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)) 15:25:44 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)) 15:25:44 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)) 15:25:44 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)) 15:25:44 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)) 15:25:44 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)) 15:25:44 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)) 15:25:44 INFO - Cleaning up... 15:25:44 INFO - Return code: 0 15:25:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:44 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 0x10d4553f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf10d89840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, '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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 15:25:44 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 15:25:44 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 15:25:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:25:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:44 INFO - 'HOME': '/Users/cltbld', 15:25:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:44 INFO - 'LOGNAME': 'cltbld', 15:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:44 INFO - 'MOZ_NO_REMOTE': '1', 15:25:44 INFO - 'NO_EM_RESTART': '1', 15:25:44 INFO - 'PAGER': '/bin/cat', 15:25:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:44 INFO - 'PWD': '/builds/slave/test', 15:25:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:44 INFO - 'SHELL': '/bin/bash', 15:25:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:25:44 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:25:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:44 INFO - 'USER': 'cltbld', 15:25:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:44 INFO - 'XPC_FLAGS': '0x0', 15:25:44 INFO - 'XPC_SERVICE_NAME': '0', 15:25:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:25:45 INFO - Cleaning up... 15:25:45 INFO - Return code: 0 15:25:45 INFO - Running post-action listener: _resource_record_post_action 15:25:45 INFO - Running post-action listener: _start_resource_monitoring 15:25:45 INFO - Starting resource monitoring. 15:25:45 INFO - [mozharness: 2016-12-02 23:25:45.096134Z] Finished create-virtualenv step (success) 15:25:45 INFO - [mozharness: 2016-12-02 23:25:45.097218Z] Running install step. 15:25:45 INFO - Running pre-action listener: _resource_record_pre_action 15:25:45 INFO - Running main action method: install 15:25:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:45 INFO - Reading from file tmpfile_stdout 15:25:45 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:45 INFO - Reading from file tmpfile_stdout 15:25:45 INFO - Output received: 15:25:45 INFO - Usage: mozinstall [options] installer 15:25:45 INFO - Options: 15:25:45 INFO - -h, --help show this help message and exit 15:25:45 INFO - -d DEST, --destination=DEST 15:25:45 INFO - Directory to install application into. [default: 15:25:45 INFO - "/builds/slave/test"] 15:25:45 INFO - --app=APP Application being installed. [default: firefox] 15:25:45 INFO - mkdir: /builds/slave/test/build/application 15:25:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:26:17 INFO - Reading from file tmpfile_stdout 15:26:17 INFO - Output received: 15:26:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:26:17 INFO - Running post-action listener: _resource_record_post_action 15:26:17 INFO - [mozharness: 2016-12-02 23:26:17.961423Z] Finished install step (success) 15:26:17 INFO - [mozharness: 2016-12-02 23:26:17.961556Z] Running run-tests step. 15:26:17 INFO - Running pre-action listener: _resource_record_pre_action 15:26:17 INFO - Running main action method: run_tests 15:26:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:26:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:26:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:26:17 INFO - 2016-12-02 15:26:17.976 screenresolution[6821:125117] starting screenresolution argv=screenresolution get 15:26:17 INFO - 2016-12-02 15:26:17.979 screenresolution[6821:125117] Display 0: 1600x1200x32@60 15:26:17 INFO - 2016-12-02 15:26:17.985 screenresolution[6822:125119] starting screenresolution argv=screenresolution list 15:26:17 INFO - Available Modes on Display 0 15:26:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:26:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:26:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:26:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:26:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:26:18 INFO - Intel Iris: 15:26:18 INFO - Chipset Model: Intel Iris 15:26:18 INFO - Type: GPU 15:26:18 INFO - Bus: Built-In 15:26:18 INFO - VRAM (Dynamic, Max): 1536 MB 15:26:18 INFO - Vendor: Intel (0x8086) 15:26:18 INFO - Device ID: 0x0a2e 15:26:18 INFO - Revision ID: 0x0009 15:26:18 INFO - Displays: 15:26:18 INFO - Display: 15:26:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:26:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:26:18 INFO - Display Serial Number: 1600x1200 60 15:26:18 INFO - Main Display: Yes 15:26:18 INFO - Mirror: Off 15:26:18 INFO - Online: Yes 15:26:18 INFO - Rotation: Supported 15:26:18 INFO - Return code: 0 15:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:26:18 INFO - Python 2.7.3 15:26:18 INFO - Return code: 0 15:26:18 INFO - grabbing minidump binary from tooltool 15:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:18 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 0x10d26ad30>, '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 0x10d0d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d262b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:26:18 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 15:26:18 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 15:26:18 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 15:26:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:26:18 INFO - Return code: 0 15:26:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:26:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:26:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:26:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:26:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 15:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --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 15:26:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRAc0yUnTD/Render', 15:26:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:18 INFO - 'HOME': '/Users/cltbld', 15:26:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:18 INFO - 'LOGNAME': 'cltbld', 15:26:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:26:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:18 INFO - 'MOZ_NO_REMOTE': '1', 15:26:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:26:18 INFO - 'NO_EM_RESTART': '1', 15:26:18 INFO - 'PAGER': '/bin/cat', 15:26:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:18 INFO - 'PWD': '/builds/slave/test', 15:26:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:26:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:18 INFO - 'SHELL': '/bin/bash', 15:26:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G5YBBlc3Pi/Listeners', 15:26:18 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 15:26:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:18 INFO - 'USER': 'cltbld', 15:26:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:18 INFO - 'XPC_FLAGS': '0x0', 15:26:18 INFO - 'XPC_SERVICE_NAME': '0', 15:26:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 15:26:18 INFO - mozversion application_buildid: 20161202130744 15:26:18 INFO - mozversion application_changeset: 633e960e72dbd3006a2d0325416e50a19a7e1838 15:26:18 INFO - mozversion application_display_name: Nightly 15:26:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:26:18 INFO - mozversion application_name: Firefox 15:26:18 INFO - mozversion application_remotingname: firefox 15:26:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:26:18 INFO - mozversion application_vendor: Mozilla 15:26:18 INFO - mozversion application_version: 53.0a1 15:26:18 INFO - mozversion platform_buildid: 20161202130744 15:26:18 INFO - mozversion platform_changeset: 633e960e72dbd3006a2d0325416e50a19a7e1838 15:26:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:26:18 INFO - mozversion platform_version: 53.0a1 15:26:18 INFO - using testdate: 1480721178 15:26:18 INFO - actual date: 1480721178 15:26:18 INFO - starting webserver on 'localhost:61403' 15:26:18 INFO - SUITE-START | Running 2 tests 15:26:18 INFO - TEST-START | dromaeo_css 15:26:18 INFO - operating with platform_type : mac_ 15:26:18 INFO - Initialising browser for dromaeo_css test... 15:26:18 INFO - TEST-INFO | started process 6832 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp3LVEEe/profile http://localhost:61403/getInfo.html) 15:26:21 INFO - PROCESS | 6832 | __metrics Screen width/height:1600/1200 15:26:21 INFO - PROCESS | 6832 | colorDepth:24 15:26:21 INFO - PROCESS | 6832 | Browser inner width/height: 1024/689 15:26:21 INFO - PROCESS | 6832 | __metrics 15:26:21 INFO - PROCESS | 6832 | 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" 15:26:21 INFO - PROCESS | 6832 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:26:22 INFO - TEST-INFO | 6832: exit 0 15:26:22 INFO - Browser initialized. 15:26:22 INFO - Running cycle 1/1 for dromaeo_css test... 15:26:22 INFO - TEST-INFO | started process 6834 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp3LVEEe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:26:34 INFO - PROCESS | 6834 | RSS: Main: 245260288 15:26:34 INFO - PROCESS | 6834 | 15:27:26 INFO - PROCESS | 6834 | 1480721246133 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:29:38 INFO - PROCESS | 6834 | Cycle 1(1): loaded http://localhost:61403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61403/tests/dromaeo/cssquery-ext.html) 15:29:40 INFO - PROCESS | 6834 | RSS: Main: 382873600 15:29:40 INFO - PROCESS | 6834 | 15:32:43 INFO - PROCESS | 6834 | Cycle 1(1): loaded http://localhost:61403/tests/dromaeo/cssquery-ext.html (next: http://localhost:61403/tests/dromaeo/cssquery-jquery.html) 15:32:44 INFO - PROCESS | 6834 | RSS: Main: 372662272 15:32:44 INFO - PROCESS | 6834 | 15:35:46 INFO - PROCESS | 6834 | Cycle 1(1): loaded http://localhost:61403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61403/tests/dromaeo/cssquery-mootools.html) 15:35:46 INFO - PROCESS | 6834 | RSS: Main: 347607040 15:35:46 INFO - PROCESS | 6834 | 15:38:49 INFO - PROCESS | 6834 | Cycle 1(1): loaded http://localhost:61403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61403/tests/dromaeo/cssquery-prototype.html) 15:38:50 INFO - PROCESS | 6834 | RSS: Main: 344043520 15:38:50 INFO - PROCESS | 6834 | 15:41:53 INFO - PROCESS | 6834 | Cycle 1(1): loaded http://localhost:61403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61403/tests/dromaeo/cssquery-yui.html) 15:41:54 INFO - PROCESS | 6834 | RSS: Main: 331583488 15:41:54 INFO - PROCESS | 6834 | 15:44:57 INFO - PROCESS | 6834 | Cycle 1(1): loaded http://localhost:61403/tests/dromaeo/cssquery-yui.html (next: http://localhost:61403/tests/dromaeo/cssquery-dojo.html) 15:44:57 INFO - PROCESS | 6834 | RSS: Main: 453877760 15:44:57 INFO - PROCESS | 6834 | 15:44:57 INFO - PROCESS | 6834 | __start_tp_report 15:44:57 INFO - PROCESS | 6834 | _x_x_mozilla_page_load 15:44:57 INFO - PROCESS | 6834 | _x_x_mozilla_page_load_details 15:44:57 INFO - PROCESS | 6834 | |i|pagename|runs| 15:44:57 INFO - PROCESS | 6834 | |0;dojo.html;2918.3871387008726;3290.4077266092095;3299.8185099819507;3326.767126301157;3354.4465163248065;5594.24477695511;5632.971835140829;5650.29371328584;5657.038303488406;5739.5408367330565;5596.328440587135;5645.407232240617;5722.256106706132;5736.967345877741;5737.770489180428;5021.472745361739;5095.439501654815;5095.898082038357;5148.948510514884;5178.559822415081;5217.791288348461;5233.162693968966;5241.213817927322;5245.895082098375;5302.045631786277;5206.062908676437;5213.582913366921;5227.4511176326505;5251.2385704072885;5305.681659100447;5069.239614057884;5116.027954688634;5132.974335128338;5134.768935397916;5176.50823171798;5027.648064635477;5101.974490127563;5122.410922743895;5131.717755523445;5163.63854530183;5591.161325801122;5686.829395118153;5711.371749107595;5735.455131762517;5751.971240143815;6191.349908259658;6202.627842329474;6209.59637623553;6211.3167551569295;6219.346968568326;6190.414649421895;6267.279262884781;6270.184875966141;6279.8744025119695;6285.340039295854;5551.472610102034;5679.858003549903;5698.088305871123;5702.971485142548;5708.628939119027;6232.501399888089;6240.188775459162;6266.373362663697;6275.278342990523;6281.654509002049;5101.438841727407;6124.5712800103565;6132.080187971751;6136.693165341715;6138.508919286446;6115.908261376083;6121.178620693132;6137.9720220348345;6203.534734894901;6257.9687101564205;6113.32753397126;6121.418465245794;6127.387261273837;6130.804493123798;6135.171751813537;6102.920364089578;6107.006761825774;6110.327863934964;6131.417515336036;6154.892119418458;4892.0705066037335;4895.339129217581;4907.288443175719;4911.901761964741;4918.139325618003;4293.3989241506215;4373.75944323059;4375.906023494126;4385.429894113809;4388.780560972003;5584.52531534816;5655.953648575027;5669;5746.770129194869;5747.85630359236;6180.3201647818705;6216.471599913967;6241.500679945593;6275.278342990523;6290.025046117859;5639.718014099279;5647.181158732043;5711.114777209456;5726.3700992890745;5752.654840709487;5178.0679477694375;5367.946320536823;5369.838904832861;5372.006178856924;5377.085895397791;4878.609711223165;6203.565750397429;6285.622862628257;6288.811335659938;6295.055741638791;6247.437730604086;6269.874602508015;6275.215598050244;6291.496680265476;6295;5628.155776633538;6029.849253768515;6312.242530896322;6318.62088274705;6385;5988.850278743066;6054.061620448838;6054.63672179653;6104.511639068953;6130.816075517741;6058;6215.34738852414;6221.688915554295;6234.220722409699;6252;5002;6025.969870150621;6048.425399587032;6064.654420378391;6075.179850720273;5850.590458668023;5897;5980.192673988956;5988.161657367885;6033.78881739137;5804;5845.853853653693;5880.26496687914;5926.881462370642;5927.762889484545;5966.940330596812;6034.788782392595;6035.577509574463;6058.121572371893;6081.239845019372;5682.346530149086;5776.19133321327;5854.121881717776;5858;5876.647401155773 15:44:57 INFO - PROCESS | 6834 | |1;ext.html;503.41855157293327;514.452108504443;515.1191462598956;527.5673947363161;542.9782808687653;31112.066638000866;38896.611033889654;39985.60014399855;40020.79989600048;42202.36696449556;41406.17187656253;41821.7908910455;41888.37167442483;41908;41960.58039419605;8001.8799718004275;8384.496930184177;9178.862317065266;9363.157315841572;9372.343935924488;8528;10955.945220273887;11219.719507012349;11251.774964500704;11415.942920285386;11262.155338349616;11317.660470185907;11345.659630211107;11370.829437558443;11382.487788049517;11194.272372295816;11198.216124871262;11222.270552414067;11266.54933802651;11268.887311126866;11123.27698699582;11185.496652650569;11214.495347709291;11220.775584488265;11231.550737970472;36330.45504317437;38778.418323725164;39068.21863562713;39101.80449097765;39134.60865391338;3274;3394.507796369537;3465.6361082086523;3520.366334059868;3760.2855457462992;29791.106266812032;30576.54135187974;30601.38797224043;30623;30682.53976190359;3052.7557795376315;3251.3334766373073;3308.768386212966;3366.7138293245102;3375.8480868360984;458179;483198.6720531175;488094;488637;488821;59284;59489;59820;59905.80188396208;59946.70026649839;63272.36727632757;63303;63326.733465330435;63388;63466.36533634697;15210.011349262262;15225.847741522442;15485.922570387302;15707.371705131894;15770.448034318744;10589.682309530726;10798.67603971882;10816.567337306577;12138.907498325016;12205.267683938991;15820.559298837728;16636.50090497263;19496.610067798563;19782.90108549477;20057.699134512994;6372.490200783926;6502.057201705727;7906.802329941683;7916.485428447132;7940.960295198487;852.4459101584021;973.0755782007121;1053.847192157133;1071.2822408985999;1113.2374323588367;29520.261993450335;29703.43558772918;30381;30555.69444305573;30622.23444413863;1004.8944860789658;1046.6336782126348;1085.945702714861;1092.6831218946575;1093.2183488805542;15349.925505214751;15357.385704571916;15377.692446151013;15418.074915505105;15814.288357023961;667338;672538;673044;673791;674296;57258.713706432034;57602.847943040906;57870.4212957865;57969.71015144897;58141.41858581445;1200.9399530023463;1244.0545185658784;1250.06245316013;1337.5586056601298;1349.811026456297;27155;28344.433111337246;28951.131466056053;29972.100836974925;30954.502685830033;55546.722266390025;56097;56102.719486402304;56136;56165;612665;618405;618965;619221;619360;26136.60795088113;26583;26899.86550067237;27005.459890802467;41307.38038929478;45425.31862022006;45452.86367840831;45693.54306457026;45963.850903727674;46142.76928615336;36435;36974.075648109014;37124.81437592795;38247.61752382552;39726.2054758909;37442.063948401505;37478.62521374752;38216.235675286895;38554.22891542209;38688.41967370548;35646.64353356537;36268.81865590655;36826.89519314425;37653;39355.80322098371;32808;33686.49470257899;34273;34385;34501.482477763355;21003.73977561351;24710.876445617658;24911.75088249167;25268.862901169123;25517.23448296554 15:44:57 INFO - PROCESS | 6834 | |2;jquery.html;350.63183657159976;363.08864749478806;368.46572469918607;373.18086799475157;400.2455371624489;14606.634834129152;14789.260536973148;15611.141387223684;19436.70844937327;20139.899300503475;19140;19484.220631174736;19726.21095156192;20208.191672333127;20424.8978755106;5537.224788529599;5822.243108395903;5825.563082768788;5841.474267315941;5842.182094506772;4632.143053535106;5776.682282474462;5801.593888427812;5802.216700745409;5812.4768770810615;5600.327960644708;5681.488666020057;5745.597808153431;5774.711264436783;5780.4797568218855;5236.1098613235845;5388.407275199725;5454;5726.856828579319;5752.626079304852;4456.153330867125;4984.177610694231;4998.750062496897;5014.172661510846;5029.899402011976;13103.148295360867;13308.866911330859;20868.165273389048;23379;24989;2300.7124109486313;2312.921107893206;2396.2930935374106;2703.8783254753585;2860.0561814601338;9369.390989585656;9757.951210243904;10183.083522483012;10244.94877525615;10411.791764164675;1772.2822256985942;1775.6448710258;1795.8204179582067;1801.5676237702858;1842.8525717942666;107571;110694.44652776765;111478;112783.43608281988;118964;9241.399309045026;9367.344285899922;11231.932966368182;11365.09079273656;11471.713207169721;13989;14232.359543820552;14243.928780356031;14269.714605707828;14320.498782542561;7215.567065976058;7816.960915195387;8247.628856701343;8249.587520623945;8410.03284622264;8029.638666260033;8059.274665280153;8077.838443231102;8182;8281.8343633127;4382.649388048949;4491.236489796743;4548.363229147922;4604.930926036112;4642.234031384851;1402.6715652017601;1891.1111777464569;1916.8562357823218;1924.7978962209047;1924.8941308228182;773.5474747272908;819.2012787532227;891.1838590055394;971.946542940145;972.9610815567439;19820.70268945967;19843.900780496006;20576.279830205873;20596.58806823855;20750.792492074885;909.4679612426804;926.3746970794822;930.8650245714468;950.7623094226443;971.6696323250129;8105.75682729519;9447.960724320319;10088.445135517617;10094.49527523621;10722.78554428907;336901;451582;574740;594476;596330;116030.839691602;126050;128141;128828.35585822011;130946;899.7525680437932;922.5341202692597;941.0307383395113;941.5010044676333;942;14722.77915831242;18146.90926545359;18248.45254642363;18532.166052527937;18654.893391406855;50791.22230721907;52222.95554088973;53032.939341212186;53159.20261196008;53997;75765;77667;78352;80428;81606.59196703979;7586.71025925605;7855.253750893656;7915.248051435105;7973.960130199312;8169.346452283922;10552.894471055191;11038.668839934493;12425.440855161358;12612.936935315265;12723.936380318039;10600.363978161335;10640.733981650521;10763.138948884227;10931.344119352865;11154.16343774204;9219.124183202584;10484.63303784364;10645;10700.518476668412;10738.128070970004;10980.011798938134;11194;11226.775464490827;11251.493682784458;11302.830457543309;7785.805354865947;7964.323032542299;7965.362770978192;7987.202879352099;8215.876761848458;9977.002299769965;10611.31026483276;10921.56313747473;10956.780864382827;10984.505697243483 15:44:57 INFO - PROCESS | 6834 | |3;mootools.html;1245.7321675839692;1296.8314119164506;1424.8717615414614;1527.3966783120668;1779.154901421825;6603.504737144715;7359.7792066238035;7736.690532378705;8238;8244.258016778489;8161.755147345574;8259.958700206505;8266.50400975942;8271.54506502142;8287.41988060836;2038.7859274776158;2254.7407048189502;2303.2744685424123;2310.4108452344713;2313.3060081975423;2114.3656902929138;2259.627161518356;2319.6056670365992;2328.522652856169;2343.238447504559;2264.184893438361;2265.7394399644004;2276.692646492727;2281.6577513372963;2283.132409684326;2261.4685548896077;2290.828187885915;2291.644795056769;2292.3123063081007;2295.070496448941;2272.034385386221;2299.8045166160896;2306.8961896714522;2307.526956973816;2319.153508969231;8158.551279679616;8347.707830225912;8351.24838764508;8360.790980225482;8363.456375335583;4431.8670439886855;5019.824306149304;5175.637705360627;5193.818216362409;5202.06362854686;2799.9160025199276;2974.7391982093764;3565.0552603560077;3569.928601427983;3574.195805943668;989.9010098990043;1043.5147656339761;1091.252492042953;1093.7101668057971;1097.3251450358052;10928.781424371547;10935.671929842118;10935.781284374269;10974.957379048978;10983.835242471368;4431.889202769957;4677.883052923704;4709.576138147583;4712.811487540528;4721.3390125382475;9458.290628202913;9465.858012129824;9468.715938521855;9482.762930926781;9522.85715714265;5191.013707395583;5199.844004679866;5202.323697919246;5204.479552044765;5205.895882082337;4268.637165840876;4423.402840616475;4581.244094724333;4681.485036645966;4708.6468514860835;3551.8756843510355;3718.8140592970244;3757.28611563802;3807.6573108420375;3844.2888065707375;1249.987500124987;1252.943617537213;1257.3713143428286;1265.6329664397406;1265.658272266483;691.2810676896072;840.8864803251605;850.1710831938934;864.2481041493941;864.4553931023415;5321.3348331458565;5345;5474.746070673282;5594.916076258859;5616.202815099129;843.3801156150224;877.4998250996871;881.2553392383426;907.4101833808078;930.5626355612851;3167.5723777289772;3666.633336666312;3708.313961917054;3771.17034252464;3829.1767270037076;9456.52717364129;9555.04449555039;9740.074692904163;10082.546285417175;10115.291929565006;9960.651377201762;9964.10323070927;9984.251181161442;9984.700458986243;9992.25058120644;7365.3002964719335;7586.734464293723;7632.5038872473115;7744.419168562267;7838.725644602411;5588.720563971867;5606.327240730975;5695.914561281501;5777.16231146473;5818.94181058201;9100.180983711498;9198.67804626835;9222.723318300461;9317.39436936597;9419.293552983416;9266.490343031199;9409.764755881159;9442.85835712451;9510.429374237292;9533.952330238304;6327.3988971047675;7060.823479413056;7150.034745309525;7205.459590530626;7210.531315464478;7354.96322518384;7732;7822.530648161129;7904.170062143622;7922.564258965812;6872.140982377203;6953.061336719478;6997;7012.929870701228;7137.928620713727;6768;6778.694958726967;6827.52207345481;6897.448204143757;6901.206361268318;6240.875182496416;6455.935440645533;6536.117624120683;6551.475881929529;6657.800265992028;4178.686598505064;4683.906321873612;4772.7136371817805;4777.713337199779;4907.68100073494;4116.300228961144;4697.7651117444675;4779.426468823764;4803.543663351976;4964.8758781030765 15:44:57 INFO - PROCESS | 6834 | |4;prototype.html;302.07866008673545;307.81992534367396;311.9766017548684;316.2788841441514;321.9179109327121;5268.73656317184;5292.682439053655;5345.91981120283;5391.73041347933;5415.377231618365;4204.5375008749015;4869.074875773601;5057.241413787933;5086.109930762121;5324.387695415028;3534.505169276297;4010.258102251093;4029.597040295976;4030.6976976726714;4080.551139374681;3507.4563442666426;3976.6421022108007;3989.8603548875794;4008.298547754146;4025.9331277211563;3365.141888818348;3643.471696603991;3800.467934489174;3816.2749077675153;3840.503672612796;4024.9396259055993;4032.278212206749;4034.6368826805433;4043.029672878503;4075.391749280463;3507.526483924663;3526.7354948378716;3529.505869178317;3545.3441113394106;3563.7747838206465;4442.601409921413;5080.949190508121;5099.286099946011;5117.769700363493;5134;3488.9127771805656;4333.090051089275;4575.977120114411;4582.816687332503;4590.855264144072;4555.749433781174;4976.979719157564;5112.539871411554;5471.674538321197;5480.616356855022;3268.4933835255574;3821.159344944108;3859.3053250414914;3862.208247309295;3884.4173373994126;5547.44525547446;5736.1682556029145;5746.9712651436475;5779.399270328369;5795.043817770063;3951.4665520154986;3972.443857859902;3974.642282194616;3980.3432433648704;3990.620891015349;3016.215783896159;3733.879836049174;3982.8406863725127;4015.6586690131667;4178.039051018282;3925.528936527578;4236.364545318165;4317.805698743564;4674.345591617176;4679.461861885927;4239.163556980937;4355.1725172217175;5206.895862082737;5507.7246137692955;5570.470805273492;1222.8899399054128;1234.512367614787;1288.4137717338588;1292.6233561257231;1301.1932601786764;830.393812516854;841.7138173021202;865.9134086591416;885.2342723544087;899.3389858454032;4130.979345103316;4239.872803815891;4531.346058688621;4544.590986811203;4828.937633720576;4254.617084462413;4638.683341410908;5152.252923326097;5157.690538567623;5465.699386533779;4244.448221731155;4604.148232576984;4838.830640927551;4860.934103006208;4975.278584605212;2439.42673471734;2505.837120587156;2670.7062223155435;2706.9864650676623;2796.972030279712;5164.612654050961;5196.584273258206;5300.602454815904;5574.749136288877;5620.4660557247;5311.017461769585;5507.972460137674;5563.079383323788;5583.330000399897;5706.573356660835;4811.735354555463;4965.205567109245;5438.45615438453;5573.860653483695;5580.469855363734;4767.856964291077;5016.423111342242;5104.464031276662;5355.4376790436445;5375.704336261387;4351.78241087938;4748.311494833299;5335.626506144533;5341.839744807662;5407.945920540901;4741.952580474152;4962.072377297412;5547.5007249347755;5577.693226872561;5587.972060139836;3583.8208089595937;3586.601225521996;3592.371335016414;3599.91000224986;3619.6426340122453;4875.7079373966635;5282.920756188583;5514.448555144453;5678;5721.084626459913;4856.902861942671;5551.861203469784;5581.748821303132;5583.1904373864745;5591.4688104629995;4642.4661163966575;5054.209342992755;5420.891582168413;5573.052581061311;5586.553075754011;5243.292155558951;5354.411014788292;5430.8099216527235;5446.400895901368;5454.563634909118;4711.552402521755;5112.8811425031445;5476.698781567052;5483.396826349178;5495.6153069284765;4822.903541929071;4995.575376093073;5039.395272567315;5482.150266708666;5556.972215138899 15:44:57 INFO - PROCESS | 6834 | |5;yui.html;692.4771797293043;714.3749219432999;732.3226015935259;770.3567521119865;790.6244533846422;15244.390224391025;15711;15753.527394178178;15756.763648545266;15774.369025239006;14047;14203.715925681507;14213;14225.573232803006;14229.288535573205;681.7545683553917;701.971611589022;705.1397295299727;838.279079991207;853.8292341531687;817.2318021060214;854.6325080215505;855.9572021398936;868.674247157316;870.7126648206076;918.7335672654922;919.3610440743686;920.5811355833114;922.4649703172178;923.1368670293298;707.2397173039004;907.4237858959575;910.7404389748956;913.3287034030016;913.8994710581898;544.1647071744892;650.9609423434609;664.7473959895209;669.1802541886199;673.9292374300677;14433.494827680981;14481.203533805636;14487.71024579513;14499;14501;13067.86932130676;13137.146085504412;13250.66873328165;13443.32783360828;13462.192268463923;12128.878711212863;12260.325682087481;12320.01439884807;12357.196782209128;12424.627261182179;4273.615374616299;4353.477582690066;4387.232234358974;4401.097774956126;4537.183307004738;103594;103602.92794144075;109171.45414272878;109530;111277;10311;10389.68830935058;10464.319819211727;10666.73333166677;10730.356178629307;18824.717629235573;18940.43178704641;18943.621127577648;18970.62058758817;19001.334953276568;7506.211847756016;7539.509931854412;7594.278543538355;7627.847443051108;7765.456418050682;3632.763870348419;4170.687198460128;4230.725002874803;4233.894152646147;4264.765437900884;3289.407906576839;3372.8144952027874;3393.609734880471;3407.2504049109157;3417.658234176612;563.7096895099028;606.6814922165898;607.975680972765;619.2661695890384;629.6064959400375;579.5161040531119;593.3214072748974;629.7701339011228;634.1724050114552;634.8607081826466;7952.767321065244;8538.615762290712;8564.871526927102;8661.913380866237;8783.824323513494;558.5922276738004;602.8643555200044;610.9755609775559;625.6246252248706;627.2504357293083;4157.8960525987095;4218.725782824106;4241;4377.212101821639;4392.890177745582;85005.57497212474;99685.50157249167;107365;111651.88348116577;114848;97114.0288597119;98670;98885;100787.99212007933;106688;70565;87569;90746.54626726692;91191;93369.53315233516;8522.446041007315;8546.957265213634;8631.136886311318;8704.042555319036;8740.257078148428;52035.479645203064;56674.7166264166;57360;58159.418405817094;58907;48684.75657621689;56907.43092569187;64152.679236603515;65779.67110164418;68723.31276687169;10895.727606809893;11205.60780372683;11417.885821141683;11471.197016208785;13432.664183395493;12118.394080295773;12348.814767778671;14506.34721437559;14808.407663693331;14824;13481;13493.932530337286;13630.659233519242;14009.719805604034;14232.786508202593;13242.404091816084;13852.93073534626;13856.307184640526;14415.207163606103;14443.555644435472;12914.354282286036;13248.668783280109;13529.932350338186;13676.93161534186;14026.719465610835;8946.731598052069;10467.456944755028;11139.108871290115;11301;12033.63899083029;11148;11322.94338528302;11453.427328633368;11549.88450115488;11629.302241865515 15:44:57 INFO - PROCESS | 6834 | __end_tp_report 15:44:57 INFO - PROCESS | 6834 | __start_cc_report 15:44:57 INFO - PROCESS | 6834 | _x_x_mozilla_cycle_collect,1479 15:44:57 INFO - PROCESS | 6834 | __end_cc_report 15:44:57 INFO - PROCESS | 6834 | __startTimestamp1480722297760__endTimestamp 15:44:57 INFO - PROCESS | 6834 | 15:44:57 INFO - PROCESS | 6834 | ------- Summary: start ------- 15:44:57 INFO - PROCESS | 6834 | Number of tests: 6 15:44:57 INFO - PROCESS | 6834 | 15:44:57 INFO - PROCESS | 6834 | [#0] dojo.html Cycles:165 Average:5673.91 Median:5845.85 stddev:650.76 (11.1%) stddev-sans-first:615.81 15:44:57 INFO - PROCESS | 6834 | Values: 2918.4 3290.4 3299.8 3326.8 3354.4 5594.2 5633.0 5650.3 5657.0 5739.5 5596.3 5645.4 5722.3 5737.0 5737.8 5021.5 5095.4 5095.9 5148.9 5178.6 5217.8 5233.2 5241.2 5245.9 5302.0 5206.1 5213.6 5227.5 5251.2 5305.7 5069.2 5116.0 5133.0 5134.8 5176.5 5027.6 5102.0 5122.4 5131.7 5163.6 5591.2 5686.8 5711.4 5735.5 5752.0 6191.3 6202.6 6209.6 6211.3 6219.3 6190.4 6267.3 6270.2 6279.9 6285.3 5551.5 5679.9 5698.1 5703.0 5708.6 6232.5 6240.2 6266.4 6275.3 6281.7 5101.4 6124.6 6132.1 6136.7 6138.5 6115.9 6121.2 6138.0 6203.5 6258.0 6113.3 6121.4 6127.4 6130.8 6135.2 6102.9 6107.0 6110.3 6131.4 6154.9 4892.1 4895.3 4907.3 4911.9 4918.1 4293.4 4373.8 4375.9 4385.4 4388.8 5584.5 5656.0 5669.0 5746.8 5747.9 6180.3 6216.5 6241.5 6275.3 6290.0 5639.7 5647.2 5711.1 5726.4 5752.7 5178.1 5367.9 5369.8 5372.0 5377.1 4878.6 6203.6 6285.6 6288.8 6295.1 6247.4 6269.9 6275.2 6291.5 6295.0 5628.2 6029.8 6312.2 6318.6 6385.0 5988.9 6054.1 6054.6 6104.5 6130.8 6058.0 6215.3 6221.7 6234.2 6252.0 5002.0 6026.0 6048.4 6064.7 6075.2 5850.6 5897.0 5980.2 5988.2 6033.8 5804.0 5845.9 5880.3 5926.9 5927.8 5966.9 6034.8 6035.6 6058.1 6081.2 5682.3 5776.2 5854.1 5858.0 5876.6 15:44:57 INFO - PROCESS | 6834 | 15:44:57 INFO - PROCESS | 6834 | [#1] ext.html Cycles:180 Average:72079.61 Median:19583.50 stddev:159463.43 (814.3%) stddev-sans-first:159820.21 15:44:57 INFO - PROCESS | 6834 | Values: 503.4 514.5 515.1 527.6 543.0 31112.1 38896.6 39985.6 40020.8 42202.4 41406.2 41821.8 41888.4 41908.0 41960.6 8001.9 8384.5 9178.9 9363.2 9372.3 8528.0 10955.9 11219.7 11251.8 11415.9 11262.2 11317.7 11345.7 11370.8 11382.5 11194.3 11198.2 11222.3 11266.5 11268.9 11123.3 11185.5 11214.5 11220.8 11231.6 36330.5 38778.4 39068.2 39101.8 39134.6 3274.0 3394.5 3465.6 3520.4 3760.3 29791.1 30576.5 30601.4 30623.0 30682.5 3052.8 3251.3 3308.8 3366.7 3375.8 458179.0 483198.7 488094.0 488637.0 488821.0 59284.0 59489.0 59820.0 59905.8 59946.7 63272.4 63303.0 63326.7 63388.0 63466.4 15210.0 15225.8 15485.9 15707.4 15770.4 10589.7 10798.7 10816.6 12138.9 12205.3 15820.6 16636.5 19496.6 19782.9 20057.7 6372.5 6502.1 7906.8 7916.5 7941.0 852.4 973.1 1053.8 1071.3 1113.2 29520.3 29703.4 30381.0 30555.7 30622.2 1004.9 1046.6 1085.9 1092.7 1093.2 15349.9 15357.4 15377.7 15418.1 15814.3 667338.0 672538.0 673044.0 673791.0 674296.0 57258.7 57602.8 57870.4 57969.7 58141.4 1200.9 1244.1 1250.1 1337.6 1349.8 27155.0 28344.4 28951.1 29972.1 30954.5 55546.7 56097.0 56102.7 56136.0 56165.0 612665.0 618405.0 618965.0 619221.0 619360.0 26136.6 26583.0 26899.9 27005.5 41307.4 45425.3 45452.9 45693.5 45963.9 46142.8 36435.0 36974.1 37124.8 38247.6 39726.2 37442.1 37478.6 38216.2 38554.2 38688.4 35646.6 36268.8 36826.9 37653.0 39355.8 32808.0 33686.5 34273.0 34385.0 34501.5 21003.7 24710.9 24911.8 25268.9 25517.2 15:44:57 INFO - PROCESS | 6834 | 15:44:57 INFO - PROCESS | 6834 | [#2] jquery.html Cycles:180 Average:31859.24 Median:370.82 stddev:87753.14 (23664.4%) stddev-sans-first:87967.42 15:44:57 INFO - PROCESS | 6834 | Values: 350.6 363.1 368.5 373.2 400.2 14606.6 14789.3 15611.1 19436.7 20139.9 19140.0 19484.2 19726.2 20208.2 20424.9 5537.2 5822.2 5825.6 5841.5 5842.2 4632.1 5776.7 5801.6 5802.2 5812.5 5600.3 5681.5 5745.6 5774.7 5780.5 5236.1 5388.4 5454.0 5726.9 5752.6 4456.2 4984.2 4998.8 5014.2 5029.9 13103.1 13308.9 20868.2 23379.0 24989.0 2300.7 2312.9 2396.3 2703.9 2860.1 9369.4 9758.0 10183.1 10244.9 10411.8 1772.3 1775.6 1795.8 1801.6 1842.9 107571.0 110694.4 111478.0 112783.4 118964.0 9241.4 9367.3 11231.9 11365.1 11471.7 13989.0 14232.4 14243.9 14269.7 14320.5 7215.6 7817.0 8247.6 8249.6 8410.0 8029.6 8059.3 8077.8 8182.0 8281.8 4382.6 4491.2 4548.4 4604.9 4642.2 1402.7 1891.1 1916.9 1924.8 1924.9 773.5 819.2 891.2 971.9 973.0 19820.7 19843.9 20576.3 20596.6 20750.8 909.5 926.4 930.9 950.8 971.7 8105.8 9448.0 10088.4 10094.5 10722.8 336901.0 451582.0 574740.0 594476.0 596330.0 116030.8 126050.0 128141.0 128828.4 130946.0 899.8 922.5 941.0 941.5 942.0 14722.8 18146.9 18248.5 18532.2 18654.9 50791.2 52223.0 53032.9 53159.2 53997.0 75765.0 77667.0 78352.0 80428.0 81606.6 7586.7 7855.3 7915.2 7974.0 8169.3 10552.9 11038.7 12425.4 12612.9 12723.9 10600.4 10640.7 10763.1 10931.3 11154.2 9219.1 10484.6 10645.0 10700.5 10738.1 10980.0 11194.0 11226.8 11251.5 11302.8 7785.8 7964.3 7965.4 7987.2 8215.9 9977.0 10611.3 10921.6 10956.8 10984.5 15:44:57 INFO - PROCESS | 6834 | 15:44:57 INFO - PROCESS | 6834 | [#3] mootools.html Cycles:180 Average:5366.50 Median:5263.62 stddev:2966.62 (56.4%) stddev-sans-first:2958.77 15:44:57 INFO - PROCESS | 6834 | Values: 1245.7 1296.8 1424.9 1527.4 1779.2 6603.5 7359.8 7736.7 8238.0 8244.3 8161.8 8260.0 8266.5 8271.5 8287.4 2038.8 2254.7 2303.3 2310.4 2313.3 2114.4 2259.6 2319.6 2328.5 2343.2 2264.2 2265.7 2276.7 2281.7 2283.1 2261.5 2290.8 2291.6 2292.3 2295.1 2272.0 2299.8 2306.9 2307.5 2319.2 8158.6 8347.7 8351.2 8360.8 8363.5 4431.9 5019.8 5175.6 5193.8 5202.1 2799.9 2974.7 3565.1 3569.9 3574.2 989.9 1043.5 1091.3 1093.7 1097.3 10928.8 10935.7 10935.8 10975.0 10983.8 4431.9 4677.9 4709.6 4712.8 4721.3 9458.3 9465.9 9468.7 9482.8 9522.9 5191.0 5199.8 5202.3 5204.5 5205.9 4268.6 4423.4 4581.2 4681.5 4708.6 3551.9 3718.8 3757.3 3807.7 3844.3 1250.0 1252.9 1257.4 1265.6 1265.7 691.3 840.9 850.2 864.2 864.5 5321.3 5345.0 5474.7 5594.9 5616.2 843.4 877.5 881.3 907.4 930.6 3167.6 3666.6 3708.3 3771.2 3829.2 9456.5 9555.0 9740.1 10082.5 10115.3 9960.7 9964.1 9984.3 9984.7 9992.3 7365.3 7586.7 7632.5 7744.4 7838.7 5588.7 5606.3 5695.9 5777.2 5818.9 9100.2 9198.7 9222.7 9317.4 9419.3 9266.5 9409.8 9442.9 9510.4 9534.0 6327.4 7060.8 7150.0 7205.5 7210.5 7355.0 7732.0 7822.5 7904.2 7922.6 6872.1 6953.1 6997.0 7012.9 7137.9 6768.0 6778.7 6827.5 6897.4 6901.2 6240.9 6455.9 6536.1 6551.5 6657.8 4178.7 4683.9 4772.7 4777.7 4907.7 4116.3 4697.8 4779.4 4803.5 4964.9 15:44:57 INFO - PROCESS | 6834 | 15:44:57 INFO - PROCESS | 6834 | [#4] prototype.html Cycles:180 Average:4351.04 Median:4825.92 stddev:1321.12 (27.4%) stddev-sans-first:1289.39 15:44:57 INFO - PROCESS | 6834 | Values: 302.1 307.8 312.0 316.3 321.9 5268.7 5292.7 5345.9 5391.7 5415.4 4204.5 4869.1 5057.2 5086.1 5324.4 3534.5 4010.3 4029.6 4030.7 4080.6 3507.5 3976.6 3989.9 4008.3 4025.9 3365.1 3643.5 3800.5 3816.3 3840.5 4024.9 4032.3 4034.6 4043.0 4075.4 3507.5 3526.7 3529.5 3545.3 3563.8 4442.6 5080.9 5099.3 5117.8 5134.0 3488.9 4333.1 4576.0 4582.8 4590.9 4555.7 4977.0 5112.5 5471.7 5480.6 3268.5 3821.2 3859.3 3862.2 3884.4 5547.4 5736.2 5747.0 5779.4 5795.0 3951.5 3972.4 3974.6 3980.3 3990.6 3016.2 3733.9 3982.8 4015.7 4178.0 3925.5 4236.4 4317.8 4674.3 4679.5 4239.2 4355.2 5206.9 5507.7 5570.5 1222.9 1234.5 1288.4 1292.6 1301.2 830.4 841.7 865.9 885.2 899.3 4131.0 4239.9 4531.3 4544.6 4828.9 4254.6 4638.7 5152.3 5157.7 5465.7 4244.4 4604.1 4838.8 4860.9 4975.3 2439.4 2505.8 2670.7 2707.0 2797.0 5164.6 5196.6 5300.6 5574.7 5620.5 5311.0 5508.0 5563.1 5583.3 5706.6 4811.7 4965.2 5438.5 5573.9 5580.5 4767.9 5016.4 5104.5 5355.4 5375.7 4351.8 4748.3 5335.6 5341.8 5407.9 4742.0 4962.1 5547.5 5577.7 5588.0 3583.8 3586.6 3592.4 3599.9 3619.6 4875.7 5282.9 5514.4 5678.0 5721.1 4856.9 5551.9 5581.7 5583.2 5591.5 4642.5 5054.2 5420.9 5573.1 5586.6 5243.3 5354.4 5430.8 5446.4 5454.6 4711.6 5112.9 5476.7 5483.4 5495.6 4822.9 4995.6 5039.4 5482.2 5557.0 15:44:57 INFO - PROCESS | 6834 | 15:44:57 INFO - PROCESS | 6834 | [#5] yui.html Cycles:180 Average:20871.67 Median:4252.88 stddev:30933.55 (727.4%) stddev-sans-first:30983.22 15:44:57 INFO - PROCESS | 6834 | Values: 692.5 714.4 732.3 770.4 790.6 15244.4 15711.0 15753.5 15756.8 15774.4 14047.0 14203.7 14213.0 14225.6 14229.3 681.8 702.0 705.1 838.3 853.8 817.2 854.6 856.0 868.7 870.7 918.7 919.4 920.6 922.5 923.1 707.2 907.4 910.7 913.3 913.9 544.2 651.0 664.7 669.2 673.9 14433.5 14481.2 14487.7 14499.0 14501.0 13067.9 13137.1 13250.7 13443.3 13462.2 12128.9 12260.3 12320.0 12357.2 12424.6 4273.6 4353.5 4387.2 4401.1 4537.2 103594.0 103602.9 109171.5 109530.0 111277.0 10311.0 10389.7 10464.3 10666.7 10730.4 18824.7 18940.4 18943.6 18970.6 19001.3 7506.2 7539.5 7594.3 7627.8 7765.5 3632.8 4170.7 4230.7 4233.9 4264.8 3289.4 3372.8 3393.6 3407.3 3417.7 563.7 606.7 608.0 619.3 629.6 579.5 593.3 629.8 634.2 634.9 7952.8 8538.6 8564.9 8661.9 8783.8 558.6 602.9 611.0 625.6 627.3 4157.9 4218.7 4241.0 4377.2 4392.9 85005.6 99685.5 107365.0 111651.9 114848.0 97114.0 98670.0 98885.0 100788.0 106688.0 70565.0 87569.0 90746.5 91191.0 93369.5 8522.4 8547.0 8631.1 8704.0 8740.3 52035.5 56674.7 57360.0 58159.4 58907.0 48684.8 56907.4 64152.7 65779.7 68723.3 10895.7 11205.6 11417.9 11471.2 13432.7 12118.4 12348.8 14506.3 14808.4 14824.0 13481.0 13493.9 13630.7 14009.7 14232.8 13242.4 13852.9 13856.3 14415.2 14443.6 12914.4 13248.7 13529.9 13676.9 14026.7 8946.7 10467.5 11139.1 11301.0 12033.6 11148.0 11322.9 11453.4 11549.9 11629.3 15:44:57 INFO - PROCESS | 6834 | -------- Summary: end -------- 15:44:57 INFO - PROCESS | 6834 | 15:44:58 INFO - TEST-INFO | 6834: exit 0 15:44:58 INFO - TEST-OK | dromaeo_css | took 1119878ms 15:44:58 INFO - TEST-START | kraken 15:44:58 INFO - operating with platform_type : mac_ 15:44:58 INFO - Initialising browser for kraken test... 15:44:58 INFO - TEST-INFO | started process 6837 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpM8RiCT/profile http://localhost:61403/getInfo.html) 15:45:00 INFO - PROCESS | 6837 | __metrics Screen width/height:1600/1200 15:45:00 INFO - PROCESS | 6837 | colorDepth:24 15:45:00 INFO - PROCESS | 6837 | Browser inner width/height: 1024/689 15:45:00 INFO - PROCESS | 6837 | __metrics 15:45:00 INFO - PROCESS | 6837 | 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" 15:45:00 INFO - PROCESS | 6837 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:45:01 INFO - TEST-INFO | 6837: exit 0 15:45:01 INFO - Browser initialized. 15:45:01 INFO - Running cycle 1/1 for kraken test... 15:45:01 INFO - TEST-INFO | started process 6838 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpM8RiCT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:14 INFO - PROCESS | 6838 | RSS: Main: 245198848 15:45:14 INFO - PROCESS | 6838 | 15:45:16 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61403/tests/kraken/driver.html?testName=audio-beat-detection) 15:45:17 INFO - PROCESS | 6838 | RSS: Main: 294117376 15:45:17 INFO - PROCESS | 6838 | 15:45:20 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61403/tests/kraken/driver.html?testName=audio-dft) 15:45:20 INFO - PROCESS | 6838 | RSS: Main: 296091648 15:45:20 INFO - PROCESS | 6838 | 15:45:24 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61403/tests/kraken/driver.html?testName=audio-fft) 15:45:24 INFO - PROCESS | 6838 | RSS: Main: 387383296 15:45:24 INFO - PROCESS | 6838 | 15:45:26 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61403/tests/kraken/driver.html?testName=audio-oscillator) 15:45:27 INFO - PROCESS | 6838 | RSS: Main: 290267136 15:45:27 INFO - PROCESS | 6838 | 15:45:29 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:45:30 INFO - PROCESS | 6838 | RSS: Main: 294146048 15:45:30 INFO - PROCESS | 6838 | 15:45:33 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61403/tests/kraken/driver.html?testName=imaging-darkroom) 15:45:33 INFO - PROCESS | 6838 | RSS: Main: 336752640 15:45:33 INFO - PROCESS | 6838 | 15:45:36 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61403/tests/kraken/driver.html?testName=imaging-desaturate) 15:45:37 INFO - PROCESS | 6838 | RSS: Main: 337219584 15:45:37 INFO - PROCESS | 6838 | 15:45:40 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61403/tests/kraken/driver.html?testName=json-parse-financial) 15:45:40 INFO - PROCESS | 6838 | RSS: Main: 336240640 15:45:40 INFO - PROCESS | 6838 | 15:45:42 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:45:43 INFO - PROCESS | 6838 | RSS: Main: 309563392 15:45:43 INFO - PROCESS | 6838 | 15:45:44 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61403/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:45:45 INFO - PROCESS | 6838 | RSS: Main: 315904000 15:45:45 INFO - PROCESS | 6838 | 15:45:47 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:45:48 INFO - PROCESS | 6838 | RSS: Main: 317427712 15:45:48 INFO - PROCESS | 6838 | 15:45:51 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:45:52 INFO - PROCESS | 6838 | RSS: Main: 333950976 15:45:52 INFO - PROCESS | 6838 | 15:45:55 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:45:55 INFO - PROCESS | 6838 | RSS: Main: 327839744 15:45:55 INFO - PROCESS | 6838 | 15:45:57 INFO - PROCESS | 6838 | Cycle 1(1): loaded http://localhost:61403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61403/tests/kraken/driver.html?testName=ai-astar) 15:45:58 INFO - PROCESS | 6838 | RSS: Main: 371634176 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | __start_tp_report 15:45:58 INFO - PROCESS | 6838 | _x_x_mozilla_page_load 15:45:58 INFO - PROCESS | 6838 | _x_x_mozilla_page_load_details 15:45:58 INFO - PROCESS | 6838 | |i|pagename|runs| 15:45:58 INFO - PROCESS | 6838 | |0;ai-astar;114;115;114;114;121;114;113;114;115;114 15:45:58 INFO - PROCESS | 6838 | |1;audio-beat-detection;151;117;114;151;107;115;113;113;134;109 15:45:58 INFO - PROCESS | 6838 | |2;audio-dft;184;183;187;194;253;182;179;180;181;183 15:45:58 INFO - PROCESS | 6838 | |3;audio-fft;80;58;59;88;63;59;58;58;75;59 15:45:58 INFO - PROCESS | 6838 | |4;audio-oscillator;93;70;86;69;68;67;81;68;70;106 15:45:58 INFO - PROCESS | 6838 | |5;imaging-gaussian-blur;117;130;88;84;87;84;86;84;87;86 15:45:58 INFO - PROCESS | 6838 | |6;imaging-darkroom;93;93;103;149;93;93;92;93;93;93 15:45:58 INFO - PROCESS | 6838 | |7;imaging-desaturate;85;84;87;88;86;84;91;71;127;129 15:45:58 INFO - PROCESS | 6838 | |8;json-parse-financial;56;56;55;56;57;57;58;56;56;55 15:45:58 INFO - PROCESS | 6838 | |9;json-stringify-tinderbox;65;69;70;76;74;71;72;72;72;71 15:45:58 INFO - PROCESS | 6838 | |10;stanford-crypto-aes;89;89;78;98;106;105;105;87;87;89 15:45:58 INFO - PROCESS | 6838 | |11;stanford-crypto-ccm;153;162;158;168;150;158;162;142;213;193 15:45:58 INFO - PROCESS | 6838 | |12;stanford-crypto-pbkdf2;177;173;174;172;174;172;176;175;173;175 15:45:58 INFO - PROCESS | 6838 | |13;stanford-crypto-sha256-iterative;68;69;69;69;69;74;76;89;88;88 15:45:58 INFO - PROCESS | 6838 | __end_tp_report 15:45:58 INFO - PROCESS | 6838 | __start_cc_report 15:45:58 INFO - PROCESS | 6838 | _x_x_mozilla_cycle_collect,1982 15:45:58 INFO - PROCESS | 6838 | __end_cc_report 15:45:58 INFO - PROCESS | 6838 | __startTimestamp1480722358043__endTimestamp 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | ------- Summary: start ------- 15:45:58 INFO - PROCESS | 6838 | Number of tests: 14 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:2.25 (2.0%) stddev-sans-first:2.37 15:45:58 INFO - PROCESS | 6838 | Values: 114.0 115.0 114.0 114.0 121.0 114.0 113.0 114.0 115.0 114.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#1] audio-beat-detection Cycles:10 Average:122.40 Median:116.00 stddev:16.73 (14.4%) stddev-sans-first:14.18 15:45:58 INFO - PROCESS | 6838 | Values: 151.0 117.0 114.0 151.0 107.0 115.0 113.0 113.0 134.0 109.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#2] audio-dft Cycles:10 Average:190.60 Median:183.50 stddev:22.34 (12.2%) stddev-sans-first:23.56 15:45:58 INFO - PROCESS | 6838 | Values: 184.0 183.0 187.0 194.0 253.0 182.0 179.0 180.0 181.0 183.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#3] audio-fft Cycles:10 Average:65.70 Median:61.00 stddev:11.10 (18.2%) stddev-sans-first:10.49 15:45:58 INFO - PROCESS | 6838 | Values: 80.0 58.0 59.0 88.0 63.0 59.0 58.0 58.0 75.0 59.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:70.00 stddev:13.38 (19.1%) stddev-sans-first:13.01 15:45:58 INFO - PROCESS | 6838 | Values: 93.0 70.0 86.0 69.0 68.0 67.0 81.0 68.0 70.0 106.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:86.00 stddev:16.27 (18.9%) stddev-sans-first:14.82 15:45:58 INFO - PROCESS | 6838 | Values: 117.0 130.0 88.0 84.0 87.0 84.0 86.0 84.0 87.0 86.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:93.00 stddev:17.68 (19.0%) stddev-sans-first:18.60 15:45:58 INFO - PROCESS | 6838 | Values: 93.0 93.0 103.0 149.0 93.0 93.0 92.0 93.0 93.0 93.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:85.50 stddev:19.08 (22.3%) stddev-sans-first:20.00 15:45:58 INFO - PROCESS | 6838 | Values: 85.0 84.0 87.0 88.0 86.0 84.0 91.0 71.0 127.0 129.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 15:45:58 INFO - PROCESS | 6838 | Values: 56.0 56.0 55.0 56.0 57.0 57.0 58.0 56.0 56.0 55.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:72.00 stddev:2.94 (4.1%) stddev-sans-first:2.09 15:45:58 INFO - PROCESS | 6838 | Values: 65.0 69.0 70.0 76.0 74.0 71.0 72.0 72.0 72.0 71.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:88.00 stddev:9.58 (10.9%) stddev-sans-first:10.03 15:45:58 INFO - PROCESS | 6838 | Values: 89.0 89.0 78.0 98.0 106.0 105.0 105.0 87.0 87.0 89.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#11] stanford-crypto-ccm Cycles:10 Average:165.90 Median:162.00 stddev:21.35 (13.2%) stddev-sans-first:22.13 15:45:58 INFO - PROCESS | 6838 | Values: 153.0 162.0 158.0 168.0 150.0 158.0 162.0 142.0 213.0 193.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:174.50 stddev:1.66 (1.0%) stddev-sans-first:1.39 15:45:58 INFO - PROCESS | 6838 | Values: 177.0 173.0 174.0 172.0 174.0 172.0 176.0 175.0 173.0 175.0 15:45:58 INFO - PROCESS | 6838 | 15:45:58 INFO - PROCESS | 6838 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:75.00 stddev:8.95 (11.9%) stddev-sans-first:9.02 15:45:58 INFO - PROCESS | 6838 | Values: 68.0 69.0 69.0 69.0 69.0 74.0 76.0 89.0 88.0 88.0 15:45:58 INFO - PROCESS | 6838 | -------- Summary: end -------- 15:45:58 INFO - PROCESS | 6838 | 15:45:59 INFO - TEST-INFO | 6838: exit 0 15:45:59 INFO - TEST-OK | kraken | took 60849ms 15:45:59 INFO - SUITE-END | took 1180s 15:45:59 INFO - Completed test suite (00:19:41) 15:45:59 INFO - javascript benchmark 15:45:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2918.3871387008726, 3290.4077266092095, 3299.8185099819507, 3326.767126301157, 3354.4465163248065, 5594.24477695511, 5632.971835140829, 5650.29371328584, 5657.038303488406, 5739.5408367330565, 5596.328440587135, 5645.407232240617, 5722.256106706132, 5736.967345877741, 5737.770489180428, 5021.472745361739, 5095.439501654815, 5095.898082038357, 5148.948510514884, 5178.559822415081, 5217.791288348461, 5233.162693968966, 5241.213817927322, 5245.895082098375, 5302.045631786277, 5206.062908676437, 5213.582913366921, 5227.4511176326505, 5251.2385704072885, 5305.681659100447, 5069.239614057884, 5116.027954688634, 5132.974335128338, 5134.768935397916, 5176.50823171798, 5027.648064635477, 5101.974490127563, 5122.410922743895, 5131.717755523445, 5163.63854530183, 5591.161325801122, 5686.829395118153, 5711.371749107595, 5735.455131762517, 5751.971240143815, 6191.349908259658, 6202.627842329474, 6209.59637623553, 6211.3167551569295, 6219.346968568326, 6190.414649421895, 6267.279262884781, 6270.184875966141, 6279.8744025119695, 6285.340039295854, 5551.472610102034, 5679.858003549903, 5698.088305871123, 5702.971485142548, 5708.628939119027, 6232.501399888089, 6240.188775459162, 6266.373362663697, 6275.278342990523, 6281.654509002049, 5101.438841727407, 6124.5712800103565, 6132.080187971751, 6136.693165341715, 6138.508919286446, 6115.908261376083, 6121.178620693132, 6137.9720220348345, 6203.534734894901, 6257.9687101564205, 6113.32753397126, 6121.418465245794, 6127.387261273837, 6130.804493123798, 6135.171751813537, 6102.920364089578, 6107.006761825774, 6110.327863934964, 6131.417515336036, 6154.892119418458, 4892.0705066037335, 4895.339129217581, 4907.288443175719, 4911.901761964741, 4918.139325618003, 4293.3989241506215, 4373.75944323059, 4375.906023494126, 4385.429894113809, 4388.780560972003, 5584.52531534816, 5655.953648575027, 5669.0, 5746.770129194869, 5747.85630359236, 6180.3201647818705, 6216.471599913967, 6241.500679945593, 6275.278342990523, 6290.025046117859, 5639.718014099279, 5647.181158732043, 5711.114777209456, 5726.3700992890745, 5752.654840709487, 5178.0679477694375, 5367.946320536823, 5369.838904832861, 5372.006178856924, 5377.085895397791, 4878.609711223165, 6203.565750397429, 6285.622862628257, 6288.811335659938, 6295.055741638791, 6247.437730604086, 6269.874602508015, 6275.215598050244, 6291.496680265476, 6295.0, 5628.155776633538, 6029.849253768515, 6312.242530896322, 6318.62088274705, 6385.0, 5988.850278743066, 6054.061620448838, 6054.63672179653, 6104.511639068953, 6130.816075517741, 6058.0, 6215.34738852414, 6221.688915554295, 6234.220722409699, 6252.0, 5002.0, 6025.969870150621, 6048.425399587032, 6064.654420378391, 6075.179850720273, 5850.590458668023, 5897.0, 5980.192673988956, 5988.161657367885, 6033.78881739137, 5804.0, 5845.853853653693, 5880.26496687914, 5926.881462370642, 5927.762889484545, 5966.940330596812, 6034.788782392595, 6035.577509574463, 6058.121572371893, 6081.239845019372, 5682.346530149086, 5776.19133321327, 5854.121881717776, 5858.0, 5876.647401155773], "value": 5631.636148767613, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.41855157293327, 514.452108504443, 515.1191462598956, 527.5673947363161, 542.9782808687653, 31112.066638000866, 38896.611033889654, 39985.60014399855, 40020.79989600048, 42202.36696449556, 41406.17187656253, 41821.7908910455, 41888.37167442483, 41908.0, 41960.58039419605, 8001.8799718004275, 8384.496930184177, 9178.862317065266, 9363.157315841572, 9372.343935924488, 8528.0, 10955.945220273887, 11219.719507012349, 11251.774964500704, 11415.942920285386, 11262.155338349616, 11317.660470185907, 11345.659630211107, 11370.829437558443, 11382.487788049517, 11194.272372295816, 11198.216124871262, 11222.270552414067, 11266.54933802651, 11268.887311126866, 11123.27698699582, 11185.496652650569, 11214.495347709291, 11220.775584488265, 11231.550737970472, 36330.45504317437, 38778.418323725164, 39068.21863562713, 39101.80449097765, 39134.60865391338, 3274.0, 3394.507796369537, 3465.6361082086523, 3520.366334059868, 3760.2855457462992, 29791.106266812032, 30576.54135187974, 30601.38797224043, 30623.0, 30682.53976190359, 3052.7557795376315, 3251.3334766373073, 3308.768386212966, 3366.7138293245102, 3375.8480868360984, 458179.0, 483198.6720531175, 488094.0, 488637.0, 488821.0, 59284.0, 59489.0, 59820.0, 59905.80188396208, 59946.70026649839, 63272.36727632757, 63303.0, 63326.733465330435, 63388.0, 63466.36533634697, 15210.011349262262, 15225.847741522442, 15485.922570387302, 15707.371705131894, 15770.448034318744, 10589.682309530726, 10798.67603971882, 10816.567337306577, 12138.907498325016, 12205.267683938991, 15820.559298837728, 16636.50090497263, 19496.610067798563, 19782.90108549477, 20057.699134512994, 6372.490200783926, 6502.057201705727, 7906.802329941683, 7916.485428447132, 7940.960295198487, 852.4459101584021, 973.0755782007121, 1053.847192157133, 1071.2822408985999, 1113.2374323588367, 29520.261993450335, 29703.43558772918, 30381.0, 30555.69444305573, 30622.23444413863, 1004.8944860789658, 1046.6336782126348, 1085.945702714861, 1092.6831218946575, 1093.2183488805542, 15349.925505214751, 15357.385704571916, 15377.692446151013, 15418.074915505105, 15814.288357023961, 667338.0, 672538.0, 673044.0, 673791.0, 674296.0, 57258.713706432034, 57602.847943040906, 57870.4212957865, 57969.71015144897, 58141.41858581445, 1200.9399530023463, 1244.0545185658784, 1250.06245316013, 1337.5586056601298, 1349.811026456297, 27155.0, 28344.433111337246, 28951.131466056053, 29972.100836974925, 30954.502685830033, 55546.722266390025, 56097.0, 56102.719486402304, 56136.0, 56165.0, 612665.0, 618405.0, 618965.0, 619221.0, 619360.0, 26136.60795088113, 26583.0, 26899.86550067237, 27005.459890802467, 41307.38038929478, 45425.31862022006, 45452.86367840831, 45693.54306457026, 45963.850903727674, 46142.76928615336, 36435.0, 36974.075648109014, 37124.81437592795, 38247.61752382552, 39726.2054758909, 37442.063948401505, 37478.62521374752, 38216.235675286895, 38554.22891542209, 38688.41967370548, 35646.64353356537, 36268.81865590655, 36826.89519314425, 37653.0, 39355.80322098371, 32808.0, 33686.49470257899, 34273.0, 34385.0, 34501.482477763355, 21003.73977561351, 24710.876445617658, 24911.75088249167, 25268.862901169123, 25517.23448296554], "value": 20190.68460331084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.63183657159976, 363.08864749478806, 368.46572469918607, 373.18086799475157, 400.2455371624489, 14606.634834129152, 14789.260536973148, 15611.141387223684, 19436.70844937327, 20139.899300503475, 19140.0, 19484.220631174736, 19726.21095156192, 20208.191672333127, 20424.8978755106, 5537.224788529599, 5822.243108395903, 5825.563082768788, 5841.474267315941, 5842.182094506772, 4632.143053535106, 5776.682282474462, 5801.593888427812, 5802.216700745409, 5812.4768770810615, 5600.327960644708, 5681.488666020057, 5745.597808153431, 5774.711264436783, 5780.4797568218855, 5236.1098613235845, 5388.407275199725, 5454.0, 5726.856828579319, 5752.626079304852, 4456.153330867125, 4984.177610694231, 4998.750062496897, 5014.172661510846, 5029.899402011976, 13103.148295360867, 13308.866911330859, 20868.165273389048, 23379.0, 24989.0, 2300.7124109486313, 2312.921107893206, 2396.2930935374106, 2703.8783254753585, 2860.0561814601338, 9369.390989585656, 9757.951210243904, 10183.083522483012, 10244.94877525615, 10411.791764164675, 1772.2822256985942, 1775.6448710258, 1795.8204179582067, 1801.5676237702858, 1842.8525717942666, 107571.0, 110694.44652776765, 111478.0, 112783.43608281988, 118964.0, 9241.399309045026, 9367.344285899922, 11231.932966368182, 11365.09079273656, 11471.713207169721, 13989.0, 14232.359543820552, 14243.928780356031, 14269.714605707828, 14320.498782542561, 7215.567065976058, 7816.960915195387, 8247.628856701343, 8249.587520623945, 8410.03284622264, 8029.638666260033, 8059.274665280153, 8077.838443231102, 8182.0, 8281.8343633127, 4382.649388048949, 4491.236489796743, 4548.363229147922, 4604.930926036112, 4642.234031384851, 1402.6715652017601, 1891.1111777464569, 1916.8562357823218, 1924.7978962209047, 1924.8941308228182, 773.5474747272908, 819.2012787532227, 891.1838590055394, 971.946542940145, 972.9610815567439, 19820.70268945967, 19843.900780496006, 20576.279830205873, 20596.58806823855, 20750.792492074885, 909.4679612426804, 926.3746970794822, 930.8650245714468, 950.7623094226443, 971.6696323250129, 8105.75682729519, 9447.960724320319, 10088.445135517617, 10094.49527523621, 10722.78554428907, 336901.0, 451582.0, 574740.0, 594476.0, 596330.0, 116030.839691602, 126050.0, 128141.0, 128828.35585822011, 130946.0, 899.7525680437932, 922.5341202692597, 941.0307383395113, 941.5010044676333, 942.0, 14722.77915831242, 18146.90926545359, 18248.45254642363, 18532.166052527937, 18654.893391406855, 50791.22230721907, 52222.95554088973, 53032.939341212186, 53159.20261196008, 53997.0, 75765.0, 77667.0, 78352.0, 80428.0, 81606.59196703979, 7586.71025925605, 7855.253750893656, 7915.248051435105, 7973.960130199312, 8169.346452283922, 10552.894471055191, 11038.668839934493, 12425.440855161358, 12612.936935315265, 12723.936380318039, 10600.363978161335, 10640.733981650521, 10763.138948884227, 10931.344119352865, 11154.16343774204, 9219.124183202584, 10484.63303784364, 10645.0, 10700.518476668412, 10738.128070970004, 10980.011798938134, 11194.0, 11226.775464490827, 11251.493682784458, 11302.830457543309, 7785.805354865947, 7964.323032542299, 7965.362770978192, 7987.202879352099, 8215.876761848458, 9977.002299769965, 10611.31026483276, 10921.56313747473, 10956.780864382827, 10984.505697243483], "value": 9107.517254619084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.7321675839692, 1296.8314119164506, 1424.8717615414614, 1527.3966783120668, 1779.154901421825, 6603.504737144715, 7359.7792066238035, 7736.690532378705, 8238.0, 8244.258016778489, 8161.755147345574, 8259.958700206505, 8266.50400975942, 8271.54506502142, 8287.41988060836, 2038.7859274776158, 2254.7407048189502, 2303.2744685424123, 2310.4108452344713, 2313.3060081975423, 2114.3656902929138, 2259.627161518356, 2319.6056670365992, 2328.522652856169, 2343.238447504559, 2264.184893438361, 2265.7394399644004, 2276.692646492727, 2281.6577513372963, 2283.132409684326, 2261.4685548896077, 2290.828187885915, 2291.644795056769, 2292.3123063081007, 2295.070496448941, 2272.034385386221, 2299.8045166160896, 2306.8961896714522, 2307.526956973816, 2319.153508969231, 8158.551279679616, 8347.707830225912, 8351.24838764508, 8360.790980225482, 8363.456375335583, 4431.8670439886855, 5019.824306149304, 5175.637705360627, 5193.818216362409, 5202.06362854686, 2799.9160025199276, 2974.7391982093764, 3565.0552603560077, 3569.928601427983, 3574.195805943668, 989.9010098990043, 1043.5147656339761, 1091.252492042953, 1093.7101668057971, 1097.3251450358052, 10928.781424371547, 10935.671929842118, 10935.781284374269, 10974.957379048978, 10983.835242471368, 4431.889202769957, 4677.883052923704, 4709.576138147583, 4712.811487540528, 4721.3390125382475, 9458.290628202913, 9465.858012129824, 9468.715938521855, 9482.762930926781, 9522.85715714265, 5191.013707395583, 5199.844004679866, 5202.323697919246, 5204.479552044765, 5205.895882082337, 4268.637165840876, 4423.402840616475, 4581.244094724333, 4681.485036645966, 4708.6468514860835, 3551.8756843510355, 3718.8140592970244, 3757.28611563802, 3807.6573108420375, 3844.2888065707375, 1249.987500124987, 1252.943617537213, 1257.3713143428286, 1265.6329664397406, 1265.658272266483, 691.2810676896072, 840.8864803251605, 850.1710831938934, 864.2481041493941, 864.4553931023415, 5321.3348331458565, 5345.0, 5474.746070673282, 5594.916076258859, 5616.202815099129, 843.3801156150224, 877.4998250996871, 881.2553392383426, 907.4101833808078, 930.5626355612851, 3167.5723777289772, 3666.633336666312, 3708.313961917054, 3771.17034252464, 3829.1767270037076, 9456.52717364129, 9555.04449555039, 9740.074692904163, 10082.546285417175, 10115.291929565006, 9960.651377201762, 9964.10323070927, 9984.251181161442, 9984.700458986243, 9992.25058120644, 7365.3002964719335, 7586.734464293723, 7632.5038872473115, 7744.419168562267, 7838.725644602411, 5588.720563971867, 5606.327240730975, 5695.914561281501, 5777.16231146473, 5818.94181058201, 9100.180983711498, 9198.67804626835, 9222.723318300461, 9317.39436936597, 9419.293552983416, 9266.490343031199, 9409.764755881159, 9442.85835712451, 9510.429374237292, 9533.952330238304, 6327.3988971047675, 7060.823479413056, 7150.034745309525, 7205.459590530626, 7210.531315464478, 7354.96322518384, 7732.0, 7822.530648161129, 7904.170062143622, 7922.564258965812, 6872.140982377203, 6953.061336719478, 6997.0, 7012.929870701228, 7137.928620713727, 6768.0, 6778.694958726967, 6827.52207345481, 6897.448204143757, 6901.206361268318, 6240.875182496416, 6455.935440645533, 6536.117624120683, 6551.475881929529, 6657.800265992028, 4178.686598505064, 4683.906321873612, 4772.7136371817805, 4777.713337199779, 4907.68100073494, 4116.300228961144, 4697.7651117444675, 4779.426468823764, 4803.543663351976, 4964.8758781030765], "value": 4335.987141972807, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.07866008673545, 307.81992534367396, 311.9766017548684, 316.2788841441514, 321.9179109327121, 5268.73656317184, 5292.682439053655, 5345.91981120283, 5391.73041347933, 5415.377231618365, 4204.5375008749015, 4869.074875773601, 5057.241413787933, 5086.109930762121, 5324.387695415028, 3534.505169276297, 4010.258102251093, 4029.597040295976, 4030.6976976726714, 4080.551139374681, 3507.4563442666426, 3976.6421022108007, 3989.8603548875794, 4008.298547754146, 4025.9331277211563, 3365.141888818348, 3643.471696603991, 3800.467934489174, 3816.2749077675153, 3840.503672612796, 4024.9396259055993, 4032.278212206749, 4034.6368826805433, 4043.029672878503, 4075.391749280463, 3507.526483924663, 3526.7354948378716, 3529.505869178317, 3545.3441113394106, 3563.7747838206465, 4442.601409921413, 5080.949190508121, 5099.286099946011, 5117.769700363493, 5134.0, 3488.9127771805656, 4333.090051089275, 4575.977120114411, 4582.816687332503, 4590.855264144072, 4555.749433781174, 4976.979719157564, 5112.539871411554, 5471.674538321197, 5480.616356855022, 3268.4933835255574, 3821.159344944108, 3859.3053250414914, 3862.208247309295, 3884.4173373994126, 5547.44525547446, 5736.1682556029145, 5746.9712651436475, 5779.399270328369, 5795.043817770063, 3951.4665520154986, 3972.443857859902, 3974.642282194616, 3980.3432433648704, 3990.620891015349, 3016.215783896159, 3733.879836049174, 3982.8406863725127, 4015.6586690131667, 4178.039051018282, 3925.528936527578, 4236.364545318165, 4317.805698743564, 4674.345591617176, 4679.461861885927, 4239.163556980937, 4355.1725172217175, 5206.895862082737, 5507.7246137692955, 5570.470805273492, 1222.8899399054128, 1234.512367614787, 1288.4137717338588, 1292.6233561257231, 1301.1932601786764, 830.393812516854, 841.7138173021202, 865.9134086591416, 885.2342723544087, 899.3389858454032, 4130.979345103316, 4239.872803815891, 4531.346058688621, 4544.590986811203, 4828.937633720576, 4254.617084462413, 4638.683341410908, 5152.252923326097, 5157.690538567623, 5465.699386533779, 4244.448221731155, 4604.148232576984, 4838.830640927551, 4860.934103006208, 4975.278584605212, 2439.42673471734, 2505.837120587156, 2670.7062223155435, 2706.9864650676623, 2796.972030279712, 5164.612654050961, 5196.584273258206, 5300.602454815904, 5574.749136288877, 5620.4660557247, 5311.017461769585, 5507.972460137674, 5563.079383323788, 5583.330000399897, 5706.573356660835, 4811.735354555463, 4965.205567109245, 5438.45615438453, 5573.860653483695, 5580.469855363734, 4767.856964291077, 5016.423111342242, 5104.464031276662, 5355.4376790436445, 5375.704336261387, 4351.78241087938, 4748.311494833299, 5335.626506144533, 5341.839744807662, 5407.945920540901, 4741.952580474152, 4962.072377297412, 5547.5007249347755, 5577.693226872561, 5587.972060139836, 3583.8208089595937, 3586.601225521996, 3592.371335016414, 3599.91000224986, 3619.6426340122453, 4875.7079373966635, 5282.920756188583, 5514.448555144453, 5678.0, 5721.084626459913, 4856.902861942671, 5551.861203469784, 5581.748821303132, 5583.1904373864745, 5591.4688104629995, 4642.4661163966575, 5054.209342992755, 5420.891582168413, 5573.052581061311, 5586.553075754011, 5243.292155558951, 5354.411014788292, 5430.8099216527235, 5446.400895901368, 5454.563634909118, 4711.552402521755, 5112.8811425031445, 5476.698781567052, 5483.396826349178, 5495.6153069284765, 4822.903541929071, 4995.575376093073, 5039.395272567315, 5482.150266708666, 5556.972215138899], "value": 3936.3226989790755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.4771797293043, 714.3749219432999, 732.3226015935259, 770.3567521119865, 790.6244533846422, 15244.390224391025, 15711.0, 15753.527394178178, 15756.763648545266, 15774.369025239006, 14047.0, 14203.715925681507, 14213.0, 14225.573232803006, 14229.288535573205, 681.7545683553917, 701.971611589022, 705.1397295299727, 838.279079991207, 853.8292341531687, 817.2318021060214, 854.6325080215505, 855.9572021398936, 868.674247157316, 870.7126648206076, 918.7335672654922, 919.3610440743686, 920.5811355833114, 922.4649703172178, 923.1368670293298, 707.2397173039004, 907.4237858959575, 910.7404389748956, 913.3287034030016, 913.8994710581898, 544.1647071744892, 650.9609423434609, 664.7473959895209, 669.1802541886199, 673.9292374300677, 14433.494827680981, 14481.203533805636, 14487.71024579513, 14499.0, 14501.0, 13067.86932130676, 13137.146085504412, 13250.66873328165, 13443.32783360828, 13462.192268463923, 12128.878711212863, 12260.325682087481, 12320.01439884807, 12357.196782209128, 12424.627261182179, 4273.615374616299, 4353.477582690066, 4387.232234358974, 4401.097774956126, 4537.183307004738, 103594.0, 103602.92794144075, 109171.45414272878, 109530.0, 111277.0, 10311.0, 10389.68830935058, 10464.319819211727, 10666.73333166677, 10730.356178629307, 18824.717629235573, 18940.43178704641, 18943.621127577648, 18970.62058758817, 19001.334953276568, 7506.211847756016, 7539.509931854412, 7594.278543538355, 7627.847443051108, 7765.456418050682, 3632.763870348419, 4170.687198460128, 4230.725002874803, 4233.894152646147, 4264.765437900884, 3289.407906576839, 3372.8144952027874, 3393.609734880471, 3407.2504049109157, 3417.658234176612, 563.7096895099028, 606.6814922165898, 607.975680972765, 619.2661695890384, 629.6064959400375, 579.5161040531119, 593.3214072748974, 629.7701339011228, 634.1724050114552, 634.8607081826466, 7952.767321065244, 8538.615762290712, 8564.871526927102, 8661.913380866237, 8783.824323513494, 558.5922276738004, 602.8643555200044, 610.9755609775559, 625.6246252248706, 627.2504357293083, 4157.8960525987095, 4218.725782824106, 4241.0, 4377.212101821639, 4392.890177745582, 85005.57497212474, 99685.50157249167, 107365.0, 111651.88348116577, 114848.0, 97114.0288597119, 98670.0, 98885.0, 100787.99212007933, 106688.0, 70565.0, 87569.0, 90746.54626726692, 91191.0, 93369.53315233516, 8522.446041007315, 8546.957265213634, 8631.136886311318, 8704.042555319036, 8740.257078148428, 52035.479645203064, 56674.7166264166, 57360.0, 58159.418405817094, 58907.0, 48684.75657621689, 56907.43092569187, 64152.679236603515, 65779.67110164418, 68723.31276687169, 10895.727606809893, 11205.60780372683, 11417.885821141683, 11471.197016208785, 13432.664183395493, 12118.394080295773, 12348.814767778671, 14506.34721437559, 14808.407663693331, 14824.0, 13481.0, 13493.932530337286, 13630.659233519242, 14009.719805604034, 14232.786508202593, 13242.404091816084, 13852.93073534626, 13856.307184640526, 14415.207163606103, 14443.555644435472, 12914.354282286036, 13248.668783280109, 13529.932350338186, 13676.93161534186, 14026.719465610835, 8946.731598052069, 10467.456944755028, 11139.108871290115, 11301.0, 12033.63899083029, 11148.0, 11322.94338528302, 11453.427328633368, 11549.88450115488, 11629.302241865515], "value": 7337.6998993209945, "unit": "score"}], "name": "dromaeo_css", "value": 7114.794025998601, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 121.0, 114.0, 113.0, 114.0, 115.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 114.0, 151.0, 107.0, 115.0, 113.0, 113.0, 134.0, 109.0], "value": 122.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 187.0, 194.0, 253.0, 182.0, 179.0, 180.0, 181.0, 183.0], "value": 190.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 88.0, 63.0, 59.0, 58.0, 58.0, 75.0, 59.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 86.0, 69.0, 68.0, 67.0, 81.0, 68.0, 70.0, 106.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 130.0, 88.0, 84.0, 87.0, 84.0, 86.0, 84.0, 87.0, 86.0], "value": 93.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 103.0, 149.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 87.0, 88.0, 86.0, 84.0, 91.0, 71.0, 127.0, 129.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 57.0, 57.0, 58.0, 56.0, 56.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 70.0, 76.0, 74.0, 71.0, 72.0, 72.0, 72.0, 71.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 78.0, 98.0, 106.0, 105.0, 105.0, 87.0, 87.0, 89.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 162.0, 158.0, 168.0, 150.0, 158.0, 162.0, 142.0, 213.0, 193.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 174.0, 172.0, 174.0, 172.0, 176.0, 175.0, 173.0, 175.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 74.0, 76.0, 89.0, 88.0, 88.0], "value": 75.9, "unit": "score"}], "name": "kraken", "value": 1493.9, "alertThreshold": 2.0}]} 15:45:59 INFO - Return code: 0 15:45:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:45:59 INFO - # TBPL SUCCESS # 15:45:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:45:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:45:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:45:59 INFO - 2016-12-02 15:45:59.841 screenresolution[6842:127309] starting screenresolution argv=screenresolution get 15:45:59 INFO - 2016-12-02 15:45:59.844 screenresolution[6842:127309] Display 0: 1600x1200x32@60 15:45:59 INFO - 2016-12-02 15:45:59.850 screenresolution[6843:127313] starting screenresolution argv=screenresolution list 15:45:59 INFO - Available Modes on Display 0 15:45:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:45:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:45:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:45:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:46:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:46:00 INFO - Intel Iris: 15:46:00 INFO - Chipset Model: Intel Iris 15:46:00 INFO - Type: GPU 15:46:00 INFO - Bus: Built-In 15:46:00 INFO - VRAM (Dynamic, Max): 1536 MB 15:46:00 INFO - Vendor: Intel (0x8086) 15:46:00 INFO - Device ID: 0x0a2e 15:46:00 INFO - Revision ID: 0x0009 15:46:00 INFO - Displays: 15:46:00 INFO - Display: 15:46:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:46:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:46:00 INFO - Display Serial Number: 1600x1200 60 15:46:00 INFO - Main Display: Yes 15:46:00 INFO - Mirror: Off 15:46:00 INFO - Online: Yes 15:46:00 INFO - Rotation: Supported 15:46:00 INFO - Return code: 0 15:46:00 INFO - Running post-action listener: _resource_record_post_action 15:46:00 INFO - [mozharness: 2016-12-02 23:46:00.085266Z] Finished run-tests step (success) 15:46:00 INFO - Running post-run listener: _resource_record_post_run 15:46:00 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 610816; Write bytes: 696733696; Read time: 6; Write time: 1949 15:46:00 INFO - TinderboxPrint: CPU usage
53.7% 15:46:00 INFO - TinderboxPrint: I/O read bytes / time
610,816 / 6 15:46:00 INFO - TinderboxPrint: I/O write bytes / time
696,733,696 / 1,949 15:46:00 INFO - TinderboxPrint: CPU idle
2,249.6 (46.3%) 15:46:00 INFO - TinderboxPrint: CPU system
973.8 (20.0%) 15:46:00 INFO - TinderboxPrint: CPU user
1,634.4 (33.6%) 15:46:00 INFO - TinderboxPrint: Swap in / out
383,827,968 / 0 15:46:00 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 366791168; Write bytes: 367371776; Read time: 27798; Write time: 747 15:46:00 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 610304; Write bytes: 306221568; Read time: 5; Write time: 1130 15:46:00 INFO - Running post-run listener: _upload_blobber_files 15:46:00 INFO - Blob upload gear active. 15:46:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:46:00 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 15:46:00 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:46:00 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:46:00 INFO - (blobuploader) - INFO - Open directory for files ... 15:46:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:46:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:02 INFO - (blobuploader) - INFO - Done attempting. 15:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:03 INFO - (blobuploader) - INFO - Done attempting. 15:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:07 INFO - (blobuploader) - INFO - Done attempting. 15:46:07 INFO - (blobuploader) - INFO - Iteration through files over. 15:46:07 INFO - Return code: 0 15:46:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:46:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:46:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7bd4b441ac079a9126c4dbb886abe2c8c90d8622800a8a93ea0296e807243d8856c86426ccff2671d33911e573b07ddf222cc1b9e5132f44259c5497368a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d39eb544235576cadc0881242bae8be950fad298bf36947e0da8c7f73fde64daf590337826392fc8741a85b613173771b04552e7038c6e462b164a14bd0bfc2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b0ec3a404081a15d01b0a7dbcae7e61d825a4c7b549bd22257fd6e769ad299fd22ab6cc404caec3870e51668317f327094f0bcdd0aa61f8d7b93e6d97ddeb6a"} 15:46:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:46:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:46:07 INFO - Contents: 15:46:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7bd4b441ac079a9126c4dbb886abe2c8c90d8622800a8a93ea0296e807243d8856c86426ccff2671d33911e573b07ddf222cc1b9e5132f44259c5497368a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d39eb544235576cadc0881242bae8be950fad298bf36947e0da8c7f73fde64daf590337826392fc8741a85b613173771b04552e7038c6e462b164a14bd0bfc2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b0ec3a404081a15d01b0a7dbcae7e61d825a4c7b549bd22257fd6e769ad299fd22ab6cc404caec3870e51668317f327094f0bcdd0aa61f8d7b93e6d97ddeb6a"} 15:46:07 INFO - Running post-run listener: copy_logs_to_upload_dir 15:46:07 INFO - Copying logs to upload dir... 15:46:07 INFO - mkdir: /builds/slave/test/build/upload/logs 15:46:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.950059 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-12-02 15:46:07.782431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 15:46:07.786264) ========= 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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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/Firefox/sha512/9c7bd4b441ac079a9126c4dbb886abe2c8c90d8622800a8a93ea0296e807243d8856c86426ccff2671d33911e573b07ddf222cc1b9e5132f44259c5497368a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d39eb544235576cadc0881242bae8be950fad298bf36947e0da8c7f73fde64daf590337826392fc8741a85b613173771b04552e7038c6e462b164a14bd0bfc2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b0ec3a404081a15d01b0a7dbcae7e61d825a4c7b549bd22257fd6e769ad299fd22ab6cc404caec3870e51668317f327094f0bcdd0aa61f8d7b93e6d97ddeb6a"} build_url:https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/LfYz7PmsSw6xwvj_-F16sw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7bd4b441ac079a9126c4dbb886abe2c8c90d8622800a8a93ea0296e807243d8856c86426ccff2671d33911e573b07ddf222cc1b9e5132f44259c5497368a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d39eb544235576cadc0881242bae8be950fad298bf36947e0da8c7f73fde64daf590337826392fc8741a85b613173771b04552e7038c6e462b164a14bd0bfc2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b0ec3a404081a15d01b0a7dbcae7e61d825a4c7b549bd22257fd6e769ad299fd22ab6cc404caec3870e51668317f327094f0bcdd0aa61f8d7b93e6d97ddeb6a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 15:46:07.829939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:46:07.830221) ========= 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.KRAc0yUnTD/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.G5YBBlc3Pi/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.005374 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 15:46:07.882486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 15:46:07.885807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 15:46:07.886158) ========= ========= Total master_lag: 0.28 =========