builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0180 starttime: 1485966478.93 results: success (0) buildid: 20170201070708 builduid: 32478d2170fe418c9ee08c36cf22f37d revision: 662e5af3a92895074b6644bc0f8547d84d00d7df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 08:27:58.933116) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 08:27:58.933543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 08:27:58.933812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 08:27:58.968204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 08:27:58.968472) ========= 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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-01 08:27:58-- 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% 153M=0s 2017-02-01 08:27:59 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.499804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 08:27:59.491393) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 08:27:59.491703) ========= 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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.019511 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 08:27:59.540009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 08:27:59.540360) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 662e5af3a92895074b6644bc0f8547d84d00d7df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 662e5af3a92895074b6644bc0f8547d84d00d7df --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Npb2cvEdoN/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.lxCa4PpXpc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-01 08:27:59,627 truncating revision to first 12 chars 2017-02-01 08:27:59,627 Setting DEBUG logging. 2017-02-01 08:27:59,627 attempt 1/10 2017-02-01 08:27:59,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/662e5af3a928?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 08:28:00,640 unpacking tar archive at: mozilla-aurora-662e5af3a928/testing/mozharness/ program finished with exit code 0 elapsedTime=1.263989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 08:28:00.827625) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 08:28:00.827961) ========= script_repo_revision: 662e5af3a92895074b6644bc0f8547d84d00d7df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 08:28:00.828367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 08:28:00.828636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 08:28:00.848716) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-01 08:28:00.849097) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Npb2cvEdoN/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.lxCa4PpXpc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28:01 INFO - MultiFileLogger online at 20170201 08:28:01 in /builds/slave/test 08:28:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:28:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:28:01 INFO - {'append_to_log': False, 08:28:01 INFO - 'base_work_dir': '/builds/slave/test', 08:28:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:28:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:28:01 INFO - 'branch': 'Mozilla-Aurora', 08:28:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:28:01 INFO - 'config_files': ('talos/mac_config.py',), 08:28:01 INFO - 'default_actions': ('clobber', 08:28:01 INFO - 'read-buildbot-config', 08:28:01 INFO - 'download-and-extract', 08:28:01 INFO - 'populate-webroot', 08:28:01 INFO - 'create-virtualenv', 08:28:01 INFO - 'install', 08:28:01 INFO - 'run-tests'), 08:28:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:28:01 INFO - 'download_minidump_stackwalk': True, 08:28:01 INFO - 'download_symbols': 'ondemand', 08:28:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:28:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:28:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:28:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:28:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:28:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:28:01 INFO - 'installer_path': 'installer.exe', 08:28:01 INFO - 'log_level': 'info', 08:28:01 INFO - 'log_name': 'talos', 08:28:01 INFO - 'log_to_console': True, 08:28:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:28:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:28:01 INFO - 'opt_config_files': (), 08:28:01 INFO - 'pip_index': False, 08:28:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:28:01 INFO - 'cmd': ('bash', 08:28:01 INFO - '-c', 08:28:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:28:01 INFO - 'enabled': True, 08:28:01 INFO - 'halt_on_failure': False, 08:28:01 INFO - 'name': 'check_screen_resolution'},), 08:28:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:28:01 INFO - 'cmd': ('bash', 08:28:01 INFO - '-c', 08:28:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:28:01 INFO - 'enabled': True, 08:28:01 INFO - 'halt_on_failure': False, 08:28:01 INFO - 'name': 'check_screen_resolution'},), 08:28:01 INFO - 'run_cmd_checks_enabled': True, 08:28:01 INFO - 'sps_profile': False, 08:28:01 INFO - 'sps_profile_interval': 0, 08:28:01 INFO - 'suite': 'dromaeojs', 08:28:01 INFO - 'system_bits': '32', 08:28:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:28:01 INFO - 'title': 't-yosemite-r7-0180', 08:28:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:28:01 INFO - 'use_talos_json': True, 08:28:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:28:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:28:01 INFO - 'work_dir': 'build'} 08:28:01 INFO - [mozharness: 2017-02-01 16:28:01.065523Z] Running clobber step. 08:28:01 INFO - Running pre-action listener: _resource_record_pre_action 08:28:01 INFO - Running main action method: clobber 08:28:01 INFO - rmtree: /builds/slave/test/build 08:28:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:02 INFO - Running post-action listener: _resource_record_post_action 08:28:02 INFO - [mozharness: 2017-02-01 16:28:02.674974Z] Finished clobber step (success) 08:28:02 INFO - [mozharness: 2017-02-01 16:28:02.675104Z] Running read-buildbot-config step. 08:28:02 INFO - Running pre-action listener: _resource_record_pre_action 08:28:02 INFO - Running main action method: read_buildbot_config 08:28:02 INFO - Using buildbot properties: 08:28:02 INFO - { 08:28:02 INFO - "project": "", 08:28:02 INFO - "product": "firefox", 08:28:02 INFO - "script_repo_revision": "production", 08:28:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:28:02 INFO - "repository": "", 08:28:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:28:02 INFO - "buildid": "20170201070708", 08:28:02 INFO - "pgo_build": "False", 08:28:02 INFO - "basedir": "/builds/slave/test", 08:28:02 INFO - "buildnumber": 85, 08:28:02 INFO - "slavename": "t-yosemite-r7-0180", 08:28:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:28:02 INFO - "platform": "yosemite_r7", 08:28:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:28:02 INFO - "branch": "mozilla-aurora", 08:28:02 INFO - "repo_path": "releases/mozilla-aurora", 08:28:02 INFO - "revision": "662e5af3a92895074b6644bc0f8547d84d00d7df", 08:28:02 INFO - "stage_platform": "macosx64", 08:28:02 INFO - "builduid": "32478d2170fe418c9ee08c36cf22f37d", 08:28:02 INFO - "slavebuilddir": "test" 08:28:02 INFO - } 08:28:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:28:02 INFO - Running post-action listener: _resource_record_post_action 08:28:02 INFO - [mozharness: 2017-02-01 16:28:02.678444Z] Finished read-buildbot-config step (success) 08:28:02 INFO - [mozharness: 2017-02-01 16:28:02.678592Z] Running download-and-extract step. 08:28:02 INFO - Running pre-action listener: _resource_record_pre_action 08:28:02 INFO - Running main action method: download_and_extract 08:28:02 INFO - mkdir: /builds/slave/test/build/tests 08:28:02 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')]} 08:28:02 INFO - trying https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:28:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:28:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:28:04 INFO - Downloaded 1199 bytes. 08:28:04 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:28:04 INFO - Using the following test package requirements: 08:28:04 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:28:04 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:28:04 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:28:04 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:28:04 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:28:04 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:28:04 INFO - u'jsshell-mac.zip'], 08:28:04 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:28:04 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:28:04 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:28:04 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:28:04 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:28:04 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:28:04 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:28:04 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:28:04 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:28:04 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:28:04 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:28:04 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:28:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:28:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:28:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:28:05 INFO - Expected file size: 16354759 08:28:05 INFO - Obtained file size: 16354759 08:28:11 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:28:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:28:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:28:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:28:12 INFO - Expected file size: 16354759 08:28:12 INFO - Obtained file size: 16354759 08:28:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:28:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:28:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:28:19 INFO - Expected file size: 14403485 08:28:19 INFO - Obtained file size: 14403485 08:28:19 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')]} 08:28:19 INFO - trying https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:28:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:28:22 INFO - Downloaded 73847296 bytes. 08:28:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:28:22 INFO - mkdir: /builds/slave/test/properties 08:28:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:22 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:22 INFO - Contents: 08:28:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:28:23 INFO - Running post-action listener: _resource_record_post_action 08:28:23 INFO - Running post-action listener: set_extra_try_arguments 08:28:23 INFO - [mozharness: 2017-02-01 16:28:23.300999Z] Finished download-and-extract step (success) 08:28:23 INFO - [mozharness: 2017-02-01 16:28:23.301128Z] Running populate-webroot step. 08:28:23 INFO - Running pre-action listener: _resource_record_pre_action 08:28:23 INFO - Running main action method: populate_webroot 08:28:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:23 INFO - '--tppagecycles', 08:28:23 INFO - '7'], 08:28:23 INFO - 'tests': ['tsvgm']}}, 08:28:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:28:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:28:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:28:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:28:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:28:23 INFO - 'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:28:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:28:23 INFO - 'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['damp', 'tps']}, 08:28:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:28:23 INFO - 'tests': ['damp', 'tps']}, 08:28:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['dromaeo_dom']}, 08:28:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['basic_compositor_video']}, 08:28:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:28:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['a11yr', 08:28:23 INFO - 'ts_paint', 08:28:23 INFO - 'tpaint', 08:28:23 INFO - 'sessionrestore', 08:28:23 INFO - 'sessionrestore_no_auto_restore', 08:28:23 INFO - 'tabpaint']}, 08:28:23 INFO - 'other-e10s': {'tests': ['a11yr', 08:28:23 INFO - 'ts_paint', 08:28:23 INFO - 'tpaint', 08:28:23 INFO - 'sessionrestore', 08:28:23 INFO - 'sessionrestore_no_auto_restore', 08:28:23 INFO - 'tabpaint']}, 08:28:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:28:23 INFO - 'ts_paint', 08:28:23 INFO - 'tpaint', 08:28:23 INFO - 'sessionrestore', 08:28:23 INFO - 'sessionrestore_no_auto_restore', 08:28:23 INFO - 'tabpaint']}, 08:28:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:28:23 INFO - 'ts_paint', 08:28:23 INFO - 'tpaint', 08:28:23 INFO - 'sessionrestore', 08:28:23 INFO - 'sessionrestore_no_auto_restore', 08:28:23 INFO - 'tabpaint']}, 08:28:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['a11yr', 08:28:23 INFO - 'ts_paint', 08:28:23 INFO - 'tpaint', 08:28:23 INFO - 'sessionrestore', 08:28:23 INFO - 'sessionrestore_no_auto_restore', 08:28:23 INFO - 'tabpaint']}, 08:28:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['a11yr', 08:28:23 INFO - 'ts_paint', 08:28:23 INFO - 'tpaint', 08:28:23 INFO - 'sessionrestore', 08:28:23 INFO - 'sessionrestore_no_auto_restore', 08:28:23 INFO - 'tabpaint']}, 08:28:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['tsvgx', 08:28:23 INFO - 'tsvgr_opacity', 08:28:23 INFO - 'tart', 08:28:23 INFO - 'tscrollx', 08:28:23 INFO - 'cart', 08:28:23 INFO - 'tsvg_static']}, 08:28:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:28:23 INFO - 'tsvgr_opacity', 08:28:23 INFO - 'tart', 08:28:23 INFO - 'tscrollx', 08:28:23 INFO - 'cart', 08:28:23 INFO - 'tsvg_static']}, 08:28:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:28:23 INFO - 'talos_options': ['--disable-e10s'], 08:28:23 INFO - 'tests': ['tp5o']}, 08:28:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:28:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:28:23 INFO - 'talos_options': ['--disable-e10s', 08:28:23 INFO - '--xperf_path', 08:28:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:23 INFO - 'tests': ['tp5n']}, 08:28:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:28:23 INFO - 'talos_options': ['--xperf_path', 08:28:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:23 INFO - 'tests': ['tp5n']}}, 08:28:23 INFO - 'talos.zip': {'path': '', 08:28:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:23 INFO - Running post-action listener: _resource_record_post_action 08:28:23 INFO - [mozharness: 2017-02-01 16:28:23.320010Z] Finished populate-webroot step (success) 08:28:23 INFO - [mozharness: 2017-02-01 16:28:23.320133Z] Running create-virtualenv step. 08:28:23 INFO - Running pre-action listener: _resource_record_pre_action 08:28:23 INFO - Running main action method: create_virtualenv 08:28:23 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:23 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 08:28:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:23 INFO - Using real prefix '/tools/python27' 08:28:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:27 INFO - Installing pip.................done. 08:28:27 INFO - Return code: 0 08:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:28:27 INFO - Reading from file tmpfile_stdout 08:28:27 INFO - Output received: 08:28:27 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) 08:28:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28: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', 'pip>=1.5'] in /builds/slave/test/build 08:28: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 pip>=1.5 08:28:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:27 INFO - 'HOME': '/Users/cltbld', 08:28:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:27 INFO - 'LOGNAME': 'cltbld', 08:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:27 INFO - 'MOZ_NO_REMOTE': '1', 08:28:27 INFO - 'NO_EM_RESTART': '1', 08:28:27 INFO - 'PAGER': '/bin/cat', 08:28:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:27 INFO - 'PWD': '/builds/slave/test', 08:28:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:27 INFO - 'SHELL': '/bin/bash', 08:28:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:27 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:27 INFO - 'USER': 'cltbld', 08:28:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:27 INFO - 'XPC_FLAGS': '0x0', 08:28:27 INFO - 'XPC_SERVICE_NAME': '0', 08:28:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:27 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 08:28:27 INFO - Cleaning up... 08:28:27 INFO - Return code: 0 08:28:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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', '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 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:28: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 psutil>=3.1.1 08:28:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:27 INFO - 'HOME': '/Users/cltbld', 08:28:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:27 INFO - 'LOGNAME': 'cltbld', 08:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:27 INFO - 'MOZ_NO_REMOTE': '1', 08:28:27 INFO - 'NO_EM_RESTART': '1', 08:28:27 INFO - 'PAGER': '/bin/cat', 08:28:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:27 INFO - 'PWD': '/builds/slave/test', 08:28:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:27 INFO - 'SHELL': '/bin/bash', 08:28:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:27 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:27 INFO - 'USER': 'cltbld', 08:28:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:27 INFO - 'XPC_FLAGS': '0x0', 08:28:27 INFO - 'XPC_SERVICE_NAME': '0', 08:28:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:27 INFO - Downloading/unpacking psutil>=3.1.1 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:31 INFO - Installing collected packages: psutil 08:28:31 INFO - Running setup.py install for psutil 08:28:31 INFO - building 'psutil._psutil_osx' extension 08:28:31 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 08:28:32 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 08:28:32 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 08:28:32 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 08:28:32 INFO - building 'psutil._psutil_posix' extension 08:28:32 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 08:28:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:28:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:28:32 INFO - ^ 08:28:32 INFO - 1 warning generated. 08:28:32 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 08:28:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:32 INFO - Successfully installed psutil 08:28:32 INFO - Cleaning up... 08:28:32 INFO - Return code: 0 08:28:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:28:32 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')]} 08:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:32 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')]} 08:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:32 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 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28:32 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 08:28:32 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 08:28:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:32 INFO - 'HOME': '/Users/cltbld', 08:28:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:32 INFO - 'LOGNAME': 'cltbld', 08:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:32 INFO - 'MOZ_NO_REMOTE': '1', 08:28:32 INFO - 'NO_EM_RESTART': '1', 08:28:32 INFO - 'PAGER': '/bin/cat', 08:28:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:32 INFO - 'PWD': '/builds/slave/test', 08:28:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:32 INFO - 'SHELL': '/bin/bash', 08:28:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:32 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:32 INFO - 'USER': 'cltbld', 08:28:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:32 INFO - 'XPC_FLAGS': '0x0', 08:28:32 INFO - 'XPC_SERVICE_NAME': '0', 08:28:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:28:35 INFO - Installing collected packages: mozsystemmonitor 08:28:35 INFO - Running setup.py install for mozsystemmonitor 08:28:35 INFO - Successfully installed mozsystemmonitor 08:28:35 INFO - Cleaning up... 08:28:35 INFO - Return code: 0 08:28:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:35 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 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28:35 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 08:28:35 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 08:28:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:35 INFO - 'HOME': '/Users/cltbld', 08:28:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:35 INFO - 'LOGNAME': 'cltbld', 08:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:35 INFO - 'MOZ_NO_REMOTE': '1', 08:28:35 INFO - 'NO_EM_RESTART': '1', 08:28:35 INFO - 'PAGER': '/bin/cat', 08:28:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:35 INFO - 'PWD': '/builds/slave/test', 08:28:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:35 INFO - 'SHELL': '/bin/bash', 08:28:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:35 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:35 INFO - 'USER': 'cltbld', 08:28:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:35 INFO - 'XPC_FLAGS': '0x0', 08:28:35 INFO - 'XPC_SERVICE_NAME': '0', 08:28:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:28:36 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 08:28:36 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 08:28:36 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 08:28:36 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 08:28:36 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 08:28:36 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 08:28:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:28:38 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 08:28:38 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 08:28:38 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 08:28:38 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 08:28:38 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 08:28:38 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 08:28:39 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:39 INFO - warning: no files found matching '*.txt' 08:28:39 INFO - no previously-included directories found matching 'build' 08:28:39 INFO - no previously-included directories found matching 'dist' 08:28:39 INFO - no previously-included directories found matching '.git*' 08:28:39 INFO - Installing collected packages: jsonschema, functools32 08:28:39 INFO - Running setup.py install for functools32 08:28:39 INFO - warning: no files found matching '*.txt' 08:28:39 INFO - no previously-included directories found matching 'build' 08:28:39 INFO - no previously-included directories found matching 'dist' 08:28:39 INFO - no previously-included directories found matching '.git*' 08:28:39 INFO - Successfully installed jsonschema functools32 08:28:39 INFO - Cleaning up... 08:28:39 INFO - Return code: 0 08:28:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 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 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28:39 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 08:28:39 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 08:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:39 INFO - 'HOME': '/Users/cltbld', 08:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:39 INFO - 'LOGNAME': 'cltbld', 08:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:39 INFO - 'MOZ_NO_REMOTE': '1', 08:28:39 INFO - 'NO_EM_RESTART': '1', 08:28:39 INFO - 'PAGER': '/bin/cat', 08:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:39 INFO - 'PWD': '/builds/slave/test', 08:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:39 INFO - 'SHELL': '/bin/bash', 08:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:39 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:39 INFO - 'USER': 'cltbld', 08:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:39 INFO - 'XPC_FLAGS': '0x0', 08:28:39 INFO - 'XPC_SERVICE_NAME': '0', 08:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:28:39 INFO - Cleaning up... 08:28:39 INFO - Return code: 0 08:28:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 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 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28:39 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 08:28:39 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 08:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:39 INFO - 'HOME': '/Users/cltbld', 08:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:39 INFO - 'LOGNAME': 'cltbld', 08:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:39 INFO - 'MOZ_NO_REMOTE': '1', 08:28:39 INFO - 'NO_EM_RESTART': '1', 08:28:39 INFO - 'PAGER': '/bin/cat', 08:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:39 INFO - 'PWD': '/builds/slave/test', 08:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:39 INFO - 'SHELL': '/bin/bash', 08:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:39 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:39 INFO - 'USER': 'cltbld', 08:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:39 INFO - 'XPC_FLAGS': '0x0', 08:28:39 INFO - 'XPC_SERVICE_NAME': '0', 08:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:42 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:28:42 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 08:28:42 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 08:28:42 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 08:28:42 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 08:28:42 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 08:28:42 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 08:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:28:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:28:43 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 08:28:43 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 08:28:43 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 08:28:43 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 08:28:43 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 08:28:43 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 08:28:43 INFO - Downloading docopt-0.6.1.tar.gz 08:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:28:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:28:44 INFO - Running setup.py install for blobuploader 08:28:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:28:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:28:44 INFO - Running setup.py install for requests 08:28:44 INFO - Running setup.py install for docopt 08:28:44 INFO - Successfully installed blobuploader requests docopt 08:28:44 INFO - Cleaning up... 08:28:45 INFO - Return code: 0 08:28:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 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 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28:45 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 08:28:45 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 08:28:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:45 INFO - 'HOME': '/Users/cltbld', 08:28:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:45 INFO - 'LOGNAME': 'cltbld', 08:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:45 INFO - 'MOZ_NO_REMOTE': '1', 08:28:45 INFO - 'NO_EM_RESTART': '1', 08:28:45 INFO - 'PAGER': '/bin/cat', 08:28:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:45 INFO - 'PWD': '/builds/slave/test', 08:28:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:45 INFO - 'SHELL': '/bin/bash', 08:28:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:45 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:45 INFO - 'USER': 'cltbld', 08:28:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:45 INFO - 'XPC_FLAGS': '0x0', 08:28:45 INFO - 'XPC_SERVICE_NAME': '0', 08:28:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:45 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-IsNuhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:45 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-XGAfS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:45 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-LLO65Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:45 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-TJeMnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:45 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mPFQ88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:45 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_b7ejw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:45 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-3f5jI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:45 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-qkTTyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:46 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-zIrq0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:46 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-0bhyBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:46 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-0Z4Kmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:46 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-qEhHmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:46 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-VQwTxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:46 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-fUq2PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:46 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mRYvVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:46 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-t2czD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:46 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ELz1iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:28:47 INFO - Running setup.py install for manifestparser 08:28:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Running setup.py install for mozcrash 08:28:47 INFO - Running setup.py install for mozdebug 08:28:47 INFO - Running setup.py install for mozdevice 08:28:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Running setup.py install for mozfile 08:28:47 INFO - Running setup.py install for mozhttpd 08:28:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:28:47 INFO - Running setup.py install for mozinfo 08:28:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Running setup.py install for mozInstall 08:28:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Running setup.py install for mozleak 08:28:48 INFO - Running setup.py install for mozlog 08:28:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Running setup.py install for moznetwork 08:28:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Running setup.py install for mozprocess 08:28:48 INFO - Running setup.py install for mozprofile 08:28:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Running setup.py install for mozrunner 08:28:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:28:49 INFO - Running setup.py install for mozscreenshot 08:28:49 INFO - Running setup.py install for moztest 08:28:49 INFO - Running setup.py install for mozversion 08:28:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:28:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:28:49 INFO - Cleaning up... 08:28:49 INFO - Return code: 0 08:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 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 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28:49 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 08:28:49 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 08:28:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:49 INFO - 'HOME': '/Users/cltbld', 08:28:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:49 INFO - 'LOGNAME': 'cltbld', 08:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:49 INFO - 'MOZ_NO_REMOTE': '1', 08:28:49 INFO - 'NO_EM_RESTART': '1', 08:28:49 INFO - 'PAGER': '/bin/cat', 08:28:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:49 INFO - 'PWD': '/builds/slave/test', 08:28:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:49 INFO - 'SHELL': '/bin/bash', 08:28:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:49 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:49 INFO - 'USER': 'cltbld', 08:28:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:49 INFO - 'XPC_FLAGS': '0x0', 08:28:49 INFO - 'XPC_SERVICE_NAME': '0', 08:28:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:49 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_re9KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-g5TtCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-SbvizL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-nDpfWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-hOtoRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_bHiyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-YKa9ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-jBMVAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_eymzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Ts1wam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:50 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)) 08:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:50 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-VviiFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:51 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)) 08:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:51 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-xyAWcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:51 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-7fLNvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:51 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)) 08:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:51 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-sbPj0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:51 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)) 08:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:51 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-KyiH4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:51 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)) 08:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:51 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2ub9V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:51 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-OMrKpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:51 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)) 08:28:51 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)) 08:28:51 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)) 08:28:51 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)) 08:28:51 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)) 08:28:51 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)) 08:28:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:28:51 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 08:28:51 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 08:28:51 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 08:28:51 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 08:28:51 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 08:28:51 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 08:28:54 INFO - Downloading blessings-1.6.tar.gz 08:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:28:54 INFO - Installing collected packages: blessings 08:28:54 INFO - Running setup.py install for blessings 08:28:54 INFO - Successfully installed blessings 08:28:54 INFO - Cleaning up... 08:28:54 INFO - Return code: 0 08:28:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:54 INFO - Reading from file tmpfile_stdout 08:28:54 INFO - Current package versions: 08:28:54 INFO - blessings == 1.6 08:28:54 INFO - blobuploader == 1.2.4 08:28:54 INFO - docopt == 0.6.1 08:28:54 INFO - functools32 == 3.2.3-2 08:28:54 INFO - jsonschema == 2.5.1 08:28:54 INFO - manifestparser == 1.1 08:28:54 INFO - mozInstall == 1.12 08:28:54 INFO - mozcrash == 1.0 08:28:54 INFO - mozdebug == 0.1 08:28:54 INFO - mozdevice == 0.49 08:28:54 INFO - mozfile == 1.2 08:28:54 INFO - mozhttpd == 0.7 08:28:54 INFO - mozinfo == 0.9 08:28:54 INFO - mozleak == 0.1 08:28:54 INFO - mozlog == 3.4 08:28:54 INFO - moznetwork == 0.27 08:28:54 INFO - mozprocess == 0.24 08:28:54 INFO - mozprofile == 0.28 08:28:54 INFO - mozrunner == 6.13 08:28:54 INFO - mozscreenshot == 0.1 08:28:54 INFO - mozsystemmonitor == 0.3 08:28:54 INFO - moztest == 0.8 08:28:54 INFO - mozversion == 1.4 08:28:54 INFO - psutil == 3.1.1 08:28:54 INFO - requests == 1.2.3 08:28:54 INFO - wsgiref == 0.1.2 08:28:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:54 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')]} 08:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:54 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')]} 08:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:54 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 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28:54 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 08:28:54 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 08:28:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:54 INFO - 'HOME': '/Users/cltbld', 08:28:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:54 INFO - 'LOGNAME': 'cltbld', 08:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:54 INFO - 'MOZ_NO_REMOTE': '1', 08:28:54 INFO - 'NO_EM_RESTART': '1', 08:28:54 INFO - 'PAGER': '/bin/cat', 08:28:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:54 INFO - 'PWD': '/builds/slave/test', 08:28:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:54 INFO - 'SHELL': '/bin/bash', 08:28:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:54 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:54 INFO - 'USER': 'cltbld', 08:28:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:54 INFO - 'XPC_FLAGS': '0x0', 08:28:54 INFO - 'XPC_SERVICE_NAME': '0', 08:28:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:55 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)) 08:28:55 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)) 08:28:55 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)) 08:28:55 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)) 08:28:55 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)) 08:28:55 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)) 08:28:55 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)) 08:28:55 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)) 08:28:55 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)) 08:28:55 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)) 08:28:55 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)) 08:28:55 INFO - Cleaning up... 08:28:55 INFO - Return code: 0 08:28:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:28:55 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')]} 08:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:55 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')]} 08:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:55 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 0x10644cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10644f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb102d56db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, '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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 08:28:55 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 08:28:55 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 08:28:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:28:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:55 INFO - 'HOME': '/Users/cltbld', 08:28:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:55 INFO - 'LOGNAME': 'cltbld', 08:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:55 INFO - 'MOZ_NO_REMOTE': '1', 08:28:55 INFO - 'NO_EM_RESTART': '1', 08:28:55 INFO - 'PAGER': '/bin/cat', 08:28:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:55 INFO - 'PWD': '/builds/slave/test', 08:28:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:55 INFO - 'SHELL': '/bin/bash', 08:28:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:28:55 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:28:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:55 INFO - 'USER': 'cltbld', 08:28:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:55 INFO - 'XPC_FLAGS': '0x0', 08:28:55 INFO - 'XPC_SERVICE_NAME': '0', 08:28:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:28:55 INFO - Cleaning up... 08:28:55 INFO - Return code: 0 08:28:55 INFO - Running post-action listener: _resource_record_post_action 08:28:55 INFO - Running post-action listener: _start_resource_monitoring 08:28:55 INFO - Starting resource monitoring. 08:28:55 INFO - [mozharness: 2017-02-01 16:28:55.539720Z] Finished create-virtualenv step (success) 08:28:55 INFO - [mozharness: 2017-02-01 16:28:55.540660Z] Running install step. 08:28:55 INFO - Running pre-action listener: _resource_record_pre_action 08:28:55 INFO - Running main action method: install 08:28:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:55 INFO - Reading from file tmpfile_stdout 08:28:55 INFO - Detecting whether we're running mozinstall >=1.0... 08:28:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:28:55 INFO - Reading from file tmpfile_stdout 08:28:55 INFO - Output received: 08:28:55 INFO - Usage: mozinstall [options] installer 08:28:55 INFO - Options: 08:28:55 INFO - -h, --help show this help message and exit 08:28:55 INFO - -d DEST, --destination=DEST 08:28:55 INFO - Directory to install application into. [default: 08:28:55 INFO - "/builds/slave/test"] 08:28:55 INFO - --app=APP Application being installed. [default: firefox] 08:28:55 INFO - mkdir: /builds/slave/test/build/application 08:28:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:29:16 INFO - Reading from file tmpfile_stdout 08:29:16 INFO - Output received: 08:29:16 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:29:16 INFO - Running post-action listener: _resource_record_post_action 08:29:16 INFO - [mozharness: 2017-02-01 16:29:16.166270Z] Finished install step (success) 08:29:16 INFO - [mozharness: 2017-02-01 16:29:16.166406Z] Running run-tests step. 08:29:16 INFO - Running pre-action listener: _resource_record_pre_action 08:29:16 INFO - Running main action method: run_tests 08:29:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:29:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:29:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:29:16 INFO - 2017-02-01 08:29:16.181 screenresolution[1934:25143] starting screenresolution argv=screenresolution get 08:29:16 INFO - 2017-02-01 08:29:16.183 screenresolution[1934:25143] Display 0: 1600x1200x32@60 08:29:16 INFO - 2017-02-01 08:29:16.189 screenresolution[1935:25146] starting screenresolution argv=screenresolution list 08:29:16 INFO - Available Modes on Display 0 08:29:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:29:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:29:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:29:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:29:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:29:16 INFO - Intel Iris: 08:29:16 INFO - Chipset Model: Intel Iris 08:29:16 INFO - Type: GPU 08:29:16 INFO - Bus: Built-In 08:29:16 INFO - VRAM (Dynamic, Max): 1536 MB 08:29:16 INFO - Vendor: Intel (0x8086) 08:29:16 INFO - Device ID: 0x0a2e 08:29:16 INFO - Revision ID: 0x0009 08:29:16 INFO - Displays: 08:29:16 INFO - Display: 08:29:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:29:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:29:16 INFO - Display Serial Number: 1600x1200 60 08:29:16 INFO - Main Display: Yes 08:29:16 INFO - Mirror: Off 08:29:16 INFO - Online: Yes 08:29:16 INFO - Rotation: Supported 08:29:16 INFO - Return code: 0 08:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:16 INFO - Python 2.7.3 08:29:16 INFO - Return code: 0 08:29:16 INFO - grabbing minidump binary from tooltool 08:29: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')]} 08:29:16 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 0x10622ad30>, '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 0x106151db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10621fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:16 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 08:29:16 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 08:29:16 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 08:29:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:16 INFO - Return code: 0 08:29:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:29:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:29:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 08:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --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 08:29:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npb2cvEdoN/Render', 08:29:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:16 INFO - 'HOME': '/Users/cltbld', 08:29:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:16 INFO - 'LOGNAME': 'cltbld', 08:29:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:16 INFO - 'MOZ_NO_REMOTE': '1', 08:29:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:16 INFO - 'NO_EM_RESTART': '1', 08:29:16 INFO - 'PAGER': '/bin/cat', 08:29:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:16 INFO - 'PWD': '/builds/slave/test', 08:29:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:16 INFO - 'SHELL': '/bin/bash', 08:29:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lxCa4PpXpc/Listeners', 08:29:16 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 08:29:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:16 INFO - 'USER': 'cltbld', 08:29:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:16 INFO - 'XPC_FLAGS': '0x0', 08:29:16 INFO - 'XPC_SERVICE_NAME': '0', 08:29:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 08:29:16 INFO - mozversion application_buildid: 20170201070708 08:29:16 INFO - mozversion application_changeset: 662e5af3a92895074b6644bc0f8547d84d00d7df 08:29:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:29:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:16 INFO - mozversion application_name: Firefox 08:29:16 INFO - mozversion application_remotingname: firefox-dev 08:29:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:29:16 INFO - mozversion application_vendor: Mozilla 08:29:16 INFO - mozversion application_version: 53.0a2 08:29:16 INFO - mozversion platform_buildid: 20170201070708 08:29:16 INFO - mozversion platform_changeset: 662e5af3a92895074b6644bc0f8547d84d00d7df 08:29:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:29:16 INFO - mozversion platform_version: 53.0a2 08:29:16 INFO - using testdate: 1485966556 08:29:16 INFO - actual date: 1485966556 08:29:16 INFO - starting webserver on 'localhost:56949' 08:29:16 INFO - SUITE-START | Running 2 tests 08:29:16 INFO - TEST-START | dromaeo_css 08:29:16 INFO - operating with platform_type : mac_ 08:29:16 INFO - Initialising browser for dromaeo_css test... 08:29:16 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp2N5lsB/profile http://localhost:56949/getInfo.html) 08:29:19 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 08:29:19 INFO - PROCESS | 1945 | colorDepth:24 08:29:19 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 08:29:19 INFO - PROCESS | 1945 | __metrics 08:29:19 INFO - PROCESS | 1945 | 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" 08:29:19 INFO - PROCESS | 1945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:20 INFO - TEST-INFO | 1945: exit 0 08:29:20 INFO - Browser initialized. 08:29:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:29:20 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp2N5lsB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:32 INFO - PROCESS | 1947 | RSS: Main: 213311488 08:29:32 INFO - PROCESS | 1947 | 08:32:35 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56949/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56949/tests/dromaeo/cssquery-ext.html) 08:32:37 INFO - PROCESS | 1947 | RSS: Main: 335073280 08:32:37 INFO - PROCESS | 1947 | 08:34:22 INFO - PROCESS | 1947 | ************************* 08:34:22 INFO - PROCESS | 1947 | A coding exception was thrown and uncaught in a Task. 08:34:22 INFO - PROCESS | 1947 | 08:34:22 ERROR - PROCESS | 1947 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:34:22 INFO - PROCESS | 1947 | Full stack: 08:34:22 INFO - PROCESS | 1947 | ************************* 08:35:40 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56949/tests/dromaeo/cssquery-ext.html (next: http://localhost:56949/tests/dromaeo/cssquery-jquery.html) 08:35:40 INFO - PROCESS | 1947 | RSS: Main: 349089792 08:35:40 INFO - PROCESS | 1947 | 08:38:42 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56949/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56949/tests/dromaeo/cssquery-mootools.html) 08:38:43 INFO - PROCESS | 1947 | RSS: Main: 347844608 08:38:43 INFO - PROCESS | 1947 | 08:41:45 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56949/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56949/tests/dromaeo/cssquery-prototype.html) 08:41:46 INFO - PROCESS | 1947 | RSS: Main: 329793536 08:41:46 INFO - PROCESS | 1947 | 08:44:49 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56949/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56949/tests/dromaeo/cssquery-yui.html) 08:44:50 INFO - PROCESS | 1947 | RSS: Main: 316473344 08:44:50 INFO - PROCESS | 1947 | 08:47:53 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56949/tests/dromaeo/cssquery-yui.html (next: http://localhost:56949/tests/dromaeo/cssquery-dojo.html) 08:47:53 INFO - PROCESS | 1947 | RSS: Main: 533512192 08:47:53 INFO - PROCESS | 1947 | 08:47:53 INFO - PROCESS | 1947 | __start_tp_report 08:47:53 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 08:47:53 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 08:47:53 INFO - PROCESS | 1947 | |i|pagename|runs| 08:47:53 INFO - PROCESS | 1947 | |0;dojo.html;2871.411360671062;3331.1838599543103;3335.6164041135276;3343.9498407523874;3385.4583266677337;5670.206171136044;5679.886402271957;5705.372409035002;5750.798722044729;5762.337331206907;5622.971885140579;5661.264035675356;5677.687727175004;5679.914801277974;5716.114002329635;5144.819931302405;5145.408278048017;5185;5195.376554813428;5242.8165014224505;5154.278401023859;5170.043541944752;5182.844514664566;5247.685138891659;5290.841274761744;5253.763580638881;5255.632105752599;5257.8948421031555;5261.184516399945;5270.472952704718;5253.3170687810725;5254.343207099094;5256.08018596744;5256.842294731164;5258.947410525903;5090.618203634742;5196.948030519684;5202.037623039712;5209.53114219722;5257.500537448975;5733.856653583652;5739.684317362543;5746.080627099644;5749.913751293734;5761.107028410603;5599.972000140014;5853.595137167049;6167.568270221086;6189.195404597419;6198.4731297839735;6249.656268905208;6268.749250029993;6269.498440124779;6276.309605943343;6280.591761535486;5812.244408226946;5844.094165404369;5867.970660146715;5887.587868849182;5927.229460170193;6225.470834978987;6239.719212635442;6242.375762423812;6248.218972628421;6260.7495700171485;4962.082014827269;6087.3303936566945;6103.647786248204;6135.416406698499;6141.263048434216;5122.667026643257;6279.246490421178;6284.025975973731;6289.559730818799;6290.087937249074;6195.783147589813;6240.65676387794;6247.687615619201;6250.968745156245;6252.249730032425;5986.311574169026;6078.544109191828;6108.615274519878;6132.080187971751;6134.6625935573975;4843.2735089736825;4924.8276310328965;4927.704337739747;4939.259111133359;5015.623828212826;4417.757023363682;4430.645548356124;4432.84485043022;4453.15390075891;4477;5846.327672317738;5896.174535565025;5897.115432685132;5899.380565040695;5927.436893495111;5964.821055368346;5983.072623743326;6010.639361638316;6158.261008678987;6169.784057557964;5838;5843.094320380348;5849.976254155506;5882.735276912549;5883.02930016551;5443.836684899459;5452.154915988028;5453;5467.617266791286;5483.7806487740845;6185.443310101932;6200.782972595937;6206.379362063757;6303.054541818764;6305.3379395163765;6185.690715464299;6186.876262474815;6217.378262173746;6225.190725205694;6258.280297765633;6178.505719542336;6204.3795620439405;6232.439080482778;6244.843878903063;6254.6247225166635;6120.479759220516;6170.259568851767;6188.1955345806555;6190.350013248544;6197.163382943425;6143.508519318533;6162.969185154046;6206.565540412128;6216.129741836237;6226.40849119333;6007.939920600913;6044.848878778066;6065.029595264737;6134.5590473767;6140.657627863787;6105.206323178136;6109.95128740435;6114.114890844268;6122.764110201706;6129;5743.483086522233;5982.790602328898;5991.161237426851;5992.0712289595185;6008.669523176267;5934.347221805684;6091.939080609137;6105.419985101408;6143.754249829957;6159.414855588712;5987.221661184019;6024.126501657148;6024.819255422344;6037.607555508878;6042.607230530001 08:47:53 INFO - PROCESS | 1947 | |1;ext.html;480.6539291709969;481.27568010144773;485.3375142929901;488.18473149839764;518.3727689495712;36605.633943660556;40841.795791021075;40891.386629200584;41002;41013.76958691244;35280.64719352806;39051.43794248227;42728.57271427285;43198.56801431985;43233.78383108088;8333.250007499324;9188.494632795193;9404.81190376192;9419.387739796926;9422.952885235598;8317.750467485956;11022.889771102267;11219.214654974156;11294.435278236097;11323.547058117665;11235.606753763619;11305.208635395526;11308.264962777434;11314.264572802782;11318.943405282962;8371.288440482565;11238.044766194884;11268.154888383322;11278.605248816335;11308.773824523463;8361.498310101413;10908.563657453693;11147.832782508269;11151;11333.320000799897;40575.39136912949;40772.38841417381;40842.18315633671;40948.97627559305;40980;3885.822268635917;3932;3967.6230758078227;3999.280129576675;4046.1735101453814;28959.71040289591;28961.71038289611;28982.710172898423;29309.413811723858;30268.09195724132;3102.410541997036;3331.283773988604;3356.748243881694;3362.1258472797003;3363.562736844219;500004;500552;500580;501904;502429.4878525657;59795;60327;60349;60423;60439;60559;62242;63019;63035;63166;15983.840161598468;16241.91879040621;16250.268737906823;16259;16306.184690765414;11384.146189035855;11650.41747912601;11679.649610511698;12644.367781611067;12646.241225526313;15559.688806223812;15854.841451585336;15866.603334916488;16372.099534525716;16381.918090409472;5864.296284445809;6515.980046185698;6568.704408301638;6577.375149360803;6582.506312026617;894.2532984957503;894.7986702991905;899.3524662243175;907.2832462354665;926.8795056642729;28511;29496.4456149382;29826.850865745968;30492.54261186084;30556;1008.8587597736323;1040.7086015915556;1090.8800031996475;1129.9152563557602;1200.7298357869583;15471.381144754308;15475.303611337516;15487.070775753491;15545.611359715871;15904;643050;647687;648138;648399;648427;60378.09432858511;60488.395116049156;60501.69749151226;60560;60613.393866060775;1445.2340259662396;1456.5630310906686;1468.7796830475086;1470.985290147085;1471.5732437592978;27279.181624551296;29417.892370646663;29642.407151857275;29849.55225671573;30003.249918752204;46893.29660055033;50223.74888125536;51462.74268628633;51570;54175;572490;576942;577216.227837733;577262;577500;24080.75919240785;24515.509689805745;24532.386690332885;24540.386490337885;24605.384865377793;37185.88442346734;41525.961850953965;41854.58145418507;42897.571024289355;43165.92085197895;27294.45411091727;34595.82702086474;35167.47248791321;35613.821930891216;35978.4603230957;34486.65513344935;34688;34699;35663;35852;33791.98624041283;34278.14304642404;34564.30871382508;34665.960021199404;34738;29345;31103.222419439695;31149.532757008208;31213.37573248477;31343.37313253768;23520.41198969971;23697;23782.88108559446;23930.64104038406;24430.26709198727 08:47:53 INFO - PROCESS | 1947 | |2;jquery.html;345.7666075399105;372.1013751789429;380.7315842331156;397.346365229198;425.6188667773075;15372.846271537295;15779.28993195306;19459.027048647564;20822.85474298913;21644.8917755411;20788.48028799277;20959.266425675105;21308.04113814882;21531.892340538314;21659.891700541513;5353.330833645794;5406.810761623344;5543.223948647193;5725.427457254273;6014.789482368118;5851.034579294412;5978.611390259641;5982.401759824004;5985.790497332594;5990.970045149768;5657.3494048184575;5766.596338256324;5808.854778630526;5834.183214349994;5941.732622032019;5779.711014449261;5837.795677151322;5895.292564892197;5896.233489646362;5905.970470147622;4365.694401391904;5109.054824857376;5164.380274367062;5167.948320516822;5175.068487672217;26005.73994260052;26144.34639134018;26220.475590488084;26234.212973610633;26262.949482020886;3088.629364476255;3108.4094022135723;3211.550382946389;3227.354529094167;3311.718503927169;15058.849411505964;15276;15522.301496432689;15669.373225070984;16409;1755.4294854172445;1821.6720990221754;1834.1012903677235;1849.7410362549253;1853.0827240515896;103121.48439257756;125475;125588;128532;129895.05157422647;9453.291003174789;11495;11544.480498377594;11554.94222528882;11813.940930295465;14684.779728304084;14697.706045879022;14700.191489468181;14701.117932924059;14706.455822138736;8451.957740211259;8572.53262258857;8616.224539791323;8678.78303042429;8697.391182617283;7050.858982820315;7264.273572642694;8418.831623367498;8452.915470845335;8629.395942284105;6284.245890493079;6999.510034297652;7015.088038554955;7032.824179395556;7118.5017048806085;1578.4712121439218;1595.8749081897236;1851.6296740651653;1891.6311319292606;1892.1579896946002;1012.5977907861641;1065.6270305393205;1076.5478499030426;1097.4677281518457;1127.813910704741;21064.473388165112;22410.439739006655;22457.775422245893;22576.66135007976;22611.547769044526;1093.9617113401152;1094.9726256843483;1095.6001059613184;1115.5999220977621;1118.5022664914197;11518.654440366803;11962.760744785055;11968;12012.939935300443;12018.87981120195;399938;582929;723659;737185;753191;82601.17398826055;130655.34672326577;134110.65889341178;134567;135105;1035.8860525342207;1061.5170097605571;1073.2648136026846;1076.3380520979697;1079.1151255970185;19858.90070549638;20704.792952070286;21223;21268.361949141552;21268.468288292916;54825.725871370385;55615.72192139013;55688.72155639196;57410.703571856655;57805.13292300703;62079.06881396873;63426;76989.61505192438;77062.22937770774;78573.8213926803;8052.677892884453;8135.959320203361;8253.422260441952;8273.296769774637;8299.95850020746;11866.881331186578;13271.469141234242;13350.132241404277;13421.261830599411;13665.385057672627;9510.524473776146;11173.776524469627;11396.772064558829;11680.70798230051;11703.76592468129;4750.5249475052215;8994.685186018458;9645.263852506616;11154.776904462027;11435.256708313933;11541.769164616493;11592.304461732323;11663.358515281741;11715.765684686088;11869;8088.757337279891;8382.329413646772;8387.83224335522;8498.490090594583;8508.404411691123;10785.352878827296;11058.612948546763;11328.830067548828;11485.253458525169;11573.826392603949 08:47:53 INFO - PROCESS | 1947 | |3;mootools.html;1276.2789024201325;1421.3959067396354;1435.1747745046598;1440.063958427023;1444.5154334544586;7989.520628762279;8399.790005249872;8414.200650938159;8427.789305267364;8435.789105272355;7398.815029624248;7619.80950476237;7622.542647441143;7857.135715071352;8156.510609363442;2205.4376134085787;2306.5386922615544;2310.0528783198893;2310.480141968052;2311.7919387255142;2287.7025986621716;2322.4658328584437;2323.9883800581056;2325.7092863392077;2329.77867102625;1838.8804727692657;1953.5799803042344;2086.686996950462;2273.1702928431087;2289.839711220215;2217.3791338425267;2300.1719381022817;2301.5742087713825;2302.6776251324745;2305.9077636894503;2237.876916769577;2291.3126062181277;2300.0914638717613;2310.9306720798404;2313.086330899302;8166.959165204136;8293.419460637759;8295;8298.875516867252;8310.916890831135;5034.3455350804525;5192.350956130484;5197;5199.376074871039;5205.037068142406;3343.6154842193214;3488.197864327895;3502.8773992910383;3552.928941421183;3575.535180426554;1004.7689031522791;1172.8123500240006;1212.9575464858688;1243.1670780576944;1255.215490318551;10424.478776061167;10630.627928022483;10651.520681569347;10654.62708805188;10683.931606839255;4435.2016637005;4647.16351056813;4692.835750748707;4703.2004559225015;4709.505501922317;9536.28477864163;9537.904620953701;9546.856797148048;9547.809043819085;9555;5222.660527065728;5222.97388513055;5226.712530810766;5228.686278823283;5230.163173892235;4592.563706447882;4680.4149481314835;4740.099381117577;4814.109389762835;4824.782884770194;3810.790406527612;3878.7672739635714;3902.1415288636454;3939.4090886366703;3972.56301806801;1261.161327717058;1264.2604076615282;1282.3972732815562;1300.6618279247464;1300.7057977312634;755.3503986571544;793.6309616028575;903.304455569208;921.502388710089;924.2929159193222;5367.570594352443;5523.475269849358;5558.916616250759;5713.8285851424525;5883.441073098049;964.8215080210183;987.5753426026878;991.4087888938294;1001.2090448545713;1026.9743256418649;3346.8828590999683;3588.7129029677562;3615.1142969972525;3694.9261014779554;3795.7342985990717;9542.90457095434;9842.212622990144;9859.950700246596;9866.260030497742;9870.753231169134;9369.953150234205;9742.9025709742;9754.951225243829;9766.095611355717;9766.121049105472;7468.178500364956;7719.459637825298;7721.613919304013;7726.961365193138;7761.573113478813;5488.753006114654;5500;5529.253550770755;5578.107502799533;5688.232088667977;7838.294553490213;9101.544922753968;9119.316051296046;9124.635014599342;9148.405353651991;9111;9230.123138301851;9268.768280792765;9351.579178936829;9364.765880853032;7134.32223938725;7145.785626431215;7267.563946163247;7274.30894065063;7286.817829554304;7775.533467991939;7785.14363420012;7851.646675899484;7855.37157027425;7865;6957.826054348682;7050.189228238818;7095.574265544084;7103.502754807114;7185.245549217257;6980.581165130108;7028.297170282931;7034.964825175842;7056;7059.223485416497;6296.811095667137;6306.747730090929;6325.588836725598;6374.426301632875;6407.839804004937;4883.291922671264;4896.290037944549;4917.6311776616185;4919.975400122977;5036.823711170238;4888.193448081169;4976.10430122567;4983.72589507566;5066.189409694432;5153.871153221199 08:47:53 INFO - PROCESS | 1947 | |4;prototype.html;327.56270379043974;347.405935849697;348.5347061672667;358.0868784599272;368.4105431309903;4045.6763458923288;4190.763724701213;4395.670324725643;4600.838970636024;5160.483951604838;5008.545812551851;5027.824026159085;5033.647644664866;5035.723035233061;5049.84850454487;3657.6970277470127;3778.414345776409;4003.7597744135446;4014.31756601377;4032.879013629581;3594.7124230061663;3906.6988394806344;3931.4889064421586;4030.1133750574827;4037.091654377756;3954.307996100685;3989.840406383741;4006.4390985262085;4026.315526360526;4030.677545796344;3960.930279033772;3973.403989401598;3975.3440682287533;3981.3079441237646;4026.99988508563;3549.2014296783277;3568.3220188164423;3575.5530558680166;3586.278586278601;3592.3354179476883;4844;4961.727105009223;4975.512243878061;4993.101241776479;5018.623603229772;3984.553361342447;4589.79345929434;4589.816407343702;4597.70114942531;4607.262837945946;4115.92985823688;4466.709663871838;5392.274472168908;5404.756785944642;5439.449756819327;3724.646158614927;3899.941500877489;3917.843286268546;3948.8420463181437;3964.088259700285;5072.340595722606;5387.407385187666;5387.488188622075;5622.803201887955;5648.237487939116;3960.881173564798;4041.2927737645796;4051.817668204938;4058.289799285113;4099.724652817656;3892.90267743303;3993.6805055595482;4112.424260603518;4115.506139263248;4123.113530590937;3969.0672691917375;4379.189849877783;4458.926599131355;4530.844634618217;4542.227821270392;4967.602591792648;5461.42655021225;5530.677115611453;5531.087370583889;5574.797954807828;1061.9522121504551;1324.2650329067267;1337.3580681273043;1342.6576223063057;1349.7030653256463;750.0474397515126;829.9128142133824;855.6962278391081;857.8718984535316;884.1777147252988;4545;4863.465018847924;4864.173090574611;4865.299758633922;4881.365422495124;4644.790984405709;4818.855609253848;5016.2224855147515;5302.496262855023;5344.652597581145;4543.681942264076;4544.613707834871;4797.976010119927;4810.3404325507645;4884.072026314989;2713.6743590769233;2763.2815467978066;2787.3728411107745;2794.413173233603;2799.4882763307587;4990.5508504234795;5067.086425305464;5116.872078198;5540.479082017672;5544.861378465571;4815.590674792612;5219.895602088013;5465.371482279509;5491.517290331588;5546.334439867242;4416;4460.531644177315;4688.671792974459;5365.382980957162;5465.672059676433;4844.46710861812;4957.305977163128;5198.454162312903;5266.657667251617;5283.286756287852;4199.41208230854;4350.543192964693;5232.895342093213;5271.736413179402;5296.655717378512;5438.504411286928;5466.3713672928125;5496.725163741717;5504.22940788298;5567.359753628384;3199.8320612976563;3550.751447398657;3588.1747198144053;3615.060084378028;3634.473001414833;3608.8195590220907;4738.526147385372;5624.550035997028;5667.433256674464;5693.5160511357;5058.3929928408825;5500.42245564226;5509.584057884137;5546.306711661043;5578.944210557843;5264.578833693372;5425.755840987086;5431.6740995540395;5508.724563771715;5517.2551705519245;5300.257963884982;5359.919601205907;5386.845261895117;5392.865178370572;5408.971635636636;5185.403678577012;5468.726563671721;5509.889802204014;5516.91724624139;5522.779088836402;4468.910621787481;5107.310513080686;5277.393099793573;5314.1497360422145;5364.249005139206 08:47:53 INFO - PROCESS | 1947 | |5;yui.html;643.7071132634652;687.8486732918758;706.2161001288565;738.3318097122107;744.8249661329585;14742.115473071623;15763.369465221378;15775.60560985976;15786.05283682977;15805.130717810516;14049.648758781035;14421.783673244883;14430.855691443083;14451;14625.707485850304;692.3422748389025;723.0997408226765;723.9430431569914;870.9564521773917;887.8268737596171;841.4614646626164;879.3932186791126;885.406777459104;893.093510087262;895.9776005599847;922.8154369126169;934.1499235695518;939.037486576258;940.4545363689078;941.7739742461794;721.4985585018414;932.0818993291603;933.0948979489884;934.0845970948475;937.9062093790635;555.574985136371;668.7091115364832;690.9550879192836;697.0206859362604;701.4738945790657;15090.622734431727;15098.16960067196;15110.093394396372;15119.848801512064;15136.924315378463;13586;13595.184288942597;13625.727485450236;13664.385102670305;13709.657258568515;12321.69195770104;12571.497140114385;12616.81074783879;12621.305828179446;12705.491780328775;4342.174986752507;4346.609364849321;4377.649788016951;4408.074304396081;4554.726716396994;94806;107434;108321.45839270753;108769.45615271873;108983.99999999921;9927.453990030474;10184.981501849756;10412.947935260276;10900.836487452694;11178.496967636313;20627.278045268344;20783.480412989797;21049.15803367879;21144.78855211428;21171.0473028711;7430.962845185848;7460.552366858006;7534.623268836536;7610.695572177162;7671.232876712284;4229.217594744982;4252.766097864647;4259;4299.634531064895;4371.103923695635;3304.8512816923294;3325.085601459618;3340.8496617651776;3367.107716455141;3377.7466689997855;603.6891001134419;604.4590091867753;607.7994261893565;615.0405367626516;615.6398506873439;632.8449529865212;634.8603307272392;644.4200219802216;653.2389765922742;673.9090222819857;9173;9255.305852061123;9620.989796071452;9683.661071862593;9992.25058120644;626.6083697688945;645.7550807193888;661.9007148927603;668.2215219269497;682.2699711308852;4441.4892287387365;4815.277708343777;4862.051899879561;5172.405173405032;5574.554035677136;94830;99377;101130.4943475278;103360.48319758353;103568.44647330296;82108.58945705234;86897.56551217203;87409.56295218483;88028;89958;59890;67186.66406668033;73262.26737732554;77500;79005;10121.797564048826;10670.46647667629;10825.242233043926;10829.891701082888;10848.728781780519;45874.77062614799;47790;48993.75503122462;48995.26507102325;49042.75478622727;51951.701207468606;61841;64881;68123;69034.65482672554;11699.473523691284;12286.631401057983;12574.742525747351;12872.592193163866;13520;13865.79201311961;14132.293385330488;14510;14916.925415372854;14931.10413375201;13450.798238026633;13510.924010981133;13541.458341666223;14064.718705626035;14369.13785172893;13102.803457948328;13571.728565428833;13791;14249.643758905695;14258.358373873409;12507;12559;13563.525276615272;13828;13836.23900685472;9916.157126644028;10405.375677459377;11324.773504529698;11470.426478675867;11832.526698931946;8508.404411691123;9588.280878934247;10121.291509594257;10802.783944320912;11000.889991100306 08:47:53 INFO - PROCESS | 1947 | __end_tp_report 08:47:53 INFO - PROCESS | 1947 | __start_cc_report 08:47:53 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,1647 08:47:53 INFO - PROCESS | 1947 | __end_cc_report 08:47:53 INFO - PROCESS | 1947 | __startTimestamp1485967673655__endTimestamp 08:47:53 INFO - PROCESS | 1947 | 08:47:53 INFO - PROCESS | 1947 | ------- Summary: start ------- 08:47:53 INFO - PROCESS | 1947 | Number of tests: 6 08:47:53 INFO - PROCESS | 1947 | 08:47:53 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5729.20 Median:5982.79 stddev:638.70 (10.7%) stddev-sans-first:600.03 08:47:53 INFO - PROCESS | 1947 | Values: 2871.4 3331.2 3335.6 3343.9 3385.5 5670.2 5679.9 5705.4 5750.8 5762.3 5623.0 5661.3 5677.7 5679.9 5716.1 5144.8 5145.4 5185.0 5195.4 5242.8 5154.3 5170.0 5182.8 5247.7 5290.8 5253.8 5255.6 5257.9 5261.2 5270.5 5253.3 5254.3 5256.1 5256.8 5258.9 5090.6 5196.9 5202.0 5209.5 5257.5 5733.9 5739.7 5746.1 5749.9 5761.1 5600.0 5853.6 6167.6 6189.2 6198.5 6249.7 6268.7 6269.5 6276.3 6280.6 5812.2 5844.1 5868.0 5887.6 5927.2 6225.5 6239.7 6242.4 6248.2 6260.7 4962.1 6087.3 6103.6 6135.4 6141.3 5122.7 6279.2 6284.0 6289.6 6290.1 6195.8 6240.7 6247.7 6251.0 6252.2 5986.3 6078.5 6108.6 6132.1 6134.7 4843.3 4924.8 4927.7 4939.3 5015.6 4417.8 4430.6 4432.8 4453.2 4477.0 5846.3 5896.2 5897.1 5899.4 5927.4 5964.8 5983.1 6010.6 6158.3 6169.8 5838.0 5843.1 5850.0 5882.7 5883.0 5443.8 5452.2 5453.0 5467.6 5483.8 6185.4 6200.8 6206.4 6303.1 6305.3 6185.7 6186.9 6217.4 6225.2 6258.3 6178.5 6204.4 6232.4 6244.8 6254.6 6120.5 6170.3 6188.2 6190.4 6197.2 6143.5 6163.0 6206.6 6216.1 6226.4 6007.9 6044.8 6065.0 6134.6 6140.7 6105.2 6110.0 6114.1 6122.8 6129.0 5743.5 5982.8 5991.2 5992.1 6008.7 5934.3 6091.9 6105.4 6143.8 6159.4 5987.2 6024.1 6024.8 6037.6 6042.6 08:47:53 INFO - PROCESS | 1947 | 08:47:53 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:70054.44 Median:34718.50 stddev:154592.03 (445.3%) stddev-sans-first:154937.45 08:47:53 INFO - PROCESS | 1947 | Values: 480.7 481.3 485.3 488.2 518.4 36605.6 40841.8 40891.4 41002.0 41013.8 35280.6 39051.4 42728.6 43198.6 43233.8 8333.3 9188.5 9404.8 9419.4 9423.0 8317.8 11022.9 11219.2 11294.4 11323.5 11235.6 11305.2 11308.3 11314.3 11318.9 8371.3 11238.0 11268.2 11278.6 11308.8 8361.5 10908.6 11147.8 11151.0 11333.3 40575.4 40772.4 40842.2 40949.0 40980.0 3885.8 3932.0 3967.6 3999.3 4046.2 28959.7 28961.7 28982.7 29309.4 30268.1 3102.4 3331.3 3356.7 3362.1 3363.6 500004.0 500552.0 500580.0 501904.0 502429.5 59795.0 60327.0 60349.0 60423.0 60439.0 60559.0 62242.0 63019.0 63035.0 63166.0 15983.8 16241.9 16250.3 16259.0 16306.2 11384.1 11650.4 11679.6 12644.4 12646.2 15559.7 15854.8 15866.6 16372.1 16381.9 5864.3 6516.0 6568.7 6577.4 6582.5 894.3 894.8 899.4 907.3 926.9 28511.0 29496.4 29826.9 30492.5 30556.0 1008.9 1040.7 1090.9 1129.9 1200.7 15471.4 15475.3 15487.1 15545.6 15904.0 643050.0 647687.0 648138.0 648399.0 648427.0 60378.1 60488.4 60501.7 60560.0 60613.4 1445.2 1456.6 1468.8 1471.0 1471.6 27279.2 29417.9 29642.4 29849.6 30003.2 46893.3 50223.7 51462.7 51570.0 54175.0 572490.0 576942.0 577216.2 577262.0 577500.0 24080.8 24515.5 24532.4 24540.4 24605.4 37185.9 41526.0 41854.6 42897.6 43165.9 27294.5 34595.8 35167.5 35613.8 35978.5 34486.7 34688.0 34699.0 35663.0 35852.0 33792.0 34278.1 34564.3 34666.0 34738.0 29345.0 31103.2 31149.5 31213.4 31343.4 23520.4 23697.0 23782.9 23930.6 24430.3 08:47:53 INFO - PROCESS | 1947 | 08:47:53 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:36407.74 Median:22434.11 stddev:108638.50 (484.3%) stddev-sans-first:108909.52 08:47:53 INFO - PROCESS | 1947 | Values: 345.8 372.1 380.7 397.3 425.6 15372.8 15779.3 19459.0 20822.9 21644.9 20788.5 20959.3 21308.0 21531.9 21659.9 5353.3 5406.8 5543.2 5725.4 6014.8 5851.0 5978.6 5982.4 5985.8 5991.0 5657.3 5766.6 5808.9 5834.2 5941.7 5779.7 5837.8 5895.3 5896.2 5906.0 4365.7 5109.1 5164.4 5167.9 5175.1 26005.7 26144.3 26220.5 26234.2 26262.9 3088.6 3108.4 3211.6 3227.4 3311.7 15058.8 15276.0 15522.3 15669.4 16409.0 1755.4 1821.7 1834.1 1849.7 1853.1 103121.5 125475.0 125588.0 128532.0 129895.1 9453.3 11495.0 11544.5 11554.9 11813.9 14684.8 14697.7 14700.2 14701.1 14706.5 8452.0 8572.5 8616.2 8678.8 8697.4 7050.9 7264.3 8418.8 8452.9 8629.4 6284.2 6999.5 7015.1 7032.8 7118.5 1578.5 1595.9 1851.6 1891.6 1892.2 1012.6 1065.6 1076.5 1097.5 1127.8 21064.5 22410.4 22457.8 22576.7 22611.5 1094.0 1095.0 1095.6 1115.6 1118.5 11518.7 11962.8 11968.0 12012.9 12018.9 399938.0 582929.0 723659.0 737185.0 753191.0 82601.2 130655.3 134110.7 134567.0 135105.0 1035.9 1061.5 1073.3 1076.3 1079.1 19858.9 20704.8 21223.0 21268.4 21268.5 54825.7 55615.7 55688.7 57410.7 57805.1 62079.1 63426.0 76989.6 77062.2 78573.8 8052.7 8136.0 8253.4 8273.3 8300.0 11866.9 13271.5 13350.1 13421.3 13665.4 9510.5 11173.8 11396.8 11680.7 11703.8 4750.5 8994.7 9645.3 11154.8 11435.3 11541.8 11592.3 11663.4 11715.8 11869.0 8088.8 8382.3 8387.8 8498.5 8508.4 10785.4 11058.6 11328.8 11485.3 11573.8 08:47:53 INFO - PROCESS | 1947 | 08:47:53 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5392.79 Median:5229.42 stddev:2911.76 (55.7%) stddev-sans-first:2903.48 08:47:53 INFO - PROCESS | 1947 | Values: 1276.3 1421.4 1435.2 1440.1 1444.5 7989.5 8399.8 8414.2 8427.8 8435.8 7398.8 7619.8 7622.5 7857.1 8156.5 2205.4 2306.5 2310.1 2310.5 2311.8 2287.7 2322.5 2324.0 2325.7 2329.8 1838.9 1953.6 2086.7 2273.2 2289.8 2217.4 2300.2 2301.6 2302.7 2305.9 2237.9 2291.3 2300.1 2310.9 2313.1 8167.0 8293.4 8295.0 8298.9 8310.9 5034.3 5192.4 5197.0 5199.4 5205.0 3343.6 3488.2 3502.9 3552.9 3575.5 1004.8 1172.8 1213.0 1243.2 1255.2 10424.5 10630.6 10651.5 10654.6 10683.9 4435.2 4647.2 4692.8 4703.2 4709.5 9536.3 9537.9 9546.9 9547.8 9555.0 5222.7 5223.0 5226.7 5228.7 5230.2 4592.6 4680.4 4740.1 4814.1 4824.8 3810.8 3878.8 3902.1 3939.4 3972.6 1261.2 1264.3 1282.4 1300.7 1300.7 755.4 793.6 903.3 921.5 924.3 5367.6 5523.5 5558.9 5713.8 5883.4 964.8 987.6 991.4 1001.2 1027.0 3346.9 3588.7 3615.1 3694.9 3795.7 9542.9 9842.2 9860.0 9866.3 9870.8 9370.0 9742.9 9755.0 9766.1 9766.1 7468.2 7719.5 7721.6 7727.0 7761.6 5488.8 5500.0 5529.3 5578.1 5688.2 7838.3 9101.5 9119.3 9124.6 9148.4 9111.0 9230.1 9268.8 9351.6 9364.8 7134.3 7145.8 7267.6 7274.3 7286.8 7775.5 7785.1 7851.6 7855.4 7865.0 6957.8 7050.2 7095.6 7103.5 7185.2 6980.6 7028.3 7035.0 7056.0 7059.2 6296.8 6306.7 6325.6 6374.4 6407.8 4883.3 4896.3 4917.6 4920.0 5036.8 4888.2 4976.1 4983.7 5066.2 5153.9 08:47:53 INFO - PROCESS | 1947 | 08:47:53 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4347.94 Median:4817.22 stddev:1284.69 (26.7%) stddev-sans-first:1252.35 08:47:53 INFO - PROCESS | 1947 | Values: 327.6 347.4 348.5 358.1 368.4 4045.7 4190.8 4395.7 4600.8 5160.5 5008.5 5027.8 5033.6 5035.7 5049.8 3657.7 3778.4 4003.8 4014.3 4032.9 3594.7 3906.7 3931.5 4030.1 4037.1 3954.3 3989.8 4006.4 4026.3 4030.7 3960.9 3973.4 3975.3 3981.3 4027.0 3549.2 3568.3 3575.6 3586.3 3592.3 4844.0 4961.7 4975.5 4993.1 5018.6 3984.6 4589.8 4589.8 4597.7 4607.3 4115.9 4466.7 5392.3 5404.8 5439.4 3724.6 3899.9 3917.8 3948.8 3964.1 5072.3 5387.4 5387.5 5622.8 5648.2 3960.9 4041.3 4051.8 4058.3 4099.7 3892.9 3993.7 4112.4 4115.5 4123.1 3969.1 4379.2 4458.9 4530.8 4542.2 4967.6 5461.4 5530.7 5531.1 5574.8 1062.0 1324.3 1337.4 1342.7 1349.7 750.0 829.9 855.7 857.9 884.2 4545.0 4863.5 4864.2 4865.3 4881.4 4644.8 4818.9 5016.2 5302.5 5344.7 4543.7 4544.6 4798.0 4810.3 4884.1 2713.7 2763.3 2787.4 2794.4 2799.5 4990.6 5067.1 5116.9 5540.5 5544.9 4815.6 5219.9 5465.4 5491.5 5546.3 4416.0 4460.5 4688.7 5365.4 5465.7 4844.5 4957.3 5198.5 5266.7 5283.3 4199.4 4350.5 5232.9 5271.7 5296.7 5438.5 5466.4 5496.7 5504.2 5567.4 3199.8 3550.8 3588.2 3615.1 3634.5 3608.8 4738.5 5624.6 5667.4 5693.5 5058.4 5500.4 5509.6 5546.3 5578.9 5264.6 5425.8 5431.7 5508.7 5517.3 5300.3 5359.9 5386.8 5392.9 5409.0 5185.4 5468.7 5509.9 5516.9 5522.8 4468.9 5107.3 5277.4 5314.1 5364.2 08:47:53 INFO - PROCESS | 1947 | 08:47:53 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:19967.96 Median:4392.86 stddev:28484.70 (648.4%) stddev-sans-first:28527.65 08:47:53 INFO - PROCESS | 1947 | Values: 643.7 687.8 706.2 738.3 744.8 14742.1 15763.4 15775.6 15786.1 15805.1 14049.6 14421.8 14430.9 14451.0 14625.7 692.3 723.1 723.9 871.0 887.8 841.5 879.4 885.4 893.1 896.0 922.8 934.1 939.0 940.5 941.8 721.5 932.1 933.1 934.1 937.9 555.6 668.7 691.0 697.0 701.5 15090.6 15098.2 15110.1 15119.8 15136.9 13586.0 13595.2 13625.7 13664.4 13709.7 12321.7 12571.5 12616.8 12621.3 12705.5 4342.2 4346.6 4377.6 4408.1 4554.7 94806.0 107434.0 108321.5 108769.5 108984.0 9927.5 10185.0 10412.9 10900.8 11178.5 20627.3 20783.5 21049.2 21144.8 21171.0 7431.0 7460.6 7534.6 7610.7 7671.2 4229.2 4252.8 4259.0 4299.6 4371.1 3304.9 3325.1 3340.8 3367.1 3377.7 603.7 604.5 607.8 615.0 615.6 632.8 634.9 644.4 653.2 673.9 9173.0 9255.3 9621.0 9683.7 9992.3 626.6 645.8 661.9 668.2 682.3 4441.5 4815.3 4862.1 5172.4 5574.6 94830.0 99377.0 101130.5 103360.5 103568.4 82108.6 86897.6 87409.6 88028.0 89958.0 59890.0 67186.7 73262.3 77500.0 79005.0 10121.8 10670.5 10825.2 10829.9 10848.7 45874.8 47790.0 48993.8 48995.3 49042.8 51951.7 61841.0 64881.0 68123.0 69034.7 11699.5 12286.6 12574.7 12872.6 13520.0 13865.8 14132.3 14510.0 14916.9 14931.1 13450.8 13510.9 13541.5 14064.7 14369.1 13102.8 13571.7 13791.0 14249.6 14258.4 12507.0 12559.0 13563.5 13828.0 13836.2 9916.2 10405.4 11324.8 11470.4 11832.5 8508.4 9588.3 10121.3 10802.8 11000.9 08:47:53 INFO - PROCESS | 1947 | -------- Summary: end -------- 08:47:53 INFO - PROCESS | 1947 | 08:47:54 INFO - TEST-INFO | 1947: exit 0 08:47:54 INFO - TEST-OK | dromaeo_css | took 1117508ms 08:47:54 INFO - TEST-START | kraken 08:47:54 INFO - operating with platform_type : mac_ 08:47:54 INFO - Initialising browser for kraken test... 08:47:54 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmphHRCMI/profile http://localhost:56949/getInfo.html) 08:47:56 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 08:47:56 INFO - PROCESS | 1950 | colorDepth:24 08:47:56 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 08:47:56 INFO - PROCESS | 1950 | __metrics 08:47:56 INFO - PROCESS | 1950 | 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" 08:47:56 INFO - PROCESS | 1950 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:47:57 INFO - TEST-INFO | 1950: exit 0 08:47:57 INFO - Browser initialized. 08:47:57 INFO - Running cycle 1/1 for kraken test... 08:47:57 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmphHRCMI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:09 INFO - PROCESS | 1951 | RSS: Main: 213000192 08:48:09 INFO - PROCESS | 1951 | 08:48:12 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56949/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:13 INFO - PROCESS | 1951 | RSS: Main: 265748480 08:48:13 INFO - PROCESS | 1951 | 08:48:15 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56949/tests/kraken/driver.html?testName=audio-dft) 08:48:16 INFO - PROCESS | 1951 | RSS: Main: 274591744 08:48:16 INFO - PROCESS | 1951 | 08:48:19 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56949/tests/kraken/driver.html?testName=audio-fft) 08:48:20 INFO - PROCESS | 1951 | RSS: Main: 371331072 08:48:20 INFO - PROCESS | 1951 | 08:48:22 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56949/tests/kraken/driver.html?testName=audio-oscillator) 08:48:22 INFO - PROCESS | 1951 | RSS: Main: 275968000 08:48:22 INFO - PROCESS | 1951 | 08:48:24 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56949/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:25 INFO - PROCESS | 1951 | RSS: Main: 278556672 08:48:25 INFO - PROCESS | 1951 | 08:48:28 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56949/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:28 INFO - PROCESS | 1951 | RSS: Main: 318046208 08:48:28 INFO - PROCESS | 1951 | 08:48:31 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56949/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:32 INFO - PROCESS | 1951 | RSS: Main: 319713280 08:48:32 INFO - PROCESS | 1951 | 08:48:35 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56949/tests/kraken/driver.html?testName=json-parse-financial) 08:48:35 INFO - PROCESS | 1951 | RSS: Main: 314867712 08:48:35 INFO - PROCESS | 1951 | 08:48:37 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56949/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:38 INFO - PROCESS | 1951 | RSS: Main: 294903808 08:48:38 INFO - PROCESS | 1951 | 08:48:40 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56949/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:40 INFO - PROCESS | 1951 | RSS: Main: 298741760 08:48:40 INFO - PROCESS | 1951 | 08:48:42 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56949/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:43 INFO - PROCESS | 1951 | RSS: Main: 300597248 08:48:43 INFO - PROCESS | 1951 | 08:48:46 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:47 INFO - PROCESS | 1951 | RSS: Main: 314875904 08:48:47 INFO - PROCESS | 1951 | 08:48:50 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:50 INFO - PROCESS | 1951 | RSS: Main: 308559872 08:48:50 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:56949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56949/tests/kraken/driver.html?testName=ai-astar) 08:48:52 INFO - PROCESS | 1951 | RSS: Main: 353009664 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | __start_tp_report 08:48:52 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 08:48:52 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 08:48:52 INFO - PROCESS | 1951 | |i|pagename|runs| 08:48:52 INFO - PROCESS | 1951 | |0;ai-astar;115;112;112;113;113;114;112;112;115;114 08:48:52 INFO - PROCESS | 1951 | |1;audio-beat-detection;139;111;162;174;110;108;108;108;126;109 08:48:52 INFO - PROCESS | 1951 | |2;audio-dft;183;186;184;186;185;184;185;186;194;261 08:48:52 INFO - PROCESS | 1951 | |3;audio-fft;81;59;58;100;84;85;78;58;73;57 08:48:52 INFO - PROCESS | 1951 | |4;audio-oscillator;87;69;87;69;68;70;81;68;69;82 08:48:52 INFO - PROCESS | 1951 | |5;imaging-gaussian-blur;87;83;86;84;86;84;87;110;73;113 08:48:52 INFO - PROCESS | 1951 | |6;imaging-darkroom;92;95;93;95;97;94;93;94;94;93 08:48:52 INFO - PROCESS | 1951 | |7;imaging-desaturate;87;87;86;104;139;116;87;88;86;100 08:48:52 INFO - PROCESS | 1951 | |8;json-parse-financial;52;52;52;54;57;57;56;56;57;56 08:48:52 INFO - PROCESS | 1951 | |9;json-stringify-tinderbox;69;71;85;77;76;72;72;76;73;73 08:48:52 INFO - PROCESS | 1951 | |10;stanford-crypto-aes;78;77;84;96;91;100;89;83;89;83 08:48:52 INFO - PROCESS | 1951 | |11;stanford-crypto-ccm;137;137;142;141;148;133;142;144;200;145 08:48:52 INFO - PROCESS | 1951 | |12;stanford-crypto-pbkdf2;169;167;166;164;172;227;204;171;166;164 08:48:52 INFO - PROCESS | 1951 | |13;stanford-crypto-sha256-iterative;67;67;67;65;68;66;68;79;85;83 08:48:52 INFO - PROCESS | 1951 | __end_tp_report 08:48:52 INFO - PROCESS | 1951 | __start_cc_report 08:48:52 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,2071 08:48:52 INFO - PROCESS | 1951 | __end_cc_report 08:48:52 INFO - PROCESS | 1951 | __startTimestamp1485967732937__endTimestamp 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | ------- Summary: start ------- 08:48:52 INFO - PROCESS | 1951 | Number of tests: 14 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.23 (1.1%) stddev-sans-first:1.12 08:48:52 INFO - PROCESS | 1951 | Values: 115.0 112.0 112.0 113.0 113.0 114.0 112.0 112.0 115.0 114.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:118.50 stddev:24.74 (20.9%) stddev-sans-first:25.75 08:48:52 INFO - PROCESS | 1951 | Values: 139.0 111.0 162.0 174.0 110.0 108.0 108.0 108.0 126.0 109.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#2] audio-dft Cycles:10 Average:193.40 Median:186.00 stddev:23.95 (12.9%) stddev-sans-first:25.10 08:48:52 INFO - PROCESS | 1951 | Values: 183.0 186.0 184.0 186.0 185.0 184.0 185.0 186.0 194.0 261.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#3] audio-fft Cycles:10 Average:73.30 Median:75.50 stddev:14.85 (19.7%) stddev-sans-first:15.48 08:48:52 INFO - PROCESS | 1951 | Values: 81.0 59.0 58.0 100.0 84.0 85.0 78.0 58.0 73.0 57.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:75.50 stddev:8.19 (10.9%) stddev-sans-first:7.45 08:48:52 INFO - PROCESS | 1951 | Values: 87.0 69.0 87.0 69.0 68.0 70.0 81.0 68.0 69.0 82.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:85.00 stddev:12.40 (14.6%) stddev-sans-first:13.13 08:48:52 INFO - PROCESS | 1951 | Values: 87.0 83.0 86.0 84.0 86.0 84.0 87.0 110.0 73.0 113.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:1.41 (1.5%) stddev-sans-first:1.30 08:48:52 INFO - PROCESS | 1951 | Values: 92.0 95.0 93.0 95.0 97.0 94.0 93.0 94.0 94.0 93.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:86.50 stddev:17.63 (20.4%) stddev-sans-first:18.24 08:48:52 INFO - PROCESS | 1951 | Values: 87.0 87.0 86.0 104.0 139.0 116.0 87.0 88.0 86.0 100.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:56.00 stddev:2.18 (3.9%) stddev-sans-first:2.05 08:48:52 INFO - PROCESS | 1951 | Values: 52.0 52.0 52.0 54.0 57.0 57.0 56.0 56.0 57.0 56.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:74.50 stddev:4.48 (6.0%) stddev-sans-first:4.30 08:48:52 INFO - PROCESS | 1951 | Values: 69.0 71.0 85.0 77.0 76.0 72.0 72.0 76.0 73.0 73.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.50 stddev:7.42 (8.6%) stddev-sans-first:7.12 08:48:52 INFO - PROCESS | 1951 | Values: 78.0 77.0 84.0 96.0 91.0 100.0 89.0 83.0 89.0 83.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:143.00 stddev:19.16 (13.4%) stddev-sans-first:19.99 08:48:52 INFO - PROCESS | 1951 | Values: 137.0 137.0 142.0 141.0 148.0 133.0 142.0 144.0 200.0 145.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:170.00 stddev:21.17 (12.5%) stddev-sans-first:22.26 08:48:52 INFO - PROCESS | 1951 | Values: 169.0 167.0 166.0 164.0 172.0 227.0 204.0 171.0 166.0 164.0 08:48:52 INFO - PROCESS | 1951 | 08:48:52 INFO - PROCESS | 1951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:68.00 stddev:7.66 (11.3%) stddev-sans-first:7.95 08:48:52 INFO - PROCESS | 1951 | Values: 67.0 67.0 67.0 65.0 68.0 66.0 68.0 79.0 85.0 83.0 08:48:52 INFO - PROCESS | 1951 | -------- Summary: end -------- 08:48:52 INFO - PROCESS | 1951 | 08:48:53 INFO - TEST-INFO | 1951: exit 0 08:48:53 INFO - TEST-OK | kraken | took 59576ms 08:48:53 INFO - SUITE-END | took 1177s 08:48:54 INFO - Completed test suite (00:19:37) 08:48:54 INFO - javascript benchmark 08:48:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2871.411360671062, 3331.1838599543103, 3335.6164041135276, 3343.9498407523874, 3385.4583266677337, 5670.206171136044, 5679.886402271957, 5705.372409035002, 5750.798722044729, 5762.337331206907, 5622.971885140579, 5661.264035675356, 5677.687727175004, 5679.914801277974, 5716.114002329635, 5144.819931302405, 5145.408278048017, 5185.0, 5195.376554813428, 5242.8165014224505, 5154.278401023859, 5170.043541944752, 5182.844514664566, 5247.685138891659, 5290.841274761744, 5253.763580638881, 5255.632105752599, 5257.8948421031555, 5261.184516399945, 5270.472952704718, 5253.3170687810725, 5254.343207099094, 5256.08018596744, 5256.842294731164, 5258.947410525903, 5090.618203634742, 5196.948030519684, 5202.037623039712, 5209.53114219722, 5257.500537448975, 5733.856653583652, 5739.684317362543, 5746.080627099644, 5749.913751293734, 5761.107028410603, 5599.972000140014, 5853.595137167049, 6167.568270221086, 6189.195404597419, 6198.4731297839735, 6249.656268905208, 6268.749250029993, 6269.498440124779, 6276.309605943343, 6280.591761535486, 5812.244408226946, 5844.094165404369, 5867.970660146715, 5887.587868849182, 5927.229460170193, 6225.470834978987, 6239.719212635442, 6242.375762423812, 6248.218972628421, 6260.7495700171485, 4962.082014827269, 6087.3303936566945, 6103.647786248204, 6135.416406698499, 6141.263048434216, 5122.667026643257, 6279.246490421178, 6284.025975973731, 6289.559730818799, 6290.087937249074, 6195.783147589813, 6240.65676387794, 6247.687615619201, 6250.968745156245, 6252.249730032425, 5986.311574169026, 6078.544109191828, 6108.615274519878, 6132.080187971751, 6134.6625935573975, 4843.2735089736825, 4924.8276310328965, 4927.704337739747, 4939.259111133359, 5015.623828212826, 4417.757023363682, 4430.645548356124, 4432.84485043022, 4453.15390075891, 4477.0, 5846.327672317738, 5896.174535565025, 5897.115432685132, 5899.380565040695, 5927.436893495111, 5964.821055368346, 5983.072623743326, 6010.639361638316, 6158.261008678987, 6169.784057557964, 5838.0, 5843.094320380348, 5849.976254155506, 5882.735276912549, 5883.02930016551, 5443.836684899459, 5452.154915988028, 5453.0, 5467.617266791286, 5483.7806487740845, 6185.443310101932, 6200.782972595937, 6206.379362063757, 6303.054541818764, 6305.3379395163765, 6185.690715464299, 6186.876262474815, 6217.378262173746, 6225.190725205694, 6258.280297765633, 6178.505719542336, 6204.3795620439405, 6232.439080482778, 6244.843878903063, 6254.6247225166635, 6120.479759220516, 6170.259568851767, 6188.1955345806555, 6190.350013248544, 6197.163382943425, 6143.508519318533, 6162.969185154046, 6206.565540412128, 6216.129741836237, 6226.40849119333, 6007.939920600913, 6044.848878778066, 6065.029595264737, 6134.5590473767, 6140.657627863787, 6105.206323178136, 6109.95128740435, 6114.114890844268, 6122.764110201706, 6129.0, 5743.483086522233, 5982.790602328898, 5991.161237426851, 5992.0712289595185, 6008.669523176267, 5934.347221805684, 6091.939080609137, 6105.419985101408, 6143.754249829957, 6159.414855588712, 5987.221661184019, 6024.126501657148, 6024.819255422344, 6037.607555508878, 6042.607230530001], "value": 5687.681648372898, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.6539291709969, 481.27568010144773, 485.3375142929901, 488.18473149839764, 518.3727689495712, 36605.633943660556, 40841.795791021075, 40891.386629200584, 41002.0, 41013.76958691244, 35280.64719352806, 39051.43794248227, 42728.57271427285, 43198.56801431985, 43233.78383108088, 8333.250007499324, 9188.494632795193, 9404.81190376192, 9419.387739796926, 9422.952885235598, 8317.750467485956, 11022.889771102267, 11219.214654974156, 11294.435278236097, 11323.547058117665, 11235.606753763619, 11305.208635395526, 11308.264962777434, 11314.264572802782, 11318.943405282962, 8371.288440482565, 11238.044766194884, 11268.154888383322, 11278.605248816335, 11308.773824523463, 8361.498310101413, 10908.563657453693, 11147.832782508269, 11151.0, 11333.320000799897, 40575.39136912949, 40772.38841417381, 40842.18315633671, 40948.97627559305, 40980.0, 3885.822268635917, 3932.0, 3967.6230758078227, 3999.280129576675, 4046.1735101453814, 28959.71040289591, 28961.71038289611, 28982.710172898423, 29309.413811723858, 30268.09195724132, 3102.410541997036, 3331.283773988604, 3356.748243881694, 3362.1258472797003, 3363.562736844219, 500004.0, 500552.0, 500580.0, 501904.0, 502429.4878525657, 59795.0, 60327.0, 60349.0, 60423.0, 60439.0, 60559.0, 62242.0, 63019.0, 63035.0, 63166.0, 15983.840161598468, 16241.91879040621, 16250.268737906823, 16259.0, 16306.184690765414, 11384.146189035855, 11650.41747912601, 11679.649610511698, 12644.367781611067, 12646.241225526313, 15559.688806223812, 15854.841451585336, 15866.603334916488, 16372.099534525716, 16381.918090409472, 5864.296284445809, 6515.980046185698, 6568.704408301638, 6577.375149360803, 6582.506312026617, 894.2532984957503, 894.7986702991905, 899.3524662243175, 907.2832462354665, 926.8795056642729, 28511.0, 29496.4456149382, 29826.850865745968, 30492.54261186084, 30556.0, 1008.8587597736323, 1040.7086015915556, 1090.8800031996475, 1129.9152563557602, 1200.7298357869583, 15471.381144754308, 15475.303611337516, 15487.070775753491, 15545.611359715871, 15904.0, 643050.0, 647687.0, 648138.0, 648399.0, 648427.0, 60378.09432858511, 60488.395116049156, 60501.69749151226, 60560.0, 60613.393866060775, 1445.2340259662396, 1456.5630310906686, 1468.7796830475086, 1470.985290147085, 1471.5732437592978, 27279.181624551296, 29417.892370646663, 29642.407151857275, 29849.55225671573, 30003.249918752204, 46893.29660055033, 50223.74888125536, 51462.74268628633, 51570.0, 54175.0, 572490.0, 576942.0, 577216.227837733, 577262.0, 577500.0, 24080.75919240785, 24515.509689805745, 24532.386690332885, 24540.386490337885, 24605.384865377793, 37185.88442346734, 41525.961850953965, 41854.58145418507, 42897.571024289355, 43165.92085197895, 27294.45411091727, 34595.82702086474, 35167.47248791321, 35613.821930891216, 35978.4603230957, 34486.65513344935, 34688.0, 34699.0, 35663.0, 35852.0, 33791.98624041283, 34278.14304642404, 34564.30871382508, 34665.960021199404, 34738.0, 29345.0, 31103.222419439695, 31149.532757008208, 31213.37573248477, 31343.37313253768, 23520.41198969971, 23697.0, 23782.88108559446, 23930.64104038406, 24430.26709198727], "value": 19705.88480835637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.7666075399105, 372.1013751789429, 380.7315842331156, 397.346365229198, 425.6188667773075, 15372.846271537295, 15779.28993195306, 19459.027048647564, 20822.85474298913, 21644.8917755411, 20788.48028799277, 20959.266425675105, 21308.04113814882, 21531.892340538314, 21659.891700541513, 5353.330833645794, 5406.810761623344, 5543.223948647193, 5725.427457254273, 6014.789482368118, 5851.034579294412, 5978.611390259641, 5982.401759824004, 5985.790497332594, 5990.970045149768, 5657.3494048184575, 5766.596338256324, 5808.854778630526, 5834.183214349994, 5941.732622032019, 5779.711014449261, 5837.795677151322, 5895.292564892197, 5896.233489646362, 5905.970470147622, 4365.694401391904, 5109.054824857376, 5164.380274367062, 5167.948320516822, 5175.068487672217, 26005.73994260052, 26144.34639134018, 26220.475590488084, 26234.212973610633, 26262.949482020886, 3088.629364476255, 3108.4094022135723, 3211.550382946389, 3227.354529094167, 3311.718503927169, 15058.849411505964, 15276.0, 15522.301496432689, 15669.373225070984, 16409.0, 1755.4294854172445, 1821.6720990221754, 1834.1012903677235, 1849.7410362549253, 1853.0827240515896, 103121.48439257756, 125475.0, 125588.0, 128532.0, 129895.05157422647, 9453.291003174789, 11495.0, 11544.480498377594, 11554.94222528882, 11813.940930295465, 14684.779728304084, 14697.706045879022, 14700.191489468181, 14701.117932924059, 14706.455822138736, 8451.957740211259, 8572.53262258857, 8616.224539791323, 8678.78303042429, 8697.391182617283, 7050.858982820315, 7264.273572642694, 8418.831623367498, 8452.915470845335, 8629.395942284105, 6284.245890493079, 6999.510034297652, 7015.088038554955, 7032.824179395556, 7118.5017048806085, 1578.4712121439218, 1595.8749081897236, 1851.6296740651653, 1891.6311319292606, 1892.1579896946002, 1012.5977907861641, 1065.6270305393205, 1076.5478499030426, 1097.4677281518457, 1127.813910704741, 21064.473388165112, 22410.439739006655, 22457.775422245893, 22576.66135007976, 22611.547769044526, 1093.9617113401152, 1094.9726256843483, 1095.6001059613184, 1115.5999220977621, 1118.5022664914197, 11518.654440366803, 11962.760744785055, 11968.0, 12012.939935300443, 12018.87981120195, 399938.0, 582929.0, 723659.0, 737185.0, 753191.0, 82601.17398826055, 130655.34672326577, 134110.65889341178, 134567.0, 135105.0, 1035.8860525342207, 1061.5170097605571, 1073.2648136026846, 1076.3380520979697, 1079.1151255970185, 19858.90070549638, 20704.792952070286, 21223.0, 21268.361949141552, 21268.468288292916, 54825.725871370385, 55615.72192139013, 55688.72155639196, 57410.703571856655, 57805.13292300703, 62079.06881396873, 63426.0, 76989.61505192438, 77062.22937770774, 78573.8213926803, 8052.677892884453, 8135.959320203361, 8253.422260441952, 8273.296769774637, 8299.95850020746, 11866.881331186578, 13271.469141234242, 13350.132241404277, 13421.261830599411, 13665.385057672627, 9510.524473776146, 11173.776524469627, 11396.772064558829, 11680.70798230051, 11703.76592468129, 4750.5249475052215, 8994.685186018458, 9645.263852506616, 11154.776904462027, 11435.256708313933, 11541.769164616493, 11592.304461732323, 11663.358515281741, 11715.765684686088, 11869.0, 8088.757337279891, 8382.329413646772, 8387.83224335522, 8498.490090594583, 8508.404411691123, 10785.352878827296, 11058.612948546763, 11328.830067548828, 11485.253458525169, 11573.826392603949], "value": 9977.77412085086, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.2789024201325, 1421.3959067396354, 1435.1747745046598, 1440.063958427023, 1444.5154334544586, 7989.520628762279, 8399.790005249872, 8414.200650938159, 8427.789305267364, 8435.789105272355, 7398.815029624248, 7619.80950476237, 7622.542647441143, 7857.135715071352, 8156.510609363442, 2205.4376134085787, 2306.5386922615544, 2310.0528783198893, 2310.480141968052, 2311.7919387255142, 2287.7025986621716, 2322.4658328584437, 2323.9883800581056, 2325.7092863392077, 2329.77867102625, 1838.8804727692657, 1953.5799803042344, 2086.686996950462, 2273.1702928431087, 2289.839711220215, 2217.3791338425267, 2300.1719381022817, 2301.5742087713825, 2302.6776251324745, 2305.9077636894503, 2237.876916769577, 2291.3126062181277, 2300.0914638717613, 2310.9306720798404, 2313.086330899302, 8166.959165204136, 8293.419460637759, 8295.0, 8298.875516867252, 8310.916890831135, 5034.3455350804525, 5192.350956130484, 5197.0, 5199.376074871039, 5205.037068142406, 3343.6154842193214, 3488.197864327895, 3502.8773992910383, 3552.928941421183, 3575.535180426554, 1004.7689031522791, 1172.8123500240006, 1212.9575464858688, 1243.1670780576944, 1255.215490318551, 10424.478776061167, 10630.627928022483, 10651.520681569347, 10654.62708805188, 10683.931606839255, 4435.2016637005, 4647.16351056813, 4692.835750748707, 4703.2004559225015, 4709.505501922317, 9536.28477864163, 9537.904620953701, 9546.856797148048, 9547.809043819085, 9555.0, 5222.660527065728, 5222.97388513055, 5226.712530810766, 5228.686278823283, 5230.163173892235, 4592.563706447882, 4680.4149481314835, 4740.099381117577, 4814.109389762835, 4824.782884770194, 3810.790406527612, 3878.7672739635714, 3902.1415288636454, 3939.4090886366703, 3972.56301806801, 1261.161327717058, 1264.2604076615282, 1282.3972732815562, 1300.6618279247464, 1300.7057977312634, 755.3503986571544, 793.6309616028575, 903.304455569208, 921.502388710089, 924.2929159193222, 5367.570594352443, 5523.475269849358, 5558.916616250759, 5713.8285851424525, 5883.441073098049, 964.8215080210183, 987.5753426026878, 991.4087888938294, 1001.2090448545713, 1026.9743256418649, 3346.8828590999683, 3588.7129029677562, 3615.1142969972525, 3694.9261014779554, 3795.7342985990717, 9542.90457095434, 9842.212622990144, 9859.950700246596, 9866.260030497742, 9870.753231169134, 9369.953150234205, 9742.9025709742, 9754.951225243829, 9766.095611355717, 9766.121049105472, 7468.178500364956, 7719.459637825298, 7721.613919304013, 7726.961365193138, 7761.573113478813, 5488.753006114654, 5500.0, 5529.253550770755, 5578.107502799533, 5688.232088667977, 7838.294553490213, 9101.544922753968, 9119.316051296046, 9124.635014599342, 9148.405353651991, 9111.0, 9230.123138301851, 9268.768280792765, 9351.579178936829, 9364.765880853032, 7134.32223938725, 7145.785626431215, 7267.563946163247, 7274.30894065063, 7286.817829554304, 7775.533467991939, 7785.14363420012, 7851.646675899484, 7855.37157027425, 7865.0, 6957.826054348682, 7050.189228238818, 7095.574265544084, 7103.502754807114, 7185.245549217257, 6980.581165130108, 7028.297170282931, 7034.964825175842, 7056.0, 7059.223485416497, 6296.811095667137, 6306.747730090929, 6325.588836725598, 6374.426301632875, 6407.839804004937, 4883.291922671264, 4896.290037944549, 4917.6311776616185, 4919.975400122977, 5036.823711170238, 4888.193448081169, 4976.10430122567, 4983.72589507566, 5066.189409694432, 5153.871153221199], "value": 4391.50730441222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.56270379043974, 347.405935849697, 348.5347061672667, 358.0868784599272, 368.4105431309903, 4045.6763458923288, 4190.763724701213, 4395.670324725643, 4600.838970636024, 5160.483951604838, 5008.545812551851, 5027.824026159085, 5033.647644664866, 5035.723035233061, 5049.84850454487, 3657.6970277470127, 3778.414345776409, 4003.7597744135446, 4014.31756601377, 4032.879013629581, 3594.7124230061663, 3906.6988394806344, 3931.4889064421586, 4030.1133750574827, 4037.091654377756, 3954.307996100685, 3989.840406383741, 4006.4390985262085, 4026.315526360526, 4030.677545796344, 3960.930279033772, 3973.403989401598, 3975.3440682287533, 3981.3079441237646, 4026.99988508563, 3549.2014296783277, 3568.3220188164423, 3575.5530558680166, 3586.278586278601, 3592.3354179476883, 4844.0, 4961.727105009223, 4975.512243878061, 4993.101241776479, 5018.623603229772, 3984.553361342447, 4589.79345929434, 4589.816407343702, 4597.70114942531, 4607.262837945946, 4115.92985823688, 4466.709663871838, 5392.274472168908, 5404.756785944642, 5439.449756819327, 3724.646158614927, 3899.941500877489, 3917.843286268546, 3948.8420463181437, 3964.088259700285, 5072.340595722606, 5387.407385187666, 5387.488188622075, 5622.803201887955, 5648.237487939116, 3960.881173564798, 4041.2927737645796, 4051.817668204938, 4058.289799285113, 4099.724652817656, 3892.90267743303, 3993.6805055595482, 4112.424260603518, 4115.506139263248, 4123.113530590937, 3969.0672691917375, 4379.189849877783, 4458.926599131355, 4530.844634618217, 4542.227821270392, 4967.602591792648, 5461.42655021225, 5530.677115611453, 5531.087370583889, 5574.797954807828, 1061.9522121504551, 1324.2650329067267, 1337.3580681273043, 1342.6576223063057, 1349.7030653256463, 750.0474397515126, 829.9128142133824, 855.6962278391081, 857.8718984535316, 884.1777147252988, 4545.0, 4863.465018847924, 4864.173090574611, 4865.299758633922, 4881.365422495124, 4644.790984405709, 4818.855609253848, 5016.2224855147515, 5302.496262855023, 5344.652597581145, 4543.681942264076, 4544.613707834871, 4797.976010119927, 4810.3404325507645, 4884.072026314989, 2713.6743590769233, 2763.2815467978066, 2787.3728411107745, 2794.413173233603, 2799.4882763307587, 4990.5508504234795, 5067.086425305464, 5116.872078198, 5540.479082017672, 5544.861378465571, 4815.590674792612, 5219.895602088013, 5465.371482279509, 5491.517290331588, 5546.334439867242, 4416.0, 4460.531644177315, 4688.671792974459, 5365.382980957162, 5465.672059676433, 4844.46710861812, 4957.305977163128, 5198.454162312903, 5266.657667251617, 5283.286756287852, 4199.41208230854, 4350.543192964693, 5232.895342093213, 5271.736413179402, 5296.655717378512, 5438.504411286928, 5466.3713672928125, 5496.725163741717, 5504.22940788298, 5567.359753628384, 3199.8320612976563, 3550.751447398657, 3588.1747198144053, 3615.060084378028, 3634.473001414833, 3608.8195590220907, 4738.526147385372, 5624.550035997028, 5667.433256674464, 5693.5160511357, 5058.3929928408825, 5500.42245564226, 5509.584057884137, 5546.306711661043, 5578.944210557843, 5264.578833693372, 5425.755840987086, 5431.6740995540395, 5508.724563771715, 5517.2551705519245, 5300.257963884982, 5359.919601205907, 5386.845261895117, 5392.865178370572, 5408.971635636636, 5185.403678577012, 5468.726563671721, 5509.889802204014, 5516.91724624139, 5522.779088836402, 4468.910621787481, 5107.310513080686, 5277.393099793573, 5314.1497360422145, 5364.249005139206], "value": 3951.666945376677, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.7071132634652, 687.8486732918758, 706.2161001288565, 738.3318097122107, 744.8249661329585, 14742.115473071623, 15763.369465221378, 15775.60560985976, 15786.05283682977, 15805.130717810516, 14049.648758781035, 14421.783673244883, 14430.855691443083, 14451.0, 14625.707485850304, 692.3422748389025, 723.0997408226765, 723.9430431569914, 870.9564521773917, 887.8268737596171, 841.4614646626164, 879.3932186791126, 885.406777459104, 893.093510087262, 895.9776005599847, 922.8154369126169, 934.1499235695518, 939.037486576258, 940.4545363689078, 941.7739742461794, 721.4985585018414, 932.0818993291603, 933.0948979489884, 934.0845970948475, 937.9062093790635, 555.574985136371, 668.7091115364832, 690.9550879192836, 697.0206859362604, 701.4738945790657, 15090.622734431727, 15098.16960067196, 15110.093394396372, 15119.848801512064, 15136.924315378463, 13586.0, 13595.184288942597, 13625.727485450236, 13664.385102670305, 13709.657258568515, 12321.69195770104, 12571.497140114385, 12616.81074783879, 12621.305828179446, 12705.491780328775, 4342.174986752507, 4346.609364849321, 4377.649788016951, 4408.074304396081, 4554.726716396994, 94806.0, 107434.0, 108321.45839270753, 108769.45615271873, 108983.99999999921, 9927.453990030474, 10184.981501849756, 10412.947935260276, 10900.836487452694, 11178.496967636313, 20627.278045268344, 20783.480412989797, 21049.15803367879, 21144.78855211428, 21171.0473028711, 7430.962845185848, 7460.552366858006, 7534.623268836536, 7610.695572177162, 7671.232876712284, 4229.217594744982, 4252.766097864647, 4259.0, 4299.634531064895, 4371.103923695635, 3304.8512816923294, 3325.085601459618, 3340.8496617651776, 3367.107716455141, 3377.7466689997855, 603.6891001134419, 604.4590091867753, 607.7994261893565, 615.0405367626516, 615.6398506873439, 632.8449529865212, 634.8603307272392, 644.4200219802216, 653.2389765922742, 673.9090222819857, 9173.0, 9255.305852061123, 9620.989796071452, 9683.661071862593, 9992.25058120644, 626.6083697688945, 645.7550807193888, 661.9007148927603, 668.2215219269497, 682.2699711308852, 4441.4892287387365, 4815.277708343777, 4862.051899879561, 5172.405173405032, 5574.554035677136, 94830.0, 99377.0, 101130.4943475278, 103360.48319758353, 103568.44647330296, 82108.58945705234, 86897.56551217203, 87409.56295218483, 88028.0, 89958.0, 59890.0, 67186.66406668033, 73262.26737732554, 77500.0, 79005.0, 10121.797564048826, 10670.46647667629, 10825.242233043926, 10829.891701082888, 10848.728781780519, 45874.77062614799, 47790.0, 48993.75503122462, 48995.26507102325, 49042.75478622727, 51951.701207468606, 61841.0, 64881.0, 68123.0, 69034.65482672554, 11699.473523691284, 12286.631401057983, 12574.742525747351, 12872.592193163866, 13520.0, 13865.79201311961, 14132.293385330488, 14510.0, 14916.925415372854, 14931.10413375201, 13450.798238026633, 13510.924010981133, 13541.458341666223, 14064.718705626035, 14369.13785172893, 13102.803457948328, 13571.728565428833, 13791.0, 14249.643758905695, 14258.358373873409, 12507.0, 12559.0, 13563.525276615272, 13828.0, 13836.23900685472, 9916.157126644028, 10405.375677459377, 11324.773504529698, 11470.426478675867, 11832.526698931946, 8508.404411691123, 9588.280878934247, 10121.291509594257, 10802.783944320912, 11000.889991100306], "value": 7421.567540012998, "unit": "score"}], "name": "dromaeo_css", "value": 7240.201156884798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 112.0, 113.0, 113.0, 114.0, 112.0, 112.0, 115.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 111.0, 162.0, 174.0, 110.0, 108.0, 108.0, 108.0, 126.0, 109.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 184.0, 186.0, 185.0, 184.0, 185.0, 186.0, 194.0, 261.0], "value": 193.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 100.0, 84.0, 85.0, 78.0, 58.0, 73.0, 57.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 87.0, 69.0, 68.0, 70.0, 81.0, 68.0, 69.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 84.0, 86.0, 84.0, 87.0, 110.0, 73.0, 113.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 93.0, 95.0, 97.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 104.0, 139.0, 116.0, 87.0, 88.0, 86.0, 100.0], "value": 98.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 54.0, 57.0, 57.0, 56.0, 56.0, 57.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 85.0, 77.0, 76.0, 72.0, 72.0, 76.0, 73.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 84.0, 96.0, 91.0, 100.0, 89.0, 83.0, 89.0, 83.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 142.0, 141.0, 148.0, 133.0, 142.0, 144.0, 200.0, 145.0], "value": 146.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 166.0, 164.0, 172.0, 227.0, 204.0, 171.0, 166.0, 164.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 65.0, 68.0, 66.0, 68.0, 79.0, 85.0, 83.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1473.4, "alertThreshold": 2.0}]} 08:48:54 INFO - Return code: 0 08:48:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:48:54 ERROR - # TBPL SUCCESS # 08:48:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:48:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:48:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:48:54 INFO - 2017-02-01 08:48:54.201 screenresolution[1955:27277] starting screenresolution argv=screenresolution get 08:48:54 INFO - 2017-02-01 08:48:54.204 screenresolution[1955:27277] Display 0: 1600x1200x32@60 08:48:54 INFO - 2017-02-01 08:48:54.211 screenresolution[1956:27280] starting screenresolution argv=screenresolution list 08:48:54 INFO - Available Modes on Display 0 08:48:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:48:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:48:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:48:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:48:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:48:54 INFO - Intel Iris: 08:48:54 INFO - Chipset Model: Intel Iris 08:48:54 INFO - Type: GPU 08:48:54 INFO - Bus: Built-In 08:48:54 INFO - VRAM (Dynamic, Max): 1536 MB 08:48:54 INFO - Vendor: Intel (0x8086) 08:48:54 INFO - Device ID: 0x0a2e 08:48:54 INFO - Revision ID: 0x0009 08:48:54 INFO - Displays: 08:48:54 INFO - Display: 08:48:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:48:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:48:54 INFO - Display Serial Number: 1600x1200 60 08:48:54 INFO - Main Display: Yes 08:48:54 INFO - Mirror: Off 08:48:54 INFO - Online: Yes 08:48:54 INFO - Rotation: Supported 08:48:54 INFO - Return code: 0 08:48:54 INFO - Running post-action listener: _resource_record_post_action 08:48:54 INFO - [mozharness: 2017-02-01 16:48:54.448755Z] Finished run-tests step (success) 08:48:54 INFO - Running post-run listener: _resource_record_post_run 08:48:54 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 380928; Write bytes: 508811264; Read time: 5; Write time: 1805 08:48:54 INFO - TinderboxPrint: CPU usage
53.7% 08:48:54 INFO - TinderboxPrint: I/O read bytes / time
380,928 / 5 08:48:54 INFO - TinderboxPrint: I/O write bytes / time
508,811,264 / 1,805 08:48:54 INFO - TinderboxPrint: CPU idle
2,219.8 (46.3%) 08:48:54 INFO - TinderboxPrint: CPU system
963.3 (20.1%) 08:48:54 INFO - TinderboxPrint: CPU user
1,610.5 (33.6%) 08:48:54 INFO - TinderboxPrint: Swap in / out
207,458,304 / 0 08:48:54 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200917504; Write bytes: 201872896; Read time: 15569; Write time: 437 08:48:54 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 380928; Write bytes: 296264192; Read time: 5; Write time: 1334 08:48:54 INFO - Running post-run listener: _upload_blobber_files 08:48:54 INFO - Blob upload gear active. 08:48:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:48:54 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 08:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:48:55 INFO - (blobuploader) - INFO - Open directory for files ... 08:48:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:48:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:48:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:56 INFO - (blobuploader) - INFO - Done attempting. 08:48:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:48:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:57 INFO - (blobuploader) - INFO - Done attempting. 08:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:48:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:58 INFO - (blobuploader) - INFO - Done attempting. 08:48:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:48:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:49:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:00 INFO - (blobuploader) - INFO - Done attempting. 08:49:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:49:00 INFO - Return code: 0 08:49:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:49:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:49:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fe1d72bf09153db969365e9f0e8d2437bb873c04a5e6ad87a216833aed8b2e365aba5f5ea552a9b3402aff5f14b9a63c38df3724474a227b4dcc6456c52c98e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88ef321d18b4ec2f6103d9985fee377259b9017d17d271bbb85ae59c6df6e90dfa4b107efb1bec8fba3be2d355c2171cf6aecd6b743c95716409efebbeed538f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a3fcfb316e746b76143f5b5e1e3755baeb8e70b0e1137de3e740633ff13d80e6a6a9dca1ca1411b3df793353dc8ba2da9614a955deaadb57f7cffaa22289e6e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e0e9cdb5ca83954f33e8583e4cd119e813bed41ae9cdc457c16122b81a476aa09f581888442ee6c8be74203d41db52a3c734d28151efccd42e905b6544c7ace"} 08:49:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:49:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:49:00 INFO - Contents: 08:49:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fe1d72bf09153db969365e9f0e8d2437bb873c04a5e6ad87a216833aed8b2e365aba5f5ea552a9b3402aff5f14b9a63c38df3724474a227b4dcc6456c52c98e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88ef321d18b4ec2f6103d9985fee377259b9017d17d271bbb85ae59c6df6e90dfa4b107efb1bec8fba3be2d355c2171cf6aecd6b743c95716409efebbeed538f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a3fcfb316e746b76143f5b5e1e3755baeb8e70b0e1137de3e740633ff13d80e6a6a9dca1ca1411b3df793353dc8ba2da9614a955deaadb57f7cffaa22289e6e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e0e9cdb5ca83954f33e8583e4cd119e813bed41ae9cdc457c16122b81a476aa09f581888442ee6c8be74203d41db52a3c734d28151efccd42e905b6544c7ace"} 08:49:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:49:00 INFO - Copying logs to upload dir... 08:49:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:49:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.654474 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-01 08:49:00.545361) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 08:49:00.548720) ========= 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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fe1d72bf09153db969365e9f0e8d2437bb873c04a5e6ad87a216833aed8b2e365aba5f5ea552a9b3402aff5f14b9a63c38df3724474a227b4dcc6456c52c98e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88ef321d18b4ec2f6103d9985fee377259b9017d17d271bbb85ae59c6df6e90dfa4b107efb1bec8fba3be2d355c2171cf6aecd6b743c95716409efebbeed538f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a3fcfb316e746b76143f5b5e1e3755baeb8e70b0e1137de3e740633ff13d80e6a6a9dca1ca1411b3df793353dc8ba2da9614a955deaadb57f7cffaa22289e6e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e0e9cdb5ca83954f33e8583e4cd119e813bed41ae9cdc457c16122b81a476aa09f581888442ee6c8be74203d41db52a3c734d28151efccd42e905b6544c7ace"} build_url:https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/Z9ub5UrrTc-6tEL74xaKZw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fe1d72bf09153db969365e9f0e8d2437bb873c04a5e6ad87a216833aed8b2e365aba5f5ea552a9b3402aff5f14b9a63c38df3724474a227b4dcc6456c52c98e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88ef321d18b4ec2f6103d9985fee377259b9017d17d271bbb85ae59c6df6e90dfa4b107efb1bec8fba3be2d355c2171cf6aecd6b743c95716409efebbeed538f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a3fcfb316e746b76143f5b5e1e3755baeb8e70b0e1137de3e740633ff13d80e6a6a9dca1ca1411b3df793353dc8ba2da9614a955deaadb57f7cffaa22289e6e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e0e9cdb5ca83954f33e8583e4cd119e813bed41ae9cdc457c16122b81a476aa09f581888442ee6c8be74203d41db52a3c734d28151efccd42e905b6544c7ace"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 08:49:00.586852) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 08:49:00.587490) ========= 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.Npb2cvEdoN/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.lxCa4PpXpc/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005114 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 08:49:00.636441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 08:49:00.636787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 08:49:00.637160) ========= ========= Total master_lag: 0.19 =========