builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0249 starttime: 1490042789.01 results: success (0) buildid: 20170320124223 builduid: cfbae3e14cfd43f5912b55b3753279c8 revision: 0496e366a8f4d1393a8caba1db5f6d1f49da468d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:29.012492) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:29.012949) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:29.013229) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:29.039664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:29.039990) ========= 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.0Et80hOCHK/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.7dEpTiKTm4/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-20 13:46:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2017-03-20 13:46:29 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126096 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:29.189945) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:29.190519) ========= 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.0Et80hOCHK/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.7dEpTiKTm4/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.026506 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:29.239390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 13:46:29.239769) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0496e366a8f4d1393a8caba1db5f6d1f49da468d --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 0496e366a8f4d1393a8caba1db5f6d1f49da468d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0Et80hOCHK/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.7dEpTiKTm4/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-20 13:46:29,362 truncating revision to first 12 chars 2017-03-20 13:46:29,362 Setting DEBUG logging. 2017-03-20 13:46:29,362 attempt 1/10 2017-03-20 13:46:29,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0496e366a8f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 13:46:30,349 unpacking tar archive at: mozilla-aurora-0496e366a8f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.254210 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 13:46:30.517461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:30.517789) ========= script_repo_revision: 0496e366a8f4d1393a8caba1db5f6d1f49da468d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:30.518178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:30.518439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 13:46:30.537883) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-20 13:46:30.538155) ========= /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.0Et80hOCHK/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.7dEpTiKTm4/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:46:30 INFO - MultiFileLogger online at 20170320 13:46:30 in /builds/slave/test 13:46:30 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 13:46:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:46:30 INFO - {'append_to_log': False, 13:46:30 INFO - 'base_work_dir': '/builds/slave/test', 13:46:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:46:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:46:30 INFO - 'branch': 'Mozilla-Aurora', 13:46:30 INFO - 'buildbot_json_path': 'buildprops.json', 13:46:30 INFO - 'config_files': ('talos/mac_config.py',), 13:46:30 INFO - 'default_actions': ('clobber', 13:46:30 INFO - 'read-buildbot-config', 13:46:30 INFO - 'download-and-extract', 13:46:30 INFO - 'populate-webroot', 13:46:30 INFO - 'create-virtualenv', 13:46:30 INFO - 'install', 13:46:30 INFO - 'run-tests'), 13:46:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:46:30 INFO - 'download_minidump_stackwalk': True, 13:46:30 INFO - 'download_symbols': 'ondemand', 13:46:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:46:30 INFO - 'tooltool.py': '/tools/tooltool.py', 13:46:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:46:30 INFO - '/tools/misc-python/virtualenv.py')}, 13:46:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:46:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:46:30 INFO - 'gecko_profile': False, 13:46:30 INFO - 'gecko_profile_interval': 0, 13:46:30 INFO - 'installer_path': 'installer.exe', 13:46:30 INFO - 'log_level': 'info', 13:46:30 INFO - 'log_name': 'talos', 13:46:30 INFO - 'log_to_console': True, 13:46:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:46:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:46:30 INFO - 'opt_config_files': (), 13:46:30 INFO - 'pip_index': False, 13:46:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:46:30 INFO - 'cmd': ('bash', 13:46:30 INFO - '-c', 13:46:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:46:30 INFO - 'enabled': True, 13:46:30 INFO - 'halt_on_failure': False, 13:46:30 INFO - 'name': 'check_screen_resolution'},), 13:46:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:46:30 INFO - 'cmd': ('bash', 13:46:30 INFO - '-c', 13:46:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:46:30 INFO - 'enabled': True, 13:46:30 INFO - 'halt_on_failure': False, 13:46:30 INFO - 'name': 'check_screen_resolution'},), 13:46:30 INFO - 'run_cmd_checks_enabled': True, 13:46:30 INFO - 'suite': 'dromaeojs', 13:46:30 INFO - 'system_bits': '32', 13:46:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:46:30 INFO - 'title': 't-yosemite-r7-0249', 13:46:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:46:30 INFO - 'use_talos_json': True, 13:46:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:46:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:46:30 INFO - 'work_dir': 'build'} 13:46:30 INFO - [mozharness: 2017-03-20 20:46:30.767120Z] Running clobber step. 13:46:30 INFO - Running pre-action listener: _resource_record_pre_action 13:46:30 INFO - Running main action method: clobber 13:46:30 INFO - rmtree: /builds/slave/test/build 13:46:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:46:33 INFO - Running post-action listener: _resource_record_post_action 13:46:33 INFO - [mozharness: 2017-03-20 20:46:33.142406Z] Finished clobber step (success) 13:46:33 INFO - [mozharness: 2017-03-20 20:46:33.142605Z] Running read-buildbot-config step. 13:46:33 INFO - Running pre-action listener: _resource_record_pre_action 13:46:33 INFO - Running main action method: read_buildbot_config 13:46:33 INFO - Using buildbot properties: 13:46:33 INFO - { 13:46:33 INFO - "project": "", 13:46:33 INFO - "product": "firefox", 13:46:33 INFO - "script_repo_revision": "production", 13:46:33 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:46:33 INFO - "repository": "", 13:46:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:46:33 INFO - "buildid": "20170320124223", 13:46:33 INFO - "pgo_build": "False", 13:46:33 INFO - "basedir": "/builds/slave/test", 13:46:33 INFO - "buildnumber": 10, 13:46:33 INFO - "slavename": "t-yosemite-r7-0249", 13:46:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:46:33 INFO - "platform": "yosemite_r7", 13:46:33 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:46:33 INFO - "branch": "mozilla-aurora", 13:46:33 INFO - "repo_path": "releases/mozilla-aurora", 13:46:33 INFO - "revision": "0496e366a8f4d1393a8caba1db5f6d1f49da468d", 13:46:33 INFO - "stage_platform": "macosx64", 13:46:33 INFO - "builduid": "cfbae3e14cfd43f5912b55b3753279c8", 13:46:33 INFO - "slavebuilddir": "test" 13:46:33 INFO - } 13:46:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 13:46:33 INFO - Running post-action listener: _resource_record_post_action 13:46:33 INFO - [mozharness: 2017-03-20 20:46:33.148320Z] Finished read-buildbot-config step (success) 13:46:33 INFO - [mozharness: 2017-03-20 20:46:33.148497Z] Running download-and-extract step. 13:46:33 INFO - Running pre-action listener: _resource_record_pre_action 13:46:33 INFO - Running main action method: download_and_extract 13:46:33 INFO - mkdir: /builds/slave/test/build/tests 13:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:46:33 INFO - trying https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 13:46:33 INFO - Downloading https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 13:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 13:46:34 INFO - Downloaded 1199 bytes. 13:46:34 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 13:46:34 INFO - Using the following test package requirements: 13:46:34 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 13:46:34 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:46:34 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 13:46:34 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:46:34 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 13:46:34 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:46:34 INFO - u'jsshell-mac.zip'], 13:46:34 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:46:34 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 13:46:34 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 13:46:34 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:46:34 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 13:46:34 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:46:34 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 13:46:34 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:46:34 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 13:46:34 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:46:34 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 13:46:34 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:46:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 13:46:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:46:34 INFO - Fetch https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 13:46:35 INFO - Expected file size: 51781921 13:46:35 INFO - Obtained file size: 51781921 13:46:51 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:46:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 13:46:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:46:51 INFO - Fetch https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 13:46:53 INFO - Expected file size: 51781921 13:46:53 INFO - Obtained file size: 51781921 13:47:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 13:47:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:47:08 INFO - Fetch https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 13:47:09 INFO - Expected file size: 14404438 13:47:09 INFO - Obtained file size: 14404438 13:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:09 INFO - trying https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 13:47:09 INFO - Downloading https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 13:47:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 13:47:11 INFO - Downloaded 74683382 bytes. 13:47:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 13:47:11 INFO - mkdir: /builds/slave/test/properties 13:47:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:47:11 INFO - Writing to file /builds/slave/test/properties/build_url 13:47:11 INFO - Contents: 13:47:11 INFO - build_url:https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 13:47:12 INFO - Running post-action listener: _resource_record_post_action 13:47:12 INFO - Running post-action listener: set_extra_try_arguments 13:47:12 INFO - [mozharness: 2017-03-20 20:47:12.684788Z] Finished download-and-extract step (success) 13:47:12 INFO - [mozharness: 2017-03-20 20:47:12.684924Z] Running populate-webroot step. 13:47:12 INFO - Running pre-action listener: _resource_record_pre_action 13:47:12 INFO - Running main action method: populate_webroot 13:47:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:47:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:47:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:47:12 INFO - '--tppagecycles', 13:47:12 INFO - '7'], 13:47:12 INFO - 'tests': ['tsvgm']}}, 13:47:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:47:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:47:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:47:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:47:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:47:12 INFO - 'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:47:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:47:12 INFO - 'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['damp', 'tps']}, 13:47:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:47:12 INFO - 'tests': ['damp', 'tps']}, 13:47:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['dromaeo_dom']}, 13:47:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:47:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['basic_compositor_video']}, 13:47:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:47:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['a11yr', 13:47:12 INFO - 'ts_paint', 13:47:12 INFO - 'tpaint', 13:47:12 INFO - 'sessionrestore', 13:47:12 INFO - 'sessionrestore_no_auto_restore', 13:47:12 INFO - 'tabpaint']}, 13:47:12 INFO - 'other-e10s': {'tests': ['a11yr', 13:47:12 INFO - 'ts_paint', 13:47:12 INFO - 'tpaint', 13:47:12 INFO - 'sessionrestore', 13:47:12 INFO - 'sessionrestore_no_auto_restore', 13:47:12 INFO - 'tabpaint']}, 13:47:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:47:12 INFO - 'ts_paint', 13:47:12 INFO - 'tpaint', 13:47:12 INFO - 'sessionrestore', 13:47:12 INFO - 'sessionrestore_no_auto_restore', 13:47:12 INFO - 'tabpaint']}, 13:47:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:47:12 INFO - 'ts_paint', 13:47:12 INFO - 'tpaint', 13:47:12 INFO - 'sessionrestore', 13:47:12 INFO - 'sessionrestore_no_auto_restore', 13:47:12 INFO - 'tabpaint']}, 13:47:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['a11yr', 13:47:12 INFO - 'ts_paint', 13:47:12 INFO - 'tpaint', 13:47:12 INFO - 'sessionrestore', 13:47:12 INFO - 'sessionrestore_no_auto_restore', 13:47:12 INFO - 'tabpaint']}, 13:47:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['a11yr', 13:47:12 INFO - 'ts_paint', 13:47:12 INFO - 'tpaint', 13:47:12 INFO - 'sessionrestore', 13:47:12 INFO - 'sessionrestore_no_auto_restore', 13:47:12 INFO - 'tabpaint']}, 13:47:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['tsvgx', 13:47:12 INFO - 'tsvgr_opacity', 13:47:12 INFO - 'tart', 13:47:12 INFO - 'tscrollx', 13:47:12 INFO - 'cart', 13:47:12 INFO - 'tsvg_static']}, 13:47:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:47:12 INFO - 'tsvgr_opacity', 13:47:12 INFO - 'tart', 13:47:12 INFO - 'tscrollx', 13:47:12 INFO - 'cart', 13:47:12 INFO - 'tsvg_static']}, 13:47:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:47:12 INFO - 'talos_options': ['--disable-e10s'], 13:47:12 INFO - 'tests': ['tp5o']}, 13:47:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:47:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:47:12 INFO - 'talos_options': ['--disable-e10s', 13:47:12 INFO - '--xperf_path', 13:47:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:12 INFO - 'tests': ['tp5n']}, 13:47:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:47:12 INFO - 'talos_options': ['--xperf_path', 13:47:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:12 INFO - 'tests': ['tp5n']}}, 13:47:12 INFO - 'talos.zip': {'path': '', 13:47:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:47:12 INFO - Running post-action listener: _resource_record_post_action 13:47:12 INFO - [mozharness: 2017-03-20 20:47:12.703557Z] Finished populate-webroot step (success) 13:47:12 INFO - [mozharness: 2017-03-20 20:47:12.703678Z] Running create-virtualenv step. 13:47:12 INFO - Running pre-action listener: _resource_record_pre_action 13:47:12 INFO - Running main action method: create_virtualenv 13:47:12 INFO - Creating virtualenv /builds/slave/test/build/venv 13:47:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:47:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:47:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:47:12 INFO - Using real prefix '/tools/python27' 13:47:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:47:13 INFO - Installing distribute.............................................................................................................................................................................................done. 13:47:16 INFO - Installing pip.................done. 13:47:16 INFO - Return code: 0 13:47:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:47:16 INFO - Reading from file tmpfile_stdout 13:47:16 INFO - Output received: 13:47:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:47:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:47: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')]} 13:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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')]} 13:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:47:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:16 INFO - 'HOME': '/Users/cltbld', 13:47:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:16 INFO - 'LOGNAME': 'cltbld', 13:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:16 INFO - 'MOZ_NO_REMOTE': '1', 13:47:16 INFO - 'NO_EM_RESTART': '1', 13:47:16 INFO - 'PAGER': '/bin/cat', 13:47:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:16 INFO - 'PWD': '/builds/slave/test', 13:47:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:16 INFO - 'SHELL': '/bin/bash', 13:47:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:16 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:16 INFO - 'USER': 'cltbld', 13:47:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:16 INFO - 'XPC_FLAGS': '0x0', 13:47:16 INFO - 'XPC_SERVICE_NAME': '0', 13:47:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:47:16 INFO - Cleaning up... 13:47:17 INFO - Return code: 0 13:47:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:17 INFO - 'HOME': '/Users/cltbld', 13:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:17 INFO - 'LOGNAME': 'cltbld', 13:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:17 INFO - 'MOZ_NO_REMOTE': '1', 13:47:17 INFO - 'NO_EM_RESTART': '1', 13:47:17 INFO - 'PAGER': '/bin/cat', 13:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:17 INFO - 'PWD': '/builds/slave/test', 13:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:17 INFO - 'SHELL': '/bin/bash', 13:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:17 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:17 INFO - 'USER': 'cltbld', 13:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:17 INFO - 'XPC_FLAGS': '0x0', 13:47:17 INFO - 'XPC_SERVICE_NAME': '0', 13:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:17 INFO - Downloading/unpacking psutil>=3.1.1 13:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:47:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:47:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:47:20 INFO - Installing collected packages: psutil 13:47:20 INFO - Running setup.py install for psutil 13:47:20 INFO - building 'psutil._psutil_osx' extension 13:47:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:47:21 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 13:47:21 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 13:47:21 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 13:47:21 INFO - building 'psutil._psutil_posix' extension 13:47:21 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 13:47:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:47:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:47:21 INFO - ^ 13:47:21 INFO - 1 warning generated. 13:47:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:47:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:47:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:47:21 INFO - Successfully installed psutil 13:47:21 INFO - Cleaning up... 13:47:21 INFO - Return code: 0 13:47:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:47:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:21 INFO - 'HOME': '/Users/cltbld', 13:47:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:21 INFO - 'LOGNAME': 'cltbld', 13:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:21 INFO - 'MOZ_NO_REMOTE': '1', 13:47:21 INFO - 'NO_EM_RESTART': '1', 13:47:21 INFO - 'PAGER': '/bin/cat', 13:47:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:21 INFO - 'PWD': '/builds/slave/test', 13:47:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:21 INFO - 'SHELL': '/bin/bash', 13:47:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:21 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:21 INFO - 'USER': 'cltbld', 13:47:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:21 INFO - 'XPC_FLAGS': '0x0', 13:47:21 INFO - 'XPC_SERVICE_NAME': '0', 13:47:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:47:22 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 13:47:22 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 13:47:22 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 13:47:22 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 13:47:22 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 13:47:22 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 13:47:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:47:24 INFO - Installing collected packages: mozsystemmonitor 13:47:24 INFO - Running setup.py install for mozsystemmonitor 13:47:24 INFO - Successfully installed mozsystemmonitor 13:47:24 INFO - Cleaning up... 13:47:25 INFO - Return code: 0 13:47:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:47:25 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')]} 13:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:25 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')]} 13:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:25 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 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:25 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 13:47:25 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 13:47:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:25 INFO - 'HOME': '/Users/cltbld', 13:47:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:25 INFO - 'LOGNAME': 'cltbld', 13:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:25 INFO - 'MOZ_NO_REMOTE': '1', 13:47:25 INFO - 'NO_EM_RESTART': '1', 13:47:25 INFO - 'PAGER': '/bin/cat', 13:47:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:25 INFO - 'PWD': '/builds/slave/test', 13:47:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:25 INFO - 'SHELL': '/bin/bash', 13:47:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:25 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:25 INFO - 'USER': 'cltbld', 13:47:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:25 INFO - 'XPC_FLAGS': '0x0', 13:47:25 INFO - 'XPC_SERVICE_NAME': '0', 13:47:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:26 INFO - Downloading/unpacking jsonschema==2.5.1 13:47:26 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 13:47:26 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 13:47:26 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 13:47:26 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 13:47:26 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 13:47:26 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 13:47:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:47:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:47:29 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 13:47:29 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 13:47:29 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 13:47:29 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 13:47:29 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 13:47:29 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 13:47:29 INFO - Downloading functools32-3.2.3-2.tar.gz 13:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:47:29 INFO - warning: no files found matching '*.txt' 13:47:29 INFO - no previously-included directories found matching 'build' 13:47:29 INFO - no previously-included directories found matching 'dist' 13:47:29 INFO - no previously-included directories found matching '.git*' 13:47:29 INFO - Installing collected packages: jsonschema, functools32 13:47:29 INFO - Running setup.py install for functools32 13:47:29 INFO - warning: no files found matching '*.txt' 13:47:29 INFO - no previously-included directories found matching 'build' 13:47:29 INFO - no previously-included directories found matching 'dist' 13:47:29 INFO - no previously-included directories found matching '.git*' 13:47:29 INFO - Successfully installed jsonschema functools32 13:47:29 INFO - Cleaning up... 13:47:29 INFO - Return code: 0 13:47:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:47:29 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')]} 13:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:29 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')]} 13:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:29 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 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:29 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 13:47:29 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 13:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:29 INFO - 'HOME': '/Users/cltbld', 13:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:29 INFO - 'LOGNAME': 'cltbld', 13:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:29 INFO - 'MOZ_NO_REMOTE': '1', 13:47:29 INFO - 'NO_EM_RESTART': '1', 13:47:29 INFO - 'PAGER': '/bin/cat', 13:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:29 INFO - 'PWD': '/builds/slave/test', 13:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:29 INFO - 'SHELL': '/bin/bash', 13:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:29 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:29 INFO - 'USER': 'cltbld', 13:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:29 INFO - 'XPC_FLAGS': '0x0', 13:47:29 INFO - 'XPC_SERVICE_NAME': '0', 13:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:47:30 INFO - Cleaning up... 13:47:30 INFO - Return code: 0 13:47:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:30 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 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:30 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 13:47:30 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 13:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:30 INFO - 'HOME': '/Users/cltbld', 13:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:30 INFO - 'LOGNAME': 'cltbld', 13:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:30 INFO - 'MOZ_NO_REMOTE': '1', 13:47:30 INFO - 'NO_EM_RESTART': '1', 13:47:30 INFO - 'PAGER': '/bin/cat', 13:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:30 INFO - 'PWD': '/builds/slave/test', 13:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:30 INFO - 'SHELL': '/bin/bash', 13:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:30 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:30 INFO - 'USER': 'cltbld', 13:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:30 INFO - 'XPC_FLAGS': '0x0', 13:47:30 INFO - 'XPC_SERVICE_NAME': '0', 13:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:47:30 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 13:47:30 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 13:47:30 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 13:47:30 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 13:47:30 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 13:47:30 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 13:47:33 INFO - Downloading blobuploader-1.2.4.tar.gz 13:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:47:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:47:33 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 13:47:33 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 13:47:33 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 13:47:33 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 13:47:33 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 13:47:33 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 13:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:47:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:47:33 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 13:47:33 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 13:47:33 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 13:47:33 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 13:47:33 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 13:47:33 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 13:47:34 INFO - Downloading docopt-0.6.1.tar.gz 13:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:47:34 INFO - Installing collected packages: blobuploader, requests, docopt 13:47:34 INFO - Running setup.py install for blobuploader 13:47:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:47:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:47:34 INFO - Running setup.py install for requests 13:47:35 INFO - Running setup.py install for docopt 13:47:35 INFO - Successfully installed blobuploader requests docopt 13:47:35 INFO - Cleaning up... 13:47:35 INFO - Return code: 0 13:47:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47: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')]} 13:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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')]} 13:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:35 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 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:35 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 13:47:35 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 13:47:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:35 INFO - 'HOME': '/Users/cltbld', 13:47:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:35 INFO - 'LOGNAME': 'cltbld', 13:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:35 INFO - 'MOZ_NO_REMOTE': '1', 13:47:35 INFO - 'NO_EM_RESTART': '1', 13:47:35 INFO - 'PAGER': '/bin/cat', 13:47:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:35 INFO - 'PWD': '/builds/slave/test', 13:47:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:35 INFO - 'SHELL': '/bin/bash', 13:47:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:35 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:35 INFO - 'USER': 'cltbld', 13:47:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:35 INFO - 'XPC_FLAGS': '0x0', 13:47:35 INFO - 'XPC_SERVICE_NAME': '0', 13:47:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:47:35 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-kGsISe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:47:35 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-B11l2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:47:35 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-9Ycq2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:47:35 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-aDXW7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-qgTP6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-WtIWkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-H0Uz7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-Ml6Ebd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-4xQYIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-Kv0JnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-7Q9Vot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-77XAFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-lMtG9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:47:36 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-xXGD7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:37 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-gGQziG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:47:37 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-U0lVj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:47:37 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-nYnZus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:47:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:47:37 INFO - Running setup.py install for manifestparser 13:47:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:47:37 INFO - Running setup.py install for mozcrash 13:47:37 INFO - Running setup.py install for mozdebug 13:47:37 INFO - Running setup.py install for mozdevice 13:47:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:47:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:47:37 INFO - Running setup.py install for mozfile 13:47:38 INFO - Running setup.py install for mozhttpd 13:47:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for mozinfo 13:47:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for mozInstall 13:47:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for mozleak 13:47:38 INFO - Running setup.py install for mozlog 13:47:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for moznetwork 13:47:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for mozprocess 13:47:39 INFO - Running setup.py install for mozprofile 13:47:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:47:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:47:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:47:39 INFO - Running setup.py install for mozrunner 13:47:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:47:39 INFO - Running setup.py install for mozscreenshot 13:47:39 INFO - Running setup.py install for moztest 13:47:39 INFO - Running setup.py install for mozversion 13:47:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:47:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:47:39 INFO - Cleaning up... 13:47:39 INFO - Return code: 0 13:47:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47: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')]} 13:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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')]} 13:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:39 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 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:39 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 13:47:39 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 13:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:39 INFO - 'HOME': '/Users/cltbld', 13:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:39 INFO - 'LOGNAME': 'cltbld', 13:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:39 INFO - 'MOZ_NO_REMOTE': '1', 13:47:39 INFO - 'NO_EM_RESTART': '1', 13:47:39 INFO - 'PAGER': '/bin/cat', 13:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:39 INFO - 'PWD': '/builds/slave/test', 13:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:39 INFO - 'SHELL': '/bin/bash', 13:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:39 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:39 INFO - 'USER': 'cltbld', 13:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:39 INFO - 'XPC_FLAGS': '0x0', 13:47:39 INFO - 'XPC_SERVICE_NAME': '0', 13:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:47:40 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-wEv6qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:47:40 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-jB8XCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:47:40 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ytz9nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:47:40 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-0QCIky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:47:40 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-gk4mxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:47:40 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-Q5WKDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:47:40 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-k_mB_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:47:40 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-_oNdRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:47:41 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)) 13:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:47:41 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-FidEAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:47:41 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)) 13:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:47:41 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-yMF6vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:47:41 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)) 13:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:47:41 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-DVLL2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:47:41 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)) 13:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:47:41 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-3HEg8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 13:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:47:41 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-OUZwvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:47:41 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)) 13:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:47:41 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-mTpcxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:47:41 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)) 13:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:41 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-jHeLub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:41 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)) 13:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:47:41 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-W7S6fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:47:41 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)) 13:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:47:41 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-hf6Ffh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:47:42 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)) 13:47:42 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)) 13:47:42 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)) 13:47:42 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)) 13:47:42 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)) 13:47:42 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)) 13:47:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47:44 INFO - Downloading blessings-1.6.tar.gz 13:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:47:44 INFO - Installing collected packages: blessings 13:47:44 INFO - Running setup.py install for blessings 13:47:44 INFO - Successfully installed blessings 13:47:44 INFO - Cleaning up... 13:47:45 INFO - Return code: 0 13:47:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:47:45 INFO - Reading from file tmpfile_stdout 13:47:45 INFO - Current package versions: 13:47:45 INFO - blessings == 1.6 13:47:45 INFO - blobuploader == 1.2.4 13:47:45 INFO - docopt == 0.6.1 13:47:45 INFO - functools32 == 3.2.3-2 13:47:45 INFO - jsonschema == 2.5.1 13:47:45 INFO - manifestparser == 1.1 13:47:45 INFO - mozInstall == 1.12 13:47:45 INFO - mozcrash == 1.0 13:47:45 INFO - mozdebug == 0.1 13:47:45 INFO - mozdevice == 0.49 13:47:45 INFO - mozfile == 1.2 13:47:45 INFO - mozhttpd == 0.7 13:47:45 INFO - mozinfo == 0.9 13:47:45 INFO - mozleak == 0.1 13:47:45 INFO - mozlog == 3.4 13:47:45 INFO - moznetwork == 0.27 13:47:45 INFO - mozprocess == 0.25 13:47:45 INFO - mozprofile == 0.28 13:47:45 INFO - mozrunner == 6.13 13:47:45 INFO - mozscreenshot == 0.1 13:47:45 INFO - mozsystemmonitor == 0.3 13:47:45 INFO - moztest == 0.8 13:47:45 INFO - mozversion == 1.4 13:47:45 INFO - psutil == 3.1.1 13:47:45 INFO - requests == 1.2.3 13:47:45 INFO - wsgiref == 0.1.2 13:47:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47: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')]} 13:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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')]} 13:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:45 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 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:45 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 13:47:45 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 13:47:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:45 INFO - 'HOME': '/Users/cltbld', 13:47:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:45 INFO - 'LOGNAME': 'cltbld', 13:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:45 INFO - 'MOZ_NO_REMOTE': '1', 13:47:45 INFO - 'NO_EM_RESTART': '1', 13:47:45 INFO - 'PAGER': '/bin/cat', 13:47:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:45 INFO - 'PWD': '/builds/slave/test', 13:47:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:45 INFO - 'SHELL': '/bin/bash', 13:47:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:45 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:45 INFO - 'USER': 'cltbld', 13:47:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:45 INFO - 'XPC_FLAGS': '0x0', 13:47:45 INFO - 'XPC_SERVICE_NAME': '0', 13:47:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:45 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)) 13:47:45 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)) 13:47:45 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)) 13:47:45 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)) 13:47:45 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)) 13:47:45 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)) 13:47:45 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)) 13:47:45 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)) 13:47:45 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)) 13:47:45 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)) 13:47:45 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)) 13:47:45 INFO - Cleaning up... 13:47:45 INFO - Return code: 0 13:47:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:47: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')]} 13:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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')]} 13:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:45 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 0x105ef2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0084b64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, '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.0Et80hOCHK/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.7dEpTiKTm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 13:47:45 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 13:47:45 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 13:47:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:47:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:47:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:47:45 INFO - 'HOME': '/Users/cltbld', 13:47:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:47:45 INFO - 'LOGNAME': 'cltbld', 13:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:45 INFO - 'MOZ_NO_REMOTE': '1', 13:47:45 INFO - 'NO_EM_RESTART': '1', 13:47:45 INFO - 'PAGER': '/bin/cat', 13:47:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:45 INFO - 'PWD': '/builds/slave/test', 13:47:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:47:45 INFO - 'SHELL': '/bin/bash', 13:47:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:47:45 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:47:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:47:45 INFO - 'USER': 'cltbld', 13:47:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:47:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:45 INFO - 'XPC_FLAGS': '0x0', 13:47:45 INFO - 'XPC_SERVICE_NAME': '0', 13:47:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:47:45 INFO - Cleaning up... 13:47:45 INFO - Return code: 0 13:47:45 INFO - Running post-action listener: _resource_record_post_action 13:47:45 INFO - Running post-action listener: _start_resource_monitoring 13:47:45 INFO - Starting resource monitoring. 13:47:45 INFO - [mozharness: 2017-03-20 20:47:45.838342Z] Finished create-virtualenv step (success) 13:47:45 INFO - [mozharness: 2017-03-20 20:47:45.839351Z] Running install step. 13:47:45 INFO - Running pre-action listener: _resource_record_pre_action 13:47:45 INFO - Running main action method: install 13:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:47:46 INFO - Reading from file tmpfile_stdout 13:47:46 INFO - Detecting whether we're running mozinstall >=1.0... 13:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:47:46 INFO - Reading from file tmpfile_stdout 13:47:46 INFO - Output received: 13:47:46 INFO - Usage: mozinstall [options] installer 13:47:46 INFO - Options: 13:47:46 INFO - -h, --help show this help message and exit 13:47:46 INFO - -d DEST, --destination=DEST 13:47:46 INFO - Directory to install application into. [default: 13:47:46 INFO - "/builds/slave/test"] 13:47:46 INFO - --app=APP Application being installed. [default: firefox] 13:47:46 INFO - mkdir: /builds/slave/test/build/application 13:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:48:06 INFO - Reading from file tmpfile_stdout 13:48:06 INFO - Output received: 13:48:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:48:06 INFO - Running post-action listener: _resource_record_post_action 13:48:06 INFO - [mozharness: 2017-03-20 20:48:06.235445Z] Finished install step (success) 13:48:06 INFO - [mozharness: 2017-03-20 20:48:06.235585Z] Running run-tests step. 13:48:06 INFO - Running pre-action listener: _resource_record_pre_action 13:48:06 INFO - Running main action method: run_tests 13:48:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:48:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:48:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:48:06 INFO - 2017-03-20 13:48:06.250 screenresolution[1623:7504] starting screenresolution argv=screenresolution get 13:48:06 INFO - 2017-03-20 13:48:06.252 screenresolution[1623:7504] Display 0: 1600x1200x32@60 13:48:06 INFO - 2017-03-20 13:48:06.258 screenresolution[1624:7507] starting screenresolution argv=screenresolution list 13:48:06 INFO - Available Modes on Display 0 13:48:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:48:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:48:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:48:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:48:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:48:06 INFO - Intel Iris: 13:48:06 INFO - Chipset Model: Intel Iris 13:48:06 INFO - Type: GPU 13:48:06 INFO - Bus: Built-In 13:48:06 INFO - VRAM (Dynamic, Max): 1536 MB 13:48:06 INFO - Vendor: Intel (0x8086) 13:48:06 INFO - Device ID: 0x0a2e 13:48:06 INFO - Revision ID: 0x0009 13:48:06 INFO - Displays: 13:48:06 INFO - Display: 13:48:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:48:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:48:06 INFO - Display Serial Number: 1600x1200 60 13:48:06 INFO - Main Display: Yes 13:48:06 INFO - Mirror: Off 13:48:06 INFO - Online: Yes 13:48:06 INFO - Rotation: Supported 13:48:06 INFO - Return code: 0 13:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:48:06 INFO - Python 2.7.3 13:48:06 INFO - Return code: 0 13:48:06 INFO - grabbing minidump binary from tooltool 13:48:06 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')]} 13:48:06 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 0x105cd0d30>, '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 0x105bf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105cc5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:48:06 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 13:48:06 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 13:48:06 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 13:48:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:48:06 INFO - Return code: 0 13:48:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:48:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:48:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:48:06 INFO - ENV: RUST_BACKTRACE is now 1 13:48:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:48:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:48:06 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/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 13:48:06 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/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0249 --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 13:48:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Et80hOCHK/Render', 13:48:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:06 INFO - 'HOME': '/Users/cltbld', 13:48:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:06 INFO - 'LOGNAME': 'cltbld', 13:48:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:48:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:06 INFO - 'MOZ_NO_REMOTE': '1', 13:48:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:48:06 INFO - 'NO_EM_RESTART': '1', 13:48:06 INFO - 'PAGER': '/bin/cat', 13:48:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:06 INFO - 'PWD': '/builds/slave/test', 13:48:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:48:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:06 INFO - 'RUST_BACKTRACE': '1', 13:48:06 INFO - 'SHELL': '/bin/bash', 13:48:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7dEpTiKTm4/Listeners', 13:48:06 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 13:48:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:06 INFO - 'USER': 'cltbld', 13:48:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:06 INFO - 'XPC_FLAGS': '0x0', 13:48:06 INFO - 'XPC_SERVICE_NAME': '0', 13:48:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:06 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/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 13:48:06 INFO - mozversion application_buildid: 20170320124223 13:48:06 INFO - mozversion application_changeset: 0496e366a8f4d1393a8caba1db5f6d1f49da468d 13:48:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:48:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:48:06 INFO - mozversion application_name: Firefox 13:48:06 INFO - mozversion application_remotingname: firefox-dev 13:48:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:48:06 INFO - mozversion application_vendor: Mozilla 13:48:06 INFO - mozversion application_version: 54.0a2 13:48:06 INFO - mozversion platform_buildid: 20170320124223 13:48:06 INFO - mozversion platform_changeset: 0496e366a8f4d1393a8caba1db5f6d1f49da468d 13:48:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:48:06 INFO - mozversion platform_version: 54.0a2 13:48:06 INFO - using testdate: 1490042886 13:48:06 INFO - actual date: 1490042886 13:48:06 INFO - starting webserver on 'localhost:49241' 13:48:06 INFO - SUITE-START | Running 2 tests 13:48:06 INFO - TEST-START | dromaeo_css 13:48:06 INFO - operating with platform_type : mac_ 13:48:06 INFO - Initialising browser for dromaeo_css test... 13:48:06 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmp4h4cFU/profile http://localhost:49241/getInfo.html) 13:48:09 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 13:48:09 INFO - PROCESS | 1634 | colorDepth:24 13:48:09 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 13:48:09 INFO - PROCESS | 1634 | __metrics 13:48:09 INFO - PROCESS | 1634 | 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" 13:48:09 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:48:10 INFO - TEST-INFO | 1634: exit 0 13:48:10 INFO - Browser initialized. 13:48:10 INFO - Running cycle 1/1 for dromaeo_css test... 13:48:10 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmp4h4cFU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:48:22 INFO - PROCESS | 1636 | RSS: Main: 214568960 13:48:22 INFO - PROCESS | 1636 | 13:51:26 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 13:51:28 INFO - PROCESS | 1636 | RSS: Main: 346845184 13:51:28 INFO - PROCESS | 1636 | 13:53:12 INFO - PROCESS | 1636 | ************************* 13:53:12 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 13:53:12 INFO - PROCESS | 1636 | 13:53:12 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:53:12 INFO - PROCESS | 1636 | Full stack: 13:53:12 INFO - PROCESS | 1636 | ************************* 13:54:31 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 13:54:32 INFO - PROCESS | 1636 | RSS: Main: 351531008 13:54:32 INFO - PROCESS | 1636 | 13:57:34 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 13:57:35 INFO - PROCESS | 1636 | RSS: Main: 349270016 13:57:35 INFO - PROCESS | 1636 | 14:00:37 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 14:00:38 INFO - PROCESS | 1636 | RSS: Main: 313155584 14:00:38 INFO - PROCESS | 1636 | 14:03:41 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 14:03:42 INFO - PROCESS | 1636 | RSS: Main: 321175552 14:03:42 INFO - PROCESS | 1636 | 14:06:46 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 14:06:46 INFO - PROCESS | 1636 | RSS: Main: 511856640 14:06:46 INFO - PROCESS | 1636 | 14:06:46 INFO - PROCESS | 1636 | __start_tp_report 14:06:46 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 14:06:46 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 14:06:46 INFO - PROCESS | 1636 | |i|pagename|runs| 14:06:46 INFO - PROCESS | 1636 | |0;dojo.html;3106.860191291392;3387.1024178592693;3396.7792093513913;3440.5527281453406;3470.8091054991964;6032.969835150823;6070.089486577016;6070.210872586557;6093.5429842761805;6104.938950610493;5996.610220335675;6094.17728606638;6099.7865074722395;6108.908366374497;6118.38816118388;5368.543673787723;5414.998225328307;5432.945670543283;5452.4274951130155;5542.5565954723525;5323.733813309338;5350.143976963686;5374.973125134388;5525.0883604205255;5526.06056970316;5442.428545002757;5457.399686034533;5478.835634930959;5505.724713764316;5534.252875861767;5495.450454954513;5503.7798488060425;5506;5513.751881165317;5514.503694667479;5268.157094864841;5354.866128346784;5438.91841622376;5446.863828404282;5509.696966666832;5911.054231322968;5964.552658550582;5971.343152253248;5973.074173503114;5977.790777322773;6262.373762623747;6264.966280563702;6270.31026587075;6271.34150914152;6274.341194174637;6321.0834429008;6382.744690212386;6394.200724909387;6405.167328247345;6455.354464553554;5215.295935048758;6173;6211.65835879031;6216.937830621727;6232.563720539519;6591.110200123018;6643.667816609247;6657.267700552935;6659.600423974577;6676.198856137197;6220.377962203744;6224.62652240867;6266.780662676875;6279.874402511924;6282.340354262737;6422.293547709748;6428.742850286029;6431.260405053479;6438.195225596801;6451.161349024596;6327.272363678144;6336.778212762531;6338.207724034496;6354.110424540568;6355.904661430082;5704.600677952503;5951.791687291011;6249.218847644044;6274.6548939807835;6285.59143655661;5093.694378337312;5095.85343297755;5104.846854594368;5113.258577506241;5122.769475373617;4517.435320584927;4550.97724511382;4557.567031132037;4573.885652858705;4642.025174713348;5977.103434484862;6002.969985150046;6009.278886533557;6049.0926361046195;6049.606775559574;6138.051223665364;6289.779857704958;6291.748330066837;6368.904466433008;6422.42198202164;6151.83115208109;6181.381861813873;6188.628682279078;6190.597611155261;6209.19280493542;5707.4577915098;5719.714014299351;5734.856628584319;5737.426257374313;5772.393898640582;6374.107624932606;6413.615183089029;6499.155109835691;6735.797926062226;6746.055552222692;6277.529185311211;6285.057241413824;6301.117843502005;6303.086052522267;6307.36926307384;6579.769708060195;6637.900431493628;6661.833454163685;6719.361660642231;6722.428593569602;6336;6339.429451349401;6340.175777148941;6354.3963323484195;6357.1735674362035;6202.596831205957;6438.8390290243115;6445.355464453517;6456.7740129095255;6458.160439142881;5144.408393034849;5911.438413350725;6140.412224875342;6147.907781383194;6269.435750782452;6239.188905442445;6241.986739769247;6273.560850740587;6275.843103922439;6305.211848518935;6109.450149486567;6280.685965701788;6293.087502312231;6301.306856245901;6305.085762564311;6155.907661384993;6165.691715414122;6249.437550620466;6256.749730010749;6265.56141070139;6259.874802504016;6288.968555157195;6289.371062893674;6299.527535434769;6306.873862522815 14:06:46 INFO - PROCESS | 1636 | |1;ext.html;769.1731388757086;789.9802504937375;841.7306461932184;853.5860107847693;857.2199298638241;37286.254274914485;37996.81001594988;38105.61894381062;38106.856794296145;38151.046223844416;38517.22965540695;38714.612853871455;38728.419073713914;38749.22501549967;38818.835434936926;7138.8572228555395;8865.911340886605;9026.86459703105;9029.006809250977;9034.819303613956;7334.083239595051;10467.633632822854;10627.096696780744;10825.566977320897;10929.726756831064;9819.656312029081;10812.513436895319;10814.72963175923;10840.891591084068;10842.024217820395;7173.426125909915;10773.5690572377;10797.190210734187;10812;10820.296680715728;7155.749548765821;10458.68623941283;10699.358038517714;10712.303700259457;10720.78558428835;37094.07264818401;37352.25295494102;37355.813220934;37358;37365;3762.849486020556;3786.0164219955213;3786.8863934082024;3787.223619158066;3883.184531248413;23381.883090584608;23407.194617751637;24835;25339.873300633564;26440.074597389;3033.635963684372;3070.3705740323403;3080.7073328033803;3099.1322429719717;3221.903342899717;340096.2995185033;340591;340648;340819;341176;40991.795041024605;41176.58823411787;50451.74774126106;50476.74761626168;50624.74687626538;43368.783156084646;51745.74127129416;52021;52141.217881731805;52174;13604.93197534006;13657.975651826153;13678.52125175634;13685.384157712926;13691.657708557166;11831.408429578487;11851.170418070653;11858.991985681314;11865.466054027589;11885.168038237412;11383.715407114723;11426.485808138654;11455.656330310105;11486.425678716198;11525.366104864146;5022.874428139326;5134.101532231844;5355.732213389393;5440.211169380417;5462.781488740406;763.6868883757633;921.4102974096584;925.1349987761464;937.2829785214317;969.7575606098476;25480.617790733155;26538.071167509046;26762;27426.725732742816;27550.862245688644;1009.535613617744;1019.5666841592293;1021.5964693945998;1025.8102251083574;1040.5837664934088;13511.189328640314;13864.722705545833;14234.501792437422;14254.501092461715;14262.930280228817;443682;445630;446521;447324;447899;53047.93904121973;53160.468395316326;53164;53248.73375633097;53350.73324633352;1339.4909934224931;1370.0683535195963;1442.2067862675697;1443.2783608195903;1443.978340324896;24545;26661.466770664865;27026;27273.59089613697;27760.44479110447;44447;44548.77725611351;44605.55394446144;44731;44739.55260447354;424538;424736;425399;425721;426754.8662256669;26857.86571067132;27265.59101613517;27951.742171602735;32331;32535.674643254213;38115.047123821016;42560.36159457549;42834;44277.335839963074;44415;33171.50242746409;34612.65387346094;34934;35652;35704.82147589245;34231.65768342285;34653.82673086618;35249.1187720309;35340.29319413546;35524;34008.829955851055;34753.65246347504;35442.291154177285;35669.28661426809;35670.82164589161;29733.702662973094;31224.531632025082;31226.375472490876;31445.685543144275;31478.842605786824;23355.53288934178;23737.78420917065;23963;24131.914063866818;24142.87928560346 14:06:46 INFO - PROCESS | 1636 | |2;jquery.html;373.5330836454432;396.44101816438825;408.50978825409504;418.38706295277416;435.5448556258709;12840.871591284083;14643.341049652765;20842.89578552105;21133.943302834836;21357.252496162637;20335.389938301836;20803.687944680805;21308;21968.45078873029;22265.44336391587;6460.41856232939;6756.12170417845;6999.580025198479;7321.78034658961;7503.399728021773;7101.721690095781;7236.2401947795515;7415.517991330573;7431.591262480561;7440.107187137524;7309.6345182740915;7311.524750891202;7322.633868306563;7334.889976650355;7335.266473352649;6333.366663333676;7082.2563630818795;7333.926660733405;7451.515651482637;7454.664540095709;6981.965090174516;7159.284071592851;7199.964000179965;7244.094488188976;7266.237045110241;23570.939307731023;24615.87692061546;24782.752172478224;25255.747442525524;25588.104416345337;2692.3000019994747;2783.7912156588136;2804.1447358555633;2833.6032955386263;2875.1087162979543;14858.2570871456;14859.777103343458;14880.553583392408;14958.700825983527;15862.206889655472;1947.260041184355;1963.9018049097488;1988.3140316590752;2000.9099590518463;2026.5845501672122;144916;150986;157511.42488575197;159697;162420.37579624288;19415.902920485307;19532.414027579194;19581.41255762301;19714.507137321394;19754.155900407783;29768.40463190724;30086.54870176949;30098.69901300959;30143;30208.848955755082;8399.62201700925;9722.319437639297;9809.607615695435;10002.799944001225;10156.339837910513;8314.750557483285;8335;8345.707900223462;8490.660373585111;8515.57422128891;7389.778306650809;8121.675132994732;8419.915800842036;8711.564421778885;9035;3290.68738469845;3810.8856734298015;3909.5113110861143;3913.5951722001473;3931;756.4137793210306;848.8896443462311;873.8427083124972;880.3573391424296;909.5179554835947;15158.848411515744;20378.592428151354;21034.053467593996;21106;21461.463463413227;889.5596679643618;891.4963045879058;900.8738776571286;911.4303560274828;919.797644518205;9773.364731292444;10646.787064258671;10732.141428685687;10747.710274767078;11161.776764464828;724048;751522;763523.6414361367;769893.1505342438;779016;146461;147579.2621036888;148703;151361;152575.23712381368;1209.7580483903255;1229.9877001230052;1258.1256027061288;1263.4693428759942;1263.92416455013;17901.73147402816;18853.717194241824;18911.148998295386;18917.243310267986;18951.71572426387;63493.73012539631;63579;64070.35929640644;64404.45775482206;65027;88742;89828.5508572453;91678;92067;92401.61397579176;11170.385628790169;11341.489632966372;11399.829002564802;11536.884631153582;11580;12366.381680916098;12405.62783116508;12692.36538173106;12705.17416367933;12713.555025574431;10137.44244066554;10683.489379995539;10778.407187604756;10911.618093366695;10959.56161753521;11218.719532011439;11398.259113157617;11531.308121512737;11810.527578896748;11837.704057398634;10702.91354879805;11082.279651822606;11324;11549;11701.76596468083;11507.884921150682;11607.187496875475;11672.766544669228;11809.586664467046;11933;10828.980556493216;10997.780044399227;11062.668119956414;11154.442277885912;11177.776444470903 14:06:46 INFO - PROCESS | 1636 | |3;mootools.html;1513.4702854001093;1537.2237020304744;1561.5783738390635;1586.7857839191713;1592.2755146408385;10598.205134614906;11199.160062995266;11205.607803726862;11206;11231;10473.423961682105;10944.45277736112;10981.231313808037;10989.670309890696;11008.559657613685;2277.39648993017;2307.042577330406;2314.4908120213527;2316.4324740438615;2318.40880575453;2298.321995011467;2329.0683726509365;2337.497438050819;2340.0405833608224;2340.414896275931;2306.2965795432387;2325.104834638659;2334.323046316566;2335.2177020698086;2338.6725858379755;2268.8184945204343;2277.339571524264;2285.0517035430275;2285.337252196861;2291.5875142474347;2263.343630347197;2337.076854642407;2338.356951838241;2342.4143964009;2345.0854166874933;10803.189760767895;10900.890991090067;10904.127669786478;10921.399323037229;10928.781424371467;5369.3556773187465;5528.281323427969;5529.917051244234;5531.032069387881;5533.114701647757;3118.953215701766;3238.7247083997654;3361.4873307011944;3373.831308434593;3393.3213357328386;1095.2552264460164;1108.0636861851722;1124.415304041902;1153.826925961104;1183.1836033137108;11832.526698932032;13733.862661373358;14067.226302553356;14419.351129199107;15263.771043434357;4316.438862947797;4322.675799315064;4502.369668246448;4512.210363186429;4512.52618475062;11372.715682108013;11379.431028448544;11383.487743051583;11384.487698053608;11399.886001139883;4723.622110231173;4891.706497610155;5239.869003274873;5467.835964921059;5497.505224529731;5005.074061298671;5006.799728010838;5007.3240112584335;5014.247862820534;5018.473060328686;3547.875824346187;3633.4913112164318;3668.9633103669157;3682.2451397463456;3682.3187710273687;773.7949443397504;918.1231923513029;921.5622579274925;922.1792604581927;926.2451102351697;916.6883259691737;929.2426672262085;940.6143481172686;941.1952780372683;991.3110388280076;6436.678166091677;6505.804825855232;6587.209534855848;6670.299618539983;6682.599044057372;986.3194395866828;987.5976113918254;998.1914649134225;1005.0502275349725;1010.0555980158575;4113.259613269581;4118.567550407224;4127.174565086934;4220.78896055196;4299.935500967488;13044.608661740163;13359.53241636538;13478.326083695776;13492.190468571916;13510.256935868621;13389.062765606313;13398.995075369387;13414.195148291134;13419.463221471031;13428.127171734002;8459.95770021146;9666.709998700051;10084.69745907624;10143.137833284254;10156.390616562881;5739.397363276963;6479.157709497735;6578.605283682994;6793.660316984032;6857.108575885103;11784;12096.153269271066;12107.33409662477;12206.633800985985;12233.510659573873;11051.447427628747;12327.93836030814;12402.689932751753;12462.813057803958;12477;8961.148690874357;9264.53677316145;9267.212286955684;9272.979972202917;9277.814443711222;9682.419054856731;10049.849252261076;10107.949460252652;10143;10253.948730256301;8881.822363552821;8909.688160914337;8953.328500362368;9053.2304754094;9176.495292758962;8727.869081963903;8734.91265087341;8767.298616110824;8825.69110081144;8832.116788321373;7603.391728661583;7607.16321204656;7684.193159718149;7700.576468294297;7707.383409327128;5681.460261275172;5697.800576979786;5841.795537156179;5908.615939963888;5974.462298393166;4887.193613053806;5501.449855014466;5597.860053498695;5800.651960882361;5969.224000879858 14:06:46 INFO - PROCESS | 1636 | |4;prototype.html;373.31310388884447;373.37087008390864;373.89157144428117;384.13569468695437;384.90762217067896;4431;4643.466001409839;4747.382840230774;5034.597232221423;5053.292539044537;4287.856071964018;4658.440987081555;4667;4888.951110488894;4920.065187614351;3672.7061835053264;4010.7192496525254;4083.8570650027254;4134.338505839067;4167.583241675831;3747.5315585551807;3771.8123488376677;4016.8393264269394;4133.896652583694;4164.209389962315;3570.3394871948644;3768.792716400597;3911.8630847920326;4137.875863724078;4180.954761309673;3492.842822073;4115.736345010232;4122.299209134454;4188.371744238359;4259.531451540328;3848.634379733921;3863.594322596115;3864.343061679493;3866.46746381118;3918.725689201757;4245.662616275863;4520.005598768299;4725.086340032258;4755.2153894607345;4924.20266602691;3982.6216509431556;4420.778961051967;4538.7503687297185;4560.657950653715;4804.495527969582;4740;4858.29554714568;5222.060029194743;5294.708791016493;5314.787408503656;3835.1016246957656;4145.461090058303;4208.621224089816;4238.19474299882;4364.738115713068;4621.903324772411;5346.91979620306;5380.762424642315;5416.783328666888;5705.258316418881;3449.7757645752945;4278.700490965664;4311.762853043113;4327.242732521796;4404.097160082176;4180.331147016463;4409.867703968886;4413.801378937956;4456.264716321771;4463.308187230984;4738.976305118453;4750.857474275777;4758.286257061469;4794.400699912511;4864.927026094611;4159.875203743893;4796.395460358026;4927.669529227161;5247.685138891602;5338.092524270884;1304.8890844278153;1379.8206233189621;1489.8882583806258;1527.57991552324;1535.5316628428436;1086.7936590384666;1141.6460897121754;1144.404909447083;1155.826626006089;1162.4478372773035;4535.4103966484145;5018.29743835856;5034.295198672189;5052.932389426547;5058.797648094109;4915.311856340115;5077.898442031139;5100.744962751847;5257.6845389276;5326.97336513315;4684.634259698831;4891.926621100686;4912.38595175603;5034.723090229999;5038.060346766521;2579.3164811325014;2639.9604005939927;2881.3084859633536;2911.5923770672125;2921.9269518262213;5289.761960711778;5383.43473935239;5685.715714214272;5749.741261643236;5808.79669211584;4665.923663969569;5039.899202015939;5282.498162674539;5623.48165995179;5727.914081288784;5035.370578677665;5314.867128321823;5518.951399234213;5567.66594004361;5765.4811067004175;5199.974000130126;5480.013392700907;5501.752421141138;5524.309461317335;5542.060278902352;5025.39695236574;5030.5975521957425;5165.457626949266;5188.636795424284;5239.083160446983;5321.707306098202;5445.53712934405;5659.745311461076;5748.741306641127;5763.971180144073;3883.786391748481;4048.9797551012057;4200.348945913388;4336.804843781974;4365.257906155897;4224.408582798349;4638.466576343763;5248.063952035973;5434.429384914527;5602.85992850182;5037.262144560121;5395.919061214006;5401.729913504388;5423.538999185113;5425.755840987244;5182.948170518246;5370.650907690988;5377.139657654757;5390.380106287827;5394.9460505394445;5113.630737238322;5207.3230480037355;5221.947780522298;5265.763040663256;5269.024115956517;4417.514073451854;4790.520947905182;5268.683878967274;5337.822312357008;5340.252364669027;4560.566746159109;4634.907301853877;4863.805447782191;5234.1102012657175;5262.289590905332 14:06:46 INFO - PROCESS | 1636 | |5;yui.html;663.3068443476567;685.513285567247;705.7529864547406;765.4182821055999;823.8846561481394;14958.252087395642;15523.68952620947;15676.686466270668;15682.451114211004;15693;14238.572842814707;14304.785428218585;14316.35576399062;14530.98283120182;14699.044562103456;897.6319708919328;913.182701482173;915.7252824152761;917.312015988009;917.8302014127407;761.6344154805697;916.6837441082815;924.089771574998;924.7364501117183;925.9166674999249;965.16031052984;975.7804493988866;975.8487434447636;984.970450886471;986.5264672956985;969.3892847506027;970.4080510888352;970.6214576315243;972.2125078686287;973.6300205921775;722.7795522365676;724.9673764680603;726.7093162734895;726.9600171990538;727.0766127018657;15287.082775033534;15619.531414057596;15852.128132952683;16022.75965860513;16099.356025758956;13645.931770341085;13973.23147226902;14041.85958140426;14160.92919535406;14165.71668566623;11473.541058357656;11637;11799.292042477478;11922.761544769057;12240.44917978693;3586.4799604057266;3625.981870090659;3633.400488919325;3694.832025869804;3721.218544105741;106937;107896;110522.44738776254;111125.44437277842;111621;10473.37159770401;10655.946720266504;10786;10813.891861081445;10978.615748448767;20280.29018984358;21029;21511.56976860454;21587.35237942864;21637.026333815014;6472.349550864499;6833.487488438387;7627.389808815282;7711.38308935295;7755.806104847424;4164.208800327989;4252.893677658021;4258.339957306623;4273;4277.486701595828;3305.4380755271663;3374.2913988062783;3387.542681737983;3417.231122997355;3417.3677869594203;539.1885212754858;613.5735663713676;619.2352444730753;625.780976658166;634.7587916591666;645.9806205813833;671.9025741267488;680.9250982391933;692.3630260160664;708.0052526200697;9898.851517227247;10111.544980475895;10139.340942838691;10247.538860751283;10369.792604148026;691.2016620802981;694.9826254343682;698.5180225644289;702.2521015118882;720.5604581205461;4262.062346283813;4664.253719404879;4714.834980775657;4743.169945259566;4846.588040016638;106893;107021.76031178923;109550;110161.44919275513;110258;90472;91271.0872891276;92783.14433711288;93965;94880.52559737157;79920.20079799127;80716;80876;83056.99999999879;84864;9391.154796068387;9434.622615095594;9471.431714097176;9488.098630630078;9543.093406126407;37892.43161352637;50799;50882.49117508777;52276.7386163082;52367.69080773011;50605.74697126491;66416.66791666011;68558.97161542482;69470.65264673645;69514.65242673755;10668.98644628759;11218.607348743082;11361.659150225507;11621.171853654969;11639.6508104757;11904.464299106388;12083.972862306802;12487;13240.337983100999;13471.305738852465;10507.474626268504;10980.835287470534;11503.769924601294;11949.880501194877;12254.142210045211;11587.304761714324;11996.940015299868;12253.938730306292;12281.754364912831;12407.503699851904;11259.831102533632;11745.23655962394;11751.382121090077;11756.23584467007;11965.76068478643;9446.385984911234;9754.414735115915;10071.143952764098;10112.84830727525;10197.23520735933;7492.812679682834;8230.958845205736;8948.642054317754;10858.2399232053;11320.886791131983 14:06:46 INFO - PROCESS | 1636 | __end_tp_report 14:06:46 INFO - PROCESS | 1636 | __start_cc_report 14:06:46 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1699 14:06:46 INFO - PROCESS | 1636 | __end_cc_report 14:06:46 INFO - PROCESS | 1636 | __startTimestamp1490044006444__endTimestamp 14:06:46 INFO - PROCESS | 1636 | 14:06:46 INFO - PROCESS | 1636 | ------- Summary: start ------- 14:06:46 INFO - PROCESS | 1636 | Number of tests: 6 14:06:46 INFO - PROCESS | 1636 | 14:06:46 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5948.54 Median:6209.19 stddev:661.25 (10.6%) stddev-sans-first:624.57 14:06:46 INFO - PROCESS | 1636 | Values: 3106.9 3387.1 3396.8 3440.6 3470.8 6033.0 6070.1 6070.2 6093.5 6104.9 5996.6 6094.2 6099.8 6108.9 6118.4 5368.5 5415.0 5432.9 5452.4 5542.6 5323.7 5350.1 5375.0 5525.1 5526.1 5442.4 5457.4 5478.8 5505.7 5534.3 5495.5 5503.8 5506.0 5513.8 5514.5 5268.2 5354.9 5438.9 5446.9 5509.7 5911.1 5964.6 5971.3 5973.1 5977.8 6262.4 6265.0 6270.3 6271.3 6274.3 6321.1 6382.7 6394.2 6405.2 6455.4 5215.3 6173.0 6211.7 6216.9 6232.6 6591.1 6643.7 6657.3 6659.6 6676.2 6220.4 6224.6 6266.8 6279.9 6282.3 6422.3 6428.7 6431.3 6438.2 6451.2 6327.3 6336.8 6338.2 6354.1 6355.9 5704.6 5951.8 6249.2 6274.7 6285.6 5093.7 5095.9 5104.8 5113.3 5122.8 4517.4 4551.0 4557.6 4573.9 4642.0 5977.1 6003.0 6009.3 6049.1 6049.6 6138.1 6289.8 6291.7 6368.9 6422.4 6151.8 6181.4 6188.6 6190.6 6209.2 5707.5 5719.7 5734.9 5737.4 5772.4 6374.1 6413.6 6499.2 6735.8 6746.1 6277.5 6285.1 6301.1 6303.1 6307.4 6579.8 6637.9 6661.8 6719.4 6722.4 6336.0 6339.4 6340.2 6354.4 6357.2 6202.6 6438.8 6445.4 6456.8 6458.2 5144.4 5911.4 6140.4 6147.9 6269.4 6239.2 6242.0 6273.6 6275.8 6305.2 6109.5 6280.7 6293.1 6301.3 6305.1 6155.9 6165.7 6249.4 6256.7 6265.6 6259.9 6289.0 6289.4 6299.5 6306.9 14:06:46 INFO - PROCESS | 1636 | 14:06:46 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:54096.36 Median:34703.74 stddev:107773.53 (310.6%) stddev-sans-first:108001.49 14:06:46 INFO - PROCESS | 1636 | Values: 769.2 790.0 841.7 853.6 857.2 37286.3 37996.8 38105.6 38106.9 38151.0 38517.2 38714.6 38728.4 38749.2 38818.8 7138.9 8865.9 9026.9 9029.0 9034.8 7334.1 10467.6 10627.1 10825.6 10929.7 9819.7 10812.5 10814.7 10840.9 10842.0 7173.4 10773.6 10797.2 10812.0 10820.3 7155.7 10458.7 10699.4 10712.3 10720.8 37094.1 37352.3 37355.8 37358.0 37365.0 3762.8 3786.0 3786.9 3787.2 3883.2 23381.9 23407.2 24835.0 25339.9 26440.1 3033.6 3070.4 3080.7 3099.1 3221.9 340096.3 340591.0 340648.0 340819.0 341176.0 40991.8 41176.6 50451.7 50476.7 50624.7 43368.8 51745.7 52021.0 52141.2 52174.0 13604.9 13658.0 13678.5 13685.4 13691.7 11831.4 11851.2 11859.0 11865.5 11885.2 11383.7 11426.5 11455.7 11486.4 11525.4 5022.9 5134.1 5355.7 5440.2 5462.8 763.7 921.4 925.1 937.3 969.8 25480.6 26538.1 26762.0 27426.7 27550.9 1009.5 1019.6 1021.6 1025.8 1040.6 13511.2 13864.7 14234.5 14254.5 14262.9 443682.0 445630.0 446521.0 447324.0 447899.0 53047.9 53160.5 53164.0 53248.7 53350.7 1339.5 1370.1 1442.2 1443.3 1444.0 24545.0 26661.5 27026.0 27273.6 27760.4 44447.0 44548.8 44605.6 44731.0 44739.6 424538.0 424736.0 425399.0 425721.0 426754.9 26857.9 27265.6 27951.7 32331.0 32535.7 38115.0 42560.4 42834.0 44277.3 44415.0 33171.5 34612.7 34934.0 35652.0 35704.8 34231.7 34653.8 35249.1 35340.3 35524.0 34008.8 34753.7 35442.3 35669.3 35670.8 29733.7 31224.5 31226.4 31445.7 31478.8 23355.5 23737.8 23963.0 24131.9 24142.9 14:06:46 INFO - PROCESS | 1636 | 14:06:46 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:43049.65 Median:22918.19 stddev:126361.29 (551.4%) stddev-sans-first:126675.13 14:06:46 INFO - PROCESS | 1636 | Values: 373.5 396.4 408.5 418.4 435.5 12840.9 14643.3 20842.9 21133.9 21357.3 20335.4 20803.7 21308.0 21968.5 22265.4 6460.4 6756.1 6999.6 7321.8 7503.4 7101.7 7236.2 7415.5 7431.6 7440.1 7309.6 7311.5 7322.6 7334.9 7335.3 6333.4 7082.3 7333.9 7451.5 7454.7 6982.0 7159.3 7200.0 7244.1 7266.2 23570.9 24615.9 24782.8 25255.7 25588.1 2692.3 2783.8 2804.1 2833.6 2875.1 14858.3 14859.8 14880.6 14958.7 15862.2 1947.3 1963.9 1988.3 2000.9 2026.6 144916.0 150986.0 157511.4 159697.0 162420.4 19415.9 19532.4 19581.4 19714.5 19754.2 29768.4 30086.5 30098.7 30143.0 30208.8 8399.6 9722.3 9809.6 10002.8 10156.3 8314.8 8335.0 8345.7 8490.7 8515.6 7389.8 8121.7 8419.9 8711.6 9035.0 3290.7 3810.9 3909.5 3913.6 3931.0 756.4 848.9 873.8 880.4 909.5 15158.8 20378.6 21034.1 21106.0 21461.5 889.6 891.5 900.9 911.4 919.8 9773.4 10646.8 10732.1 10747.7 11161.8 724048.0 751522.0 763523.6 769893.2 779016.0 146461.0 147579.3 148703.0 151361.0 152575.2 1209.8 1230.0 1258.1 1263.5 1263.9 17901.7 18853.7 18911.1 18917.2 18951.7 63493.7 63579.0 64070.4 64404.5 65027.0 88742.0 89828.6 91678.0 92067.0 92401.6 11170.4 11341.5 11399.8 11536.9 11580.0 12366.4 12405.6 12692.4 12705.2 12713.6 10137.4 10683.5 10778.4 10911.6 10959.6 11218.7 11398.3 11531.3 11810.5 11837.7 10702.9 11082.3 11324.0 11549.0 11701.8 11507.9 11607.2 11672.8 11809.6 11933.0 10829.0 10997.8 11062.7 11154.4 11177.8 14:06:46 INFO - PROCESS | 1636 | 14:06:46 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:6563.07 Median:3300.11 stddev:4124.69 (125.0%) stddev-sans-first:4118.81 14:06:46 INFO - PROCESS | 1636 | Values: 1513.5 1537.2 1561.6 1586.8 1592.3 10598.2 11199.2 11205.6 11206.0 11231.0 10473.4 10944.5 10981.2 10989.7 11008.6 2277.4 2307.0 2314.5 2316.4 2318.4 2298.3 2329.1 2337.5 2340.0 2340.4 2306.3 2325.1 2334.3 2335.2 2338.7 2268.8 2277.3 2285.1 2285.3 2291.6 2263.3 2337.1 2338.4 2342.4 2345.1 10803.2 10900.9 10904.1 10921.4 10928.8 5369.4 5528.3 5529.9 5531.0 5533.1 3119.0 3238.7 3361.5 3373.8 3393.3 1095.3 1108.1 1124.4 1153.8 1183.2 11832.5 13733.9 14067.2 14419.4 15263.8 4316.4 4322.7 4502.4 4512.2 4512.5 11372.7 11379.4 11383.5 11384.5 11399.9 4723.6 4891.7 5239.9 5467.8 5497.5 5005.1 5006.8 5007.3 5014.2 5018.5 3547.9 3633.5 3669.0 3682.2 3682.3 773.8 918.1 921.6 922.2 926.2 916.7 929.2 940.6 941.2 991.3 6436.7 6505.8 6587.2 6670.3 6682.6 986.3 987.6 998.2 1005.1 1010.1 4113.3 4118.6 4127.2 4220.8 4299.9 13044.6 13359.5 13478.3 13492.2 13510.3 13389.1 13399.0 13414.2 13419.5 13428.1 8460.0 9666.7 10084.7 10143.1 10156.4 5739.4 6479.2 6578.6 6793.7 6857.1 11784.0 12096.2 12107.3 12206.6 12233.5 11051.4 12327.9 12402.7 12462.8 12477.0 8961.1 9264.5 9267.2 9273.0 9277.8 9682.4 10049.8 10107.9 10143.0 10253.9 8881.8 8909.7 8953.3 9053.2 9176.5 8727.9 8734.9 8767.3 8825.7 8832.1 7603.4 7607.2 7684.2 7700.6 7707.4 5681.5 5697.8 5841.8 5908.6 5974.5 4887.2 5501.4 5597.9 5800.7 5969.2 14:06:46 INFO - PROCESS | 1636 | 14:06:46 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4426.39 Median:4753.04 stddev:1228.27 (25.8%) stddev-sans-first:1193.45 14:06:46 INFO - PROCESS | 1636 | Values: 373.3 373.4 373.9 384.1 384.9 4431.0 4643.5 4747.4 5034.6 5053.3 4287.9 4658.4 4667.0 4889.0 4920.1 3672.7 4010.7 4083.9 4134.3 4167.6 3747.5 3771.8 4016.8 4133.9 4164.2 3570.3 3768.8 3911.9 4137.9 4181.0 3492.8 4115.7 4122.3 4188.4 4259.5 3848.6 3863.6 3864.3 3866.5 3918.7 4245.7 4520.0 4725.1 4755.2 4924.2 3982.6 4420.8 4538.8 4560.7 4804.5 4740.0 4858.3 5222.1 5294.7 5314.8 3835.1 4145.5 4208.6 4238.2 4364.7 4621.9 5346.9 5380.8 5416.8 5705.3 3449.8 4278.7 4311.8 4327.2 4404.1 4180.3 4409.9 4413.8 4456.3 4463.3 4739.0 4750.9 4758.3 4794.4 4864.9 4159.9 4796.4 4927.7 5247.7 5338.1 1304.9 1379.8 1489.9 1527.6 1535.5 1086.8 1141.6 1144.4 1155.8 1162.4 4535.4 5018.3 5034.3 5052.9 5058.8 4915.3 5077.9 5100.7 5257.7 5327.0 4684.6 4891.9 4912.4 5034.7 5038.1 2579.3 2640.0 2881.3 2911.6 2921.9 5289.8 5383.4 5685.7 5749.7 5808.8 4665.9 5039.9 5282.5 5623.5 5727.9 5035.4 5314.9 5519.0 5567.7 5765.5 5200.0 5480.0 5501.8 5524.3 5542.1 5025.4 5030.6 5165.5 5188.6 5239.1 5321.7 5445.5 5659.7 5748.7 5764.0 3883.8 4049.0 4200.3 4336.8 4365.3 4224.4 4638.5 5248.1 5434.4 5602.9 5037.3 5395.9 5401.7 5423.5 5425.8 5182.9 5370.7 5377.1 5390.4 5394.9 5113.6 5207.3 5221.9 5265.8 5269.0 4417.5 4790.5 5268.7 5337.8 5340.3 4560.6 4634.9 4863.8 5234.1 5262.3 14:06:46 INFO - PROCESS | 1636 | 14:06:46 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20518.41 Median:4208.55 stddev:30584.05 (726.7%) stddev-sans-first:30633.51 14:06:46 INFO - PROCESS | 1636 | Values: 663.3 685.5 705.8 765.4 823.9 14958.3 15523.7 15676.7 15682.5 15693.0 14238.6 14304.8 14316.4 14531.0 14699.0 897.6 913.2 915.7 917.3 917.8 761.6 916.7 924.1 924.7 925.9 965.2 975.8 975.8 985.0 986.5 969.4 970.4 970.6 972.2 973.6 722.8 725.0 726.7 727.0 727.1 15287.1 15619.5 15852.1 16022.8 16099.4 13645.9 13973.2 14041.9 14160.9 14165.7 11473.5 11637.0 11799.3 11922.8 12240.4 3586.5 3626.0 3633.4 3694.8 3721.2 106937.0 107896.0 110522.4 111125.4 111621.0 10473.4 10655.9 10786.0 10813.9 10978.6 20280.3 21029.0 21511.6 21587.4 21637.0 6472.3 6833.5 7627.4 7711.4 7755.8 4164.2 4252.9 4258.3 4273.0 4277.5 3305.4 3374.3 3387.5 3417.2 3417.4 539.2 613.6 619.2 625.8 634.8 646.0 671.9 680.9 692.4 708.0 9898.9 10111.5 10139.3 10247.5 10369.8 691.2 695.0 698.5 702.3 720.6 4262.1 4664.3 4714.8 4743.2 4846.6 106893.0 107021.8 109550.0 110161.4 110258.0 90472.0 91271.1 92783.1 93965.0 94880.5 79920.2 80716.0 80876.0 83057.0 84864.0 9391.2 9434.6 9471.4 9488.1 9543.1 37892.4 50799.0 50882.5 52276.7 52367.7 50605.7 66416.7 68559.0 69470.7 69514.7 10669.0 11218.6 11361.7 11621.2 11639.7 11904.5 12084.0 12487.0 13240.3 13471.3 10507.5 10980.8 11503.8 11949.9 12254.1 11587.3 11996.9 12253.9 12281.8 12407.5 11259.8 11745.2 11751.4 11756.2 11965.8 9446.4 9754.4 10071.1 10112.8 10197.2 7492.8 8231.0 8948.6 10858.2 11320.9 14:06:46 INFO - PROCESS | 1636 | -------- Summary: end -------- 14:06:46 INFO - PROCESS | 1636 | 14:06:47 INFO - TEST-INFO | 1636: exit 0 14:06:47 INFO - TEST-OK | dromaeo_css | took 1120335ms 14:06:47 INFO - TEST-START | kraken 14:06:47 INFO - operating with platform_type : mac_ 14:06:47 INFO - Initialising browser for kraken test... 14:06:47 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpU6Sh7A/profile http://localhost:49241/getInfo.html) 14:06:49 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 14:06:49 INFO - PROCESS | 1645 | colorDepth:24 14:06:49 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 14:06:49 INFO - PROCESS | 1645 | __metrics 14:06:49 INFO - PROCESS | 1645 | 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" 14:06:49 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:50 INFO - TEST-INFO | 1645: exit 0 14:06:50 INFO - Browser initialized. 14:06:50 INFO - Running cycle 1/1 for kraken test... 14:06:50 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpU6Sh7A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:02 INFO - PROCESS | 1646 | RSS: Main: 214851584 14:07:02 INFO - PROCESS | 1646 | 14:07:05 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 14:07:06 INFO - PROCESS | 1646 | RSS: Main: 267489280 14:07:06 INFO - PROCESS | 1646 | 14:07:08 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 14:07:09 INFO - PROCESS | 1646 | RSS: Main: 278908928 14:07:09 INFO - PROCESS | 1646 | 14:07:12 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 14:07:13 INFO - PROCESS | 1646 | RSS: Main: 376401920 14:07:13 INFO - PROCESS | 1646 | 14:07:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 14:07:15 INFO - PROCESS | 1646 | RSS: Main: 280322048 14:07:15 INFO - PROCESS | 1646 | 14:07:17 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:07:18 INFO - PROCESS | 1646 | RSS: Main: 281632768 14:07:18 INFO - PROCESS | 1646 | 14:07:21 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 14:07:21 INFO - PROCESS | 1646 | RSS: Main: 321298432 14:07:21 INFO - PROCESS | 1646 | 14:07:24 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 14:07:25 INFO - PROCESS | 1646 | RSS: Main: 322797568 14:07:25 INFO - PROCESS | 1646 | 14:07:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 14:07:28 INFO - PROCESS | 1646 | RSS: Main: 320012288 14:07:28 INFO - PROCESS | 1646 | 14:07:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:07:31 INFO - PROCESS | 1646 | RSS: Main: 295272448 14:07:31 INFO - PROCESS | 1646 | 14:07:32 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:07:33 INFO - PROCESS | 1646 | RSS: Main: 299515904 14:07:33 INFO - PROCESS | 1646 | 14:07:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:07:36 INFO - PROCESS | 1646 | RSS: Main: 308654080 14:07:36 INFO - PROCESS | 1646 | 14:07:39 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:07:39 INFO - PROCESS | 1646 | RSS: Main: 321171456 14:07:39 INFO - PROCESS | 1646 | 14:07:42 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:07:43 INFO - PROCESS | 1646 | RSS: Main: 314478592 14:07:43 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 14:07:45 INFO - PROCESS | 1646 | RSS: Main: 358944768 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | __start_tp_report 14:07:45 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 14:07:45 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 14:07:45 INFO - PROCESS | 1646 | |i|pagename|runs| 14:07:45 INFO - PROCESS | 1646 | |0;ai-astar;116;116;115;115;116;116;113;116;115;115 14:07:45 INFO - PROCESS | 1646 | |1;audio-beat-detection;143;110;112;146;109;108;110;108;129;110 14:07:45 INFO - PROCESS | 1646 | |2;audio-dft;186;184;182;181;184;182;184;182;182;186 14:07:45 INFO - PROCESS | 1646 | |3;audio-fft;83;59;62;92;78;82;90;71;74;59 14:07:45 INFO - PROCESS | 1646 | |4;audio-oscillator;89;68;86;68;70;68;82;69;68;84 14:07:45 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;87;86;87;86;87;86;87;87;86;86 14:07:45 INFO - PROCESS | 1646 | |6;imaging-darkroom;104;143;94;97;93;95;94;97;94;94 14:07:45 INFO - PROCESS | 1646 | |7;imaging-desaturate;85;85;85;84;86;86;86;84;85;83 14:07:45 INFO - PROCESS | 1646 | |8;json-parse-financial;61;59;59;59;63;65;66;63;65;63 14:07:45 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;54;63;57;62;61;57;58;58;58;60 14:07:45 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;88;83;82;86;85;86;85;83;90;91 14:07:45 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;135;137;137;136;136;137;132;140;177;137 14:07:45 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;163;166;165;165;164;165;163;164;167;164 14:07:45 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;65;65;65;64;65;64;63;64;64;64 14:07:45 INFO - PROCESS | 1646 | __end_tp_report 14:07:45 INFO - PROCESS | 1646 | __start_cc_report 14:07:45 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2088 14:07:45 INFO - PROCESS | 1646 | __end_cc_report 14:07:45 INFO - PROCESS | 1646 | __startTimestamp1490044065360__endTimestamp 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | ------- Summary: start ------- 14:07:45 INFO - PROCESS | 1646 | Number of tests: 14 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 14:07:45 INFO - PROCESS | 1646 | Values: 116.0 116.0 115.0 115.0 116.0 116.0 113.0 116.0 115.0 115.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:111.00 stddev:15.04 (13.6%) stddev-sans-first:13.08 14:07:45 INFO - PROCESS | 1646 | Values: 143.0 110.0 112.0 146.0 109.0 108.0 110.0 108.0 129.0 110.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.77 (1.0%) stddev-sans-first:1.58 14:07:45 INFO - PROCESS | 1646 | Values: 186.0 184.0 182.0 181.0 184.0 182.0 184.0 182.0 182.0 186.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:75.00 Median:80.00 stddev:12.17 (15.2%) stddev-sans-first:12.56 14:07:45 INFO - PROCESS | 1646 | Values: 83.0 59.0 62.0 92.0 78.0 82.0 90.0 71.0 74.0 59.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.00 stddev:8.84 (11.6%) stddev-sans-first:7.84 14:07:45 INFO - PROCESS | 1646 | Values: 89.0 68.0 86.0 68.0 70.0 68.0 82.0 69.0 68.0 84.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:07:45 INFO - PROCESS | 1646 | Values: 87.0 86.0 87.0 86.0 87.0 86.0 87.0 87.0 86.0 86.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:94.00 stddev:15.27 (16.2%) stddev-sans-first:16.14 14:07:45 INFO - PROCESS | 1646 | Values: 104.0 143.0 94.0 97.0 93.0 95.0 94.0 97.0 94.0 94.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 14:07:45 INFO - PROCESS | 1646 | Values: 85.0 85.0 85.0 84.0 86.0 86.0 86.0 84.0 85.0 83.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:63.00 stddev:2.67 (4.2%) stddev-sans-first:2.79 14:07:45 INFO - PROCESS | 1646 | Values: 61.0 59.0 59.0 59.0 63.0 65.0 66.0 63.0 65.0 63.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:2.70 (4.6%) stddev-sans-first:2.24 14:07:45 INFO - PROCESS | 1646 | Values: 54.0 63.0 57.0 62.0 61.0 57.0 58.0 58.0 58.0 60.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:3.00 (3.5%) stddev-sans-first:3.08 14:07:45 INFO - PROCESS | 1646 | Values: 88.0 83.0 82.0 86.0 85.0 86.0 85.0 83.0 90.0 91.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:137.00 stddev:13.01 (9.5%) stddev-sans-first:13.66 14:07:45 INFO - PROCESS | 1646 | Values: 135.0 137.0 137.0 136.0 136.0 137.0 132.0 140.0 177.0 137.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 14:07:45 INFO - PROCESS | 1646 | Values: 163.0 166.0 165.0 165.0 164.0 165.0 163.0 164.0 167.0 164.0 14:07:45 INFO - PROCESS | 1646 | 14:07:45 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 14:07:45 INFO - PROCESS | 1646 | Values: 65.0 65.0 65.0 64.0 65.0 64.0 63.0 64.0 64.0 64.0 14:07:45 INFO - PROCESS | 1646 | -------- Summary: end -------- 14:07:45 INFO - PROCESS | 1646 | 14:07:46 INFO - TEST-INFO | 1646: exit 0 14:07:46 INFO - TEST-OK | kraken | took 59086ms 14:07:46 INFO - SUITE-END | took 1179s 14:07:46 INFO - Completed test suite (00:19:39) 14:07:46 INFO - javascript benchmark 14:07:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7528.178568221234, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.860191291392, 3387.1024178592693, 3396.7792093513913, 3440.5527281453406, 3470.8091054991964, 6032.969835150823, 6070.089486577016, 6070.210872586557, 6093.5429842761805, 6104.938950610493, 5996.610220335675, 6094.17728606638, 6099.7865074722395, 6108.908366374497, 6118.38816118388, 5368.543673787723, 5414.998225328307, 5432.945670543283, 5452.4274951130155, 5542.5565954723525, 5323.733813309338, 5350.143976963686, 5374.973125134388, 5525.0883604205255, 5526.06056970316, 5442.428545002757, 5457.399686034533, 5478.835634930959, 5505.724713764316, 5534.252875861767, 5495.450454954513, 5503.7798488060425, 5506.0, 5513.751881165317, 5514.503694667479, 5268.157094864841, 5354.866128346784, 5438.91841622376, 5446.863828404282, 5509.696966666832, 5911.054231322968, 5964.552658550582, 5971.343152253248, 5973.074173503114, 5977.790777322773, 6262.373762623747, 6264.966280563702, 6270.31026587075, 6271.34150914152, 6274.341194174637, 6321.0834429008, 6382.744690212386, 6394.200724909387, 6405.167328247345, 6455.354464553554, 5215.295935048758, 6173.0, 6211.65835879031, 6216.937830621727, 6232.563720539519, 6591.110200123018, 6643.667816609247, 6657.267700552935, 6659.600423974577, 6676.198856137197, 6220.377962203744, 6224.62652240867, 6266.780662676875, 6279.874402511924, 6282.340354262737, 6422.293547709748, 6428.742850286029, 6431.260405053479, 6438.195225596801, 6451.161349024596, 6327.272363678144, 6336.778212762531, 6338.207724034496, 6354.110424540568, 6355.904661430082, 5704.600677952503, 5951.791687291011, 6249.218847644044, 6274.6548939807835, 6285.59143655661, 5093.694378337312, 5095.85343297755, 5104.846854594368, 5113.258577506241, 5122.769475373617, 4517.435320584927, 4550.97724511382, 4557.567031132037, 4573.885652858705, 4642.025174713348, 5977.103434484862, 6002.969985150046, 6009.278886533557, 6049.0926361046195, 6049.606775559574, 6138.051223665364, 6289.779857704958, 6291.748330066837, 6368.904466433008, 6422.42198202164, 6151.83115208109, 6181.381861813873, 6188.628682279078, 6190.597611155261, 6209.19280493542, 5707.4577915098, 5719.714014299351, 5734.856628584319, 5737.426257374313, 5772.393898640582, 6374.107624932606, 6413.615183089029, 6499.155109835691, 6735.797926062226, 6746.055552222692, 6277.529185311211, 6285.057241413824, 6301.117843502005, 6303.086052522267, 6307.36926307384, 6579.769708060195, 6637.900431493628, 6661.833454163685, 6719.361660642231, 6722.428593569602, 6336.0, 6339.429451349401, 6340.175777148941, 6354.3963323484195, 6357.1735674362035, 6202.596831205957, 6438.8390290243115, 6445.355464453517, 6456.7740129095255, 6458.160439142881, 5144.408393034849, 5911.438413350725, 6140.412224875342, 6147.907781383194, 6269.435750782452, 6239.188905442445, 6241.986739769247, 6273.560850740587, 6275.843103922439, 6305.211848518935, 6109.450149486567, 6280.685965701788, 6293.087502312231, 6301.306856245901, 6305.085762564311, 6155.907661384993, 6165.691715414122, 6249.437550620466, 6256.749730010749, 6265.56141070139, 6259.874802504016, 6288.968555157195, 6289.371062893674, 6299.527535434769, 6306.873862522815], "value": 5905.086655389464, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.1731388757086, 789.9802504937375, 841.7306461932184, 853.5860107847693, 857.2199298638241, 37286.254274914485, 37996.81001594988, 38105.61894381062, 38106.856794296145, 38151.046223844416, 38517.22965540695, 38714.612853871455, 38728.419073713914, 38749.22501549967, 38818.835434936926, 7138.8572228555395, 8865.911340886605, 9026.86459703105, 9029.006809250977, 9034.819303613956, 7334.083239595051, 10467.633632822854, 10627.096696780744, 10825.566977320897, 10929.726756831064, 9819.656312029081, 10812.513436895319, 10814.72963175923, 10840.891591084068, 10842.024217820395, 7173.426125909915, 10773.5690572377, 10797.190210734187, 10812.0, 10820.296680715728, 7155.749548765821, 10458.68623941283, 10699.358038517714, 10712.303700259457, 10720.78558428835, 37094.07264818401, 37352.25295494102, 37355.813220934, 37358.0, 37365.0, 3762.849486020556, 3786.0164219955213, 3786.8863934082024, 3787.223619158066, 3883.184531248413, 23381.883090584608, 23407.194617751637, 24835.0, 25339.873300633564, 26440.074597389, 3033.635963684372, 3070.3705740323403, 3080.7073328033803, 3099.1322429719717, 3221.903342899717, 340096.2995185033, 340591.0, 340648.0, 340819.0, 341176.0, 40991.795041024605, 41176.58823411787, 50451.74774126106, 50476.74761626168, 50624.74687626538, 43368.783156084646, 51745.74127129416, 52021.0, 52141.217881731805, 52174.0, 13604.93197534006, 13657.975651826153, 13678.52125175634, 13685.384157712926, 13691.657708557166, 11831.408429578487, 11851.170418070653, 11858.991985681314, 11865.466054027589, 11885.168038237412, 11383.715407114723, 11426.485808138654, 11455.656330310105, 11486.425678716198, 11525.366104864146, 5022.874428139326, 5134.101532231844, 5355.732213389393, 5440.211169380417, 5462.781488740406, 763.6868883757633, 921.4102974096584, 925.1349987761464, 937.2829785214317, 969.7575606098476, 25480.617790733155, 26538.071167509046, 26762.0, 27426.725732742816, 27550.862245688644, 1009.535613617744, 1019.5666841592293, 1021.5964693945998, 1025.8102251083574, 1040.5837664934088, 13511.189328640314, 13864.722705545833, 14234.501792437422, 14254.501092461715, 14262.930280228817, 443682.0, 445630.0, 446521.0, 447324.0, 447899.0, 53047.93904121973, 53160.468395316326, 53164.0, 53248.73375633097, 53350.73324633352, 1339.4909934224931, 1370.0683535195963, 1442.2067862675697, 1443.2783608195903, 1443.978340324896, 24545.0, 26661.466770664865, 27026.0, 27273.59089613697, 27760.44479110447, 44447.0, 44548.77725611351, 44605.55394446144, 44731.0, 44739.55260447354, 424538.0, 424736.0, 425399.0, 425721.0, 426754.8662256669, 26857.86571067132, 27265.59101613517, 27951.742171602735, 32331.0, 32535.674643254213, 38115.047123821016, 42560.36159457549, 42834.0, 44277.335839963074, 44415.0, 33171.50242746409, 34612.65387346094, 34934.0, 35652.0, 35704.82147589245, 34231.65768342285, 34653.82673086618, 35249.1187720309, 35340.29319413546, 35524.0, 34008.829955851055, 34753.65246347504, 35442.291154177285, 35669.28661426809, 35670.82164589161, 29733.702662973094, 31224.531632025082, 31226.375472490876, 31445.685543144275, 31478.842605786824, 23355.53288934178, 23737.78420917065, 23963.0, 24131.914063866818, 24142.87928560346], "value": 18177.906629779416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.5330836454432, 396.44101816438825, 408.50978825409504, 418.38706295277416, 435.5448556258709, 12840.871591284083, 14643.341049652765, 20842.89578552105, 21133.943302834836, 21357.252496162637, 20335.389938301836, 20803.687944680805, 21308.0, 21968.45078873029, 22265.44336391587, 6460.41856232939, 6756.12170417845, 6999.580025198479, 7321.78034658961, 7503.399728021773, 7101.721690095781, 7236.2401947795515, 7415.517991330573, 7431.591262480561, 7440.107187137524, 7309.6345182740915, 7311.524750891202, 7322.633868306563, 7334.889976650355, 7335.266473352649, 6333.366663333676, 7082.2563630818795, 7333.926660733405, 7451.515651482637, 7454.664540095709, 6981.965090174516, 7159.284071592851, 7199.964000179965, 7244.094488188976, 7266.237045110241, 23570.939307731023, 24615.87692061546, 24782.752172478224, 25255.747442525524, 25588.104416345337, 2692.3000019994747, 2783.7912156588136, 2804.1447358555633, 2833.6032955386263, 2875.1087162979543, 14858.2570871456, 14859.777103343458, 14880.553583392408, 14958.700825983527, 15862.206889655472, 1947.260041184355, 1963.9018049097488, 1988.3140316590752, 2000.9099590518463, 2026.5845501672122, 144916.0, 150986.0, 157511.42488575197, 159697.0, 162420.37579624288, 19415.902920485307, 19532.414027579194, 19581.41255762301, 19714.507137321394, 19754.155900407783, 29768.40463190724, 30086.54870176949, 30098.69901300959, 30143.0, 30208.848955755082, 8399.62201700925, 9722.319437639297, 9809.607615695435, 10002.799944001225, 10156.339837910513, 8314.750557483285, 8335.0, 8345.707900223462, 8490.660373585111, 8515.57422128891, 7389.778306650809, 8121.675132994732, 8419.915800842036, 8711.564421778885, 9035.0, 3290.68738469845, 3810.8856734298015, 3909.5113110861143, 3913.5951722001473, 3931.0, 756.4137793210306, 848.8896443462311, 873.8427083124972, 880.3573391424296, 909.5179554835947, 15158.848411515744, 20378.592428151354, 21034.053467593996, 21106.0, 21461.463463413227, 889.5596679643618, 891.4963045879058, 900.8738776571286, 911.4303560274828, 919.797644518205, 9773.364731292444, 10646.787064258671, 10732.141428685687, 10747.710274767078, 11161.776764464828, 724048.0, 751522.0, 763523.6414361367, 769893.1505342438, 779016.0, 146461.0, 147579.2621036888, 148703.0, 151361.0, 152575.23712381368, 1209.7580483903255, 1229.9877001230052, 1258.1256027061288, 1263.4693428759942, 1263.92416455013, 17901.73147402816, 18853.717194241824, 18911.148998295386, 18917.243310267986, 18951.71572426387, 63493.73012539631, 63579.0, 64070.35929640644, 64404.45775482206, 65027.0, 88742.0, 89828.5508572453, 91678.0, 92067.0, 92401.61397579176, 11170.385628790169, 11341.489632966372, 11399.829002564802, 11536.884631153582, 11580.0, 12366.381680916098, 12405.62783116508, 12692.36538173106, 12705.17416367933, 12713.555025574431, 10137.44244066554, 10683.489379995539, 10778.407187604756, 10911.618093366695, 10959.56161753521, 11218.719532011439, 11398.259113157617, 11531.308121512737, 11810.527578896748, 11837.704057398634, 10702.91354879805, 11082.279651822606, 11324.0, 11549.0, 11701.76596468083, 11507.884921150682, 11607.187496875475, 11672.766544669228, 11809.586664467046, 11933.0, 10828.980556493216, 10997.780044399227, 11062.668119956414, 11154.442277885912, 11177.776444470903], "value": 11346.530828038387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.4702854001093, 1537.2237020304744, 1561.5783738390635, 1586.7857839191713, 1592.2755146408385, 10598.205134614906, 11199.160062995266, 11205.607803726862, 11206.0, 11231.0, 10473.423961682105, 10944.45277736112, 10981.231313808037, 10989.670309890696, 11008.559657613685, 2277.39648993017, 2307.042577330406, 2314.4908120213527, 2316.4324740438615, 2318.40880575453, 2298.321995011467, 2329.0683726509365, 2337.497438050819, 2340.0405833608224, 2340.414896275931, 2306.2965795432387, 2325.104834638659, 2334.323046316566, 2335.2177020698086, 2338.6725858379755, 2268.8184945204343, 2277.339571524264, 2285.0517035430275, 2285.337252196861, 2291.5875142474347, 2263.343630347197, 2337.076854642407, 2338.356951838241, 2342.4143964009, 2345.0854166874933, 10803.189760767895, 10900.890991090067, 10904.127669786478, 10921.399323037229, 10928.781424371467, 5369.3556773187465, 5528.281323427969, 5529.917051244234, 5531.032069387881, 5533.114701647757, 3118.953215701766, 3238.7247083997654, 3361.4873307011944, 3373.831308434593, 3393.3213357328386, 1095.2552264460164, 1108.0636861851722, 1124.415304041902, 1153.826925961104, 1183.1836033137108, 11832.526698932032, 13733.862661373358, 14067.226302553356, 14419.351129199107, 15263.771043434357, 4316.438862947797, 4322.675799315064, 4502.369668246448, 4512.210363186429, 4512.52618475062, 11372.715682108013, 11379.431028448544, 11383.487743051583, 11384.487698053608, 11399.886001139883, 4723.622110231173, 4891.706497610155, 5239.869003274873, 5467.835964921059, 5497.505224529731, 5005.074061298671, 5006.799728010838, 5007.3240112584335, 5014.247862820534, 5018.473060328686, 3547.875824346187, 3633.4913112164318, 3668.9633103669157, 3682.2451397463456, 3682.3187710273687, 773.7949443397504, 918.1231923513029, 921.5622579274925, 922.1792604581927, 926.2451102351697, 916.6883259691737, 929.2426672262085, 940.6143481172686, 941.1952780372683, 991.3110388280076, 6436.678166091677, 6505.804825855232, 6587.209534855848, 6670.299618539983, 6682.599044057372, 986.3194395866828, 987.5976113918254, 998.1914649134225, 1005.0502275349725, 1010.0555980158575, 4113.259613269581, 4118.567550407224, 4127.174565086934, 4220.78896055196, 4299.935500967488, 13044.608661740163, 13359.53241636538, 13478.326083695776, 13492.190468571916, 13510.256935868621, 13389.062765606313, 13398.995075369387, 13414.195148291134, 13419.463221471031, 13428.127171734002, 8459.95770021146, 9666.709998700051, 10084.69745907624, 10143.137833284254, 10156.390616562881, 5739.397363276963, 6479.157709497735, 6578.605283682994, 6793.660316984032, 6857.108575885103, 11784.0, 12096.153269271066, 12107.33409662477, 12206.633800985985, 12233.510659573873, 11051.447427628747, 12327.93836030814, 12402.689932751753, 12462.813057803958, 12477.0, 8961.148690874357, 9264.53677316145, 9267.212286955684, 9272.979972202917, 9277.814443711222, 9682.419054856731, 10049.849252261076, 10107.949460252652, 10143.0, 10253.948730256301, 8881.822363552821, 8909.688160914337, 8953.328500362368, 9053.2304754094, 9176.495292758962, 8727.869081963903, 8734.91265087341, 8767.298616110824, 8825.69110081144, 8832.116788321373, 7603.391728661583, 7607.16321204656, 7684.193159718149, 7700.576468294297, 7707.383409327128, 5681.460261275172, 5697.800576979786, 5841.795537156179, 5908.615939963888, 5974.462298393166, 4887.193613053806, 5501.449855014466, 5597.860053498695, 5800.651960882361, 5969.224000879858], "value": 4981.882474685875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.31310388884447, 373.37087008390864, 373.89157144428117, 384.13569468695437, 384.90762217067896, 4431.0, 4643.466001409839, 4747.382840230774, 5034.597232221423, 5053.292539044537, 4287.856071964018, 4658.440987081555, 4667.0, 4888.951110488894, 4920.065187614351, 3672.7061835053264, 4010.7192496525254, 4083.8570650027254, 4134.338505839067, 4167.583241675831, 3747.5315585551807, 3771.8123488376677, 4016.8393264269394, 4133.896652583694, 4164.209389962315, 3570.3394871948644, 3768.792716400597, 3911.8630847920326, 4137.875863724078, 4180.954761309673, 3492.842822073, 4115.736345010232, 4122.299209134454, 4188.371744238359, 4259.531451540328, 3848.634379733921, 3863.594322596115, 3864.343061679493, 3866.46746381118, 3918.725689201757, 4245.662616275863, 4520.005598768299, 4725.086340032258, 4755.2153894607345, 4924.20266602691, 3982.6216509431556, 4420.778961051967, 4538.7503687297185, 4560.657950653715, 4804.495527969582, 4740.0, 4858.29554714568, 5222.060029194743, 5294.708791016493, 5314.787408503656, 3835.1016246957656, 4145.461090058303, 4208.621224089816, 4238.19474299882, 4364.738115713068, 4621.903324772411, 5346.91979620306, 5380.762424642315, 5416.783328666888, 5705.258316418881, 3449.7757645752945, 4278.700490965664, 4311.762853043113, 4327.242732521796, 4404.097160082176, 4180.331147016463, 4409.867703968886, 4413.801378937956, 4456.264716321771, 4463.308187230984, 4738.976305118453, 4750.857474275777, 4758.286257061469, 4794.400699912511, 4864.927026094611, 4159.875203743893, 4796.395460358026, 4927.669529227161, 5247.685138891602, 5338.092524270884, 1304.8890844278153, 1379.8206233189621, 1489.8882583806258, 1527.57991552324, 1535.5316628428436, 1086.7936590384666, 1141.6460897121754, 1144.404909447083, 1155.826626006089, 1162.4478372773035, 4535.4103966484145, 5018.29743835856, 5034.295198672189, 5052.932389426547, 5058.797648094109, 4915.311856340115, 5077.898442031139, 5100.744962751847, 5257.6845389276, 5326.97336513315, 4684.634259698831, 4891.926621100686, 4912.38595175603, 5034.723090229999, 5038.060346766521, 2579.3164811325014, 2639.9604005939927, 2881.3084859633536, 2911.5923770672125, 2921.9269518262213, 5289.761960711778, 5383.43473935239, 5685.715714214272, 5749.741261643236, 5808.79669211584, 4665.923663969569, 5039.899202015939, 5282.498162674539, 5623.48165995179, 5727.914081288784, 5035.370578677665, 5314.867128321823, 5518.951399234213, 5567.66594004361, 5765.4811067004175, 5199.974000130126, 5480.013392700907, 5501.752421141138, 5524.309461317335, 5542.060278902352, 5025.39695236574, 5030.5975521957425, 5165.457626949266, 5188.636795424284, 5239.083160446983, 5321.707306098202, 5445.53712934405, 5659.745311461076, 5748.741306641127, 5763.971180144073, 3883.786391748481, 4048.9797551012057, 4200.348945913388, 4336.804843781974, 4365.257906155897, 4224.408582798349, 4638.466576343763, 5248.063952035973, 5434.429384914527, 5602.85992850182, 5037.262144560121, 5395.919061214006, 5401.729913504388, 5423.538999185113, 5425.755840987244, 5182.948170518246, 5370.650907690988, 5377.139657654757, 5390.380106287827, 5394.9460505394445, 5113.630737238322, 5207.3230480037355, 5221.947780522298, 5265.763040663256, 5269.024115956517, 4417.514073451854, 4790.520947905182, 5268.683878967274, 5337.822312357008, 5340.252364669027, 4560.566746159109, 4634.907301853877, 4863.805447782191, 5234.1102012657175, 5262.289590905332], "value": 4072.1227693283345, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.3068443476567, 685.513285567247, 705.7529864547406, 765.4182821055999, 823.8846561481394, 14958.252087395642, 15523.68952620947, 15676.686466270668, 15682.451114211004, 15693.0, 14238.572842814707, 14304.785428218585, 14316.35576399062, 14530.98283120182, 14699.044562103456, 897.6319708919328, 913.182701482173, 915.7252824152761, 917.312015988009, 917.8302014127407, 761.6344154805697, 916.6837441082815, 924.089771574998, 924.7364501117183, 925.9166674999249, 965.16031052984, 975.7804493988866, 975.8487434447636, 984.970450886471, 986.5264672956985, 969.3892847506027, 970.4080510888352, 970.6214576315243, 972.2125078686287, 973.6300205921775, 722.7795522365676, 724.9673764680603, 726.7093162734895, 726.9600171990538, 727.0766127018657, 15287.082775033534, 15619.531414057596, 15852.128132952683, 16022.75965860513, 16099.356025758956, 13645.931770341085, 13973.23147226902, 14041.85958140426, 14160.92919535406, 14165.71668566623, 11473.541058357656, 11637.0, 11799.292042477478, 11922.761544769057, 12240.44917978693, 3586.4799604057266, 3625.981870090659, 3633.400488919325, 3694.832025869804, 3721.218544105741, 106937.0, 107896.0, 110522.44738776254, 111125.44437277842, 111621.0, 10473.37159770401, 10655.946720266504, 10786.0, 10813.891861081445, 10978.615748448767, 20280.29018984358, 21029.0, 21511.56976860454, 21587.35237942864, 21637.026333815014, 6472.349550864499, 6833.487488438387, 7627.389808815282, 7711.38308935295, 7755.806104847424, 4164.208800327989, 4252.893677658021, 4258.339957306623, 4273.0, 4277.486701595828, 3305.4380755271663, 3374.2913988062783, 3387.542681737983, 3417.231122997355, 3417.3677869594203, 539.1885212754858, 613.5735663713676, 619.2352444730753, 625.780976658166, 634.7587916591666, 645.9806205813833, 671.9025741267488, 680.9250982391933, 692.3630260160664, 708.0052526200697, 9898.851517227247, 10111.544980475895, 10139.340942838691, 10247.538860751283, 10369.792604148026, 691.2016620802981, 694.9826254343682, 698.5180225644289, 702.2521015118882, 720.5604581205461, 4262.062346283813, 4664.253719404879, 4714.834980775657, 4743.169945259566, 4846.588040016638, 106893.0, 107021.76031178923, 109550.0, 110161.44919275513, 110258.0, 90472.0, 91271.0872891276, 92783.14433711288, 93965.0, 94880.52559737157, 79920.20079799127, 80716.0, 80876.0, 83056.99999999879, 84864.0, 9391.154796068387, 9434.622615095594, 9471.431714097176, 9488.098630630078, 9543.093406126407, 37892.43161352637, 50799.0, 50882.49117508777, 52276.7386163082, 52367.69080773011, 50605.74697126491, 66416.66791666011, 68558.97161542482, 69470.65264673645, 69514.65242673755, 10668.98644628759, 11218.607348743082, 11361.659150225507, 11621.171853654969, 11639.6508104757, 11904.464299106388, 12083.972862306802, 12487.0, 13240.337983100999, 13471.305738852465, 10507.474626268504, 10980.835287470534, 11503.769924601294, 11949.880501194877, 12254.142210045211, 11587.304761714324, 11996.940015299868, 12253.938730306292, 12281.754364912831, 12407.503699851904, 11259.831102533632, 11745.23655962394, 11751.382121090077, 11756.23584467007, 11965.76068478643, 9446.385984911234, 9754.414735115915, 10071.143952764098, 10112.84830727525, 10197.23520735933, 7492.812679682834, 8230.958845205736, 8948.642054317754, 10858.2399232053, 11320.886791131983], "value": 7366.302367444516, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1415.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 115.0, 115.0, 116.0, 116.0, 113.0, 116.0, 115.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 112.0, 146.0, 109.0, 108.0, 110.0, 108.0, 129.0, 110.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 182.0, 181.0, 184.0, 182.0, 184.0, 182.0, 182.0, 186.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 62.0, 92.0, 78.0, 82.0, 90.0, 71.0, 74.0, 59.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 86.0, 68.0, 70.0, 68.0, 82.0, 69.0, 68.0, 84.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 86.0, 87.0, 86.0, 87.0, 87.0, 86.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 143.0, 94.0, 97.0, 93.0, 95.0, 94.0, 97.0, 94.0, 94.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 86.0, 86.0, 86.0, 84.0, 85.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 59.0, 63.0, 65.0, 66.0, 63.0, 65.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 63.0, 57.0, 62.0, 61.0, 57.0, 58.0, 58.0, 58.0, 60.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 82.0, 86.0, 85.0, 86.0, 85.0, 83.0, 90.0, 91.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 137.0, 136.0, 136.0, 137.0, 132.0, 140.0, 177.0, 137.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 165.0, 165.0, 164.0, 165.0, 163.0, 164.0, 167.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 64.0], "value": 64.3, "unit": "score"}]}]} 14:07:46 INFO - Return code: 0 14:07:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:07:46 ERROR - # TBPL SUCCESS # 14:07:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:07:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:07:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:07:46 INFO - 2017-03-20 14:07:46.681 screenresolution[1650:9890] starting screenresolution argv=screenresolution get 14:07:46 INFO - 2017-03-20 14:07:46.683 screenresolution[1650:9890] Display 0: 1600x1200x32@60 14:07:46 INFO - 2017-03-20 14:07:46.689 screenresolution[1651:9893] starting screenresolution argv=screenresolution list 14:07:46 INFO - Available Modes on Display 0 14:07:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:07:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:07:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:07:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:07:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:07:46 INFO - Intel Iris: 14:07:46 INFO - Chipset Model: Intel Iris 14:07:46 INFO - Type: GPU 14:07:46 INFO - Bus: Built-In 14:07:46 INFO - VRAM (Dynamic, Max): 1536 MB 14:07:46 INFO - Vendor: Intel (0x8086) 14:07:46 INFO - Device ID: 0x0a2e 14:07:46 INFO - Revision ID: 0x0009 14:07:46 INFO - Displays: 14:07:46 INFO - Display: 14:07:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:07:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:07:46 INFO - Display Serial Number: 1600x1200 60 14:07:46 INFO - Main Display: Yes 14:07:46 INFO - Mirror: Off 14:07:46 INFO - Online: Yes 14:07:46 INFO - Rotation: Supported 14:07:46 INFO - Return code: 0 14:07:46 INFO - Running post-action listener: _resource_record_post_action 14:07:46 INFO - [mozharness: 2017-03-20 21:07:46.928213Z] Finished run-tests step (success) 14:07:46 INFO - Running post-run listener: _resource_record_post_run 14:07:46 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 37872640; Write bytes: 509810688; Read time: 240; Write time: 1574 14:07:46 INFO - TinderboxPrint: CPU usage
54.0% 14:07:46 INFO - TinderboxPrint: I/O read bytes / time
37,872,640 / 240 14:07:46 INFO - TinderboxPrint: I/O write bytes / time
509,810,688 / 1,574 14:07:46 INFO - TinderboxPrint: CPU idle
2,209.9 (46.0%) 14:07:46 INFO - TinderboxPrint: CPU system
956.4 (19.9%) 14:07:46 INFO - TinderboxPrint: CPU user
1,635.3 (34.1%) 14:07:46 INFO - TinderboxPrint: Swap in / out
246,439,936 / 0 14:07:46 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204362240; Write bytes: 202545152; Read time: 15885; Write time: 431 14:07:47 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35750912; Write bytes: 296284160; Read time: 218; Write time: 1111 14:07:47 INFO - Running post-run listener: _upload_blobber_files 14:07:47 INFO - Blob upload gear active. 14:07:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:07:47 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 14:07:47 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'] 14:07:47 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 14:07:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:07:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:07:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:48 INFO - (blobuploader) - INFO - Done attempting. 14:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:50 INFO - (blobuploader) - INFO - Done attempting. 14:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:07:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:51 INFO - (blobuploader) - INFO - Done attempting. 14:07:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:07:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:07:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:53 INFO - (blobuploader) - INFO - Done attempting. 14:07:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:07:53 INFO - Return code: 0 14:07:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:07:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:07:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75267360bd33168b1a87a04f79f0a303936720edbe7ac5e07c6980498728ea676cc8d9a3def1e7935c6cd2e4ae4e2710a4cf981be110843a499e93e366c4f0da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd8df14711ea5c3fc7c7ff994ca765182c58332a43c0959326e5a11a2f139b840963d01720cf9352baa76f98ea16179a7a1a764980d96024be4b89c7dd00cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3ce3326e1449819a6e3e75cfd254bfcbe249c7f09967350cd3550aed72f4f78d7ee6e01f06971f1ad9de151c2a39d92b9602d72e54b81affbd4251e99ce968f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70e0a285d6877ffedd3c16c2a906090e73b4fba7c12f95c6c20cb947b8f133b3f3bc658a7a0f7ec475b72ae657aac1c523c8a3bc8e57d87a0709f3a62404a909"} 14:07:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:07:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:07:53 INFO - Contents: 14:07:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75267360bd33168b1a87a04f79f0a303936720edbe7ac5e07c6980498728ea676cc8d9a3def1e7935c6cd2e4ae4e2710a4cf981be110843a499e93e366c4f0da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd8df14711ea5c3fc7c7ff994ca765182c58332a43c0959326e5a11a2f139b840963d01720cf9352baa76f98ea16179a7a1a764980d96024be4b89c7dd00cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3ce3326e1449819a6e3e75cfd254bfcbe249c7f09967350cd3550aed72f4f78d7ee6e01f06971f1ad9de151c2a39d92b9602d72e54b81affbd4251e99ce968f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70e0a285d6877ffedd3c16c2a906090e73b4fba7c12f95c6c20cb947b8f133b3f3bc658a7a0f7ec475b72ae657aac1c523c8a3bc8e57d87a0709f3a62404a909"} 14:07:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:07:53 INFO - Copying logs to upload dir... 14:07:53 INFO - mkdir: /builds/slave/test/build/upload/logs 14:07:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.567432 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-20 14:07:53.151728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 14:07:53.155343) ========= 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.0Et80hOCHK/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.7dEpTiKTm4/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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/75267360bd33168b1a87a04f79f0a303936720edbe7ac5e07c6980498728ea676cc8d9a3def1e7935c6cd2e4ae4e2710a4cf981be110843a499e93e366c4f0da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd8df14711ea5c3fc7c7ff994ca765182c58332a43c0959326e5a11a2f139b840963d01720cf9352baa76f98ea16179a7a1a764980d96024be4b89c7dd00cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3ce3326e1449819a6e3e75cfd254bfcbe249c7f09967350cd3550aed72f4f78d7ee6e01f06971f1ad9de151c2a39d92b9602d72e54b81affbd4251e99ce968f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70e0a285d6877ffedd3c16c2a906090e73b4fba7c12f95c6c20cb947b8f133b3f3bc658a7a0f7ec475b72ae657aac1c523c8a3bc8e57d87a0709f3a62404a909"} build_url:https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011027 build_url: 'https://queue.taskcluster.net/v1/task/X8lTH_9mRAyxJj0B5N585A/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75267360bd33168b1a87a04f79f0a303936720edbe7ac5e07c6980498728ea676cc8d9a3def1e7935c6cd2e4ae4e2710a4cf981be110843a499e93e366c4f0da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd8df14711ea5c3fc7c7ff994ca765182c58332a43c0959326e5a11a2f139b840963d01720cf9352baa76f98ea16179a7a1a764980d96024be4b89c7dd00cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3ce3326e1449819a6e3e75cfd254bfcbe249c7f09967350cd3550aed72f4f78d7ee6e01f06971f1ad9de151c2a39d92b9602d72e54b81affbd4251e99ce968f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70e0a285d6877ffedd3c16c2a906090e73b4fba7c12f95c6c20cb947b8f133b3f3bc658a7a0f7ec475b72ae657aac1c523c8a3bc8e57d87a0709f3a62404a909"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 14:07:53.191626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 14:07:53.192520) ========= 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.0Et80hOCHK/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.7dEpTiKTm4/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.005322 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 14:07:53.242214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 14:07:53.242629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 14:07:53.243063) ========= ========= Total master_lag: 0.19 =========