builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0267 starttime: 1484081519.82 results: success (0) buildid: 20170110113605 builduid: bbdcd4a9b195478db67edad459f2168c revision: dde7452acab4b3256784f0cf260d2d9243fdef73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 12:51:59.824890) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 12:51:59.825316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 12:51:59.825601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 12:51:59.928198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:51:59.928557) ========= 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.viLlIK5C4F/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.kSuKJTPFWl/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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-01-10 12:51:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.4M=0.001s 2017-01-10 12:52:00 (17.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153046 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:52:00.108890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:52:00.109244) ========= 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.viLlIK5C4F/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.kSuKJTPFWl/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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.024953 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 12:52:00.157282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-10 12:52:00.157633) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev dde7452acab4b3256784f0cf260d2d9243fdef73 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev dde7452acab4b3256784f0cf260d2d9243fdef73 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.viLlIK5C4F/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.kSuKJTPFWl/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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-01-10 12:52:00,265 truncating revision to first 12 chars 2017-01-10 12:52:00,265 Setting DEBUG logging. 2017-01-10 12:52:00,266 attempt 1/10 2017-01-10 12:52:00,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/dde7452acab4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 12:52:02,178 unpacking tar archive at: graphics-dde7452acab4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.192311 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-10 12:52:02.548600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 12:52:02.548922) ========= script_repo_revision: dde7452acab4b3256784f0cf260d2d9243fdef73 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 12:52:02.549332) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 12:52:02.554716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 12:52:02.582512) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-10 12:52:02.582792) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.viLlIK5C4F/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.kSuKJTPFWl/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52:02 INFO - MultiFileLogger online at 20170110 12:52:02 in /builds/slave/test 12:52:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 12:52:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:52:02 INFO - {'append_to_log': False, 12:52:02 INFO - 'base_work_dir': '/builds/slave/test', 12:52:02 INFO - 'blob_upload_branch': 'Graphics', 12:52:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:52:02 INFO - 'branch': 'Graphics', 12:52:02 INFO - 'buildbot_json_path': 'buildprops.json', 12:52:02 INFO - 'config_files': ('talos/mac_config.py',), 12:52:02 INFO - 'default_actions': ('clobber', 12:52:02 INFO - 'read-buildbot-config', 12:52:02 INFO - 'download-and-extract', 12:52:02 INFO - 'populate-webroot', 12:52:02 INFO - 'create-virtualenv', 12:52:02 INFO - 'install', 12:52:02 INFO - 'run-tests'), 12:52:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:52:02 INFO - 'download_minidump_stackwalk': True, 12:52:02 INFO - 'download_symbols': 'ondemand', 12:52:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:52:02 INFO - 'tooltool.py': '/tools/tooltool.py', 12:52:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:52:02 INFO - '/tools/misc-python/virtualenv.py')}, 12:52:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:52:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:52:02 INFO - 'installer_path': 'installer.exe', 12:52:02 INFO - 'log_level': 'info', 12:52:02 INFO - 'log_name': 'talos', 12:52:02 INFO - 'log_to_console': True, 12:52:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:52:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:52:02 INFO - 'opt_config_files': (), 12:52:02 INFO - 'pip_index': False, 12:52:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:52:02 INFO - 'cmd': ('bash', 12:52:02 INFO - '-c', 12:52:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:52:02 INFO - 'enabled': True, 12:52:02 INFO - 'halt_on_failure': False, 12:52:02 INFO - 'name': 'check_screen_resolution'},), 12:52:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:52:02 INFO - 'cmd': ('bash', 12:52:02 INFO - '-c', 12:52:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:52:02 INFO - 'enabled': True, 12:52:02 INFO - 'halt_on_failure': False, 12:52:02 INFO - 'name': 'check_screen_resolution'},), 12:52:02 INFO - 'run_cmd_checks_enabled': True, 12:52:02 INFO - 'sps_profile': False, 12:52:02 INFO - 'sps_profile_interval': 0, 12:52:02 INFO - 'suite': 'dromaeojs', 12:52:02 INFO - 'system_bits': '32', 12:52:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:52:02 INFO - 'title': 't-yosemite-r7-0267', 12:52:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:52:02 INFO - 'use_talos_json': True, 12:52:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:52:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:52:02 INFO - 'work_dir': 'build'} 12:52:02 INFO - [mozharness: 2017-01-10 20:52:02.797097Z] Running clobber step. 12:52:02 INFO - Running pre-action listener: _resource_record_pre_action 12:52:02 INFO - Running main action method: clobber 12:52:02 INFO - rmtree: /builds/slave/test/build 12:52:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:52:05 INFO - Running post-action listener: _resource_record_post_action 12:52:05 INFO - [mozharness: 2017-01-10 20:52:05.201883Z] Finished clobber step (success) 12:52:05 INFO - [mozharness: 2017-01-10 20:52:05.202167Z] Running read-buildbot-config step. 12:52:05 INFO - Running pre-action listener: _resource_record_pre_action 12:52:05 INFO - Running main action method: read_buildbot_config 12:52:05 INFO - Using buildbot properties: 12:52:05 INFO - { 12:52:05 INFO - "project": "", 12:52:05 INFO - "product": "firefox", 12:52:05 INFO - "script_repo_revision": "default", 12:52:05 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 12:52:05 INFO - "repository": "", 12:52:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 12:52:05 INFO - "buildid": "20170110113605", 12:52:05 INFO - "pgo_build": "False", 12:52:05 INFO - "basedir": "/builds/slave/test", 12:52:05 INFO - "buildnumber": 6, 12:52:05 INFO - "slavename": "t-yosemite-r7-0267", 12:52:05 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:52:05 INFO - "platform": "yosemite_r7", 12:52:05 INFO - "scheduler": "tests-graphics-macosx64-talos", 12:52:05 INFO - "branch": "graphics", 12:52:05 INFO - "repo_path": "projects/graphics", 12:52:05 INFO - "revision": "dde7452acab4b3256784f0cf260d2d9243fdef73", 12:52:05 INFO - "stage_platform": "macosx64", 12:52:05 INFO - "builduid": "bbdcd4a9b195478db67edad459f2168c", 12:52:05 INFO - "slavebuilddir": "test" 12:52:05 INFO - } 12:52:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:52:05 INFO - Running post-action listener: _resource_record_post_action 12:52:05 INFO - [mozharness: 2017-01-10 20:52:05.207989Z] Finished read-buildbot-config step (success) 12:52:05 INFO - [mozharness: 2017-01-10 20:52:05.208214Z] Running download-and-extract step. 12:52:05 INFO - Running pre-action listener: _resource_record_pre_action 12:52:05 INFO - Running main action method: download_and_extract 12:52:05 INFO - mkdir: /builds/slave/test/build/tests 12:52:05 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')]} 12:52:05 INFO - trying https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:52:05 INFO - Downloading https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 12:52:06 INFO - Downloaded 1199 bytes. 12:52:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:52:06 INFO - Using the following test package requirements: 12:52:06 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:52:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:52:06 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:52:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:52:06 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:52:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:52:06 INFO - u'jsshell-mac.zip'], 12:52:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:52:06 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:52:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:52:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:52:06 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:52:06 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:52:06 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:52:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:52:06 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:52:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:52:06 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:52:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:52:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:52:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:52:06 INFO - Fetch https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:52:07 INFO - Expected file size: 16309970 12:52:07 INFO - Obtained file size: 16309970 12:52:14 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:52:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:52:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:52:14 INFO - Fetch https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:52:15 INFO - Expected file size: 16309970 12:52:15 INFO - Obtained file size: 16309970 12:52:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 12:52:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:52:21 INFO - Fetch https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 12:52:22 INFO - Expected file size: 14403529 12:52:22 INFO - Obtained file size: 14403529 12:52:22 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')]} 12:52:22 INFO - trying https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:52:22 INFO - Downloading https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 12:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 12:52:24 INFO - Downloaded 69874190 bytes. 12:52:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:52:24 INFO - mkdir: /builds/slave/test/properties 12:52:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:52:24 INFO - Writing to file /builds/slave/test/properties/build_url 12:52:24 INFO - Contents: 12:52:24 INFO - build_url:https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:52:25 INFO - Running post-action listener: _resource_record_post_action 12:52:25 INFO - Running post-action listener: set_extra_try_arguments 12:52:25 INFO - [mozharness: 2017-01-10 20:52:25.490866Z] Finished download-and-extract step (success) 12:52:25 INFO - [mozharness: 2017-01-10 20:52:25.491013Z] Running populate-webroot step. 12:52:25 INFO - Running pre-action listener: _resource_record_pre_action 12:52:25 INFO - Running main action method: populate_webroot 12:52:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:52:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:52:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:52:25 INFO - '--tppagecycles', 12:52:25 INFO - '7'], 12:52:25 INFO - 'tests': ['tsvgm']}}, 12:52:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:52:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:52:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:52:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:52:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:52:25 INFO - 'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:52:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:52:25 INFO - 'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['damp', 'tps']}, 12:52:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:52:25 INFO - 'tests': ['damp', 'tps']}, 12:52:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['dromaeo_dom']}, 12:52:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:52:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['basic_compositor_video']}, 12:52:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:52:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['a11yr', 12:52:25 INFO - 'ts_paint', 12:52:25 INFO - 'tpaint', 12:52:25 INFO - 'sessionrestore', 12:52:25 INFO - 'sessionrestore_no_auto_restore', 12:52:25 INFO - 'tabpaint']}, 12:52:25 INFO - 'other-e10s': {'tests': ['a11yr', 12:52:25 INFO - 'ts_paint', 12:52:25 INFO - 'tpaint', 12:52:25 INFO - 'sessionrestore', 12:52:25 INFO - 'sessionrestore_no_auto_restore', 12:52:25 INFO - 'tabpaint']}, 12:52:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:52:25 INFO - 'ts_paint', 12:52:25 INFO - 'tpaint', 12:52:25 INFO - 'sessionrestore', 12:52:25 INFO - 'sessionrestore_no_auto_restore', 12:52:25 INFO - 'tabpaint']}, 12:52:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:52:25 INFO - 'ts_paint', 12:52:25 INFO - 'tpaint', 12:52:25 INFO - 'sessionrestore', 12:52:25 INFO - 'sessionrestore_no_auto_restore', 12:52:25 INFO - 'tabpaint']}, 12:52:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['a11yr', 12:52:25 INFO - 'ts_paint', 12:52:25 INFO - 'tpaint', 12:52:25 INFO - 'sessionrestore', 12:52:25 INFO - 'sessionrestore_no_auto_restore', 12:52:25 INFO - 'tabpaint']}, 12:52:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['a11yr', 12:52:25 INFO - 'ts_paint', 12:52:25 INFO - 'tpaint', 12:52:25 INFO - 'sessionrestore', 12:52:25 INFO - 'sessionrestore_no_auto_restore', 12:52:25 INFO - 'tabpaint']}, 12:52:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['tsvgx', 12:52:25 INFO - 'tsvgr_opacity', 12:52:25 INFO - 'tart', 12:52:25 INFO - 'tscrollx', 12:52:25 INFO - 'cart', 12:52:25 INFO - 'tsvg_static']}, 12:52:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:52:25 INFO - 'tsvgr_opacity', 12:52:25 INFO - 'tart', 12:52:25 INFO - 'tscrollx', 12:52:25 INFO - 'cart', 12:52:25 INFO - 'tsvg_static']}, 12:52:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:52:25 INFO - 'talos_options': ['--disable-e10s'], 12:52:25 INFO - 'tests': ['tp5o']}, 12:52:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:52:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:52:25 INFO - 'talos_options': ['--disable-e10s', 12:52:25 INFO - '--xperf_path', 12:52:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:25 INFO - 'tests': ['tp5n']}, 12:52:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:52:25 INFO - 'talos_options': ['--xperf_path', 12:52:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:25 INFO - 'tests': ['tp5n']}}, 12:52:25 INFO - 'talos.zip': {'path': '', 12:52:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:52:25 INFO - Running post-action listener: _resource_record_post_action 12:52:25 INFO - [mozharness: 2017-01-10 20:52:25.509280Z] Finished populate-webroot step (success) 12:52:25 INFO - [mozharness: 2017-01-10 20:52:25.509406Z] Running create-virtualenv step. 12:52:25 INFO - Running pre-action listener: _resource_record_pre_action 12:52:25 INFO - Running main action method: create_virtualenv 12:52:25 INFO - Creating virtualenv /builds/slave/test/build/venv 12:52:25 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 12:52:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:52:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:52:25 INFO - Using real prefix '/tools/python27' 12:52:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:52:26 INFO - Installing distribute.............................................................................................................................................................................................done. 12:52:29 INFO - Installing pip.................done. 12:52:29 INFO - Return code: 0 12:52:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:52:29 INFO - Reading from file tmpfile_stdout 12:52:29 INFO - Output received: 12:52:29 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) 12:52:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:52: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')]} 12:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52: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', 'pip>=1.5'] in /builds/slave/test/build 12:52: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 pip>=1.5 12:52:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:29 INFO - 'HOME': '/Users/cltbld', 12:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:29 INFO - 'LOGNAME': 'cltbld', 12:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:29 INFO - 'MOZ_NO_REMOTE': '1', 12:52:29 INFO - 'NO_EM_RESTART': '1', 12:52:29 INFO - 'PAGER': '/bin/cat', 12:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:29 INFO - 'PWD': '/builds/slave/test', 12:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:29 INFO - 'SHELL': '/bin/bash', 12:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:29 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:29 INFO - 'USER': 'cltbld', 12:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:29 INFO - 'XPC_FLAGS': '0x0', 12:52:29 INFO - 'XPC_SERVICE_NAME': '0', 12:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:29 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 12:52:29 INFO - Cleaning up... 12:52:29 INFO - Return code: 0 12:52:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:52: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')]} 12:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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', '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 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:52: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 psutil>=3.1.1 12:52:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:29 INFO - 'HOME': '/Users/cltbld', 12:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:29 INFO - 'LOGNAME': 'cltbld', 12:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:29 INFO - 'MOZ_NO_REMOTE': '1', 12:52:29 INFO - 'NO_EM_RESTART': '1', 12:52:29 INFO - 'PAGER': '/bin/cat', 12:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:29 INFO - 'PWD': '/builds/slave/test', 12:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:29 INFO - 'SHELL': '/bin/bash', 12:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:29 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:29 INFO - 'USER': 'cltbld', 12:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:29 INFO - 'XPC_FLAGS': '0x0', 12:52:29 INFO - 'XPC_SERVICE_NAME': '0', 12:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:29 INFO - Downloading/unpacking psutil>=3.1.1 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:52:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:33 INFO - Installing collected packages: psutil 12:52:33 INFO - Running setup.py install for psutil 12:52:34 INFO - building 'psutil._psutil_osx' extension 12:52:34 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 12:52:34 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 12:52:34 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 12:52:34 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 12:52:34 INFO - building 'psutil._psutil_posix' extension 12:52:34 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 12:52:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:52:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:52:34 INFO - ^ 12:52:34 INFO - 1 warning generated. 12:52:34 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 12:52:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:35 INFO - Successfully installed psutil 12:52:35 INFO - Cleaning up... 12:52:35 INFO - Return code: 0 12:52:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:52: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')]} 12:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:35 INFO - 'HOME': '/Users/cltbld', 12:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:35 INFO - 'LOGNAME': 'cltbld', 12:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:35 INFO - 'MOZ_NO_REMOTE': '1', 12:52:35 INFO - 'NO_EM_RESTART': '1', 12:52:35 INFO - 'PAGER': '/bin/cat', 12:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:35 INFO - 'PWD': '/builds/slave/test', 12:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:35 INFO - 'SHELL': '/bin/bash', 12:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:35 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:35 INFO - 'USER': 'cltbld', 12:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:35 INFO - 'XPC_FLAGS': '0x0', 12:52:35 INFO - 'XPC_SERVICE_NAME': '0', 12:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:52:35 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 12:52:35 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 12:52:35 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 12:52:35 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 12:52:35 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 12:52:35 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 12:52:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:52:38 INFO - Installing collected packages: mozsystemmonitor 12:52:38 INFO - Running setup.py install for mozsystemmonitor 12:52:38 INFO - Successfully installed mozsystemmonitor 12:52:38 INFO - Cleaning up... 12:52:38 INFO - Return code: 0 12:52:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:38 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 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52:38 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 12:52:38 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 12:52:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:38 INFO - 'HOME': '/Users/cltbld', 12:52:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:38 INFO - 'LOGNAME': 'cltbld', 12:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:38 INFO - 'MOZ_NO_REMOTE': '1', 12:52:38 INFO - 'NO_EM_RESTART': '1', 12:52:38 INFO - 'PAGER': '/bin/cat', 12:52:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:38 INFO - 'PWD': '/builds/slave/test', 12:52:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:38 INFO - 'SHELL': '/bin/bash', 12:52:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:38 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:38 INFO - 'USER': 'cltbld', 12:52:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:38 INFO - 'XPC_FLAGS': '0x0', 12:52:38 INFO - 'XPC_SERVICE_NAME': '0', 12:52:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:38 INFO - Downloading/unpacking jsonschema==2.5.1 12:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:52:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:52:41 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 12:52:41 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 12:52:41 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 12:52:41 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 12:52:41 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 12:52:41 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 12:52:41 INFO - Downloading functools32-3.2.3-2.tar.gz 12:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:52:41 INFO - warning: no files found matching '*.txt' 12:52:41 INFO - no previously-included directories found matching 'build' 12:52:41 INFO - no previously-included directories found matching 'dist' 12:52:41 INFO - no previously-included directories found matching '.git*' 12:52:41 INFO - Installing collected packages: jsonschema, functools32 12:52:41 INFO - Running setup.py install for functools32 12:52:41 INFO - warning: no files found matching '*.txt' 12:52:41 INFO - no previously-included directories found matching 'build' 12:52:41 INFO - no previously-included directories found matching 'dist' 12:52:41 INFO - no previously-included directories found matching '.git*' 12:52:41 INFO - Successfully installed jsonschema functools32 12:52:41 INFO - Cleaning up... 12:52:41 INFO - Return code: 0 12:52:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:52:41 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')]} 12:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:41 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')]} 12:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:41 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 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52:41 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 12:52:41 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 12:52:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:41 INFO - 'HOME': '/Users/cltbld', 12:52:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:41 INFO - 'LOGNAME': 'cltbld', 12:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:41 INFO - 'MOZ_NO_REMOTE': '1', 12:52:41 INFO - 'NO_EM_RESTART': '1', 12:52:41 INFO - 'PAGER': '/bin/cat', 12:52:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:41 INFO - 'PWD': '/builds/slave/test', 12:52:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:41 INFO - 'SHELL': '/bin/bash', 12:52:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:41 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:42 INFO - 'USER': 'cltbld', 12:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:42 INFO - 'XPC_FLAGS': '0x0', 12:52:42 INFO - 'XPC_SERVICE_NAME': '0', 12:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:52:42 INFO - Cleaning up... 12:52:42 INFO - Return code: 0 12:52:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:42 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 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52:42 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 12:52:42 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 12:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:42 INFO - 'HOME': '/Users/cltbld', 12:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:42 INFO - 'LOGNAME': 'cltbld', 12:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:42 INFO - 'MOZ_NO_REMOTE': '1', 12:52:42 INFO - 'NO_EM_RESTART': '1', 12:52:42 INFO - 'PAGER': '/bin/cat', 12:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:42 INFO - 'PWD': '/builds/slave/test', 12:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:42 INFO - 'SHELL': '/bin/bash', 12:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:42 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:42 INFO - 'USER': 'cltbld', 12:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:42 INFO - 'XPC_FLAGS': '0x0', 12:52:42 INFO - 'XPC_SERVICE_NAME': '0', 12:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:52:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:52:45 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 12:52:45 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 12:52:45 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 12:52:45 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 12:52:45 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 12:52:45 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 12:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:52:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:52:45 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 12:52:45 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 12:52:45 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 12:52:45 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 12:52:45 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 12:52:45 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 12:52:46 INFO - Downloading docopt-0.6.1.tar.gz 12:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:52:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:52:46 INFO - Running setup.py install for blobuploader 12:52:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:52:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:52:46 INFO - Running setup.py install for requests 12:52:47 INFO - Running setup.py install for docopt 12:52:47 INFO - Successfully installed blobuploader requests docopt 12:52:47 INFO - Cleaning up... 12:52:47 INFO - Return code: 0 12:52:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:47 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')]} 12:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:47 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')]} 12:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:47 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 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52:47 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 12:52:47 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 12:52:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:47 INFO - 'HOME': '/Users/cltbld', 12:52:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:47 INFO - 'LOGNAME': 'cltbld', 12:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:47 INFO - 'MOZ_NO_REMOTE': '1', 12:52:47 INFO - 'NO_EM_RESTART': '1', 12:52:47 INFO - 'PAGER': '/bin/cat', 12:52:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:47 INFO - 'PWD': '/builds/slave/test', 12:52:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:47 INFO - 'SHELL': '/bin/bash', 12:52:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:47 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:47 INFO - 'USER': 'cltbld', 12:52:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:47 INFO - 'XPC_FLAGS': '0x0', 12:52:47 INFO - 'XPC_SERVICE_NAME': '0', 12:52:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:47 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-gA0Zxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:47 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-cq90_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:47 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-iMgn8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:47 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-f_QKf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:47 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-zjiPl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:48 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-XqTS6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:48 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-b2HDmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:48 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Tlf76L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:48 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-hKHZyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:48 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-PwO6rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:48 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-HPlYjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:48 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-m5ZBlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:48 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-MSVexA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:48 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-sz9hCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:49 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-dpdH8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:49 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-PIvvrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:49 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-_WPTdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:52:49 INFO - Running setup.py install for manifestparser 12:52:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:52:49 INFO - Running setup.py install for mozcrash 12:52:49 INFO - Running setup.py install for mozdebug 12:52:49 INFO - Running setup.py install for mozdevice 12:52:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:52:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:52:49 INFO - Running setup.py install for mozfile 12:52:50 INFO - Running setup.py install for mozhttpd 12:52:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:52:50 INFO - Running setup.py install for mozinfo 12:52:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:52:50 INFO - Running setup.py install for mozInstall 12:52:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:52:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:52:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:52:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:52:50 INFO - Running setup.py install for mozleak 12:52:50 INFO - Running setup.py install for mozlog 12:52:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:52:50 INFO - Running setup.py install for moznetwork 12:52:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:52:50 INFO - Running setup.py install for mozprocess 12:52:51 INFO - Running setup.py install for mozprofile 12:52:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:52:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:52:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:52:51 INFO - Running setup.py install for mozrunner 12:52:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:52:51 INFO - Running setup.py install for mozscreenshot 12:52:51 INFO - Running setup.py install for moztest 12:52:51 INFO - Running setup.py install for mozversion 12:52:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:52:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:52:51 INFO - Cleaning up... 12:52:51 INFO - Return code: 0 12:52:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:51 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')]} 12:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:51 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')]} 12:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:51 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 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52:51 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 12:52:51 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 12:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:51 INFO - 'HOME': '/Users/cltbld', 12:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:51 INFO - 'LOGNAME': 'cltbld', 12:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:51 INFO - 'MOZ_NO_REMOTE': '1', 12:52:51 INFO - 'NO_EM_RESTART': '1', 12:52:51 INFO - 'PAGER': '/bin/cat', 12:52:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:51 INFO - 'PWD': '/builds/slave/test', 12:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:51 INFO - 'SHELL': '/bin/bash', 12:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:51 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:51 INFO - 'USER': 'cltbld', 12:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:51 INFO - 'XPC_FLAGS': '0x0', 12:52:51 INFO - 'XPC_SERVICE_NAME': '0', 12:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-ZZdVa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:52 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)) 12:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-dBD0SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:52 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)) 12:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-PgSuFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:52 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)) 12:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-TVwDoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:52 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)) 12:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-vNRCeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:52 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)) 12:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-_y2kgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:52 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)) 12:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-MtYLGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:52 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)) 12:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-lArfmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:53 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)) 12:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-br7YQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:53 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)) 12:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-PPHk1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:53 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)) 12:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-tlwxRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:53 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)) 12:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-0Uq8R0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-FslWVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:53 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)) 12:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-RPbMN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:53 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)) 12:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-X6Cu9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:53 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)) 12:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-gHDHM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:53 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)) 12:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-cZovpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:53 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)) 12:52:53 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)) 12:52:53 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)) 12:52:53 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)) 12:52:53 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)) 12:52:53 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)) 12:52:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:52:53 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 12:52:53 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 12:52:53 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 12:52:53 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 12:52:53 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 12:52:53 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 12:52:56 INFO - Downloading blessings-1.6.tar.gz 12:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:52:56 INFO - Installing collected packages: blessings 12:52:56 INFO - Running setup.py install for blessings 12:52:56 INFO - Successfully installed blessings 12:52:56 INFO - Cleaning up... 12:52:56 INFO - Return code: 0 12:52:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:57 INFO - Reading from file tmpfile_stdout 12:52:57 INFO - Current package versions: 12:52:57 INFO - blessings == 1.6 12:52:57 INFO - blobuploader == 1.2.4 12:52:57 INFO - docopt == 0.6.1 12:52:57 INFO - functools32 == 3.2.3-2 12:52:57 INFO - jsonschema == 2.5.1 12:52:57 INFO - manifestparser == 1.1 12:52:57 INFO - mozInstall == 1.12 12:52:57 INFO - mozcrash == 1.0 12:52:57 INFO - mozdebug == 0.1 12:52:57 INFO - mozdevice == 0.49 12:52:57 INFO - mozfile == 1.2 12:52:57 INFO - mozhttpd == 0.7 12:52:57 INFO - mozinfo == 0.9 12:52:57 INFO - mozleak == 0.1 12:52:57 INFO - mozlog == 3.4 12:52:57 INFO - moznetwork == 0.27 12:52:57 INFO - mozprocess == 0.24 12:52:57 INFO - mozprofile == 0.28 12:52:57 INFO - mozrunner == 6.13 12:52:57 INFO - mozscreenshot == 0.1 12:52:57 INFO - mozsystemmonitor == 0.3 12:52:57 INFO - moztest == 0.8 12:52:57 INFO - mozversion == 1.4 12:52:57 INFO - psutil == 3.1.1 12:52:57 INFO - requests == 1.2.3 12:52:57 INFO - wsgiref == 0.1.2 12:52:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:57 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 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52:57 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 12:52:57 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 12:52:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:57 INFO - 'HOME': '/Users/cltbld', 12:52:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:57 INFO - 'LOGNAME': 'cltbld', 12:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:57 INFO - 'MOZ_NO_REMOTE': '1', 12:52:57 INFO - 'NO_EM_RESTART': '1', 12:52:57 INFO - 'PAGER': '/bin/cat', 12:52:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:57 INFO - 'PWD': '/builds/slave/test', 12:52:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:57 INFO - 'SHELL': '/bin/bash', 12:52:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:57 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:57 INFO - 'USER': 'cltbld', 12:52:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:57 INFO - 'XPC_FLAGS': '0x0', 12:52:57 INFO - 'XPC_SERVICE_NAME': '0', 12:52:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:57 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)) 12:52:57 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)) 12:52:57 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)) 12:52:57 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)) 12:52:57 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)) 12:52:57 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)) 12:52:57 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)) 12:52:57 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)) 12:52:57 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)) 12:52:57 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)) 12:52:57 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)) 12:52:57 INFO - Cleaning up... 12:52:57 INFO - Return code: 0 12:52:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:57 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 0x105701b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105704768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff182c8c580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, '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.viLlIK5C4F/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.kSuKJTPFWl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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 12:52:57 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 12:52:57 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 12:52:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:52:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:52:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:52:57 INFO - 'HOME': '/Users/cltbld', 12:52:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:52:57 INFO - 'LOGNAME': 'cltbld', 12:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:57 INFO - 'MOZ_NO_REMOTE': '1', 12:52:57 INFO - 'NO_EM_RESTART': '1', 12:52:57 INFO - 'PAGER': '/bin/cat', 12:52:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:57 INFO - 'PWD': '/builds/slave/test', 12:52:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:52:57 INFO - 'SHELL': '/bin/bash', 12:52:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:52:57 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:52:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:52:57 INFO - 'USER': 'cltbld', 12:52:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:52:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:57 INFO - 'XPC_FLAGS': '0x0', 12:52:57 INFO - 'XPC_SERVICE_NAME': '0', 12:52:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:52:57 INFO - Cleaning up... 12:52:57 INFO - Return code: 0 12:52:57 INFO - Running post-action listener: _resource_record_post_action 12:52:57 INFO - Running post-action listener: _start_resource_monitoring 12:52:57 INFO - Starting resource monitoring. 12:52:57 INFO - [mozharness: 2017-01-10 20:52:57.786989Z] Finished create-virtualenv step (success) 12:52:57 INFO - [mozharness: 2017-01-10 20:52:57.787919Z] Running install step. 12:52:57 INFO - Running pre-action listener: _resource_record_pre_action 12:52:57 INFO - Running main action method: install 12:52:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:58 INFO - Reading from file tmpfile_stdout 12:52:58 INFO - Detecting whether we're running mozinstall >=1.0... 12:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:52:58 INFO - Reading from file tmpfile_stdout 12:52:58 INFO - Output received: 12:52:58 INFO - Usage: mozinstall [options] installer 12:52:58 INFO - Options: 12:52:58 INFO - -h, --help show this help message and exit 12:52:58 INFO - -d DEST, --destination=DEST 12:52:58 INFO - Directory to install application into. [default: 12:52:58 INFO - "/builds/slave/test"] 12:52:58 INFO - --app=APP Application being installed. [default: firefox] 12:52:58 INFO - mkdir: /builds/slave/test/build/application 12:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:53:19 INFO - Reading from file tmpfile_stdout 12:53:19 INFO - Output received: 12:53:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:53:19 INFO - Running post-action listener: _resource_record_post_action 12:53:19 INFO - [mozharness: 2017-01-10 20:53:19.840463Z] Finished install step (success) 12:53:19 INFO - [mozharness: 2017-01-10 20:53:19.840623Z] Running run-tests step. 12:53:19 INFO - Running pre-action listener: _resource_record_pre_action 12:53:19 INFO - Running main action method: run_tests 12:53:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:53:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:53:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:53:19 INFO - 2017-01-10 12:53:19.855 screenresolution[1630:7918] starting screenresolution argv=screenresolution get 12:53:19 INFO - 2017-01-10 12:53:19.857 screenresolution[1630:7918] Display 0: 1600x1200x32@60 12:53:19 INFO - 2017-01-10 12:53:19.863 screenresolution[1631:7920] starting screenresolution argv=screenresolution list 12:53:19 INFO - Available Modes on Display 0 12:53:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:53:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:53:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:53:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:53:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:53:20 INFO - Intel Iris: 12:53:20 INFO - Chipset Model: Intel Iris 12:53:20 INFO - Type: GPU 12:53:20 INFO - Bus: Built-In 12:53:20 INFO - VRAM (Dynamic, Max): 1536 MB 12:53:20 INFO - Vendor: Intel (0x8086) 12:53:20 INFO - Device ID: 0x0a2e 12:53:20 INFO - Revision ID: 0x0009 12:53:20 INFO - Displays: 12:53:20 INFO - Display: 12:53:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:53:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:53:20 INFO - Display Serial Number: 1600x1200 60 12:53:20 INFO - Main Display: Yes 12:53:20 INFO - Mirror: Off 12:53:20 INFO - Online: Yes 12:53:20 INFO - Rotation: Supported 12:53:20 INFO - Return code: 0 12:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:53:20 INFO - Python 2.7.3 12:53:20 INFO - Return code: 0 12:53:20 INFO - grabbing minidump binary from tooltool 12:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:20 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 0x1054dfd30>, '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 0x105406db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054d4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:53:20 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 12:53:20 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 12:53:20 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 12:53:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:53:20 INFO - Return code: 0 12:53:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:53:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:53:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:53:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:53:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--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 12:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0267 --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 12:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.viLlIK5C4F/Render', 12:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:20 INFO - 'HOME': '/Users/cltbld', 12:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:20 INFO - 'LOGNAME': 'cltbld', 12:53:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:53:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:20 INFO - 'MOZ_NO_REMOTE': '1', 12:53:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:53:20 INFO - 'NO_EM_RESTART': '1', 12:53:20 INFO - 'PAGER': '/bin/cat', 12:53:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:20 INFO - 'PWD': '/builds/slave/test', 12:53:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:20 INFO - 'SHELL': '/bin/bash', 12:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSuKJTPFWl/Listeners', 12:53:20 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 12:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:20 INFO - 'USER': 'cltbld', 12:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:20 INFO - 'XPC_FLAGS': '0x0', 12:53:20 INFO - 'XPC_SERVICE_NAME': '0', 12:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--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 12:53:20 INFO - mozversion application_buildid: 20170110113605 12:53:20 INFO - mozversion application_changeset: dde7452acab4b3256784f0cf260d2d9243fdef73 12:53:20 INFO - mozversion application_display_name: Nightly 12:53:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:53:20 INFO - mozversion application_name: Firefox 12:53:20 INFO - mozversion application_remotingname: firefox 12:53:20 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 12:53:20 INFO - mozversion application_vendor: Mozilla 12:53:20 INFO - mozversion application_version: 53.0a1 12:53:20 INFO - mozversion platform_buildid: 20170110113605 12:53:20 INFO - mozversion platform_changeset: dde7452acab4b3256784f0cf260d2d9243fdef73 12:53:20 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 12:53:20 INFO - mozversion platform_version: 53.0a1 12:53:20 INFO - using testdate: 1484081600 12:53:20 INFO - actual date: 1484081600 12:53:20 INFO - starting webserver on 'localhost:49240' 12:53:20 INFO - SUITE-START | Running 2 tests 12:53:20 INFO - TEST-START | dromaeo_css 12:53:20 INFO - operating with platform_type : mac_ 12:53:20 INFO - Initialising browser for dromaeo_css test... 12:53:20 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpOvozoq/profile http://localhost:49240/getInfo.html) 12:53:22 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 12:53:22 INFO - PROCESS | 1641 | colorDepth:24 12:53:22 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 12:53:22 INFO - PROCESS | 1641 | __metrics 12:53:22 INFO - PROCESS | 1641 | 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" 12:53:22 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:53:23 INFO - TEST-INFO | 1641: exit 0 12:53:23 INFO - Browser initialized. 12:53:23 INFO - Running cycle 1/1 for dromaeo_css test... 12:53:23 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpOvozoq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:53:35 INFO - PROCESS | 1644 | RSS: Main: 233603072 12:53:35 INFO - PROCESS | 1644 | 12:56:40 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 12:56:41 INFO - PROCESS | 1644 | RSS: Main: 346193920 12:56:41 INFO - PROCESS | 1644 | 12:58:24 INFO - PROCESS | 1644 | ************************* 12:58:24 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 12:58:24 INFO - PROCESS | 1644 | 12:58:24 INFO - PROCESS | 1644 | Full message: ReferenceError: fetch is not defined 12:58:24 INFO - PROCESS | 1644 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 12:58:25 INFO - PROCESS | 1644 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 12:58:25 INFO - PROCESS | 1644 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 12:58:25 INFO - PROCESS | 1644 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 12:58:25 INFO - PROCESS | 1644 | TaskImpl@resource://gre/modules/Task.jsm:277:3 12:58:25 INFO - PROCESS | 1644 | asyncFunction@resource://gre/modules/Task.jsm:252:14 12:58:25 INFO - PROCESS | 1644 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 12:58:25 INFO - PROCESS | 1644 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 12:58:25 INFO - PROCESS | 1644 | TaskImpl@resource://gre/modules/Task.jsm:277:3 12:58:25 INFO - PROCESS | 1644 | asyncFunction@resource://gre/modules/Task.jsm:252:14 12:58:25 INFO - PROCESS | 1644 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 12:58:25 INFO - PROCESS | 1644 | 12:58:25 INFO - PROCESS | 1644 | ************************* 12:59:44 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 12:59:45 INFO - PROCESS | 1644 | RSS: Main: 370532352 12:59:45 INFO - PROCESS | 1644 | 13:02:47 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 13:02:48 INFO - PROCESS | 1644 | RSS: Main: 342429696 13:02:48 INFO - PROCESS | 1644 | 13:05:50 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 13:05:51 INFO - PROCESS | 1644 | RSS: Main: 328912896 13:05:51 INFO - PROCESS | 1644 | 13:08:54 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 13:08:55 INFO - PROCESS | 1644 | RSS: Main: 329060352 13:08:55 INFO - PROCESS | 1644 | 13:11:58 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 13:11:59 INFO - PROCESS | 1644 | RSS: Main: 458928128 13:11:59 INFO - PROCESS | 1644 | 13:11:59 INFO - PROCESS | 1644 | __start_tp_report 13:11:59 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 13:11:59 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 13:11:59 INFO - PROCESS | 1644 | |i|pagename|runs| 13:11:59 INFO - PROCESS | 1644 | |0;dojo.html;2744.9313767155822;3373.696367326941;3378.459446488561;3403.5405220295283;3435.7287803512704;4649.58153766161;5696.3733989261145;5746.48281654651;5808.56435767317;5816.040353341698;5690.40250773668;5740.971295143529;5802.245708057946;5816.680082595455;5879.559033072515;5281.815136470224;5345;5367.436419175989;5368.3021207243;5374.193870919355;5332.173513105475;5335;5366.543843773265;5389.326334208224;5397.78408863645;5228.660137091096;5369.4362091980365;5382.6232163748555;5394.32570928634;5406.08096623573;5189.974050129763;5358.812441564526;5362.4637536246455;5385.81149659762;5404.83785486436;5172.534471897509;5219.530242278213;5223.6343455958095;5252.527272545451;5292.417834038252;5688.260526131618;5730.914036289459;5732.140178973145;5775.5668324875805;5819.185314056035;4744.928826067612;5840.620359676607;6313.494920406402;6322.4942004639515;6338.429541341256;5528.695921724304;6204.565680402374;6226.159468471789;6247.937520624781;6310.558260921737;4818.277258411266;5868.295804503487;5902.085176797603;5909.3795151508475;5925.614835035752;6284.905726414107;6286.5599408041;6288.591241569284;6295.087212354183;6298.338674439209;5248.186531087687;6110.633361998294;6121.693915304217;6145.477634401037;6148.477379422709;6246.875062498724;6268.749250030039;6281.246250449975;6303.9684801575695;6329.050642403584;6294.370562943669;6305.653189074553;6325.620462772248;6334.556581039283;6335.049742538656;6196.783112591038;6200.968995155085;6255.874882502416;6263.185785847811;6325.14610527582;5091;5091.847244582668;5103.642745007814;5109.259157422227;5139.922901156486;4449.888752781141;4450.332450132506;4491.416115904912;4496.617787488035;4549.954500455019;5837;5936.050231962865;5942.346341902387;5953.940460595339;5965.28416590012;6246.406591373812;6282.277538083087;6284.528660350401;6303.36966303366;6311.305756366796;5696.800611978644;5780.16187652788;5825.79609713658;5858.50202732764;5894.852628684317;5490.505854473116;5524.889502209933;5552.500274975271;5556.555475561945;5571.832845014656;6341.112244285711;6366.267879193952;6366.554341196164;6375.968120159369;6395.776147834804;6157.353477884758;6274.811755647338;6283.02613094971;6288.24541055058;6302.054691796267;6268.435840774352;6271.529635277464;6324.114623952558;6331.683415829282;6407.519436042222;6281.560290779602;6285.748570057147;6304.65324407162;6314.684265786784;6329.5252856036905;5290.603204759582;5715.485606295453;6242.812715618538;6308.495320374451;6322.936770632235;6084.8783024340155;6109.799438327977;6143.020634991936;6149;6203.844903877259;6191.659458729813;6240.53196010292;6242.219722534684;6250.781222657185;6266.811995640138;5896.23348964649;5937.376575459514;6081.179040829431;6098.115773212948;6107.664078475549;6170.136180934583;6211.81364559064;6242.719077641608;6246.968765156145;6279.71741271653;6114.174586430775;6114.6636934969;6136.355682653436;6140.508759299335;6158.137860699595 13:11:59 INFO - PROCESS | 1644 | |1;ext.html;477.312669755552;511.9923201151981;512.8461461561533;514.0182251898873;549.2393035645632;30415.39169216617;31842;31905.840470797644;40446.393304100464;41303.58696413035;41518.79240603793;42040.36939445911;42647.57352426475;42764.78617606908;42765.572344276545;9351.01814309498;9498.33511654181;9503.192228660571;9541.427514349127;9543.665971690993;7833.921660783405;8406.201410865959;8590.656373745043;11096.11231101514;11341.716457088598;11297.604583839568;11322.60370887019;11326.830097548502;11367;11397.487113079931;11237.943810280936;11339.262947908359;11339.829902551468;11342.943285283603;11346.092312614972;8338.916610833874;8474.364422668325;8562;11182.720431989184;11219;40048.19903601941;40444.393334100016;40458.595414045776;40513.79743101295;40551.98620034493;3489.1277180704824;3959.9010024749614;3987;4014.598540145962;4066.0648050948153;29877;30228.546571801442;30236.24409389783;30365;31191.688083119334;3142.292984078587;3142.921426964321;3180.697833705817;3222.355528894207;3263.608366995952;470518;495990;502444;504388;612758;53629;53709.925801483754;54091;54139;54303;58308.833823324145;58553.707231464425;58568;58707.119393209134;58723.70638146868;14964.850351496563;15132.243387830564;15136;15152.469663561722;15415.768763468557;10945.398003109905;11887.108466864847;11923.582674606347;11929.761404771856;11957.581484647995;15641.608959776097;15743.291551880193;17474.126293685265;17814.287428502976;17843.553911152067;7635.465517413728;7754.92245077542;7772.92227077722;7774.922250777533;7824.452288339876;779.1818590479974;830.5847076461769;873.4279047224078;881.9382643214914;888.4891187567175;29111.962162648833;29413.705862941097;29594.852025739732;30194.698053019627;30241.395172096436;1071.4053700196466;1075.887031861659;1098.566066403766;1104.320842681745;1200.5977997370803;15505.224738763241;15909.363625455084;15933.68132637364;16244.431444899608;16256.593585160466;635015;635699;636727.8163609245;637176;638989;59997.000449931984;60765.69617151886;60767.696161519794;60995;61191.69404152951;1260.3698150924538;1447.7104579084225;1460.7297649934796;1473.8305094914008;1482.044081567383;28157.296067598472;28890.711092889644;29093.41813163767;29669.406611868075;29813.850930745208;50357;50803.237951431496;50822.745886270335;50912;51030.48969510257;482972;491814;491975;494561;497272.02727972256;23158.884205578863;26213.082542110933;26555.60166597464;26595.60106598364;26624.733752662225;39708;40096.198076037734;46691.29963050489;48132.7593362031;50520;38781.03047423724;38827;38930.61069389383;39973.60026399699;40174.59825401709;37683.81158094192;38570.421443678926;38832;40004.1999160021;40023.39964900471;31752.36495270128;37005.81497092497;37532.624673752915;38297.4255386175;38501.61498385092;32545.674543254263;32842.01473955785;33027.33945321128;33097.83451082729;34131.82934085314;22349.664755029014;23150;23357.41606459852;25038.998440062194;25323.240302790946 13:11:59 INFO - PROCESS | 1644 | |2;jquery.html;368.67740726863997;388.69099066242336;392.7937832637865;399.9980000099999;420.69499612780737;14779.1509297464;15150.318235679408;17836.286548538075;20288.884111373907;20608.587828243428;21254.89372553135;21303.57392852142;21598.784012159915;21812.563748725017;21840.453988650293;5442.863928401782;5557.138643510262;5570.749316280757;5665.631733937302;5979.970100149493;5983.192269043689;6027.126066720323;6030.547708921827;6043.425874541911;6054.969725151368;3790.7915064671433;4026.0740029793164;4032.8386864525532;6016.639001659914;6479.092926990202;6530.118434011419;6535.738570457176;6544.345565443466;6556.246031706367;6560.212774467071;5598.720063996825;5750.741216645261;5807.448292412214;5808.7095645218;5823.67969761663;13395.531156409575;13400.530981415604;13444.798328025088;13636.181829090287;13661.726765464635;2456.6929133858266;2565.9223126286815;2597.7532134447197;2627.2249686342575;2627.6846778386525;10068.345557538736;10295.485225738757;10564.049235568837;10683.78632427355;11229.10167186623;1794.8294911983342;1798.3166396769143;1822.4988128264702;1849.5745978424902;1877.521232085823;90709;130852;132356;141358;145051.0887604736;9806.460644664612;11278.266912650815;11301.208915375844;11493.77012459746;11560.364179970182;15043;15432.074075555503;15446.073235605674;15473.5357939262;15508.836837237252;8317.625706843206;8536.402451828437;8611.913880861237;8720.258778003814;8724.56377181151;6758.594484330956;6800.081988931431;8118.878216826753;8405.579721013924;8446.282066024456;4693.155232058262;4700.388949436551;4710.3405523226775;4725.787339569728;4770.189067858472;1952.3654812185812;1996.6422832474057;1998.6802111662064;1999.150361096528;2001.7497812773404;996.5216695985822;1007.5264625625944;1026.3892983674702;1051.5005372448027;1082.1396989393452;21001.89499052495;21024.245349201738;21208.681869771965;21346.573068538542;21490.892545537485;889.7820034091689;1028.4138041316528;1038.3645757931288;1075.1291453922192;1079.3847506921136;9551.570179341807;9817.509124543743;10992.780144397067;11005.504752286166;11016.06363459099;549900;726709;737984;739463;747804;99745.0050998976;124188;139768;154319;163207;991.0981007283482;992.4144754594823;1008.5965613754557;1012.0587853296505;1013.3008224325339;15782.684346313239;17933.641327173646;18532.907335463235;18569.257229711202;18659.69382143237;56302.718486407306;60366.69816650889;60947.69526152341;62267.6886615564;63414.68292658507;87365;88025.35923922293;88896.555517222;89528;90423;8256.298214651822;8279.83440331178;8465.449745766506;8496.745097647081;8779.736607901517;10620.415877126832;12720.173188742701;13008.609741707385;13235.470581176645;13704.040717149705;11382.14633902444;11531.308121512737;11943.402829858298;11966.341851198267;11971.38386317836;11279.492422841156;11376.94311528437;11578.652640420802;11784.116191285517;11857;11402.346659734127;11539.423028848692;11992.460339284928;12040.518379264731;12092.576759813364;8351.540665263226;8498.405111642125;8523.48859068458;8572.314214862672;8671.6097775599;11457.427128643369;11490.77018459643;11827.349495777815;11830.645080647595;11948.820767688318 13:11:59 INFO - PROCESS | 1644 | |3;mootools.html;1441.4162264282968;1448.1673038003148;1448.608875603587;1473.5873955292516;1476.3282706368602;8020.879686804696;8444.66221351146;8448.704295349664;8449.746507604767;8450.704225352121;7414.740484083059;7647;7946.562939038351;8228.91771082289;8267.255946964788;1988.8210061094499;2273.0453209651946;2315.617923042696;2317.9768202317928;2318.3045086474076;2308.849924754894;2335.754745751697;2343.086196383403;2348.3894187511287;2354.1878052072093;2297.8391512594126;2301.4361481436986;2321.5606324079095;2323.186884590388;2327.045911176418;2289.05004423165;2307.3770082077913;2315.513742114158;2315.548468048731;2318.6290193569034;2236;2293.862368257893;2297.655351697242;2339.1695947938406;2344.15610380263;8192;8262.586870656503;8263.173682631748;8267.29727973117;8270.710525131652;4983.700977941335;5146.768395422215;5157.48425157485;5159.74201289934;5165.896682066337;2829.9717002829916;3228.499582564706;3506.877259295938;3511.052015955703;3522.5068490411363;1204.8554173499235;1209.5161935225892;1240.6898275431142;1262.6401475579416;1264.051961029228;10583.10043646291;10682.359058456517;10720;10727.463626818628;10770.892291077145;4340.609345158888;4513.75174365413;4548.363229147922;4639.86080417588;4671.462781780071;9239.445633262027;9247.861282080774;9259.305552083486;9264.073592640681;9265.44407335562;5146.6911985281;5152.124138896396;5155.458676838878;5161.716105614152;5162.1224391853475;3509.5788505379005;3809.0858194033785;4659.324397962277;4714.646401519831;4725.5746982771025;3741.8316175772156;3753.887383378503;3819.701301557484;3860.0542866997203;3867.8646247381207;1153.8499995000764;1241.714405686697;1244.6577191272472;1247.014858261963;1261.5143169879661;707.2255879811598;844.6316966514286;867.3191544637556;915.9908400915906;967.4727273635885;5361.222622719683;5554.50009499147;5605.215269862222;5727.742251598688;6040.365761595057;860.9139086091466;872.6204101215991;996.3510390304058;1017.5115944346755;1055.5777688924338;3615.909602259912;3889.6499315061214;3951.8221680024467;3971.543272523639;3983.5817239190046;9559.569819358145;9983.400995940267;9996.400215987063;10022;10048.849267260997;9137.949135849462;9770.853437198448;9848;9950.651727189514;9964.900350996542;7589.506682065648;7706.884396734054;7755.2244775521995;7858.646360913773;7859.938908247428;5502.174673798962;5644.915326270027;5663.830085097454;5681.857953551194;5880.029795083763;8842.734717958472;9048.457092574467;9181.081891810765;9222.308326875376;9328.207102396102;9234.122758337948;9259.814803703754;9261.351705380559;9364.250859931326;9438.905610943802;6254.9687251563455;6458.7093580789915;6461.353864613501;6610.537262391586;6823;7601.239876012354;7876.803079922818;7913.841723165389;7999.120096789465;7999.720009799629;6999.160100787938;7111.857762844817;7123.501354905107;7183.245759195209;7236.855262894607;6936.514443989075;6961.37347638715;6969.7212111517;7017.614031228331;7110.680019399036;6236.719347629277;6243.344448832807;6315.147455093687;6347.143135676809;6422.197225346832;4894.755262236945;4951;4999.075171093359;5004.874878128076;5050.267711181931;4908.730019848943;5017.147084995487;5053.797848086036;5196.870078248074;5269.525742683177 13:11:59 INFO - PROCESS | 1644 | |4;prototype.html;353.3233857163532;361.90409541471513;364.9872254471094;371.34272337961806;371.6265153520711;4271.103068355641;4796.712197268166;5048.015636950791;5350.91973620396;5352.652077614957;4376.781160941948;4650.4186976627925;5225.529702326789;5260.0268950244235;5373.785048598061;3460.7058400036026;4028.5568587455505;4032.213718324928;4055.5944405559358;4122.628963393294;3476.783125905938;3655.524781778365;3716.3867961786273;4088.1619268049976;4156.875293741193;3433.613638521229;4106.568810274923;4118.773467459288;4122.546519882811;4131.442255295527;3916.2559113768434;4000.8597549698197;4071.918561628751;4122.793860306972;4156.399786082365;3642.763220390666;3654.524911761454;3658.5243918290716;3667.669909708139;3676.3933950898067;4711.552402521755;5056.407231721996;5102.821401250939;5166.468430469081;5190.909908919131;4103.199876024177;4116.814743336557;4586.266197408432;4776.641751868624;4785.114753770529;4675.4155730533685;5114.26115120857;5252.26675197184;5517.613767036309;5535.889282214373;3418.5897692276835;3451.775634583744;4052.615001574846;4057.472528571267;4092.9386059209137;4919.311296418468;4950.554450099508;5308.867278317995;5486.753096110685;5874.412558744134;3825.770453772727;3902.8096430588944;4068.349064149722;4095.28332541804;4125.97937010313;3189.840507974592;3668.2846844864994;4144.958550414457;4153.293940030202;4198.307279298942;3905.843766249375;4428.889277768081;4766.165920963817;4772.6420518461255;4774.116788394158;4925.827596034122;5534.889302213933;5589.832305030855;5590.832275031756;5626.662400255997;1207.665529589808;1244.6639407359962;1254.876885187752;1261.974530877946;1274.9991256863318;765.7817522006202;765.8966039584697;800.1118758178417;873.2839071961058;878.2183856367838;4140.937885931713;4320.675949303814;4619.838305659286;4959.380077490314;4965.379327584052;4576.954230457719;5066.758644132211;5418.106012507892;5455;5462.7268636568015;4636.97986442982;4904.117258893433;4955.290424803437;4955.35580374549;4975.701457912537;2772.6118343431936;2816.6339325427152;2832.6175966244705;2875.4392893386007;2892.626002648767;4515.63874890008;4962.975185124052;5401.567874570025;5662.801801936913;5687.829365119053;4654.37165982588;4957.950420495821;5522.641028333226;5616.831495055155;5648.311901122059;4785.234362501983;5134.63932058005;5296.894062118659;5328.706921119376;5549.500544950974;4922.4339200992345;5135.563477104488;5255.527002569787;5485.6982865942755;5502.5968378063335;4501.099780043939;4856.558295127115;4993.954896533819;5104.9489505104475;5305.949079279507;4897.90204195907;5015.448300686849;5476.726163691879;5809.535237180931;5813.709314534341;3428.5371474850576;3672.559292884871;3831.2606486362383;3836.5779764225354;3851.9422208666333;5543.695096769717;5752.367239603724;5773.595848290579;5790.841831633775;5799.8390876973;5277.393099793573;5508.3114610673665;5548;5556.249906262765;5568.49883510486;4499.77501124949;5552;5562.916556251578;5581.158217788201;5581.5255703265675;4643.39802768058;5184.559312458483;5275.868103297448;5401.972990135024;5423.891522169613;5644.915326270191;5652.349979752381;5665.235193248858;5680.176374425768;5684.971575142098;5144.897102058013;5485.0949593318255;5541.722913854372;5552.7223638818705;5570.61005729595 13:11:59 INFO - PROCESS | 1644 | |5;yui.html;718.9137303523578;749.7338444852074;774.3882332956964;833.9374546908981;836.4270474724811;15029.248537573132;15482.148481833494;15667.45163919263;15691.215439228035;15698.37206511738;14443.855561444383;14589.270536473186;14592.197429141394;14597.562073137797;14605.196714180716;680.8672308899767;703.8240439890028;707.5153519838901;851;879.0681877210146;859.3297228162012;871.9084496127879;873.6112429968666;875.6584931876573;876.5047748022379;929.7489677786994;932.1005229953093;936.4381371177274;937.7514958535993;938.9530523473799;716.7777988823482;739.9926000739978;891.416122439803;925.8564922437033;928.7306681062518;690.226945820679;693.2201273567237;694.5173104692241;694.7637803146904;698.0471656189316;15243.695126097527;15286.541403757905;15293.311800968871;15293.311800968982;15294.694106117926;14137.646558836008;14192.858071419258;14210.715785684331;14236.572902812932;14308.356123974447;12894.032947528973;13027.804582931263;13096.803547946789;13232.73534529304;13628.250446225453;4435.556444355571;4451.510333863305;4485.753283569403;4495.955040449619;4563.70335928167;121078.32458659256;121652.78347216592;121674;123624.76375236223;125089;11144.442777861075;11168.66494005181;11182.496787644575;11265.436728163559;11455.026322762658;23110.53778924412;23141.305760827203;23147.842607869537;23175.7682423177;23243.53512929732;7657.540547567164;7710.730124445618;7817.765467035998;7872.645730942121;7906.05127384706;4163.458750362433;4241.088166044316;4242.8727138185905;4244.469441319835;4370.694051416371;3392.9660703393142;3739.719521035933;3886.1839013807416;3903.4144878268485;3950.9012274693364;610.6427739772195;629.7575433458152;700.0444393402968;720.6540860386939;726.2773540327408;597.0387675841891;614.640435345319;679.4157024958532;699.9545029573061;720.5568575326137;9842.693727120464;10465.581376744845;10467.790644187073;10479.214058945458;10771.56913723458;669.1277124628747;695.290803380549;695.9304069593001;700.8458139209366;704.3942209699654;4825.372701548777;5021.397432308147;5026.497350265017;5027.145385284511;5034.672746271481;87298;105470;106184.46907765411;107926;110240.4487977571;87753;89047.10952890517;89357.21285574383;90028;91458;86828.69756953651;87413.40530814164;87834;87933.12066879377;89211.55394223117;9116.817663646823;9799.804003919739;9818.852717209105;9839.901600983898;9862.408255504693;52686;54217.18674219969;54385.18422223749;55043.899122018134;55316.617084573205;67178.66410667915;67229.66385168042;67257.66371168113;69281.65359173172;74409.88385174335;11739.295642261492;11813.232139910879;12211.877881221075;12261.570845020382;12365.75268494607;12926.159799612995;13315.933420332836;13342.999275054604;13531.496673115505;13884.58346249614;12312.606048507907;12331.938340308241;12430.875691242973;12530.498780048696;12678.049146313879;12126.619675024012;12168.45241964096;12409.44157512896;12572;12665.240085594894;10819.296745711503;11634.883651163718;12213.389330533615;12387.876121239033;12446.43991020388;9856.605735770776;10172.389656620626;10297.433641149808;10304;10666.57333706674;8377.246047855722;9408.858867117136;9927.801443970935;10001.499925003574;10038.799224015333 13:11:59 INFO - PROCESS | 1644 | __end_tp_report 13:11:59 INFO - PROCESS | 1644 | __start_cc_report 13:11:59 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1718 13:11:59 INFO - PROCESS | 1644 | __end_cc_report 13:11:59 INFO - PROCESS | 1644 | __startTimestamp1484082719109__endTimestamp 13:11:59 INFO - PROCESS | 1644 | 13:11:59 INFO - PROCESS | 1644 | ------- Summary: start ------- 13:11:59 INFO - PROCESS | 1644 | Number of tests: 6 13:11:59 INFO - PROCESS | 1644 | 13:11:59 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5785.97 Median:5965.28 stddev:658.44 (11.0%) stddev-sans-first:615.73 13:11:59 INFO - PROCESS | 1644 | Values: 2744.9 3373.7 3378.5 3403.5 3435.7 4649.6 5696.4 5746.5 5808.6 5816.0 5690.4 5741.0 5802.2 5816.7 5879.6 5281.8 5345.0 5367.4 5368.3 5374.2 5332.2 5335.0 5366.5 5389.3 5397.8 5228.7 5369.4 5382.6 5394.3 5406.1 5190.0 5358.8 5362.5 5385.8 5404.8 5172.5 5219.5 5223.6 5252.5 5292.4 5688.3 5730.9 5732.1 5775.6 5819.2 4744.9 5840.6 6313.5 6322.5 6338.4 5528.7 6204.6 6226.2 6247.9 6310.6 4818.3 5868.3 5902.1 5909.4 5925.6 6284.9 6286.6 6288.6 6295.1 6298.3 5248.2 6110.6 6121.7 6145.5 6148.5 6246.9 6268.7 6281.2 6304.0 6329.1 6294.4 6305.7 6325.6 6334.6 6335.0 6196.8 6201.0 6255.9 6263.2 6325.1 5091.0 5091.8 5103.6 5109.3 5139.9 4449.9 4450.3 4491.4 4496.6 4550.0 5837.0 5936.1 5942.3 5953.9 5965.3 6246.4 6282.3 6284.5 6303.4 6311.3 5696.8 5780.2 5825.8 5858.5 5894.9 5490.5 5524.9 5552.5 5556.6 5571.8 6341.1 6366.3 6366.6 6376.0 6395.8 6157.4 6274.8 6283.0 6288.2 6302.1 6268.4 6271.5 6324.1 6331.7 6407.5 6281.6 6285.7 6304.7 6314.7 6329.5 5290.6 5715.5 6242.8 6308.5 6322.9 6084.9 6109.8 6143.0 6149.0 6203.8 6191.7 6240.5 6242.2 6250.8 6266.8 5896.2 5937.4 6081.2 6098.1 6107.7 6170.1 6211.8 6242.7 6247.0 6279.7 6114.2 6114.7 6136.4 6140.5 6158.1 13:11:59 INFO - PROCESS | 1644 | 13:11:59 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:68037.83 Median:38804.02 stddev:147683.02 (380.6%) stddev-sans-first:148010.20 13:11:59 INFO - PROCESS | 1644 | Values: 477.3 512.0 512.8 514.0 549.2 30415.4 31842.0 31905.8 40446.4 41303.6 41518.8 42040.4 42647.6 42764.8 42765.6 9351.0 9498.3 9503.2 9541.4 9543.7 7833.9 8406.2 8590.7 11096.1 11341.7 11297.6 11322.6 11326.8 11367.0 11397.5 11237.9 11339.3 11339.8 11342.9 11346.1 8338.9 8474.4 8562.0 11182.7 11219.0 40048.2 40444.4 40458.6 40513.8 40552.0 3489.1 3959.9 3987.0 4014.6 4066.1 29877.0 30228.5 30236.2 30365.0 31191.7 3142.3 3142.9 3180.7 3222.4 3263.6 470518.0 495990.0 502444.0 504388.0 612758.0 53629.0 53709.9 54091.0 54139.0 54303.0 58308.8 58553.7 58568.0 58707.1 58723.7 14964.9 15132.2 15136.0 15152.5 15415.8 10945.4 11887.1 11923.6 11929.8 11957.6 15641.6 15743.3 17474.1 17814.3 17843.6 7635.5 7754.9 7772.9 7774.9 7824.5 779.2 830.6 873.4 881.9 888.5 29112.0 29413.7 29594.9 30194.7 30241.4 1071.4 1075.9 1098.6 1104.3 1200.6 15505.2 15909.4 15933.7 16244.4 16256.6 635015.0 635699.0 636727.8 637176.0 638989.0 59997.0 60765.7 60767.7 60995.0 61191.7 1260.4 1447.7 1460.7 1473.8 1482.0 28157.3 28890.7 29093.4 29669.4 29813.9 50357.0 50803.2 50822.7 50912.0 51030.5 482972.0 491814.0 491975.0 494561.0 497272.0 23158.9 26213.1 26555.6 26595.6 26624.7 39708.0 40096.2 46691.3 48132.8 50520.0 38781.0 38827.0 38930.6 39973.6 40174.6 37683.8 38570.4 38832.0 40004.2 40023.4 31752.4 37005.8 37532.6 38297.4 38501.6 32545.7 32842.0 33027.3 33097.8 34131.8 22349.7 23150.0 23357.4 25039.0 25323.2 13:11:59 INFO - PROCESS | 1644 | 13:11:59 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:38605.81 Median:21325.07 stddev:117411.63 (550.6%) stddev-sans-first:117705.89 13:11:59 INFO - PROCESS | 1644 | Values: 368.7 388.7 392.8 400.0 420.7 14779.2 15150.3 17836.3 20288.9 20608.6 21254.9 21303.6 21598.8 21812.6 21840.5 5442.9 5557.1 5570.7 5665.6 5980.0 5983.2 6027.1 6030.5 6043.4 6055.0 3790.8 4026.1 4032.8 6016.6 6479.1 6530.1 6535.7 6544.3 6556.2 6560.2 5598.7 5750.7 5807.4 5808.7 5823.7 13395.5 13400.5 13444.8 13636.2 13661.7 2456.7 2565.9 2597.8 2627.2 2627.7 10068.3 10295.5 10564.0 10683.8 11229.1 1794.8 1798.3 1822.5 1849.6 1877.5 90709.0 130852.0 132356.0 141358.0 145051.1 9806.5 11278.3 11301.2 11493.8 11560.4 15043.0 15432.1 15446.1 15473.5 15508.8 8317.6 8536.4 8611.9 8720.3 8724.6 6758.6 6800.1 8118.9 8405.6 8446.3 4693.2 4700.4 4710.3 4725.8 4770.2 1952.4 1996.6 1998.7 1999.2 2001.7 996.5 1007.5 1026.4 1051.5 1082.1 21001.9 21024.2 21208.7 21346.6 21490.9 889.8 1028.4 1038.4 1075.1 1079.4 9551.6 9817.5 10992.8 11005.5 11016.1 549900.0 726709.0 737984.0 739463.0 747804.0 99745.0 124188.0 139768.0 154319.0 163207.0 991.1 992.4 1008.6 1012.1 1013.3 15782.7 17933.6 18532.9 18569.3 18659.7 56302.7 60366.7 60947.7 62267.7 63414.7 87365.0 88025.4 88896.6 89528.0 90423.0 8256.3 8279.8 8465.4 8496.7 8779.7 10620.4 12720.2 13008.6 13235.5 13704.0 11382.1 11531.3 11943.4 11966.3 11971.4 11279.5 11376.9 11578.7 11784.1 11857.0 11402.3 11539.4 11992.5 12040.5 12092.6 8351.5 8498.4 8523.5 8572.3 8671.6 11457.4 11490.8 11827.3 11830.6 11948.8 13:11:59 INFO - PROCESS | 1644 | 13:11:59 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5386.81 Median:5164.01 stddev:2918.80 (56.5%) stddev-sans-first:2911.93 13:11:59 INFO - PROCESS | 1644 | Values: 1441.4 1448.2 1448.6 1473.6 1476.3 8020.9 8444.7 8448.7 8449.7 8450.7 7414.7 7647.0 7946.6 8228.9 8267.3 1988.8 2273.0 2315.6 2318.0 2318.3 2308.8 2335.8 2343.1 2348.4 2354.2 2297.8 2301.4 2321.6 2323.2 2327.0 2289.1 2307.4 2315.5 2315.5 2318.6 2236.0 2293.9 2297.7 2339.2 2344.2 8192.0 8262.6 8263.2 8267.3 8270.7 4983.7 5146.8 5157.5 5159.7 5165.9 2830.0 3228.5 3506.9 3511.1 3522.5 1204.9 1209.5 1240.7 1262.6 1264.1 10583.1 10682.4 10720.0 10727.5 10770.9 4340.6 4513.8 4548.4 4639.9 4671.5 9239.4 9247.9 9259.3 9264.1 9265.4 5146.7 5152.1 5155.5 5161.7 5162.1 3509.6 3809.1 4659.3 4714.6 4725.6 3741.8 3753.9 3819.7 3860.1 3867.9 1153.8 1241.7 1244.7 1247.0 1261.5 707.2 844.6 867.3 916.0 967.5 5361.2 5554.5 5605.2 5727.7 6040.4 860.9 872.6 996.4 1017.5 1055.6 3615.9 3889.6 3951.8 3971.5 3983.6 9559.6 9983.4 9996.4 10022.0 10048.8 9137.9 9770.9 9848.0 9950.7 9964.9 7589.5 7706.9 7755.2 7858.6 7859.9 5502.2 5644.9 5663.8 5681.9 5880.0 8842.7 9048.5 9181.1 9222.3 9328.2 9234.1 9259.8 9261.4 9364.3 9438.9 6255.0 6458.7 6461.4 6610.5 6823.0 7601.2 7876.8 7913.8 7999.1 7999.7 6999.2 7111.9 7123.5 7183.2 7236.9 6936.5 6961.4 6969.7 7017.6 7110.7 6236.7 6243.3 6315.1 6347.1 6422.2 4894.8 4951.0 4999.1 5004.9 5050.3 4908.7 5017.1 5053.8 5196.9 5269.5 13:11:59 INFO - PROCESS | 1644 | 13:11:59 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4417.78 Median:4920.87 stddev:1323.97 (26.9%) stddev-sans-first:1292.06 13:11:59 INFO - PROCESS | 1644 | Values: 353.3 361.9 365.0 371.3 371.6 4271.1 4796.7 5048.0 5350.9 5352.7 4376.8 4650.4 5225.5 5260.0 5373.8 3460.7 4028.6 4032.2 4055.6 4122.6 3476.8 3655.5 3716.4 4088.2 4156.9 3433.6 4106.6 4118.8 4122.5 4131.4 3916.3 4000.9 4071.9 4122.8 4156.4 3642.8 3654.5 3658.5 3667.7 3676.4 4711.6 5056.4 5102.8 5166.5 5190.9 4103.2 4116.8 4586.3 4776.6 4785.1 4675.4 5114.3 5252.3 5517.6 5535.9 3418.6 3451.8 4052.6 4057.5 4092.9 4919.3 4950.6 5308.9 5486.8 5874.4 3825.8 3902.8 4068.3 4095.3 4126.0 3189.8 3668.3 4145.0 4153.3 4198.3 3905.8 4428.9 4766.2 4772.6 4774.1 4925.8 5534.9 5589.8 5590.8 5626.7 1207.7 1244.7 1254.9 1262.0 1275.0 765.8 765.9 800.1 873.3 878.2 4140.9 4320.7 4619.8 4959.4 4965.4 4577.0 5066.8 5418.1 5455.0 5462.7 4637.0 4904.1 4955.3 4955.4 4975.7 2772.6 2816.6 2832.6 2875.4 2892.6 4515.6 4963.0 5401.6 5662.8 5687.8 4654.4 4958.0 5522.6 5616.8 5648.3 4785.2 5134.6 5296.9 5328.7 5549.5 4922.4 5135.6 5255.5 5485.7 5502.6 4501.1 4856.6 4994.0 5104.9 5305.9 4897.9 5015.4 5476.7 5809.5 5813.7 3428.5 3672.6 3831.3 3836.6 3851.9 5543.7 5752.4 5773.6 5790.8 5799.8 5277.4 5508.3 5548.0 5556.2 5568.5 4499.8 5552.0 5562.9 5581.2 5581.5 4643.4 5184.6 5275.9 5402.0 5423.9 5644.9 5652.3 5665.2 5680.2 5685.0 5144.9 5485.1 5541.7 5552.7 5570.6 13:11:59 INFO - PROCESS | 1644 | 13:11:59 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:21342.37 Median:4468.63 stddev:31673.42 (708.8%) stddev-sans-first:31724.42 13:11:59 INFO - PROCESS | 1644 | Values: 718.9 749.7 774.4 833.9 836.4 15029.2 15482.1 15667.5 15691.2 15698.4 14443.9 14589.3 14592.2 14597.6 14605.2 680.9 703.8 707.5 851.0 879.1 859.3 871.9 873.6 875.7 876.5 929.7 932.1 936.4 937.8 939.0 716.8 740.0 891.4 925.9 928.7 690.2 693.2 694.5 694.8 698.0 15243.7 15286.5 15293.3 15293.3 15294.7 14137.6 14192.9 14210.7 14236.6 14308.4 12894.0 13027.8 13096.8 13232.7 13628.3 4435.6 4451.5 4485.8 4496.0 4563.7 121078.3 121652.8 121674.0 123624.8 125089.0 11144.4 11168.7 11182.5 11265.4 11455.0 23110.5 23141.3 23147.8 23175.8 23243.5 7657.5 7710.7 7817.8 7872.6 7906.1 4163.5 4241.1 4242.9 4244.5 4370.7 3393.0 3739.7 3886.2 3903.4 3950.9 610.6 629.8 700.0 720.7 726.3 597.0 614.6 679.4 700.0 720.6 9842.7 10465.6 10467.8 10479.2 10771.6 669.1 695.3 695.9 700.8 704.4 4825.4 5021.4 5026.5 5027.1 5034.7 87298.0 105470.0 106184.5 107926.0 110240.4 87753.0 89047.1 89357.2 90028.0 91458.0 86828.7 87413.4 87834.0 87933.1 89211.6 9116.8 9799.8 9818.9 9839.9 9862.4 52686.0 54217.2 54385.2 55043.9 55316.6 67178.7 67229.7 67257.7 69281.7 74409.9 11739.3 11813.2 12211.9 12261.6 12365.8 12926.2 13315.9 13343.0 13531.5 13884.6 12312.6 12331.9 12430.9 12530.5 12678.0 12126.6 12168.5 12409.4 12572.0 12665.2 10819.3 11634.9 12213.4 12387.9 12446.4 9856.6 10172.4 10297.4 10304.0 10666.6 8377.2 9408.9 9927.8 10001.5 10038.8 13:11:59 INFO - PROCESS | 1644 | -------- Summary: end -------- 13:11:59 INFO - PROCESS | 1644 | 13:11:59 INFO - TEST-INFO | 1644: exit 0 13:11:59 INFO - TEST-OK | dromaeo_css | took 1119344ms 13:11:59 INFO - TEST-START | kraken 13:11:59 INFO - operating with platform_type : mac_ 13:11:59 INFO - Initialising browser for kraken test... 13:11:59 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpsgp5JM/profile http://localhost:49240/getInfo.html) 13:12:01 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 13:12:01 INFO - PROCESS | 1649 | colorDepth:24 13:12:01 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 13:12:01 INFO - PROCESS | 1649 | __metrics 13:12:02 INFO - PROCESS | 1649 | 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:12:02 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:12:02 INFO - TEST-INFO | 1649: exit 0 13:12:02 INFO - Browser initialized. 13:12:02 INFO - Running cycle 1/1 for kraken test... 13:12:02 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpsgp5JM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:14 INFO - PROCESS | 1650 | RSS: Main: 234909696 13:12:14 INFO - PROCESS | 1650 | 13:12:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 13:12:18 INFO - PROCESS | 1650 | RSS: Main: 286883840 13:12:18 INFO - PROCESS | 1650 | 13:12:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 13:12:21 INFO - PROCESS | 1650 | RSS: Main: 286134272 13:12:21 INFO - PROCESS | 1650 | 13:12:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 13:12:25 INFO - PROCESS | 1650 | RSS: Main: 379822080 13:12:25 INFO - PROCESS | 1650 | 13:12:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 13:12:28 INFO - PROCESS | 1650 | RSS: Main: 282652672 13:12:28 INFO - PROCESS | 1650 | 13:12:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:12:30 INFO - PROCESS | 1650 | RSS: Main: 286793728 13:12:30 INFO - PROCESS | 1650 | 13:12:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 13:12:34 INFO - PROCESS | 1650 | RSS: Main: 327938048 13:12:34 INFO - PROCESS | 1650 | 13:12:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 13:12:37 INFO - PROCESS | 1650 | RSS: Main: 331231232 13:12:37 INFO - PROCESS | 1650 | 13:12:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 13:12:41 INFO - PROCESS | 1650 | RSS: Main: 329162752 13:12:41 INFO - PROCESS | 1650 | 13:12:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:12:43 INFO - PROCESS | 1650 | RSS: Main: 303656960 13:12:43 INFO - PROCESS | 1650 | 13:12:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:12:45 INFO - PROCESS | 1650 | RSS: Main: 306147328 13:12:45 INFO - PROCESS | 1650 | 13:12:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:48 INFO - PROCESS | 1650 | RSS: Main: 307716096 13:12:48 INFO - PROCESS | 1650 | 13:12:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:52 INFO - PROCESS | 1650 | RSS: Main: 327000064 13:12:52 INFO - PROCESS | 1650 | 13:12:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:12:55 INFO - PROCESS | 1650 | RSS: Main: 321081344 13:12:55 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 13:12:57 INFO - PROCESS | 1650 | RSS: Main: 365244416 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | __start_tp_report 13:12:57 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 13:12:57 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 13:12:57 INFO - PROCESS | 1650 | |i|pagename|runs| 13:12:57 INFO - PROCESS | 1650 | |0;ai-astar;114;114;113;112;112;113;113;112;112;112 13:12:57 INFO - PROCESS | 1650 | |1;audio-beat-detection;143;105;109;142;109;109;108;108;129;110 13:12:57 INFO - PROCESS | 1650 | |2;audio-dft;181;183;183;185;183;184;182;184;183;185 13:12:57 INFO - PROCESS | 1650 | |3;audio-fft;80;58;58;87;59;60;60;58;74;57 13:12:57 INFO - PROCESS | 1650 | |4;audio-oscillator;90;70;87;69;68;69;85;69;69;83 13:12:57 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;89;86;89;86;89;85;89;86;89;100 13:12:57 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;94;94;96;94;93;95;95;102;130 13:12:57 INFO - PROCESS | 1650 | |7;imaging-desaturate;88;87;85;85;88;87;87;88;87;87 13:12:57 INFO - PROCESS | 1650 | |8;json-parse-financial;54;57;55;55;57;57;57;55;57;55 13:12:57 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;66;80;82;73;74;71;70;71;75;71 13:12:57 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;87;88;87;88;91;86;87;91;87;88 13:12:57 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;140;144;141;138;150;158;152;139;190;175 13:12:57 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;173;173;171;174;176;175;172;173;175;174 13:12:57 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;68;67;67;65;66;67;67;67;66 13:12:57 INFO - PROCESS | 1650 | __end_tp_report 13:12:57 INFO - PROCESS | 1650 | __start_cc_report 13:12:57 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1991 13:12:57 INFO - PROCESS | 1650 | __end_cc_report 13:12:57 INFO - PROCESS | 1650 | __startTimestamp1484082777893__endTimestamp 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | ------- Summary: start ------- 13:12:57 INFO - PROCESS | 1650 | Number of tests: 14 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 13:12:57 INFO - PROCESS | 1650 | Values: 114.0 114.0 113.0 112.0 112.0 113.0 113.0 112.0 112.0 112.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:109.50 stddev:14.88 (13.6%) stddev-sans-first:12.51 13:12:57 INFO - PROCESS | 1650 | Values: 143.0 105.0 109.0 142.0 109.0 109.0 108.0 108.0 129.0 110.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.25 (0.7%) stddev-sans-first:1.01 13:12:57 INFO - PROCESS | 1650 | Values: 181.0 183.0 183.0 185.0 183.0 184.0 182.0 184.0 183.0 185.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:65.10 Median:60.00 stddev:10.99 (18.3%) stddev-sans-first:10.25 13:12:57 INFO - PROCESS | 1650 | Values: 80.0 58.0 58.0 87.0 59.0 60.0 60.0 58.0 74.0 57.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:76.50 stddev:9.09 (11.9%) stddev-sans-first:8.08 13:12:57 INFO - PROCESS | 1650 | Values: 90.0 70.0 87.0 69.0 68.0 69.0 85.0 69.0 69.0 83.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:89.00 stddev:4.26 (4.8%) stddev-sans-first:4.52 13:12:57 INFO - PROCESS | 1650 | Values: 89.0 86.0 89.0 86.0 89.0 85.0 89.0 86.0 89.0 100.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:94.00 stddev:11.28 (12.0%) stddev-sans-first:11.84 13:12:57 INFO - PROCESS | 1650 | Values: 94.0 94.0 94.0 96.0 94.0 93.0 95.0 95.0 102.0 130.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:86.90 Median:87.00 stddev:1.10 (1.3%) stddev-sans-first:1.09 13:12:57 INFO - PROCESS | 1650 | Values: 88.0 87.0 85.0 85.0 88.0 87.0 87.0 88.0 87.0 87.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:1.20 (2.1%) stddev-sans-first:1.05 13:12:57 INFO - PROCESS | 1650 | Values: 54.0 57.0 55.0 55.0 57.0 57.0 57.0 55.0 57.0 55.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:73.50 stddev:4.76 (6.5%) stddev-sans-first:4.26 13:12:57 INFO - PROCESS | 1650 | Values: 66.0 80.0 82.0 73.0 74.0 71.0 70.0 71.0 75.0 71.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:88.00 stddev:1.70 (1.9%) stddev-sans-first:1.76 13:12:57 INFO - PROCESS | 1650 | Values: 87.0 88.0 87.0 88.0 91.0 86.0 87.0 91.0 87.0 88.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:151.00 stddev:17.33 (11.5%) stddev-sans-first:17.76 13:12:57 INFO - PROCESS | 1650 | Values: 140.0 144.0 141.0 138.0 150.0 158.0 152.0 139.0 190.0 175.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 13:12:57 INFO - PROCESS | 1650 | Values: 173.0 173.0 171.0 174.0 176.0 175.0 172.0 173.0 175.0 174.0 13:12:57 INFO - PROCESS | 1650 | 13:12:57 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 13:12:57 INFO - PROCESS | 1650 | Values: 67.0 68.0 67.0 67.0 65.0 66.0 67.0 67.0 67.0 66.0 13:12:57 INFO - PROCESS | 1650 | -------- Summary: end -------- 13:12:57 INFO - PROCESS | 1650 | 13:12:58 INFO - TEST-INFO | 1650: exit 0 13:12:58 INFO - TEST-OK | kraken | took 59037ms 13:12:58 INFO - SUITE-END | took 1178s 13:12:59 INFO - Completed test suite (00:19:38) 13:12:59 INFO - javascript benchmark 13:12:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2744.9313767155822, 3373.696367326941, 3378.459446488561, 3403.5405220295283, 3435.7287803512704, 4649.58153766161, 5696.3733989261145, 5746.48281654651, 5808.56435767317, 5816.040353341698, 5690.40250773668, 5740.971295143529, 5802.245708057946, 5816.680082595455, 5879.559033072515, 5281.815136470224, 5345.0, 5367.436419175989, 5368.3021207243, 5374.193870919355, 5332.173513105475, 5335.0, 5366.543843773265, 5389.326334208224, 5397.78408863645, 5228.660137091096, 5369.4362091980365, 5382.6232163748555, 5394.32570928634, 5406.08096623573, 5189.974050129763, 5358.812441564526, 5362.4637536246455, 5385.81149659762, 5404.83785486436, 5172.534471897509, 5219.530242278213, 5223.6343455958095, 5252.527272545451, 5292.417834038252, 5688.260526131618, 5730.914036289459, 5732.140178973145, 5775.5668324875805, 5819.185314056035, 4744.928826067612, 5840.620359676607, 6313.494920406402, 6322.4942004639515, 6338.429541341256, 5528.695921724304, 6204.565680402374, 6226.159468471789, 6247.937520624781, 6310.558260921737, 4818.277258411266, 5868.295804503487, 5902.085176797603, 5909.3795151508475, 5925.614835035752, 6284.905726414107, 6286.5599408041, 6288.591241569284, 6295.087212354183, 6298.338674439209, 5248.186531087687, 6110.633361998294, 6121.693915304217, 6145.477634401037, 6148.477379422709, 6246.875062498724, 6268.749250030039, 6281.246250449975, 6303.9684801575695, 6329.050642403584, 6294.370562943669, 6305.653189074553, 6325.620462772248, 6334.556581039283, 6335.049742538656, 6196.783112591038, 6200.968995155085, 6255.874882502416, 6263.185785847811, 6325.14610527582, 5091.0, 5091.847244582668, 5103.642745007814, 5109.259157422227, 5139.922901156486, 4449.888752781141, 4450.332450132506, 4491.416115904912, 4496.617787488035, 4549.954500455019, 5837.0, 5936.050231962865, 5942.346341902387, 5953.940460595339, 5965.28416590012, 6246.406591373812, 6282.277538083087, 6284.528660350401, 6303.36966303366, 6311.305756366796, 5696.800611978644, 5780.16187652788, 5825.79609713658, 5858.50202732764, 5894.852628684317, 5490.505854473116, 5524.889502209933, 5552.500274975271, 5556.555475561945, 5571.832845014656, 6341.112244285711, 6366.267879193952, 6366.554341196164, 6375.968120159369, 6395.776147834804, 6157.353477884758, 6274.811755647338, 6283.02613094971, 6288.24541055058, 6302.054691796267, 6268.435840774352, 6271.529635277464, 6324.114623952558, 6331.683415829282, 6407.519436042222, 6281.560290779602, 6285.748570057147, 6304.65324407162, 6314.684265786784, 6329.5252856036905, 5290.603204759582, 5715.485606295453, 6242.812715618538, 6308.495320374451, 6322.936770632235, 6084.8783024340155, 6109.799438327977, 6143.020634991936, 6149.0, 6203.844903877259, 6191.659458729813, 6240.53196010292, 6242.219722534684, 6250.781222657185, 6266.811995640138, 5896.23348964649, 5937.376575459514, 6081.179040829431, 6098.115773212948, 6107.664078475549, 6170.136180934583, 6211.81364559064, 6242.719077641608, 6246.968765156145, 6279.71741271653, 6114.174586430775, 6114.6636934969, 6136.355682653436, 6140.508759299335, 6158.137860699595], "value": 5744.306108365712, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.312669755552, 511.9923201151981, 512.8461461561533, 514.0182251898873, 549.2393035645632, 30415.39169216617, 31842.0, 31905.840470797644, 40446.393304100464, 41303.58696413035, 41518.79240603793, 42040.36939445911, 42647.57352426475, 42764.78617606908, 42765.572344276545, 9351.01814309498, 9498.33511654181, 9503.192228660571, 9541.427514349127, 9543.665971690993, 7833.921660783405, 8406.201410865959, 8590.656373745043, 11096.11231101514, 11341.716457088598, 11297.604583839568, 11322.60370887019, 11326.830097548502, 11367.0, 11397.487113079931, 11237.943810280936, 11339.262947908359, 11339.829902551468, 11342.943285283603, 11346.092312614972, 8338.916610833874, 8474.364422668325, 8562.0, 11182.720431989184, 11219.0, 40048.19903601941, 40444.393334100016, 40458.595414045776, 40513.79743101295, 40551.98620034493, 3489.1277180704824, 3959.9010024749614, 3987.0, 4014.598540145962, 4066.0648050948153, 29877.0, 30228.546571801442, 30236.24409389783, 30365.0, 31191.688083119334, 3142.292984078587, 3142.921426964321, 3180.697833705817, 3222.355528894207, 3263.608366995952, 470518.0, 495990.0, 502444.0, 504388.0, 612758.0, 53629.0, 53709.925801483754, 54091.0, 54139.0, 54303.0, 58308.833823324145, 58553.707231464425, 58568.0, 58707.119393209134, 58723.70638146868, 14964.850351496563, 15132.243387830564, 15136.0, 15152.469663561722, 15415.768763468557, 10945.398003109905, 11887.108466864847, 11923.582674606347, 11929.761404771856, 11957.581484647995, 15641.608959776097, 15743.291551880193, 17474.126293685265, 17814.287428502976, 17843.553911152067, 7635.465517413728, 7754.92245077542, 7772.92227077722, 7774.922250777533, 7824.452288339876, 779.1818590479974, 830.5847076461769, 873.4279047224078, 881.9382643214914, 888.4891187567175, 29111.962162648833, 29413.705862941097, 29594.852025739732, 30194.698053019627, 30241.395172096436, 1071.4053700196466, 1075.887031861659, 1098.566066403766, 1104.320842681745, 1200.5977997370803, 15505.224738763241, 15909.363625455084, 15933.68132637364, 16244.431444899608, 16256.593585160466, 635015.0, 635699.0, 636727.8163609245, 637176.0, 638989.0, 59997.000449931984, 60765.69617151886, 60767.696161519794, 60995.0, 61191.69404152951, 1260.3698150924538, 1447.7104579084225, 1460.7297649934796, 1473.8305094914008, 1482.044081567383, 28157.296067598472, 28890.711092889644, 29093.41813163767, 29669.406611868075, 29813.850930745208, 50357.0, 50803.237951431496, 50822.745886270335, 50912.0, 51030.48969510257, 482972.0, 491814.0, 491975.0, 494561.0, 497272.02727972256, 23158.884205578863, 26213.082542110933, 26555.60166597464, 26595.60106598364, 26624.733752662225, 39708.0, 40096.198076037734, 46691.29963050489, 48132.7593362031, 50520.0, 38781.03047423724, 38827.0, 38930.61069389383, 39973.60026399699, 40174.59825401709, 37683.81158094192, 38570.421443678926, 38832.0, 40004.1999160021, 40023.39964900471, 31752.36495270128, 37005.81497092497, 37532.624673752915, 38297.4255386175, 38501.61498385092, 32545.674543254263, 32842.01473955785, 33027.33945321128, 33097.83451082729, 34131.82934085314, 22349.664755029014, 23150.0, 23357.41606459852, 25038.998440062194, 25323.240302790946], "value": 19774.27872006561, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.67740726863997, 388.69099066242336, 392.7937832637865, 399.9980000099999, 420.69499612780737, 14779.1509297464, 15150.318235679408, 17836.286548538075, 20288.884111373907, 20608.587828243428, 21254.89372553135, 21303.57392852142, 21598.784012159915, 21812.563748725017, 21840.453988650293, 5442.863928401782, 5557.138643510262, 5570.749316280757, 5665.631733937302, 5979.970100149493, 5983.192269043689, 6027.126066720323, 6030.547708921827, 6043.425874541911, 6054.969725151368, 3790.7915064671433, 4026.0740029793164, 4032.8386864525532, 6016.639001659914, 6479.092926990202, 6530.118434011419, 6535.738570457176, 6544.345565443466, 6556.246031706367, 6560.212774467071, 5598.720063996825, 5750.741216645261, 5807.448292412214, 5808.7095645218, 5823.67969761663, 13395.531156409575, 13400.530981415604, 13444.798328025088, 13636.181829090287, 13661.726765464635, 2456.6929133858266, 2565.9223126286815, 2597.7532134447197, 2627.2249686342575, 2627.6846778386525, 10068.345557538736, 10295.485225738757, 10564.049235568837, 10683.78632427355, 11229.10167186623, 1794.8294911983342, 1798.3166396769143, 1822.4988128264702, 1849.5745978424902, 1877.521232085823, 90709.0, 130852.0, 132356.0, 141358.0, 145051.0887604736, 9806.460644664612, 11278.266912650815, 11301.208915375844, 11493.77012459746, 11560.364179970182, 15043.0, 15432.074075555503, 15446.073235605674, 15473.5357939262, 15508.836837237252, 8317.625706843206, 8536.402451828437, 8611.913880861237, 8720.258778003814, 8724.56377181151, 6758.594484330956, 6800.081988931431, 8118.878216826753, 8405.579721013924, 8446.282066024456, 4693.155232058262, 4700.388949436551, 4710.3405523226775, 4725.787339569728, 4770.189067858472, 1952.3654812185812, 1996.6422832474057, 1998.6802111662064, 1999.150361096528, 2001.7497812773404, 996.5216695985822, 1007.5264625625944, 1026.3892983674702, 1051.5005372448027, 1082.1396989393452, 21001.89499052495, 21024.245349201738, 21208.681869771965, 21346.573068538542, 21490.892545537485, 889.7820034091689, 1028.4138041316528, 1038.3645757931288, 1075.1291453922192, 1079.3847506921136, 9551.570179341807, 9817.509124543743, 10992.780144397067, 11005.504752286166, 11016.06363459099, 549900.0, 726709.0, 737984.0, 739463.0, 747804.0, 99745.0050998976, 124188.0, 139768.0, 154319.0, 163207.0, 991.0981007283482, 992.4144754594823, 1008.5965613754557, 1012.0587853296505, 1013.3008224325339, 15782.684346313239, 17933.641327173646, 18532.907335463235, 18569.257229711202, 18659.69382143237, 56302.718486407306, 60366.69816650889, 60947.69526152341, 62267.6886615564, 63414.68292658507, 87365.0, 88025.35923922293, 88896.555517222, 89528.0, 90423.0, 8256.298214651822, 8279.83440331178, 8465.449745766506, 8496.745097647081, 8779.736607901517, 10620.415877126832, 12720.173188742701, 13008.609741707385, 13235.470581176645, 13704.040717149705, 11382.14633902444, 11531.308121512737, 11943.402829858298, 11966.341851198267, 11971.38386317836, 11279.492422841156, 11376.94311528437, 11578.652640420802, 11784.116191285517, 11857.0, 11402.346659734127, 11539.423028848692, 11992.460339284928, 12040.518379264731, 12092.576759813364, 8351.540665263226, 8498.405111642125, 8523.48859068458, 8572.314214862672, 8671.6097775599, 11457.427128643369, 11490.77018459643, 11827.349495777815, 11830.645080647595, 11948.820767688318], "value": 9689.456198326132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.4162264282968, 1448.1673038003148, 1448.608875603587, 1473.5873955292516, 1476.3282706368602, 8020.879686804696, 8444.66221351146, 8448.704295349664, 8449.746507604767, 8450.704225352121, 7414.740484083059, 7647.0, 7946.562939038351, 8228.91771082289, 8267.255946964788, 1988.8210061094499, 2273.0453209651946, 2315.617923042696, 2317.9768202317928, 2318.3045086474076, 2308.849924754894, 2335.754745751697, 2343.086196383403, 2348.3894187511287, 2354.1878052072093, 2297.8391512594126, 2301.4361481436986, 2321.5606324079095, 2323.186884590388, 2327.045911176418, 2289.05004423165, 2307.3770082077913, 2315.513742114158, 2315.548468048731, 2318.6290193569034, 2236.0, 2293.862368257893, 2297.655351697242, 2339.1695947938406, 2344.15610380263, 8192.0, 8262.586870656503, 8263.173682631748, 8267.29727973117, 8270.710525131652, 4983.700977941335, 5146.768395422215, 5157.48425157485, 5159.74201289934, 5165.896682066337, 2829.9717002829916, 3228.499582564706, 3506.877259295938, 3511.052015955703, 3522.5068490411363, 1204.8554173499235, 1209.5161935225892, 1240.6898275431142, 1262.6401475579416, 1264.051961029228, 10583.10043646291, 10682.359058456517, 10720.0, 10727.463626818628, 10770.892291077145, 4340.609345158888, 4513.75174365413, 4548.363229147922, 4639.86080417588, 4671.462781780071, 9239.445633262027, 9247.861282080774, 9259.305552083486, 9264.073592640681, 9265.44407335562, 5146.6911985281, 5152.124138896396, 5155.458676838878, 5161.716105614152, 5162.1224391853475, 3509.5788505379005, 3809.0858194033785, 4659.324397962277, 4714.646401519831, 4725.5746982771025, 3741.8316175772156, 3753.887383378503, 3819.701301557484, 3860.0542866997203, 3867.8646247381207, 1153.8499995000764, 1241.714405686697, 1244.6577191272472, 1247.014858261963, 1261.5143169879661, 707.2255879811598, 844.6316966514286, 867.3191544637556, 915.9908400915906, 967.4727273635885, 5361.222622719683, 5554.50009499147, 5605.215269862222, 5727.742251598688, 6040.365761595057, 860.9139086091466, 872.6204101215991, 996.3510390304058, 1017.5115944346755, 1055.5777688924338, 3615.909602259912, 3889.6499315061214, 3951.8221680024467, 3971.543272523639, 3983.5817239190046, 9559.569819358145, 9983.400995940267, 9996.400215987063, 10022.0, 10048.849267260997, 9137.949135849462, 9770.853437198448, 9848.0, 9950.651727189514, 9964.900350996542, 7589.506682065648, 7706.884396734054, 7755.2244775521995, 7858.646360913773, 7859.938908247428, 5502.174673798962, 5644.915326270027, 5663.830085097454, 5681.857953551194, 5880.029795083763, 8842.734717958472, 9048.457092574467, 9181.081891810765, 9222.308326875376, 9328.207102396102, 9234.122758337948, 9259.814803703754, 9261.351705380559, 9364.250859931326, 9438.905610943802, 6254.9687251563455, 6458.7093580789915, 6461.353864613501, 6610.537262391586, 6823.0, 7601.239876012354, 7876.803079922818, 7913.841723165389, 7999.120096789465, 7999.720009799629, 6999.160100787938, 7111.857762844817, 7123.501354905107, 7183.245759195209, 7236.855262894607, 6936.514443989075, 6961.37347638715, 6969.7212111517, 7017.614031228331, 7110.680019399036, 6236.719347629277, 6243.344448832807, 6315.147455093687, 6347.143135676809, 6422.197225346832, 4894.755262236945, 4951.0, 4999.075171093359, 5004.874878128076, 5050.267711181931, 4908.730019848943, 5017.147084995487, 5053.797848086036, 5196.870078248074, 5269.525742683177], "value": 4390.693792060421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3233857163532, 361.90409541471513, 364.9872254471094, 371.34272337961806, 371.6265153520711, 4271.103068355641, 4796.712197268166, 5048.015636950791, 5350.91973620396, 5352.652077614957, 4376.781160941948, 4650.4186976627925, 5225.529702326789, 5260.0268950244235, 5373.785048598061, 3460.7058400036026, 4028.5568587455505, 4032.213718324928, 4055.5944405559358, 4122.628963393294, 3476.783125905938, 3655.524781778365, 3716.3867961786273, 4088.1619268049976, 4156.875293741193, 3433.613638521229, 4106.568810274923, 4118.773467459288, 4122.546519882811, 4131.442255295527, 3916.2559113768434, 4000.8597549698197, 4071.918561628751, 4122.793860306972, 4156.399786082365, 3642.763220390666, 3654.524911761454, 3658.5243918290716, 3667.669909708139, 3676.3933950898067, 4711.552402521755, 5056.407231721996, 5102.821401250939, 5166.468430469081, 5190.909908919131, 4103.199876024177, 4116.814743336557, 4586.266197408432, 4776.641751868624, 4785.114753770529, 4675.4155730533685, 5114.26115120857, 5252.26675197184, 5517.613767036309, 5535.889282214373, 3418.5897692276835, 3451.775634583744, 4052.615001574846, 4057.472528571267, 4092.9386059209137, 4919.311296418468, 4950.554450099508, 5308.867278317995, 5486.753096110685, 5874.412558744134, 3825.770453772727, 3902.8096430588944, 4068.349064149722, 4095.28332541804, 4125.97937010313, 3189.840507974592, 3668.2846844864994, 4144.958550414457, 4153.293940030202, 4198.307279298942, 3905.843766249375, 4428.889277768081, 4766.165920963817, 4772.6420518461255, 4774.116788394158, 4925.827596034122, 5534.889302213933, 5589.832305030855, 5590.832275031756, 5626.662400255997, 1207.665529589808, 1244.6639407359962, 1254.876885187752, 1261.974530877946, 1274.9991256863318, 765.7817522006202, 765.8966039584697, 800.1118758178417, 873.2839071961058, 878.2183856367838, 4140.937885931713, 4320.675949303814, 4619.838305659286, 4959.380077490314, 4965.379327584052, 4576.954230457719, 5066.758644132211, 5418.106012507892, 5455.0, 5462.7268636568015, 4636.97986442982, 4904.117258893433, 4955.290424803437, 4955.35580374549, 4975.701457912537, 2772.6118343431936, 2816.6339325427152, 2832.6175966244705, 2875.4392893386007, 2892.626002648767, 4515.63874890008, 4962.975185124052, 5401.567874570025, 5662.801801936913, 5687.829365119053, 4654.37165982588, 4957.950420495821, 5522.641028333226, 5616.831495055155, 5648.311901122059, 4785.234362501983, 5134.63932058005, 5296.894062118659, 5328.706921119376, 5549.500544950974, 4922.4339200992345, 5135.563477104488, 5255.527002569787, 5485.6982865942755, 5502.5968378063335, 4501.099780043939, 4856.558295127115, 4993.954896533819, 5104.9489505104475, 5305.949079279507, 4897.90204195907, 5015.448300686849, 5476.726163691879, 5809.535237180931, 5813.709314534341, 3428.5371474850576, 3672.559292884871, 3831.2606486362383, 3836.5779764225354, 3851.9422208666333, 5543.695096769717, 5752.367239603724, 5773.595848290579, 5790.841831633775, 5799.8390876973, 5277.393099793573, 5508.3114610673665, 5548.0, 5556.249906262765, 5568.49883510486, 4499.77501124949, 5552.0, 5562.916556251578, 5581.158217788201, 5581.5255703265675, 4643.39802768058, 5184.559312458483, 5275.868103297448, 5401.972990135024, 5423.891522169613, 5644.915326270191, 5652.349979752381, 5665.235193248858, 5680.176374425768, 5684.971575142098, 5144.897102058013, 5485.0949593318255, 5541.722913854372, 5552.7223638818705, 5570.61005729595], "value": 4008.1419688201863, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.9137303523578, 749.7338444852074, 774.3882332956964, 833.9374546908981, 836.4270474724811, 15029.248537573132, 15482.148481833494, 15667.45163919263, 15691.215439228035, 15698.37206511738, 14443.855561444383, 14589.270536473186, 14592.197429141394, 14597.562073137797, 14605.196714180716, 680.8672308899767, 703.8240439890028, 707.5153519838901, 851.0, 879.0681877210146, 859.3297228162012, 871.9084496127879, 873.6112429968666, 875.6584931876573, 876.5047748022379, 929.7489677786994, 932.1005229953093, 936.4381371177274, 937.7514958535993, 938.9530523473799, 716.7777988823482, 739.9926000739978, 891.416122439803, 925.8564922437033, 928.7306681062518, 690.226945820679, 693.2201273567237, 694.5173104692241, 694.7637803146904, 698.0471656189316, 15243.695126097527, 15286.541403757905, 15293.311800968871, 15293.311800968982, 15294.694106117926, 14137.646558836008, 14192.858071419258, 14210.715785684331, 14236.572902812932, 14308.356123974447, 12894.032947528973, 13027.804582931263, 13096.803547946789, 13232.73534529304, 13628.250446225453, 4435.556444355571, 4451.510333863305, 4485.753283569403, 4495.955040449619, 4563.70335928167, 121078.32458659256, 121652.78347216592, 121674.0, 123624.76375236223, 125089.0, 11144.442777861075, 11168.66494005181, 11182.496787644575, 11265.436728163559, 11455.026322762658, 23110.53778924412, 23141.305760827203, 23147.842607869537, 23175.7682423177, 23243.53512929732, 7657.540547567164, 7710.730124445618, 7817.765467035998, 7872.645730942121, 7906.05127384706, 4163.458750362433, 4241.088166044316, 4242.8727138185905, 4244.469441319835, 4370.694051416371, 3392.9660703393142, 3739.719521035933, 3886.1839013807416, 3903.4144878268485, 3950.9012274693364, 610.6427739772195, 629.7575433458152, 700.0444393402968, 720.6540860386939, 726.2773540327408, 597.0387675841891, 614.640435345319, 679.4157024958532, 699.9545029573061, 720.5568575326137, 9842.693727120464, 10465.581376744845, 10467.790644187073, 10479.214058945458, 10771.56913723458, 669.1277124628747, 695.290803380549, 695.9304069593001, 700.8458139209366, 704.3942209699654, 4825.372701548777, 5021.397432308147, 5026.497350265017, 5027.145385284511, 5034.672746271481, 87298.0, 105470.0, 106184.46907765411, 107926.0, 110240.4487977571, 87753.0, 89047.10952890517, 89357.21285574383, 90028.0, 91458.0, 86828.69756953651, 87413.40530814164, 87834.0, 87933.12066879377, 89211.55394223117, 9116.817663646823, 9799.804003919739, 9818.852717209105, 9839.901600983898, 9862.408255504693, 52686.0, 54217.18674219969, 54385.18422223749, 55043.899122018134, 55316.617084573205, 67178.66410667915, 67229.66385168042, 67257.66371168113, 69281.65359173172, 74409.88385174335, 11739.295642261492, 11813.232139910879, 12211.877881221075, 12261.570845020382, 12365.75268494607, 12926.159799612995, 13315.933420332836, 13342.999275054604, 13531.496673115505, 13884.58346249614, 12312.606048507907, 12331.938340308241, 12430.875691242973, 12530.498780048696, 12678.049146313879, 12126.619675024012, 12168.45241964096, 12409.44157512896, 12572.0, 12665.240085594894, 10819.296745711503, 11634.883651163718, 12213.389330533615, 12387.876121239033, 12446.43991020388, 9856.605735770776, 10172.389656620626, 10297.433641149808, 10304.0, 10666.57333706674, 8377.246047855722, 9408.858867117136, 9927.801443970935, 10001.499925003574, 10038.799224015333], "value": 7578.6616028663275, "unit": "score"}], "name": "dromaeo_css", "value": 7263.162521664498, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 112.0, 112.0, 113.0, 113.0, 112.0, 112.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 105.0, 109.0, 142.0, 109.0, 109.0, 108.0, 108.0, 129.0, 110.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 183.0, 185.0, 183.0, 184.0, 182.0, 184.0, 183.0, 185.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 87.0, 59.0, 60.0, 60.0, 58.0, 74.0, 57.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 87.0, 69.0, 68.0, 69.0, 85.0, 69.0, 69.0, 83.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 89.0, 85.0, 89.0, 86.0, 89.0, 100.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 96.0, 94.0, 93.0, 95.0, 95.0, 102.0, 130.0], "value": 98.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 85.0, 85.0, 88.0, 87.0, 87.0, 88.0, 87.0, 87.0], "value": 86.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 55.0, 55.0, 57.0, 57.0, 57.0, 55.0, 57.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 80.0, 82.0, 73.0, 74.0, 71.0, 70.0, 71.0, 75.0, 71.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 87.0, 88.0, 91.0, 86.0, 87.0, 91.0, 87.0, 88.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 141.0, 138.0, 150.0, 158.0, 152.0, 139.0, 190.0, 175.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 171.0, 174.0, 176.0, 175.0, 172.0, 173.0, 175.0, 174.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 65.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1438.8, "alertThreshold": 2.0}]} 13:12:59 INFO - Return code: 0 13:12:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:12:59 INFO - # TBPL SUCCESS # 13:12:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:12:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:12:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:12:59 INFO - 2017-01-10 13:12:59.217 screenresolution[1654:10060] starting screenresolution argv=screenresolution get 13:12:59 INFO - 2017-01-10 13:12:59.220 screenresolution[1654:10060] Display 0: 1600x1200x32@60 13:12:59 INFO - 2017-01-10 13:12:59.226 screenresolution[1655:10063] starting screenresolution argv=screenresolution list 13:12:59 INFO - Available Modes on Display 0 13:12:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:12:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:12:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:12:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:12:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:12:59 INFO - Intel Iris: 13:12:59 INFO - Chipset Model: Intel Iris 13:12:59 INFO - Type: GPU 13:12:59 INFO - Bus: Built-In 13:12:59 INFO - VRAM (Dynamic, Max): 1536 MB 13:12:59 INFO - Vendor: Intel (0x8086) 13:12:59 INFO - Device ID: 0x0a2e 13:12:59 INFO - Revision ID: 0x0009 13:12:59 INFO - Displays: 13:12:59 INFO - Display: 13:12:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:12:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:12:59 INFO - Display Serial Number: 1600x1200 60 13:12:59 INFO - Main Display: Yes 13:12:59 INFO - Mirror: Off 13:12:59 INFO - Online: Yes 13:12:59 INFO - Rotation: Supported 13:12:59 INFO - Return code: 0 13:12:59 INFO - Running post-action listener: _resource_record_post_action 13:12:59 INFO - [mozharness: 2017-01-10 21:12:59.461640Z] Finished run-tests step (success) 13:12:59 INFO - Running post-run listener: _resource_record_post_run 13:12:59 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32250880; Write bytes: 551512576; Read time: 198; Write time: 1645 13:12:59 INFO - TinderboxPrint: CPU usage
53.8% 13:12:59 INFO - TinderboxPrint: I/O read bytes / time
32,250,880 / 198 13:12:59 INFO - TinderboxPrint: I/O write bytes / time
551,512,576 / 1,645 13:12:59 INFO - TinderboxPrint: CPU idle
2,221.6 (46.2%) 13:12:59 INFO - TinderboxPrint: CPU system
960.8 (20.0%) 13:12:59 INFO - TinderboxPrint: CPU user
1,623.3 (33.8%) 13:12:59 INFO - TinderboxPrint: Swap in / out
278,085,632 / 0 13:12:59 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 251388416; Write bytes: 251121664; Read time: 18109; Write time: 531 13:12:59 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 28896256; Write bytes: 298797568; Read time: 172; Write time: 1108 13:12:59 INFO - Running post-run listener: _upload_blobber_files 13:12:59 INFO - Blob upload gear active. 13:12:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:12:59 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 13:12:59 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:12:59 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:13:00 INFO - (blobuploader) - INFO - Open directory for files ... 13:13:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:13:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:13:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:01 INFO - (blobuploader) - INFO - Done attempting. 13:13:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:13:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:13:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:02 INFO - (blobuploader) - INFO - Done attempting. 13:13:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:13:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:03 INFO - (blobuploader) - INFO - Done attempting. 13:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:13:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:05 INFO - (blobuploader) - INFO - Done attempting. 13:13:05 INFO - (blobuploader) - INFO - Iteration through files over. 13:13:05 INFO - Return code: 0 13:13:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:13:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:13:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fb0575abb9a8f1ad47647c62a068fef415e9210decf6d704c456e15ea81a015af8cd68d1950583290791c9c9d7317cf6236d4e645aca78e9dd8284abbecb3839", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/93047d27328f6a38c0f337bcd664413b886385250e7c9eb3d364a1b9ef1ec72c3f7fd2a93c814f9b6904c05738b125e42eed96bffbba2c3d88d6f6ac9ad6a21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/feeb75aa50d82a0f7ed4382cbc47277aebb2df6d4fd70fc9acb5caa4deca4631951271a5620b89444c9c4c3c2b595740606db309547d8c8855d196d06590357d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2238e9bf5de5d1e762f69a5d5dd116b66d7a31080ca86d437eb232ea5a644d823fded417952ba103ab9ec4b9f0b1cf8e1126a806647cf8945d5ff3fd33094606"} 13:13:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:13:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:13:05 INFO - Contents: 13:13:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fb0575abb9a8f1ad47647c62a068fef415e9210decf6d704c456e15ea81a015af8cd68d1950583290791c9c9d7317cf6236d4e645aca78e9dd8284abbecb3839", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/93047d27328f6a38c0f337bcd664413b886385250e7c9eb3d364a1b9ef1ec72c3f7fd2a93c814f9b6904c05738b125e42eed96bffbba2c3d88d6f6ac9ad6a21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/feeb75aa50d82a0f7ed4382cbc47277aebb2df6d4fd70fc9acb5caa4deca4631951271a5620b89444c9c4c3c2b595740606db309547d8c8855d196d06590357d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2238e9bf5de5d1e762f69a5d5dd116b66d7a31080ca86d437eb232ea5a644d823fded417952ba103ab9ec4b9f0b1cf8e1126a806647cf8945d5ff3fd33094606"} 13:13:05 INFO - Running post-run listener: copy_logs_to_upload_dir 13:13:05 INFO - Copying logs to upload dir... 13:13:05 INFO - mkdir: /builds/slave/test/build/upload/logs 13:13:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.767564 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-10 13:13:05.413942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 13:13:05.418886) ========= 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.viLlIK5C4F/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.kSuKJTPFWl/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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/Graphics/sha512/fb0575abb9a8f1ad47647c62a068fef415e9210decf6d704c456e15ea81a015af8cd68d1950583290791c9c9d7317cf6236d4e645aca78e9dd8284abbecb3839", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/93047d27328f6a38c0f337bcd664413b886385250e7c9eb3d364a1b9ef1ec72c3f7fd2a93c814f9b6904c05738b125e42eed96bffbba2c3d88d6f6ac9ad6a21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/feeb75aa50d82a0f7ed4382cbc47277aebb2df6d4fd70fc9acb5caa4deca4631951271a5620b89444c9c4c3c2b595740606db309547d8c8855d196d06590357d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2238e9bf5de5d1e762f69a5d5dd116b66d7a31080ca86d437eb232ea5a644d823fded417952ba103ab9ec4b9f0b1cf8e1126a806647cf8945d5ff3fd33094606"} build_url:https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fb0575abb9a8f1ad47647c62a068fef415e9210decf6d704c456e15ea81a015af8cd68d1950583290791c9c9d7317cf6236d4e645aca78e9dd8284abbecb3839", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/93047d27328f6a38c0f337bcd664413b886385250e7c9eb3d364a1b9ef1ec72c3f7fd2a93c814f9b6904c05738b125e42eed96bffbba2c3d88d6f6ac9ad6a21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/feeb75aa50d82a0f7ed4382cbc47277aebb2df6d4fd70fc9acb5caa4deca4631951271a5620b89444c9c4c3c2b595740606db309547d8c8855d196d06590357d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2238e9bf5de5d1e762f69a5d5dd116b66d7a31080ca86d437eb232ea5a644d823fded417952ba103ab9ec4b9f0b1cf8e1126a806647cf8945d5ff3fd33094606"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 13:13:05.455606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:13:05.455918) ========= 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.viLlIK5C4F/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.kSuKJTPFWl/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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.005121 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:13:05.502887) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 13:13:05.503165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 13:13:05.506472) ========= ========= Total master_lag: 0.38 =========