builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0289 starttime: 1481581614.45 results: success (0) buildid: 20161212134146 builduid: 796dd43c047e470286fca023de0940f7 revision: 69ad226cd228e199d145b4ef9f72f1bfb7fd7e9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:54.447689) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:54.448199) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:54.448505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:54.475258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:54.475580) ========= 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.2KGkMIhApP/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.uVejPCTiSe/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-12 14:26:54-- 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% 166M=0s 2016-12-12 14:26:55 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.662389 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:55.162375) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:55.162730) ========= 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.2KGkMIhApP/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.uVejPCTiSe/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.025322 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:55.211699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-12 14:26:55.212115) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 69ad226cd228e199d145b4ef9f72f1bfb7fd7e9a --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 69ad226cd228e199d145b4ef9f72f1bfb7fd7e9a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2KGkMIhApP/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.uVejPCTiSe/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-12 14:26:55,204 truncating revision to first 12 chars 2016-12-12 14:26:55,204 Setting DEBUG logging. 2016-12-12 14:26:55,204 attempt 1/10 2016-12-12 14:26:55,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/69ad226cd228?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-12 14:26:56,030 unpacking tar archive at: graphics-69ad226cd228/testing/mozharness/ program finished with exit code 0 elapsedTime=1.114467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-12 14:26:56.348708) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:56.349021) ========= script_repo_revision: 69ad226cd228e199d145b4ef9f72f1bfb7fd7e9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:56.349448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:56.349723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 14:26:56.367780) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-12 14:26:56.368189) ========= /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.2KGkMIhApP/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.uVejPCTiSe/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:26:56 INFO - MultiFileLogger online at 20161212 14:26:56 in /builds/slave/test 14:26:56 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 14:26:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:26:56 INFO - {'append_to_log': False, 14:26:56 INFO - 'base_work_dir': '/builds/slave/test', 14:26:56 INFO - 'blob_upload_branch': 'Graphics', 14:26:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:26:56 INFO - 'branch': 'Graphics', 14:26:56 INFO - 'buildbot_json_path': 'buildprops.json', 14:26:56 INFO - 'config_files': ('talos/mac_config.py',), 14:26:56 INFO - 'default_actions': ('clobber', 14:26:56 INFO - 'read-buildbot-config', 14:26:56 INFO - 'download-and-extract', 14:26:56 INFO - 'populate-webroot', 14:26:56 INFO - 'create-virtualenv', 14:26:56 INFO - 'install', 14:26:56 INFO - 'run-tests'), 14:26:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:26:56 INFO - 'download_minidump_stackwalk': True, 14:26:56 INFO - 'download_symbols': 'ondemand', 14:26:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:26:56 INFO - 'tooltool.py': '/tools/tooltool.py', 14:26:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:26:56 INFO - '/tools/misc-python/virtualenv.py')}, 14:26:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:26:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:26:56 INFO - 'installer_path': 'installer.exe', 14:26:56 INFO - 'log_level': 'info', 14:26:56 INFO - 'log_name': 'talos', 14:26:56 INFO - 'log_to_console': True, 14:26:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:26:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:26:56 INFO - 'opt_config_files': (), 14:26:56 INFO - 'pip_index': False, 14:26:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:56 INFO - 'cmd': ('bash', 14:26:56 INFO - '-c', 14:26:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:56 INFO - 'enabled': True, 14:26:56 INFO - 'halt_on_failure': False, 14:26:56 INFO - 'name': 'check_screen_resolution'},), 14:26:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:56 INFO - 'cmd': ('bash', 14:26:56 INFO - '-c', 14:26:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:56 INFO - 'enabled': True, 14:26:56 INFO - 'halt_on_failure': False, 14:26:56 INFO - 'name': 'check_screen_resolution'},), 14:26:56 INFO - 'run_cmd_checks_enabled': True, 14:26:56 INFO - 'sps_profile': False, 14:26:56 INFO - 'sps_profile_interval': 0, 14:26:56 INFO - 'suite': 'dromaeojs', 14:26:56 INFO - 'system_bits': '32', 14:26:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:26:56 INFO - 'title': 't-yosemite-r7-0289', 14:26:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:26:56 INFO - 'use_talos_json': True, 14:26:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:26:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:26:56 INFO - 'work_dir': 'build'} 14:26:56 INFO - [mozharness: 2016-12-12 22:26:56.454683Z] Running clobber step. 14:26:56 INFO - Running pre-action listener: _resource_record_pre_action 14:26:56 INFO - Running main action method: clobber 14:26:56 INFO - rmtree: /builds/slave/test/build 14:26:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:26:58 INFO - Running post-action listener: _resource_record_post_action 14:26:58 INFO - [mozharness: 2016-12-12 22:26:58.884581Z] Finished clobber step (success) 14:26:58 INFO - [mozharness: 2016-12-12 22:26:58.884701Z] Running read-buildbot-config step. 14:26:58 INFO - Running pre-action listener: _resource_record_pre_action 14:26:58 INFO - Running main action method: read_buildbot_config 14:26:58 INFO - Using buildbot properties: 14:26:58 INFO - { 14:26:58 INFO - "project": "", 14:26:58 INFO - "product": "firefox", 14:26:58 INFO - "script_repo_revision": "default", 14:26:58 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 14:26:58 INFO - "repository": "", 14:26:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 14:26:58 INFO - "buildid": "20161212134146", 14:26:58 INFO - "pgo_build": "False", 14:26:58 INFO - "basedir": "/builds/slave/test", 14:26:58 INFO - "buildnumber": 6, 14:26:58 INFO - "slavename": "t-yosemite-r7-0289", 14:26:58 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:26:58 INFO - "platform": "yosemite_r7", 14:26:58 INFO - "scheduler": "tests-graphics-macosx64-talos", 14:26:58 INFO - "branch": "graphics", 14:26:58 INFO - "repo_path": "projects/graphics", 14:26:58 INFO - "revision": "69ad226cd228e199d145b4ef9f72f1bfb7fd7e9a", 14:26:58 INFO - "stage_platform": "macosx64", 14:26:58 INFO - "builduid": "796dd43c047e470286fca023de0940f7", 14:26:58 INFO - "slavebuilddir": "test" 14:26:58 INFO - } 14:26:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 14:26:58 INFO - Running post-action listener: _resource_record_post_action 14:26:58 INFO - [mozharness: 2016-12-12 22:26:58.888009Z] Finished read-buildbot-config step (success) 14:26:58 INFO - [mozharness: 2016-12-12 22:26:58.888142Z] Running download-and-extract step. 14:26:58 INFO - Running pre-action listener: _resource_record_pre_action 14:26:58 INFO - Running main action method: download_and_extract 14:26:58 INFO - mkdir: /builds/slave/test/build/tests 14:26:58 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')]} 14:26:58 INFO - trying https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 14:26:58 INFO - Downloading https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 14:26:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 14:26:59 INFO - Downloaded 1235 bytes. 14:26:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 14:26:59 INFO - Using the following test package requirements: 14:26:59 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 14:26:59 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:26:59 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 14:26:59 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:26:59 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 14:26:59 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:26:59 INFO - u'jsshell-mac64.zip'], 14:26:59 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:26:59 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 14:26:59 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 14:26:59 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:26:59 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 14:26:59 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:26:59 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 14:26:59 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:26:59 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 14:26:59 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:26:59 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 14:26:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 14:26:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 14:26:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 14:26:59 INFO - Fetch https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 14:27:00 INFO - Expected file size: 16287176 14:27:00 INFO - Obtained file size: 16287176 14:27:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 14:27:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 14:27:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 14:27:06 INFO - Fetch https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 14:27:07 INFO - Expected file size: 16287176 14:27:07 INFO - Obtained file size: 16287176 14:27:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 14:27:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 14:27:14 INFO - Fetch https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 14:27:15 INFO - Expected file size: 14409734 14:27:15 INFO - Obtained file size: 14409734 14:27:15 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')]} 14:27:15 INFO - trying https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 14:27:15 INFO - Downloading https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 14:27:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 14:27:17 INFO - Downloaded 69773281 bytes. 14:27:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 14:27:17 INFO - mkdir: /builds/slave/test/properties 14:27:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:27:17 INFO - Writing to file /builds/slave/test/properties/build_url 14:27:17 INFO - Contents: 14:27:17 INFO - build_url:https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 14:27:18 INFO - Running post-action listener: _resource_record_post_action 14:27:18 INFO - Running post-action listener: set_extra_try_arguments 14:27:18 INFO - [mozharness: 2016-12-12 22:27:18.366313Z] Finished download-and-extract step (success) 14:27:18 INFO - [mozharness: 2016-12-12 22:27:18.366440Z] Running populate-webroot step. 14:27:18 INFO - Running pre-action listener: _resource_record_pre_action 14:27:18 INFO - Running main action method: populate_webroot 14:27:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:27:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:27:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:27:18 INFO - '--tppagecycles', 14:27:18 INFO - '7'], 14:27:18 INFO - 'tests': ['tsvgm']}}, 14:27:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:27:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:27:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:27:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:27:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:27:18 INFO - 'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:27:18 INFO - 'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['damp', 'tps']}, 14:27:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:27:18 INFO - 'tests': ['damp', 'tps']}, 14:27:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['dromaeo_dom']}, 14:27:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:27:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['basic_compositor_video']}, 14:27:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:27:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['a11yr', 14:27:18 INFO - 'ts_paint', 14:27:18 INFO - 'tpaint', 14:27:18 INFO - 'sessionrestore', 14:27:18 INFO - 'sessionrestore_no_auto_restore', 14:27:18 INFO - 'tabpaint']}, 14:27:18 INFO - 'other-e10s': {'tests': ['a11yr', 14:27:18 INFO - 'ts_paint', 14:27:18 INFO - 'tpaint', 14:27:18 INFO - 'sessionrestore', 14:27:18 INFO - 'sessionrestore_no_auto_restore', 14:27:18 INFO - 'tabpaint']}, 14:27:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:27:18 INFO - 'ts_paint', 14:27:18 INFO - 'tpaint', 14:27:18 INFO - 'sessionrestore', 14:27:18 INFO - 'sessionrestore_no_auto_restore', 14:27:18 INFO - 'tabpaint']}, 14:27:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:27:18 INFO - 'ts_paint', 14:27:18 INFO - 'tpaint', 14:27:18 INFO - 'sessionrestore', 14:27:18 INFO - 'sessionrestore_no_auto_restore', 14:27:18 INFO - 'tabpaint']}, 14:27:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['a11yr', 14:27:18 INFO - 'ts_paint', 14:27:18 INFO - 'tpaint', 14:27:18 INFO - 'sessionrestore', 14:27:18 INFO - 'sessionrestore_no_auto_restore', 14:27:18 INFO - 'tabpaint']}, 14:27:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['a11yr', 14:27:18 INFO - 'ts_paint', 14:27:18 INFO - 'tpaint', 14:27:18 INFO - 'sessionrestore', 14:27:18 INFO - 'sessionrestore_no_auto_restore', 14:27:18 INFO - 'tabpaint']}, 14:27:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['tsvgx', 14:27:18 INFO - 'tsvgr_opacity', 14:27:18 INFO - 'tart', 14:27:18 INFO - 'tscrollx', 14:27:18 INFO - 'cart', 14:27:18 INFO - 'tsvg_static']}, 14:27:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:27:18 INFO - 'tsvgr_opacity', 14:27:18 INFO - 'tart', 14:27:18 INFO - 'tscrollx', 14:27:18 INFO - 'cart', 14:27:18 INFO - 'tsvg_static']}, 14:27:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:27:18 INFO - 'talos_options': ['--disable-e10s'], 14:27:18 INFO - 'tests': ['tp5o']}, 14:27:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:27:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:27:18 INFO - 'talos_options': ['--disable-e10s', 14:27:18 INFO - '--xperf_path', 14:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:18 INFO - 'tests': ['tp5n']}, 14:27:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:27:18 INFO - 'talos_options': ['--xperf_path', 14:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:18 INFO - 'tests': ['tp5n']}}, 14:27:18 INFO - 'talos.zip': {'path': '', 14:27:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:27:18 INFO - Running post-action listener: _resource_record_post_action 14:27:18 INFO - [mozharness: 2016-12-12 22:27:18.384877Z] Finished populate-webroot step (success) 14:27:18 INFO - [mozharness: 2016-12-12 22:27:18.384997Z] Running create-virtualenv step. 14:27:18 INFO - Running pre-action listener: _resource_record_pre_action 14:27:18 INFO - Running main action method: create_virtualenv 14:27:18 INFO - Creating virtualenv /builds/slave/test/build/venv 14:27:18 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 14:27:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:27:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:27:18 INFO - Using real prefix '/tools/python27' 14:27:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:27:19 INFO - Installing distribute.............................................................................................................................................................................................done. 14:27:22 INFO - Installing pip.................done. 14:27:22 INFO - Return code: 0 14:27:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:27:22 INFO - Reading from file tmpfile_stdout 14:27:22 INFO - Output received: 14:27:22 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) 14:27:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:22 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 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:22 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 14:27:22 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 14:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:22 INFO - 'HOME': '/Users/cltbld', 14:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:22 INFO - 'LOGNAME': 'cltbld', 14:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:22 INFO - 'MOZ_NO_REMOTE': '1', 14:27:22 INFO - 'NO_EM_RESTART': '1', 14:27:22 INFO - 'PAGER': '/bin/cat', 14:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:22 INFO - 'PWD': '/builds/slave/test', 14:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:22 INFO - 'SHELL': '/bin/bash', 14:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:22 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:22 INFO - 'USER': 'cltbld', 14:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:22 INFO - 'XPC_FLAGS': '0x0', 14:27:22 INFO - 'XPC_SERVICE_NAME': '0', 14:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:22 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 14:27:22 INFO - Cleaning up... 14:27:22 INFO - Return code: 0 14:27:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:22 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 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:22 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 14:27:22 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 14:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:22 INFO - 'HOME': '/Users/cltbld', 14:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:22 INFO - 'LOGNAME': 'cltbld', 14:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:22 INFO - 'MOZ_NO_REMOTE': '1', 14:27:22 INFO - 'NO_EM_RESTART': '1', 14:27:22 INFO - 'PAGER': '/bin/cat', 14:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:22 INFO - 'PWD': '/builds/slave/test', 14:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:22 INFO - 'SHELL': '/bin/bash', 14:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:22 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:22 INFO - 'USER': 'cltbld', 14:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:22 INFO - 'XPC_FLAGS': '0x0', 14:27:22 INFO - 'XPC_SERVICE_NAME': '0', 14:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:22 INFO - Downloading/unpacking psutil>=3.1.1 14:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:27:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:26 INFO - Installing collected packages: psutil 14:27:26 INFO - Running setup.py install for psutil 14:27:26 INFO - building 'psutil._psutil_osx' extension 14:27:26 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 14:27:27 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 14:27:27 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 14:27:27 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 14:27:27 INFO - building 'psutil._psutil_posix' extension 14:27:27 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 14:27:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:27:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:27:27 INFO - ^ 14:27:27 INFO - 1 warning generated. 14:27:27 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 14:27:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:27 INFO - Successfully installed psutil 14:27:27 INFO - Cleaning up... 14:27:27 INFO - Return code: 0 14:27:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:27 INFO - 'HOME': '/Users/cltbld', 14:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:27 INFO - 'LOGNAME': 'cltbld', 14:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:27 INFO - 'MOZ_NO_REMOTE': '1', 14:27:27 INFO - 'NO_EM_RESTART': '1', 14:27:27 INFO - 'PAGER': '/bin/cat', 14:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:27 INFO - 'PWD': '/builds/slave/test', 14:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:27 INFO - 'SHELL': '/bin/bash', 14:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:27 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:27 INFO - 'USER': 'cltbld', 14:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:27 INFO - 'XPC_FLAGS': '0x0', 14:27:27 INFO - 'XPC_SERVICE_NAME': '0', 14:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:27:30 INFO - Installing collected packages: mozsystemmonitor 14:27:30 INFO - Running setup.py install for mozsystemmonitor 14:27:31 INFO - Successfully installed mozsystemmonitor 14:27:31 INFO - Cleaning up... 14:27:31 INFO - Return code: 0 14:27:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:31 INFO - 'HOME': '/Users/cltbld', 14:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:31 INFO - 'LOGNAME': 'cltbld', 14:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:31 INFO - 'MOZ_NO_REMOTE': '1', 14:27:31 INFO - 'NO_EM_RESTART': '1', 14:27:31 INFO - 'PAGER': '/bin/cat', 14:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:31 INFO - 'PWD': '/builds/slave/test', 14:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:31 INFO - 'SHELL': '/bin/bash', 14:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:31 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:31 INFO - 'USER': 'cltbld', 14:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:31 INFO - 'XPC_FLAGS': '0x0', 14:27:31 INFO - 'XPC_SERVICE_NAME': '0', 14:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:31 INFO - Downloading/unpacking jsonschema==2.5.1 14:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:27:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:34 INFO - Downloading functools32-3.2.3-2.tar.gz 14:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:27:34 INFO - warning: no files found matching '*.txt' 14:27:34 INFO - no previously-included directories found matching 'build' 14:27:34 INFO - no previously-included directories found matching 'dist' 14:27:34 INFO - no previously-included directories found matching '.git*' 14:27:34 INFO - Installing collected packages: jsonschema, functools32 14:27:34 INFO - Running setup.py install for functools32 14:27:34 INFO - warning: no files found matching '*.txt' 14:27:34 INFO - no previously-included directories found matching 'build' 14:27:34 INFO - no previously-included directories found matching 'dist' 14:27:34 INFO - no previously-included directories found matching '.git*' 14:27:34 INFO - Successfully installed jsonschema functools32 14:27:34 INFO - Cleaning up... 14:27:34 INFO - Return code: 0 14:27:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:27:34 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')]} 14:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:34 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')]} 14:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:34 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 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:34 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 14:27:34 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 14:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:34 INFO - 'HOME': '/Users/cltbld', 14:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:34 INFO - 'LOGNAME': 'cltbld', 14:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:34 INFO - 'MOZ_NO_REMOTE': '1', 14:27:34 INFO - 'NO_EM_RESTART': '1', 14:27:34 INFO - 'PAGER': '/bin/cat', 14:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:34 INFO - 'PWD': '/builds/slave/test', 14:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:34 INFO - 'SHELL': '/bin/bash', 14:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:34 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:34 INFO - 'USER': 'cltbld', 14:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:34 INFO - 'XPC_FLAGS': '0x0', 14:27:34 INFO - 'XPC_SERVICE_NAME': '0', 14:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:27:35 INFO - Cleaning up... 14:27:35 INFO - Return code: 0 14:27:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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', '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 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:27: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 blobuploader==1.2.4 14:27:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:35 INFO - 'HOME': '/Users/cltbld', 14:27:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:35 INFO - 'LOGNAME': 'cltbld', 14:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:35 INFO - 'MOZ_NO_REMOTE': '1', 14:27:35 INFO - 'NO_EM_RESTART': '1', 14:27:35 INFO - 'PAGER': '/bin/cat', 14:27:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:35 INFO - 'PWD': '/builds/slave/test', 14:27:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:35 INFO - 'SHELL': '/bin/bash', 14:27:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:35 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:35 INFO - 'USER': 'cltbld', 14:27:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:35 INFO - 'XPC_FLAGS': '0x0', 14:27:35 INFO - 'XPC_SERVICE_NAME': '0', 14:27:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:35 INFO - Downloading/unpacking blobuploader==1.2.4 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27:37 INFO - Downloading blobuploader-1.2.4.tar.gz 14:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:27:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:27:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27:39 INFO - Downloading docopt-0.6.1.tar.gz 14:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:27:39 INFO - Installing collected packages: blobuploader, requests, docopt 14:27:39 INFO - Running setup.py install for blobuploader 14:27:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:27:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:27:39 INFO - Running setup.py install for requests 14:27:39 INFO - Running setup.py install for docopt 14:27:39 INFO - Successfully installed blobuploader requests docopt 14:27:39 INFO - Cleaning up... 14:27:40 INFO - Return code: 0 14:27:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:40 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')]} 14:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:40 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')]} 14:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:40 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 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:40 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 14:27:40 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 14:27:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:40 INFO - 'HOME': '/Users/cltbld', 14:27:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:40 INFO - 'LOGNAME': 'cltbld', 14:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:40 INFO - 'MOZ_NO_REMOTE': '1', 14:27:40 INFO - 'NO_EM_RESTART': '1', 14:27:40 INFO - 'PAGER': '/bin/cat', 14:27:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:40 INFO - 'PWD': '/builds/slave/test', 14:27:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:40 INFO - 'SHELL': '/bin/bash', 14:27:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:40 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:40 INFO - 'USER': 'cltbld', 14:27:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:40 INFO - 'XPC_FLAGS': '0x0', 14:27:40 INFO - 'XPC_SERVICE_NAME': '0', 14:27:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-vaYxzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-l4fe_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-kmUwZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-rCyne6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ObtPIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-vyIdaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-hKObZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-joNzkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-1W02jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-azsLS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-qyvEsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-0d_4oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Xbk0EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-rnP8v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-DF9s_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-40Euwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:42 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ilajQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:27:42 INFO - Running setup.py install for manifestparser 14:27:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:27:42 INFO - Running setup.py install for mozcrash 14:27:42 INFO - Running setup.py install for mozdebug 14:27:42 INFO - Running setup.py install for mozdevice 14:27:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:27:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:27:42 INFO - Running setup.py install for mozfile 14:27:42 INFO - Running setup.py install for mozhttpd 14:27:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for mozinfo 14:27:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for mozInstall 14:27:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for mozleak 14:27:43 INFO - Running setup.py install for mozlog 14:27:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for moznetwork 14:27:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:27:43 INFO - Running setup.py install for mozprocess 14:27:43 INFO - Running setup.py install for mozprofile 14:27:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Running setup.py install for mozrunner 14:27:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Running setup.py install for mozscreenshot 14:27:44 INFO - Running setup.py install for moztest 14:27:44 INFO - Running setup.py install for mozversion 14:27:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:27:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:27:44 INFO - Cleaning up... 14:27:44 INFO - Return code: 0 14:27:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:44 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 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:44 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 14:27:44 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 14:27:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:44 INFO - 'HOME': '/Users/cltbld', 14:27:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:44 INFO - 'LOGNAME': 'cltbld', 14:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:44 INFO - 'MOZ_NO_REMOTE': '1', 14:27:44 INFO - 'NO_EM_RESTART': '1', 14:27:44 INFO - 'PAGER': '/bin/cat', 14:27:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:44 INFO - 'PWD': '/builds/slave/test', 14:27:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:44 INFO - 'SHELL': '/bin/bash', 14:27:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:44 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:44 INFO - 'USER': 'cltbld', 14:27:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:44 INFO - 'XPC_FLAGS': '0x0', 14:27:44 INFO - 'XPC_SERVICE_NAME': '0', 14:27:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:44 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-1gts4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:45 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-_Gmsw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:45 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-_LO8GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:45 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-S7Dmt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:45 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-QPg1Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:45 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-DZj5AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:45 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-nqfJg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:45 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-6bLb3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:45 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-vz7uQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:45 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)) 14:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:45 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-evoH6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:46 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-WPIC22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:46 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-uLoP9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:46 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-mFFM7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:46 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Kf_Rq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:46 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-2R33og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:46 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)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:46 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-NcY2Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:46 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-YWOkMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:46 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)) 14:27:46 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)) 14:27:46 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)) 14:27:46 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)) 14:27:46 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)) 14:27:46 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)) 14:27:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:27:46 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 14:27:46 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 14:27:46 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 14:27:46 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 14:27:46 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 14:27:46 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 14:27:49 INFO - Downloading blessings-1.6.tar.gz 14:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:27:49 INFO - Installing collected packages: blessings 14:27:49 INFO - Running setup.py install for blessings 14:27:49 INFO - Successfully installed blessings 14:27:49 INFO - Cleaning up... 14:27:49 INFO - Return code: 0 14:27:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:27:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:50 INFO - Reading from file tmpfile_stdout 14:27:50 INFO - Current package versions: 14:27:50 INFO - blessings == 1.6 14:27:50 INFO - blobuploader == 1.2.4 14:27:50 INFO - docopt == 0.6.1 14:27:50 INFO - functools32 == 3.2.3-2 14:27:50 INFO - jsonschema == 2.5.1 14:27:50 INFO - manifestparser == 1.1 14:27:50 INFO - mozInstall == 1.12 14:27:50 INFO - mozcrash == 1.0 14:27:50 INFO - mozdebug == 0.1 14:27:50 INFO - mozdevice == 0.49 14:27:50 INFO - mozfile == 1.2 14:27:50 INFO - mozhttpd == 0.7 14:27:50 INFO - mozinfo == 0.9 14:27:50 INFO - mozleak == 0.1 14:27:50 INFO - mozlog == 3.4 14:27:50 INFO - moznetwork == 0.27 14:27:50 INFO - mozprocess == 0.23 14:27:50 INFO - mozprofile == 0.28 14:27:50 INFO - mozrunner == 6.13 14:27:50 INFO - mozscreenshot == 0.1 14:27:50 INFO - mozsystemmonitor == 0.3 14:27:50 INFO - moztest == 0.7 14:27:50 INFO - mozversion == 1.4 14:27:50 INFO - psutil == 3.1.1 14:27:50 INFO - requests == 1.2.3 14:27:50 INFO - wsgiref == 0.1.2 14:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:50 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 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:50 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 14:27:50 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 14:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:50 INFO - 'HOME': '/Users/cltbld', 14:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:50 INFO - 'LOGNAME': 'cltbld', 14:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:50 INFO - 'MOZ_NO_REMOTE': '1', 14:27:50 INFO - 'NO_EM_RESTART': '1', 14:27:50 INFO - 'PAGER': '/bin/cat', 14:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:50 INFO - 'PWD': '/builds/slave/test', 14:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:50 INFO - 'SHELL': '/bin/bash', 14:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:50 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:50 INFO - 'USER': 'cltbld', 14:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:50 INFO - 'XPC_FLAGS': '0x0', 14:27:50 INFO - 'XPC_SERVICE_NAME': '0', 14:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 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)) 14:27:50 INFO - Cleaning up... 14:27:50 INFO - Return code: 0 14:27:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:50 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 0x10383d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa523d991a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, '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.2KGkMIhApP/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.uVejPCTiSe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:50 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 14:27:50 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 14:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:50 INFO - 'HOME': '/Users/cltbld', 14:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:50 INFO - 'LOGNAME': 'cltbld', 14:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:50 INFO - 'MOZ_NO_REMOTE': '1', 14:27:50 INFO - 'NO_EM_RESTART': '1', 14:27:50 INFO - 'PAGER': '/bin/cat', 14:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:50 INFO - 'PWD': '/builds/slave/test', 14:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:50 INFO - 'SHELL': '/bin/bash', 14:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:27:50 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:50 INFO - 'USER': 'cltbld', 14:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:50 INFO - 'XPC_FLAGS': '0x0', 14:27:50 INFO - 'XPC_SERVICE_NAME': '0', 14:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:27:50 INFO - Cleaning up... 14:27:50 INFO - Return code: 0 14:27:50 INFO - Running post-action listener: _resource_record_post_action 14:27:50 INFO - Running post-action listener: _start_resource_monitoring 14:27:50 INFO - Starting resource monitoring. 14:27:50 INFO - [mozharness: 2016-12-12 22:27:50.654751Z] Finished create-virtualenv step (success) 14:27:50 INFO - [mozharness: 2016-12-12 22:27:50.655813Z] Running install step. 14:27:50 INFO - Running pre-action listener: _resource_record_pre_action 14:27:50 INFO - Running main action method: install 14:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:50 INFO - Reading from file tmpfile_stdout 14:27:50 INFO - Detecting whether we're running mozinstall >=1.0... 14:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:27:51 INFO - Reading from file tmpfile_stdout 14:27:51 INFO - Output received: 14:27:51 INFO - Usage: mozinstall [options] installer 14:27:51 INFO - Options: 14:27:51 INFO - -h, --help show this help message and exit 14:27:51 INFO - -d DEST, --destination=DEST 14:27:51 INFO - Directory to install application into. [default: 14:27:51 INFO - "/builds/slave/test"] 14:27:51 INFO - --app=APP Application being installed. [default: firefox] 14:27:51 INFO - mkdir: /builds/slave/test/build/application 14:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 14:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 14:28:12 INFO - Reading from file tmpfile_stdout 14:28:12 INFO - Output received: 14:28:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:28:12 INFO - Running post-action listener: _resource_record_post_action 14:28:12 INFO - [mozharness: 2016-12-12 22:28:12.993644Z] Finished install step (success) 14:28:12 INFO - [mozharness: 2016-12-12 22:28:12.993768Z] Running run-tests step. 14:28:12 INFO - Running pre-action listener: _resource_record_pre_action 14:28:12 INFO - Running main action method: run_tests 14:28:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:28:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:28:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:28:13 INFO - 2016-12-12 14:28:13.007 screenresolution[1629:8115] starting screenresolution argv=screenresolution get 14:28:13 INFO - 2016-12-12 14:28:13.010 screenresolution[1629:8115] Display 0: 1600x1200x32@60 14:28:13 INFO - 2016-12-12 14:28:13.016 screenresolution[1630:8118] starting screenresolution argv=screenresolution list 14:28:13 INFO - Available Modes on Display 0 14:28:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:28:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:28:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:28:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:28:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:28:13 INFO - Intel Iris: 14:28:13 INFO - Chipset Model: Intel Iris 14:28:13 INFO - Type: GPU 14:28:13 INFO - Bus: Built-In 14:28:13 INFO - VRAM (Dynamic, Max): 1536 MB 14:28:13 INFO - Vendor: Intel (0x8086) 14:28:13 INFO - Device ID: 0x0a2e 14:28:13 INFO - Revision ID: 0x0009 14:28:13 INFO - Displays: 14:28:13 INFO - Display: 14:28:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:28:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:28:13 INFO - Display Serial Number: 1600x1200 60 14:28:13 INFO - Main Display: Yes 14:28:13 INFO - Mirror: Off 14:28:13 INFO - Online: Yes 14:28:13 INFO - Rotation: Supported 14:28:13 INFO - Return code: 0 14:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:28:13 INFO - Python 2.7.3 14:28:13 INFO - Return code: 0 14:28:13 INFO - grabbing minidump binary from tooltool 14:28:13 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')]} 14:28:13 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 0x103652d30>, '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 0x1034b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10364ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:28:13 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 14:28:13 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 14:28:13 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 14:28:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:13 INFO - Return code: 0 14:28:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:28:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:28:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:28:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:28:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:28:13 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/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 14:28:13 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/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0289 --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 14:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2KGkMIhApP/Render', 14:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:13 INFO - 'HOME': '/Users/cltbld', 14:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:13 INFO - 'LOGNAME': 'cltbld', 14:28:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:13 INFO - 'MOZ_NO_REMOTE': '1', 14:28:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:13 INFO - 'NO_EM_RESTART': '1', 14:28:13 INFO - 'PAGER': '/bin/cat', 14:28:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:13 INFO - 'PWD': '/builds/slave/test', 14:28:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:13 INFO - 'SHELL': '/bin/bash', 14:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVejPCTiSe/Listeners', 14:28:13 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:13 INFO - 'USER': 'cltbld', 14:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:13 INFO - 'XPC_FLAGS': '0x0', 14:28:13 INFO - 'XPC_SERVICE_NAME': '0', 14:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:13 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/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 14:28:13 INFO - mozversion application_buildid: 20161212134146 14:28:13 INFO - mozversion application_changeset: 69ad226cd228e199d145b4ef9f72f1bfb7fd7e9a 14:28:13 INFO - mozversion application_display_name: Nightly 14:28:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:13 INFO - mozversion application_name: Firefox 14:28:13 INFO - mozversion application_remotingname: firefox 14:28:13 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 14:28:13 INFO - mozversion application_vendor: Mozilla 14:28:13 INFO - mozversion application_version: 53.0a1 14:28:13 INFO - mozversion platform_buildid: 20161212134146 14:28:13 INFO - mozversion platform_changeset: 69ad226cd228e199d145b4ef9f72f1bfb7fd7e9a 14:28:13 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 14:28:13 INFO - mozversion platform_version: 53.0a1 14:28:13 INFO - using testdate: 1481581693 14:28:13 INFO - actual date: 1481581693 14:28:13 INFO - starting webserver on 'localhost:49242' 14:28:13 INFO - SUITE-START | Running 2 tests 14:28:13 INFO - TEST-START | dromaeo_css 14:28:13 INFO - operating with platform_type : mac_ 14:28:13 INFO - Initialising browser for dromaeo_css test... 14:28:13 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpzHnXik/profile http://localhost:49242/getInfo.html) 14:28:16 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 14:28:16 INFO - PROCESS | 1640 | colorDepth:24 14:28:16 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 14:28:16 INFO - PROCESS | 1640 | __metrics 14:28:16 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:28:16 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:17 INFO - TEST-INFO | 1640: exit 0 14:28:17 INFO - Browser initialized. 14:28:17 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:17 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpzHnXik/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:29 INFO - PROCESS | 1643 | RSS: Main: 236929024 14:28:29 INFO - PROCESS | 1643 | 14:29:20 INFO - PROCESS | 1643 | 1481581760705 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:31:34 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 14:31:36 INFO - PROCESS | 1643 | RSS: Main: 410681344 14:31:36 INFO - PROCESS | 1643 | 14:34:39 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 14:34:39 INFO - PROCESS | 1643 | RSS: Main: 376369152 14:34:39 INFO - PROCESS | 1643 | 14:37:42 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 14:37:42 INFO - PROCESS | 1643 | RSS: Main: 352301056 14:37:42 INFO - PROCESS | 1643 | 14:40:45 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 14:40:46 INFO - PROCESS | 1643 | RSS: Main: 358170624 14:40:46 INFO - PROCESS | 1643 | 14:43:49 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 14:43:50 INFO - PROCESS | 1643 | RSS: Main: 340365312 14:43:50 INFO - PROCESS | 1643 | 14:46:53 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 14:46:54 INFO - PROCESS | 1643 | RSS: Main: 475947008 14:46:54 INFO - PROCESS | 1643 | 14:46:54 INFO - PROCESS | 1643 | __start_tp_report 14:46:54 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 14:46:54 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 14:46:54 INFO - PROCESS | 1643 | |i|pagename|runs| 14:46:54 INFO - PROCESS | 1643 | |0;dojo.html;3338.6995170434657;3348.3805495983247;3351.480520519319;3376.662333766623;3418.5897692276917;5604.3835178130375;5696.373398926125;5727;5758.165066065423;5792.218050563172;5615.2700148980675;5653.4911857932775;5655.123455864337;5655.745491452884;5657.519110875581;5108.1826907694685;5138.5889128869785;5146.176611742122;5157.71632560209;5158.690478571279;5262.657927234736;5282.471752824726;5286.074936886049;5292.973535132319;5293.232481290211;5208.921866172011;5213.191955246943;5233.450487698794;5241;5247.790088396459;5260.237265596467;5277.182036784305;5295.4969277918535;5308.761105750251;5333.386660534049;5077.593792496591;5093.949060509384;5139.460356662534;5218.060749065166;5223.242629818693;5547.472990065938;5634.3802181759975;5653.604247702621;5678.205051292781;5680.5455563554815;6191.25704915413;6203.658798766066;6204.844878878019;6209.751609935597;6233.719482623293;5008.774605142778;6136.610985192662;6187.783427580058;6263.937360626426;6280.120783090371;5705.115707065412;5735.11105778605;5764.308283006066;5780.739866705924;5815.709214539256;5187.455317191716;6281.214848143982;6283;6284.622922624657;6297.4647154992335;5988.700564971821;6066.150738896558;6127.295361033538;6142.201513803177;6149.2313460817395;6143.051335359052;6150.7847225346895;6181.783637572753;6226.034964580497;6231.40801623845;6193.721282542297;6197.349278325801;6204.565680402328;6209.348018458088;6221.346758590374;5181.300524429229;6046.274447066292;6221.004639257697;6230.7819226326865;6249.343818899041;4777.928331075037;4883.121038213085;4883.780229889663;4889.48660390661;4891;4390.890227744332;4410.779461027;4418.8453404130705;4441.555844415532;4451.77741112943;5622.353429355595;5672.064109421982;5688.516476099495;5697.914531282034;5708.4862362387585;6152.753889844445;6155.599886007395;6166.660833654102;6167;6173.938260617337;5688.345840228344;5738.454846789548;5741.827745167651;5743.167240750068;5747.453991870766;5278.894422111536;5334.8132815352055;5363.115086010843;5373.919391209135;5426.67439953604;6288.52836037299;6293.150424692608;6311.084892690626;6318.589291696025;6325.272593651789;6158;6179.196704428396;6202.689865506616;6202.906956395567;6233;6174.289956655042;6224.346443623354;6239.75040998355;6253.155823963707;6308.621482711052;6137.8366772191985;6187.195664563578;6191.4118158774845;6192.349803270772;6195;6176.752929882754;6178.752849885954;6186.752529898934;6195.19462469876;6204.627722336674;5917.023691090922;5944;6030.879382412415;6095.116208149705;6099.4510494053975;5963.13534537481;6069.2716873975405;6097.634141951497;6110.619513019744;6130.846728831636;5944;5957.642541447527;5959.791407300723;5975.581709280309;5985.25184351956;5980.162777211281;6061.484773794101;6067.514598832171;6094.7562097517375;6102.389761023862;5840.007198776303;5878.617889837147;5927.762889484372;5950.9702451487465;5965.373635768182 14:46:54 INFO - PROCESS | 1643 | |1;ext.html;418.67343472091767;445.46321682372746;463.90953764016007;477.5177071158129;492.2321178960821;30287.9399221027;31785.68214317856;39399.2120157597;40382;40571;41335.58664413355;41757;41838.581614183924;41856.79071604645;42028.73913782591;9224.123708247706;9490.478023708692;9500.619975200983;9502.952485237563;9511.80976380472;8057.9524661793885;8434.578271086451;8486;8728.170823771763;8744.956275218616;7662.850572414127;10303.536340864679;11476.598319058834;11488.195826292163;11671.883281167164;11215.439228038565;11378.203525753117;11396.25924314921;11467.483963221717;11469.139814513945;8439;11282.774344513064;11370.204085714004;11375.829362559569;11389.601363952304;30793.92221272267;31522.054338369657;31563.684363156535;31629.734810607548;37863.81068094669;2976.7951399263065;2994;3017.3965206958696;3241.789283696552;3413.5050417689545;29205.853970730222;29675.85162074176;29765.851170744223;29921.102366929026;29963.850180749174;2961.318896653782;3159.605049368829;3196.5844440222854;3301.4552598821406;3336.7831090979253;398637;399803;400016;400454;400637;56523.71738141283;56724;56809.86380272372;56832;56930.715346423;59408.40591594029;59495.405045949854;59545.40454595485;59556.70221648951;59636.40363596395;15318.463853765288;15522.767158492632;15546.689066218612;15557.844421555867;15566.922165389327;12144.149909506426;12225.93887030577;12226.510939562495;12228.816567751492;12262.632121036384;14251.714965700628;14654.413823446943;15021.221074101326;16068;16076.954997925097;5583.0787919992745;5613.635113717595;6732.528722989442;6771.119754431892;6816.352446517573;901.4411065139524;1032.1897310611134;1051.164324362134;1057.5875408590655;1076.924615276923;28568.71431285702;29359.412811743645;29469.705302946695;29878.954236601614;30052.54921176184;992.1120597065586;1033.4316126130598;1054.8312270036756;1088.6733979806027;1131.2929419113054;13140.802887956688;13871.722565548835;14061.43754249839;14136.222507761966;14384.712305754036;574680;578022;580553;580901.0954945198;583434;43217.783911080245;43968;43975.78012109919;47797.28304075442;49277.26084108741;1328.747537967783;1333.2200662612286;1356.179511395631;1357.2195987307339;1358.1783021271988;28004;28305.57541636836;28632.713672863003;28713.28216794597;29089.563656544746;44890;45306.77346613246;45402;45520.317195241434;45528.772356139336;718449;738090;739680;740148;740911;23817.64273535933;24171.879140604186;24209.636855447534;24224.273271801874;24233.909474073356;39721.60278397179;40154;40501.1899762009;40722.389164163156;41025.79487102546;33963;34192.487112692834;34270.14324641804;34896;35225.29549408946;33264.50103248405;33547.99356019323;34111.48832767461;34325.82837085899;34378;33558.3288334227;34079.318413632085;34176;34225.82887085548;34282.14294642654;29624.259393515335;30498.84750576233;30630;30641.387172255985;30718;22569.661455078516;22816.657750134094;23022.654660180448;23132.76867231306;23153.76846231516 14:46:54 INFO - PROCESS | 1643 | |2;jquery.html;308.40016168552177;350.7632348164988;370.36297568182727;382.6001828089647;393.47864080093865;14825.555233343004;15159.696806063872;17255.568610784736;19575.216991320365;20847.061882215297;19899.602007959867;20338.796612033875;20392.184312627476;20562.897185514088;20655.586888262227;5302.3106996090455;5813.505852002564;5856.385079566648;5860.384659610743;5866.472017518422;4066.32905570582;4238.491381034265;5459;5811.651300921958;5815.331236907768;4245.596668316505;4294.248506511363;6474.9963755617955;6479.967600161993;6481.416672499474;6167.7532898684;6403.807885763435;6464.254651244161;6468.870622587522;6480.995445705899;5602.1036634138345;5602.747876345574;5608.383077861432;5613.831585052414;5616.241807355996;24292.514149717084;24353;24749.5050098997;24931;25140.497190056096;2226.699395581592;2265.229821860559;2363.6572696958847;2398.556267090594;2830.3207230264793;14149.504767333094;14630.707385852224;14731.263436828116;15209.391624335123;15280.847191528053;1532.3793863485307;1797.1283927295383;1827.2142978519232;1835.155828318975;1881.7459642948163;104562.47718761358;108370.45814770876;108751;108980.28157747361;110170.44914775375;8807.559622019002;10192.643257486101;10377.896221037692;10413.479326033668;10684.94657526723;11796.466459360228;12527.812082818766;12552.184108032949;12753.872461275454;12770.042246831525;7502;7709.7301594443925;7717.382609391235;8229.547374894439;8346;7211.278872112747;7646.579438130956;8032.196780321921;8284.212999765012;8499.490030598185;6449.903251451232;6594.670266486656;6598.802035938929;6604.636744978976;6720.2943690912725;1809.5975618895461;1844.3729132094884;1847.8152184781413;1849.1309084730156;1853.944381668552;929.9163075323254;943.2831048403262;976.5947131940165;1000.9899901000897;1030.3663247102977;11527.077833773277;11655.650330490098;11835.11236657254;12009.63971080869;21614.675779863315;415.8295099009392;416.44196776319876;422.9302165142717;424.1072542298417;426.6757264479018;6059.164560725418;6073.210482637229;6090.695465226721;6221.813345599639;6245.063240513869;563676;570420;583104;583885;587828;130052.3497382526;131020.3448982768;131191;131854;134244;447.1928169653806;463.6615270852297;464.56795180482476;464.6399040743518;464.85589467265254;11245.044171245536;11346.659600212008;11381.260218085798;11572;11856.644300670994;49401.75299123481;52045;53464.73267633637;53588.73205633947;53727.925441490166;53127.20309195443;70515.29484705087;70963.64518177375;72314.1921451968;74300.51398971882;7744.690212391667;7884.921150788418;8042.638081286239;8140.145284745016;8300.501969881585;10013.949930250303;10189.337693049929;12137.817932730839;12331.198472099284;12878.549250776177;10708.946455267675;10732.034116929513;10773.784524309312;11231.71920701989;11307.038901693448;10660.307080039773;10730.409827459565;10878.292910960763;11330.150238731963;11331.546738130382;11087;11275.436228188722;11310.377929213972;11367.886321137014;11544.076473882238;7825.33484653788;7831.216878312123;8120.796980075545;8353.874691879506;8372.748817535483;10312.123469505175;10530.631427899987;11021.559137634405;11063.557457701923;11108 14:46:54 INFO - PROCESS | 1643 | |3;mootools.html;1327.3164320375004;1464.54599074287;1497.5357639131867;1653.2890856931522;1827.5431142214447;7446.813829654261;7827.060752709683;7831.295183433497;7832.216778322165;7833.216678332164;7833.843323133534;8116.026076870769;8119.391045671584;8249.216324449168;8254.215849494303;2299.2642354446584;2333.136739406422;2335.789778919897;2336.6611841283;2345.26124270855;2063.6182306273386;2141.2184552638255;2299.195281651417;2335.3811240021323;2364.373441038126;1843.8432733217626;2100.747910250772;2315.849469784467;2315.918942837001;2327.860328380294;2282.828787840902;2292.919747808827;2306.7347255065715;2311.3759284993125;2324.5234726881117;2043.3052762060822;2116.767155612881;2305.319930620471;2339.578875802355;2341.7307009693764;7984.321332686671;8189.7133600323705;8219.219174178443;8321.542315172663;8378.8324233515;5020.272060551236;5186.455422180655;5194.6104042196985;5199.506046925536;5207.192885102815;3261.7553683473598;3345.080102971678;3437.2094418283937;3444.7588668793196;3458.342914846171;978.1636700621009;998.2612866478826;1005.7535903703566;1019.918406527476;1026.697124348319;10466.947665261701;10541.104006159485;10634.30876992993;10657;10661.040506354466;4143.7928103594695;4325.545817689161;4338.219120558267;4411.250087485135;4436.511983681792;8592.269657079094;8594.699185528476;8597.484150950962;8599.914000860037;8600.268977137013;5040.193569028937;5052.191649336089;5053.963937392826;5057.873553161126;5064.898702025939;3941.5664276929515;4640.512746161672;4746.477887432379;4748.026654535812;4774.427068751703;3457.4640930655787;3491.045014791725;3500.649935006479;3536.9823150884595;3587.408077667208;1014.1734486393566;1014.7868947521104;1026.8151732688189;1042.7341028037802;1079.2984560035882;759.742625954047;856.8200677857719;875.6191056890145;891.64334266294;961.1335430652177;5549.056660367747;5649.406812284651;5709.9714501427225;5835.9708201458725;5865.149553314831;845.1421806866036;904.1862323908535;928.6888892221182;929.400536653868;991.5884907763342;3791.279656865187;3793.981030094887;3844.36567966288;3897.902552436212;3963.583823698528;9585.808283834283;9986;10006.299559030798;10010.849837252446;10014.79970400588;9396.154346108746;9781.407926899377;9957.950210249048;9963.50182490887;9970.351927124713;7598.772036838904;7807.219278072147;7814.882776758353;7819.726309579251;7820.413468989848;5419.376771671308;5507.642003269935;5510.701652710892;5650.745716442688;5881.264841894763;9205.033471485398;9299;9299.814003719752;9316.48759318217;9327.207187389147;9263.305252106255;9347.953260233928;9353.298502612468;9384.577694003923;9536.141747242782;6815.965920170367;7016.859662806817;7059.258777828254;7158.2841715828;7220.3862671671395;7829.686812527435;7911.802204944923;7914.744297875078;7927.048754149539;7933.3653307734085;6944.340287672663;6945.305469453015;7018.508704390848;7042.577445353295;7185.748498802517;6714.160729908762;6758.391744742997;6895.10363652742;6943.826404339932;6947.305269473012;6339.429451349401;6500.642464664489;6564.868702626016;6575.342465753386;6676.132102826796;4270.316749320094;4723.858284251478;4830.4444988826735;4833.613310935187;4939.259111133215;4686.906261874811;4698.976505117589;4822.252550854623;4884;5000.899982000413 14:46:54 INFO - PROCESS | 1643 | |4;prototype.html;334.4097667616657;349.0958417698161;352.9100079479734;370.1098857248319;371.5522795031987;4576.107659006491;4914.729689867056;5105.744712764365;5215.191645294981;5231.352124080917;4205.327147656376;4428.889277768058;4629.62962962963;5023.497650234975;5050.318207042048;3362.562866827309;3443.414619514676;3850.3635954719202;4037.5558688544384;4108.465899433069;3226.403115423654;3356.1945133167987;3832.463455116286;3954.228925359556;4093.1609020150945;4066.1867626474823;4090.365993271033;4093.89765255868;4105.50733911931;4118.775861035037;3369.730421566269;3496.6503349665086;3842.8296655259524;4040.252553277653;4040.5353384360883;3500.03748969033;3584.7490675652716;3590.676839084495;3608;3614.5301110855685;4728.267118596623;4986.130201174559;5010.549050585465;5021.372328458942;5053.772580233898;4452.688311818174;4601.768142450908;4652.930206046912;4652.97634520405;4661.790219440133;4882.681675947474;5388.679773455528;5407.432219616923;5446;5450.781968721247;3633.255182687543;3956.4263181838473;3961.861334853295;3967.2858885400615;4009.8596549120934;5317.388500322435;5743.339515955635;5760.452756988079;5768.558210178181;5800.941990580082;3090.860911258999;3589.192431702846;3706.4810926470313;3756.549214094326;3996.300647386696;3737.121776382548;4086;4123.773192474383;4131.97934010334;4156.750594964312;3975.7415767975567;4586.449626044896;4610.216263235258;4620.937184447529;4638.930416043762;5246.291750613695;5388.407275199725;5417.458254174551;5439.102548079602;5450.291462109901;1255.2468518888777;1281.2952875918209;1285.6014635463036;1312.094654688281;1334.6730051137533;835.703325319515;919.3426699909596;931.8462453695064;937.0535758883576;944.891337496183;4430;4810.470848206694;4869.780859861244;4884.020747344117;4911.312416261726;4408.236705317834;5076.670016448919;5197.324347834833;5296.305182341691;5311.088008317003;4393.912121757611;4823.975880120647;4832.95167048332;4855.368802055781;4896.779644915916;2503.2865633294787;2758.462099890542;2762.535855996325;2784.7026203382293;2806.368567072433;4570.851699701135;4671.789769460314;4794.736289504111;5176.430592634807;5430.972845135749;5018.799248030038;5343.156610969209;5361.463853614608;5399.653279110354;5403.972980135153;4802.967362017183;4820.39745031871;5132.589392848488;5359.22291267764;5458.754356053987;4448.9110217796115;4784.856454306377;5015.17249653803;5239.633225674319;5252.527272545489;4509.391232183744;4700.720150726826;5336.733163341895;5540.806071787468;5546.417626149358;5839.5036421904615;5846.883062338815;5855.921147992572;5864.357979765672;5933.821985340447;3017.89437369691;3779.22525882188;3805.9238815224094;3831.272058308912;3855.325318069383;5005.449400566008;5627.071533196977;5642.5485961122195;5655.745491452977;5707.20099186106;4893.266010098514;5344.679319240858;5519.66881987066;5535.39110697831;5571.022287088187;4260;5208.921866172086;5417.6478528895495;5507.862303442285;5520.475554822286;5050.696958182521;5134.794608215779;5250.482176941382;5251.030863426216;5277.313949186581;4559.566841150086;4870.4155501340065;5159.071367153948;5424.294841670716;5468.9179662304305;4469.932951005672;4629.652776041743;4736.692115012514;5428.579994603375;5455.754491047833 14:46:54 INFO - PROCESS | 1643 | |5;yui.html;732.5934106570853;741.8034220931451;778.1323823936309;814.6049166154418;839.47532792005;12261.570845020426;14947.327370268336;15309;15543.689126217498;15719.292631831566;13747.58757237282;14027.08823926444;14079.648008799784;14226.217558034305;14271.71456570868;679.2833560593572;846.1665259719172;860.9870851937226;862.4221771413169;862.9050804411542;701.799987003704;711.9181294151188;842.616609442702;873.598144853365;875.4178471316567;913.2511340700595;914.4102054175053;915.3089417489786;916.4043371808311;916.6929078758624;908.2325435007408;908.7182973278304;909.4225167018958;909.5952301225957;909.7179874239007;525.611047824607;547.384192783119;654.1104098426136;671.6138220523219;672.1094549721589;14610.342534585863;14630.195339256337;14661.560153195422;14663.853361466463;14664.120152790867;13171.67070823237;13307.401166947511;13386.598402047954;13414.579282283054;13432.932835335858;9336.626534938594;9530.428174309563;9865.408075515421;11924.46339914706;12465.376731163406;4311.1593239318345;4337;4475.552444755498;4505.301678239878;4507.391502147201;96885.51557242239;97218;110102;112225;114493.42753286181;8903.910960890309;10133.391996480235;10145.492725363702;10482.213833962483;10604.893951060545;19562.8043719561;19569.90215048944;19614.411567652995;19628.901855490632;19666.70499942502;6348.873022539523;7374.483786134919;7469.439792015621;7654.923450765533;7712;3737.9252414951548;4020.6984476164403;4147.854825081168;4238.851640192578;4249.745015299092;3405.0976491229844;3444.5866496020135;3481.982590087084;3482.233908540117;3507.596626387947;546.3334731627408;642.1619786178987;642.7686033028106;659.7130248341987;661.3023260460164;544.727636181909;592.6118392452951;622.1925306983221;625.1966223402906;635.6503922842418;8533.658653653783;8706.564671766386;8948.955255223682;9233.90766092344;9481.288903332277;597.3906615252505;640.967951602418;652.6019128331714;656.27809409649;671.9618189896621;4256.57434256578;4527.185106680763;4530.61489773373;4541.863744087683;4632.143053535039;86709;107054.46472767586;107342.92657073485;107392;115163.84836151698;75206;99775;99913.50043249737;99967;102040;82161;84931.57534212289;86455.56772216225;86676.5666171665;87086;8382.83234335322;8699.478031318142;8716.956415217883;8717.607707653298;8771.1156024651;46102;48620.513794861596;49379;51565.742171288905;51642.48357516527;67167.66416167888;72601.89090327703;77763.66708998739;78221.60889195517;79588;11105.944470277596;11302;11634.6509604712;11706.180567360203;11934.60245465561;12542.686432838887;12844.486220551073;13012.284324361872;13080.542181023618;13205.933970330087;11769.588064417705;12183.634490965285;12419.627411177678;12487.188332758342;12495.500179993061;11055.83416248773;11545.480453379787;12942;12992.610221693365;13235.3382330885;12738.936305318413;12881.355932203165;12958.935205323913;13005.284709341076;13147.543435451076;10516.474176291307;10868.456577171268;11159.218854680095;11178.776424471302;11209.943950280196;10957.342559446459;11074.280171788809;11309.71725706864;11422.600208992977;11497.482613282255 14:46:54 INFO - PROCESS | 1643 | __end_tp_report 14:46:54 INFO - PROCESS | 1643 | __start_cc_report 14:46:54 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1806 14:46:54 INFO - PROCESS | 1643 | __end_cc_report 14:46:54 INFO - PROCESS | 1643 | __startTimestamp1481582814126__endTimestamp 14:46:54 INFO - PROCESS | 1643 | 14:46:54 INFO - PROCESS | 1643 | ------- Summary: start ------- 14:46:54 INFO - PROCESS | 1643 | Number of tests: 6 14:46:54 INFO - PROCESS | 1643 | 14:46:54 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5706.35 Median:5944.00 stddev:629.28 (10.6%) stddev-sans-first:603.18 14:46:54 INFO - PROCESS | 1643 | Values: 3338.7 3348.4 3351.5 3376.7 3418.6 5604.4 5696.4 5727.0 5758.2 5792.2 5615.3 5653.5 5655.1 5655.7 5657.5 5108.2 5138.6 5146.2 5157.7 5158.7 5262.7 5282.5 5286.1 5293.0 5293.2 5208.9 5213.2 5233.5 5241.0 5247.8 5260.2 5277.2 5295.5 5308.8 5333.4 5077.6 5093.9 5139.5 5218.1 5223.2 5547.5 5634.4 5653.6 5678.2 5680.5 6191.3 6203.7 6204.8 6209.8 6233.7 5008.8 6136.6 6187.8 6263.9 6280.1 5705.1 5735.1 5764.3 5780.7 5815.7 5187.5 6281.2 6283.0 6284.6 6297.5 5988.7 6066.2 6127.3 6142.2 6149.2 6143.1 6150.8 6181.8 6226.0 6231.4 6193.7 6197.3 6204.6 6209.3 6221.3 5181.3 6046.3 6221.0 6230.8 6249.3 4777.9 4883.1 4883.8 4889.5 4891.0 4390.9 4410.8 4418.8 4441.6 4451.8 5622.4 5672.1 5688.5 5697.9 5708.5 6152.8 6155.6 6166.7 6167.0 6173.9 5688.3 5738.5 5741.8 5743.2 5747.5 5278.9 5334.8 5363.1 5373.9 5426.7 6288.5 6293.2 6311.1 6318.6 6325.3 6158.0 6179.2 6202.7 6202.9 6233.0 6174.3 6224.3 6239.8 6253.2 6308.6 6137.8 6187.2 6191.4 6192.3 6195.0 6176.8 6178.8 6186.8 6195.2 6204.6 5917.0 5944.0 6030.9 6095.1 6099.5 5963.1 6069.3 6097.6 6110.6 6130.8 5944.0 5957.6 5959.8 5975.6 5985.3 5980.2 6061.5 6067.5 6094.8 6102.4 5840.0 5878.6 5927.8 5951.0 5965.4 14:46:54 INFO - PROCESS | 1643 | 14:46:54 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:68477.64 Median:18300.64 stddev:158039.17 (863.6%) stddev-sans-first:158399.90 14:46:54 INFO - PROCESS | 1643 | Values: 418.7 445.5 463.9 477.5 492.2 30287.9 31785.7 39399.2 40382.0 40571.0 41335.6 41757.0 41838.6 41856.8 42028.7 9224.1 9490.5 9500.6 9503.0 9511.8 8058.0 8434.6 8486.0 8728.2 8745.0 7662.9 10303.5 11476.6 11488.2 11671.9 11215.4 11378.2 11396.3 11467.5 11469.1 8439.0 11282.8 11370.2 11375.8 11389.6 30793.9 31522.1 31563.7 31629.7 37863.8 2976.8 2994.0 3017.4 3241.8 3413.5 29205.9 29675.9 29765.9 29921.1 29963.9 2961.3 3159.6 3196.6 3301.5 3336.8 398637.0 399803.0 400016.0 400454.0 400637.0 56523.7 56724.0 56809.9 56832.0 56930.7 59408.4 59495.4 59545.4 59556.7 59636.4 15318.5 15522.8 15546.7 15557.8 15566.9 12144.1 12225.9 12226.5 12228.8 12262.6 14251.7 14654.4 15021.2 16068.0 16077.0 5583.1 5613.6 6732.5 6771.1 6816.4 901.4 1032.2 1051.2 1057.6 1076.9 28568.7 29359.4 29469.7 29879.0 30052.5 992.1 1033.4 1054.8 1088.7 1131.3 13140.8 13871.7 14061.4 14136.2 14384.7 574680.0 578022.0 580553.0 580901.1 583434.0 43217.8 43968.0 43975.8 47797.3 49277.3 1328.7 1333.2 1356.2 1357.2 1358.2 28004.0 28305.6 28632.7 28713.3 29089.6 44890.0 45306.8 45402.0 45520.3 45528.8 718449.0 738090.0 739680.0 740148.0 740911.0 23817.6 24171.9 24209.6 24224.3 24233.9 39721.6 40154.0 40501.2 40722.4 41025.8 33963.0 34192.5 34270.1 34896.0 35225.3 33264.5 33548.0 34111.5 34325.8 34378.0 33558.3 34079.3 34176.0 34225.8 34282.1 29624.3 30498.8 30630.0 30641.4 30718.0 22569.7 22816.7 23022.7 23132.8 23153.8 14:46:54 INFO - PROCESS | 1643 | 14:46:54 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:33345.14 Median:1569.36 stddev:96544.63 (6151.8%) stddev-sans-first:96783.59 14:46:54 INFO - PROCESS | 1643 | Values: 308.4 350.8 370.4 382.6 393.5 14825.6 15159.7 17255.6 19575.2 20847.1 19899.6 20338.8 20392.2 20562.9 20655.6 5302.3 5813.5 5856.4 5860.4 5866.5 4066.3 4238.5 5459.0 5811.7 5815.3 4245.6 4294.2 6475.0 6480.0 6481.4 6167.8 6403.8 6464.3 6468.9 6481.0 5602.1 5602.7 5608.4 5613.8 5616.2 24292.5 24353.0 24749.5 24931.0 25140.5 2226.7 2265.2 2363.7 2398.6 2830.3 14149.5 14630.7 14731.3 15209.4 15280.8 1532.4 1797.1 1827.2 1835.2 1881.7 104562.5 108370.5 108751.0 108980.3 110170.4 8807.6 10192.6 10377.9 10413.5 10684.9 11796.5 12527.8 12552.2 12753.9 12770.0 7502.0 7709.7 7717.4 8229.5 8346.0 7211.3 7646.6 8032.2 8284.2 8499.5 6449.9 6594.7 6598.8 6604.6 6720.3 1809.6 1844.4 1847.8 1849.1 1853.9 929.9 943.3 976.6 1001.0 1030.4 11527.1 11655.7 11835.1 12009.6 21614.7 415.8 416.4 422.9 424.1 426.7 6059.2 6073.2 6090.7 6221.8 6245.1 563676.0 570420.0 583104.0 583885.0 587828.0 130052.3 131020.3 131191.0 131854.0 134244.0 447.2 463.7 464.6 464.6 464.9 11245.0 11346.7 11381.3 11572.0 11856.6 49401.8 52045.0 53464.7 53588.7 53727.9 53127.2 70515.3 70963.6 72314.2 74300.5 7744.7 7884.9 8042.6 8140.1 8300.5 10013.9 10189.3 12137.8 12331.2 12878.5 10708.9 10732.0 10773.8 11231.7 11307.0 10660.3 10730.4 10878.3 11330.2 11331.5 11087.0 11275.4 11310.4 11367.9 11544.1 7825.3 7831.2 8120.8 8353.9 8372.7 10312.1 10530.6 11021.6 11063.6 11108.0 14:46:54 INFO - PROCESS | 1643 | 14:46:54 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5339.43 Median:5313.28 stddev:2923.95 (55.0%) stddev-sans-first:2916.60 14:46:54 INFO - PROCESS | 1643 | Values: 1327.3 1464.5 1497.5 1653.3 1827.5 7446.8 7827.1 7831.3 7832.2 7833.2 7833.8 8116.0 8119.4 8249.2 8254.2 2299.3 2333.1 2335.8 2336.7 2345.3 2063.6 2141.2 2299.2 2335.4 2364.4 1843.8 2100.7 2315.8 2315.9 2327.9 2282.8 2292.9 2306.7 2311.4 2324.5 2043.3 2116.8 2305.3 2339.6 2341.7 7984.3 8189.7 8219.2 8321.5 8378.8 5020.3 5186.5 5194.6 5199.5 5207.2 3261.8 3345.1 3437.2 3444.8 3458.3 978.2 998.3 1005.8 1019.9 1026.7 10466.9 10541.1 10634.3 10657.0 10661.0 4143.8 4325.5 4338.2 4411.3 4436.5 8592.3 8594.7 8597.5 8599.9 8600.3 5040.2 5052.2 5054.0 5057.9 5064.9 3941.6 4640.5 4746.5 4748.0 4774.4 3457.5 3491.0 3500.6 3537.0 3587.4 1014.2 1014.8 1026.8 1042.7 1079.3 759.7 856.8 875.6 891.6 961.1 5549.1 5649.4 5710.0 5836.0 5865.1 845.1 904.2 928.7 929.4 991.6 3791.3 3794.0 3844.4 3897.9 3963.6 9585.8 9986.0 10006.3 10010.8 10014.8 9396.2 9781.4 9958.0 9963.5 9970.4 7598.8 7807.2 7814.9 7819.7 7820.4 5419.4 5507.6 5510.7 5650.7 5881.3 9205.0 9299.0 9299.8 9316.5 9327.2 9263.3 9348.0 9353.3 9384.6 9536.1 6816.0 7016.9 7059.3 7158.3 7220.4 7829.7 7911.8 7914.7 7927.0 7933.4 6944.3 6945.3 7018.5 7042.6 7185.7 6714.2 6758.4 6895.1 6943.8 6947.3 6339.4 6500.6 6564.9 6575.3 6676.1 4270.3 4723.9 4830.4 4833.6 4939.3 4686.9 4699.0 4822.3 4884.0 5000.9 14:46:54 INFO - PROCESS | 1643 | 14:46:54 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4353.55 Median:4806.72 stddev:1299.86 (27.0%) stddev-sans-first:1268.02 14:46:54 INFO - PROCESS | 1643 | Values: 334.4 349.1 352.9 370.1 371.6 4576.1 4914.7 5105.7 5215.2 5231.4 4205.3 4428.9 4629.6 5023.5 5050.3 3362.6 3443.4 3850.4 4037.6 4108.5 3226.4 3356.2 3832.5 3954.2 4093.2 4066.2 4090.4 4093.9 4105.5 4118.8 3369.7 3496.7 3842.8 4040.3 4040.5 3500.0 3584.7 3590.7 3608.0 3614.5 4728.3 4986.1 5010.5 5021.4 5053.8 4452.7 4601.8 4652.9 4653.0 4661.8 4882.7 5388.7 5407.4 5446.0 5450.8 3633.3 3956.4 3961.9 3967.3 4009.9 5317.4 5743.3 5760.5 5768.6 5800.9 3090.9 3589.2 3706.5 3756.5 3996.3 3737.1 4086.0 4123.8 4132.0 4156.8 3975.7 4586.4 4610.2 4620.9 4638.9 5246.3 5388.4 5417.5 5439.1 5450.3 1255.2 1281.3 1285.6 1312.1 1334.7 835.7 919.3 931.8 937.1 944.9 4430.0 4810.5 4869.8 4884.0 4911.3 4408.2 5076.7 5197.3 5296.3 5311.1 4393.9 4824.0 4833.0 4855.4 4896.8 2503.3 2758.5 2762.5 2784.7 2806.4 4570.9 4671.8 4794.7 5176.4 5431.0 5018.8 5343.2 5361.5 5399.7 5404.0 4803.0 4820.4 5132.6 5359.2 5458.8 4448.9 4784.9 5015.2 5239.6 5252.5 4509.4 4700.7 5336.7 5540.8 5546.4 5839.5 5846.9 5855.9 5864.4 5933.8 3017.9 3779.2 3805.9 3831.3 3855.3 5005.4 5627.1 5642.5 5655.7 5707.2 4893.3 5344.7 5519.7 5535.4 5571.0 4260.0 5208.9 5417.6 5507.9 5520.5 5050.7 5134.8 5250.5 5251.0 5277.3 4559.6 4870.4 5159.1 5424.3 5468.9 4469.9 4629.7 4736.7 5428.6 5455.8 14:46:54 INFO - PROCESS | 1643 | 14:46:54 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20717.15 Median:4528.90 stddev:30938.97 (683.1%) stddev-sans-first:30989.37 14:46:54 INFO - PROCESS | 1643 | Values: 732.6 741.8 778.1 814.6 839.5 12261.6 14947.3 15309.0 15543.7 15719.3 13747.6 14027.1 14079.6 14226.2 14271.7 679.3 846.2 861.0 862.4 862.9 701.8 711.9 842.6 873.6 875.4 913.3 914.4 915.3 916.4 916.7 908.2 908.7 909.4 909.6 909.7 525.6 547.4 654.1 671.6 672.1 14610.3 14630.2 14661.6 14663.9 14664.1 13171.7 13307.4 13386.6 13414.6 13432.9 9336.6 9530.4 9865.4 11924.5 12465.4 4311.2 4337.0 4475.6 4505.3 4507.4 96885.5 97218.0 110102.0 112225.0 114493.4 8903.9 10133.4 10145.5 10482.2 10604.9 19562.8 19569.9 19614.4 19628.9 19666.7 6348.9 7374.5 7469.4 7654.9 7712.0 3737.9 4020.7 4147.9 4238.9 4249.7 3405.1 3444.6 3482.0 3482.2 3507.6 546.3 642.2 642.8 659.7 661.3 544.7 592.6 622.2 625.2 635.7 8533.7 8706.6 8949.0 9233.9 9481.3 597.4 641.0 652.6 656.3 672.0 4256.6 4527.2 4530.6 4541.9 4632.1 86709.0 107054.5 107342.9 107392.0 115163.8 75206.0 99775.0 99913.5 99967.0 102040.0 82161.0 84931.6 86455.6 86676.6 87086.0 8382.8 8699.5 8717.0 8717.6 8771.1 46102.0 48620.5 49379.0 51565.7 51642.5 67167.7 72601.9 77763.7 78221.6 79588.0 11105.9 11302.0 11634.7 11706.2 11934.6 12542.7 12844.5 13012.3 13080.5 13205.9 11769.6 12183.6 12419.6 12487.2 12495.5 11055.8 11545.5 12942.0 12992.6 13235.3 12738.9 12881.4 12958.9 13005.3 13147.5 10516.5 10868.5 11159.2 11178.8 11209.9 10957.3 11074.3 11309.7 11422.6 11497.5 14:46:54 INFO - PROCESS | 1643 | -------- Summary: end -------- 14:46:54 INFO - PROCESS | 1643 | 14:46:54 INFO - TEST-INFO | 1643: exit 0 14:46:54 INFO - TEST-OK | dromaeo_css | took 1121159ms 14:46:54 INFO - TEST-START | kraken 14:46:54 INFO - operating with platform_type : mac_ 14:46:54 INFO - Initialising browser for kraken test... 14:46:54 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpGmxd0E/profile http://localhost:49242/getInfo.html) 14:46:56 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 14:46:56 INFO - PROCESS | 1649 | colorDepth:24 14:46:56 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 14:46:56 INFO - PROCESS | 1649 | __metrics 14:46:57 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" 14:46:57 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:46:57 INFO - TEST-INFO | 1649: exit 0 14:46:57 INFO - Browser initialized. 14:46:57 INFO - Running cycle 1/1 for kraken test... 14:46:57 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpGmxd0E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:09 INFO - PROCESS | 1650 | RSS: Main: 238264320 14:47:09 INFO - PROCESS | 1650 | 14:47:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:13 INFO - PROCESS | 1650 | RSS: Main: 289370112 14:47:13 INFO - PROCESS | 1650 | 14:47:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 14:47:16 INFO - PROCESS | 1650 | RSS: Main: 292478976 14:47:16 INFO - PROCESS | 1650 | 14:47:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 14:47:20 INFO - PROCESS | 1650 | RSS: Main: 384172032 14:47:20 INFO - PROCESS | 1650 | 14:47:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 14:47:23 INFO - PROCESS | 1650 | RSS: Main: 284553216 14:47:23 INFO - PROCESS | 1650 | 14:47:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:47:25 INFO - PROCESS | 1650 | RSS: Main: 288763904 14:47:25 INFO - PROCESS | 1650 | 14:47:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 14:47:29 INFO - PROCESS | 1650 | RSS: Main: 330752000 14:47:29 INFO - PROCESS | 1650 | 14:47:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 14:47:33 INFO - PROCESS | 1650 | RSS: Main: 332185600 14:47:33 INFO - PROCESS | 1650 | 14:47:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 14:47:36 INFO - PROCESS | 1650 | RSS: Main: 330883072 14:47:36 INFO - PROCESS | 1650 | 14:47:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:47:38 INFO - PROCESS | 1650 | RSS: Main: 305926144 14:47:38 INFO - PROCESS | 1650 | 14:47:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:47:41 INFO - PROCESS | 1650 | RSS: Main: 308899840 14:47:41 INFO - PROCESS | 1650 | 14:47:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:47:44 INFO - PROCESS | 1650 | RSS: Main: 314695680 14:47:44 INFO - PROCESS | 1650 | 14:47:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:47:47 INFO - PROCESS | 1650 | RSS: Main: 320749568 14:47:47 INFO - PROCESS | 1650 | 14:47:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:47:51 INFO - PROCESS | 1650 | RSS: Main: 321630208 14:47:51 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 14:47:53 INFO - PROCESS | 1650 | RSS: Main: 366219264 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | __start_tp_report 14:47:53 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 14:47:53 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 14:47:53 INFO - PROCESS | 1650 | |i|pagename|runs| 14:47:53 INFO - PROCESS | 1650 | |0;ai-astar;113;116;114;115;116;114;116;115;115;113 14:47:53 INFO - PROCESS | 1650 | |1;audio-beat-detection;152;127;132;177;141;114;113;109;131;112 14:47:53 INFO - PROCESS | 1650 | |2;audio-dft;187;255;187;185;183;182;183;182;182;182 14:47:53 INFO - PROCESS | 1650 | |3;audio-fft;76;59;60;86;62;59;59;58;77;58 14:47:53 INFO - PROCESS | 1650 | |4;audio-oscillator;88;70;87;69;69;68;83;69;68;83 14:47:53 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;111;115;110;114;111;112;155;114;110;113 14:47:53 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;95;95;95;95;95;96;94;94;95 14:47:53 INFO - PROCESS | 1650 | |7;imaging-desaturate;88;87;87;88;84;87;87;88;86;85 14:47:53 INFO - PROCESS | 1650 | |8;json-parse-financial;56;55;55;54;54;55;54;55;54;55 14:47:53 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;65;68;69;78;72;70;69;72;70;72 14:47:53 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;94;93;96;111;111;93;93;93;163;94 14:47:53 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;146;147;145;144;149;148;157;145;181;154 14:47:53 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;180;176;177;229;173;181;178;180;175;174 14:47:53 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;69;69;66;68;68;66;69;79;81;83 14:47:53 INFO - PROCESS | 1650 | __end_tp_report 14:47:53 INFO - PROCESS | 1650 | __start_cc_report 14:47:53 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1950 14:47:53 INFO - PROCESS | 1650 | __end_cc_report 14:47:53 INFO - PROCESS | 1650 | __startTimestamp1481582873650__endTimestamp 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | ------- Summary: start ------- 14:47:53 INFO - PROCESS | 1650 | Number of tests: 14 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:1.05 14:47:53 INFO - PROCESS | 1650 | Values: 113.0 116.0 114.0 115.0 116.0 114.0 116.0 115.0 115.0 113.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:131.50 stddev:21.43 (16.3%) stddev-sans-first:21.31 14:47:53 INFO - PROCESS | 1650 | Values: 152.0 127.0 132.0 177.0 141.0 114.0 113.0 109.0 131.0 112.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:190.80 Median:184.00 stddev:22.65 (12.3%) stddev-sans-first:23.98 14:47:53 INFO - PROCESS | 1650 | Values: 187.0 255.0 187.0 185.0 183.0 182.0 183.0 182.0 182.0 182.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:65.40 Median:61.00 stddev:10.24 (16.8%) stddev-sans-first:10.12 14:47:53 INFO - PROCESS | 1650 | Values: 76.0 59.0 60.0 86.0 62.0 59.0 59.0 58.0 77.0 58.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:76.50 stddev:8.63 (11.3%) stddev-sans-first:7.86 14:47:53 INFO - PROCESS | 1650 | Values: 88.0 70.0 87.0 69.0 69.0 68.0 83.0 69.0 68.0 83.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:113.50 stddev:13.64 (12.0%) stddev-sans-first:14.32 14:47:53 INFO - PROCESS | 1650 | Values: 111.0 115.0 110.0 114.0 111.0 112.0 155.0 114.0 110.0 113.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 14:47:53 INFO - PROCESS | 1650 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 94.0 95.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.00 stddev:1.34 (1.5%) stddev-sans-first:1.33 14:47:53 INFO - PROCESS | 1650 | Values: 88.0 87.0 87.0 88.0 84.0 87.0 87.0 88.0 86.0 85.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.53 14:47:53 INFO - PROCESS | 1650 | Values: 56.0 55.0 55.0 54.0 54.0 55.0 54.0 55.0 54.0 55.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.00 stddev:3.41 (4.8%) stddev-sans-first:2.98 14:47:53 INFO - PROCESS | 1650 | Values: 65.0 68.0 69.0 78.0 72.0 70.0 69.0 72.0 70.0 72.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:104.10 Median:93.00 stddev:21.93 (23.6%) stddev-sans-first:22.95 14:47:53 INFO - PROCESS | 1650 | Values: 94.0 93.0 96.0 111.0 111.0 93.0 93.0 93.0 163.0 94.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:148.50 stddev:11.14 (7.5%) stddev-sans-first:11.63 14:47:53 INFO - PROCESS | 1650 | Values: 146.0 147.0 145.0 144.0 149.0 148.0 157.0 145.0 181.0 154.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:179.00 stddev:16.63 (9.3%) stddev-sans-first:17.61 14:47:53 INFO - PROCESS | 1650 | Values: 180.0 176.0 177.0 229.0 173.0 181.0 178.0 180.0 175.0 174.0 14:47:53 INFO - PROCESS | 1650 | 14:47:53 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:69.00 stddev:6.51 (9.4%) stddev-sans-first:6.83 14:47:53 INFO - PROCESS | 1650 | Values: 69.0 69.0 66.0 68.0 68.0 66.0 69.0 79.0 81.0 83.0 14:47:53 INFO - PROCESS | 1650 | -------- Summary: end -------- 14:47:53 INFO - PROCESS | 1650 | 14:47:54 INFO - TEST-INFO | 1650: exit 0 14:47:54 INFO - TEST-OK | kraken | took 59786ms 14:47:54 INFO - SUITE-END | took 1180s 14:47:54 INFO - Completed test suite (00:19:41) 14:47:54 INFO - javascript benchmark 14:47:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.6995170434657, 3348.3805495983247, 3351.480520519319, 3376.662333766623, 3418.5897692276917, 5604.3835178130375, 5696.373398926125, 5727.0, 5758.165066065423, 5792.218050563172, 5615.2700148980675, 5653.4911857932775, 5655.123455864337, 5655.745491452884, 5657.519110875581, 5108.1826907694685, 5138.5889128869785, 5146.176611742122, 5157.71632560209, 5158.690478571279, 5262.657927234736, 5282.471752824726, 5286.074936886049, 5292.973535132319, 5293.232481290211, 5208.921866172011, 5213.191955246943, 5233.450487698794, 5241.0, 5247.790088396459, 5260.237265596467, 5277.182036784305, 5295.4969277918535, 5308.761105750251, 5333.386660534049, 5077.593792496591, 5093.949060509384, 5139.460356662534, 5218.060749065166, 5223.242629818693, 5547.472990065938, 5634.3802181759975, 5653.604247702621, 5678.205051292781, 5680.5455563554815, 6191.25704915413, 6203.658798766066, 6204.844878878019, 6209.751609935597, 6233.719482623293, 5008.774605142778, 6136.610985192662, 6187.783427580058, 6263.937360626426, 6280.120783090371, 5705.115707065412, 5735.11105778605, 5764.308283006066, 5780.739866705924, 5815.709214539256, 5187.455317191716, 6281.214848143982, 6283.0, 6284.622922624657, 6297.4647154992335, 5988.700564971821, 6066.150738896558, 6127.295361033538, 6142.201513803177, 6149.2313460817395, 6143.051335359052, 6150.7847225346895, 6181.783637572753, 6226.034964580497, 6231.40801623845, 6193.721282542297, 6197.349278325801, 6204.565680402328, 6209.348018458088, 6221.346758590374, 5181.300524429229, 6046.274447066292, 6221.004639257697, 6230.7819226326865, 6249.343818899041, 4777.928331075037, 4883.121038213085, 4883.780229889663, 4889.48660390661, 4891.0, 4390.890227744332, 4410.779461027, 4418.8453404130705, 4441.555844415532, 4451.77741112943, 5622.353429355595, 5672.064109421982, 5688.516476099495, 5697.914531282034, 5708.4862362387585, 6152.753889844445, 6155.599886007395, 6166.660833654102, 6167.0, 6173.938260617337, 5688.345840228344, 5738.454846789548, 5741.827745167651, 5743.167240750068, 5747.453991870766, 5278.894422111536, 5334.8132815352055, 5363.115086010843, 5373.919391209135, 5426.67439953604, 6288.52836037299, 6293.150424692608, 6311.084892690626, 6318.589291696025, 6325.272593651789, 6158.0, 6179.196704428396, 6202.689865506616, 6202.906956395567, 6233.0, 6174.289956655042, 6224.346443623354, 6239.75040998355, 6253.155823963707, 6308.621482711052, 6137.8366772191985, 6187.195664563578, 6191.4118158774845, 6192.349803270772, 6195.0, 6176.752929882754, 6178.752849885954, 6186.752529898934, 6195.19462469876, 6204.627722336674, 5917.023691090922, 5944.0, 6030.879382412415, 6095.116208149705, 6099.4510494053975, 5963.13534537481, 6069.2716873975405, 6097.634141951497, 6110.619513019744, 6130.846728831636, 5944.0, 5957.642541447527, 5959.791407300723, 5975.581709280309, 5985.25184351956, 5980.162777211281, 6061.484773794101, 6067.514598832171, 6094.7562097517375, 6102.389761023862, 5840.007198776303, 5878.617889837147, 5927.762889484372, 5950.9702451487465, 5965.373635768182], "value": 5667.106517088271, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.67343472091767, 445.46321682372746, 463.90953764016007, 477.5177071158129, 492.2321178960821, 30287.9399221027, 31785.68214317856, 39399.2120157597, 40382.0, 40571.0, 41335.58664413355, 41757.0, 41838.581614183924, 41856.79071604645, 42028.73913782591, 9224.123708247706, 9490.478023708692, 9500.619975200983, 9502.952485237563, 9511.80976380472, 8057.9524661793885, 8434.578271086451, 8486.0, 8728.170823771763, 8744.956275218616, 7662.850572414127, 10303.536340864679, 11476.598319058834, 11488.195826292163, 11671.883281167164, 11215.439228038565, 11378.203525753117, 11396.25924314921, 11467.483963221717, 11469.139814513945, 8439.0, 11282.774344513064, 11370.204085714004, 11375.829362559569, 11389.601363952304, 30793.92221272267, 31522.054338369657, 31563.684363156535, 31629.734810607548, 37863.81068094669, 2976.7951399263065, 2994.0, 3017.3965206958696, 3241.789283696552, 3413.5050417689545, 29205.853970730222, 29675.85162074176, 29765.851170744223, 29921.102366929026, 29963.850180749174, 2961.318896653782, 3159.605049368829, 3196.5844440222854, 3301.4552598821406, 3336.7831090979253, 398637.0, 399803.0, 400016.0, 400454.0, 400637.0, 56523.71738141283, 56724.0, 56809.86380272372, 56832.0, 56930.715346423, 59408.40591594029, 59495.405045949854, 59545.40454595485, 59556.70221648951, 59636.40363596395, 15318.463853765288, 15522.767158492632, 15546.689066218612, 15557.844421555867, 15566.922165389327, 12144.149909506426, 12225.93887030577, 12226.510939562495, 12228.816567751492, 12262.632121036384, 14251.714965700628, 14654.413823446943, 15021.221074101326, 16068.0, 16076.954997925097, 5583.0787919992745, 5613.635113717595, 6732.528722989442, 6771.119754431892, 6816.352446517573, 901.4411065139524, 1032.1897310611134, 1051.164324362134, 1057.5875408590655, 1076.924615276923, 28568.71431285702, 29359.412811743645, 29469.705302946695, 29878.954236601614, 30052.54921176184, 992.1120597065586, 1033.4316126130598, 1054.8312270036756, 1088.6733979806027, 1131.2929419113054, 13140.802887956688, 13871.722565548835, 14061.43754249839, 14136.222507761966, 14384.712305754036, 574680.0, 578022.0, 580553.0, 580901.0954945198, 583434.0, 43217.783911080245, 43968.0, 43975.78012109919, 47797.28304075442, 49277.26084108741, 1328.747537967783, 1333.2200662612286, 1356.179511395631, 1357.2195987307339, 1358.1783021271988, 28004.0, 28305.57541636836, 28632.713672863003, 28713.28216794597, 29089.563656544746, 44890.0, 45306.77346613246, 45402.0, 45520.317195241434, 45528.772356139336, 718449.0, 738090.0, 739680.0, 740148.0, 740911.0, 23817.64273535933, 24171.879140604186, 24209.636855447534, 24224.273271801874, 24233.909474073356, 39721.60278397179, 40154.0, 40501.1899762009, 40722.389164163156, 41025.79487102546, 33963.0, 34192.487112692834, 34270.14324641804, 34896.0, 35225.29549408946, 33264.50103248405, 33547.99356019323, 34111.48832767461, 34325.82837085899, 34378.0, 33558.3288334227, 34079.318413632085, 34176.0, 34225.82887085548, 34282.14294642654, 29624.259393515335, 30498.84750576233, 30630.0, 30641.387172255985, 30718.0, 22569.661455078516, 22816.657750134094, 23022.654660180448, 23132.76867231306, 23153.76846231516], "value": 18777.739255339675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.40016168552177, 350.7632348164988, 370.36297568182727, 382.6001828089647, 393.47864080093865, 14825.555233343004, 15159.696806063872, 17255.568610784736, 19575.216991320365, 20847.061882215297, 19899.602007959867, 20338.796612033875, 20392.184312627476, 20562.897185514088, 20655.586888262227, 5302.3106996090455, 5813.505852002564, 5856.385079566648, 5860.384659610743, 5866.472017518422, 4066.32905570582, 4238.491381034265, 5459.0, 5811.651300921958, 5815.331236907768, 4245.596668316505, 4294.248506511363, 6474.9963755617955, 6479.967600161993, 6481.416672499474, 6167.7532898684, 6403.807885763435, 6464.254651244161, 6468.870622587522, 6480.995445705899, 5602.1036634138345, 5602.747876345574, 5608.383077861432, 5613.831585052414, 5616.241807355996, 24292.514149717084, 24353.0, 24749.5050098997, 24931.0, 25140.497190056096, 2226.699395581592, 2265.229821860559, 2363.6572696958847, 2398.556267090594, 2830.3207230264793, 14149.504767333094, 14630.707385852224, 14731.263436828116, 15209.391624335123, 15280.847191528053, 1532.3793863485307, 1797.1283927295383, 1827.2142978519232, 1835.155828318975, 1881.7459642948163, 104562.47718761358, 108370.45814770876, 108751.0, 108980.28157747361, 110170.44914775375, 8807.559622019002, 10192.643257486101, 10377.896221037692, 10413.479326033668, 10684.94657526723, 11796.466459360228, 12527.812082818766, 12552.184108032949, 12753.872461275454, 12770.042246831525, 7502.0, 7709.7301594443925, 7717.382609391235, 8229.547374894439, 8346.0, 7211.278872112747, 7646.579438130956, 8032.196780321921, 8284.212999765012, 8499.490030598185, 6449.903251451232, 6594.670266486656, 6598.802035938929, 6604.636744978976, 6720.2943690912725, 1809.5975618895461, 1844.3729132094884, 1847.8152184781413, 1849.1309084730156, 1853.944381668552, 929.9163075323254, 943.2831048403262, 976.5947131940165, 1000.9899901000897, 1030.3663247102977, 11527.077833773277, 11655.650330490098, 11835.11236657254, 12009.63971080869, 21614.675779863315, 415.8295099009392, 416.44196776319876, 422.9302165142717, 424.1072542298417, 426.6757264479018, 6059.164560725418, 6073.210482637229, 6090.695465226721, 6221.813345599639, 6245.063240513869, 563676.0, 570420.0, 583104.0, 583885.0, 587828.0, 130052.3497382526, 131020.3448982768, 131191.0, 131854.0, 134244.0, 447.1928169653806, 463.6615270852297, 464.56795180482476, 464.6399040743518, 464.85589467265254, 11245.044171245536, 11346.659600212008, 11381.260218085798, 11572.0, 11856.644300670994, 49401.75299123481, 52045.0, 53464.73267633637, 53588.73205633947, 53727.925441490166, 53127.20309195443, 70515.29484705087, 70963.64518177375, 72314.1921451968, 74300.51398971882, 7744.690212391667, 7884.921150788418, 8042.638081286239, 8140.145284745016, 8300.501969881585, 10013.949930250303, 10189.337693049929, 12137.817932730839, 12331.198472099284, 12878.549250776177, 10708.946455267675, 10732.034116929513, 10773.784524309312, 11231.71920701989, 11307.038901693448, 10660.307080039773, 10730.409827459565, 10878.292910960763, 11330.150238731963, 11331.546738130382, 11087.0, 11275.436228188722, 11310.377929213972, 11367.886321137014, 11544.076473882238, 7825.33484653788, 7831.216878312123, 8120.796980075545, 8353.874691879506, 8372.748817535483, 10312.123469505175, 10530.631427899987, 11021.559137634405, 11063.557457701923, 11108.0], "value": 8705.457989819728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.3164320375004, 1464.54599074287, 1497.5357639131867, 1653.2890856931522, 1827.5431142214447, 7446.813829654261, 7827.060752709683, 7831.295183433497, 7832.216778322165, 7833.216678332164, 7833.843323133534, 8116.026076870769, 8119.391045671584, 8249.216324449168, 8254.215849494303, 2299.2642354446584, 2333.136739406422, 2335.789778919897, 2336.6611841283, 2345.26124270855, 2063.6182306273386, 2141.2184552638255, 2299.195281651417, 2335.3811240021323, 2364.373441038126, 1843.8432733217626, 2100.747910250772, 2315.849469784467, 2315.918942837001, 2327.860328380294, 2282.828787840902, 2292.919747808827, 2306.7347255065715, 2311.3759284993125, 2324.5234726881117, 2043.3052762060822, 2116.767155612881, 2305.319930620471, 2339.578875802355, 2341.7307009693764, 7984.321332686671, 8189.7133600323705, 8219.219174178443, 8321.542315172663, 8378.8324233515, 5020.272060551236, 5186.455422180655, 5194.6104042196985, 5199.506046925536, 5207.192885102815, 3261.7553683473598, 3345.080102971678, 3437.2094418283937, 3444.7588668793196, 3458.342914846171, 978.1636700621009, 998.2612866478826, 1005.7535903703566, 1019.918406527476, 1026.697124348319, 10466.947665261701, 10541.104006159485, 10634.30876992993, 10657.0, 10661.040506354466, 4143.7928103594695, 4325.545817689161, 4338.219120558267, 4411.250087485135, 4436.511983681792, 8592.269657079094, 8594.699185528476, 8597.484150950962, 8599.914000860037, 8600.268977137013, 5040.193569028937, 5052.191649336089, 5053.963937392826, 5057.873553161126, 5064.898702025939, 3941.5664276929515, 4640.512746161672, 4746.477887432379, 4748.026654535812, 4774.427068751703, 3457.4640930655787, 3491.045014791725, 3500.649935006479, 3536.9823150884595, 3587.408077667208, 1014.1734486393566, 1014.7868947521104, 1026.8151732688189, 1042.7341028037802, 1079.2984560035882, 759.742625954047, 856.8200677857719, 875.6191056890145, 891.64334266294, 961.1335430652177, 5549.056660367747, 5649.406812284651, 5709.9714501427225, 5835.9708201458725, 5865.149553314831, 845.1421806866036, 904.1862323908535, 928.6888892221182, 929.400536653868, 991.5884907763342, 3791.279656865187, 3793.981030094887, 3844.36567966288, 3897.902552436212, 3963.583823698528, 9585.808283834283, 9986.0, 10006.299559030798, 10010.849837252446, 10014.79970400588, 9396.154346108746, 9781.407926899377, 9957.950210249048, 9963.50182490887, 9970.351927124713, 7598.772036838904, 7807.219278072147, 7814.882776758353, 7819.726309579251, 7820.413468989848, 5419.376771671308, 5507.642003269935, 5510.701652710892, 5650.745716442688, 5881.264841894763, 9205.033471485398, 9299.0, 9299.814003719752, 9316.48759318217, 9327.207187389147, 9263.305252106255, 9347.953260233928, 9353.298502612468, 9384.577694003923, 9536.141747242782, 6815.965920170367, 7016.859662806817, 7059.258777828254, 7158.2841715828, 7220.3862671671395, 7829.686812527435, 7911.802204944923, 7914.744297875078, 7927.048754149539, 7933.3653307734085, 6944.340287672663, 6945.305469453015, 7018.508704390848, 7042.577445353295, 7185.748498802517, 6714.160729908762, 6758.391744742997, 6895.10363652742, 6943.826404339932, 6947.305269473012, 6339.429451349401, 6500.642464664489, 6564.868702626016, 6575.342465753386, 6676.132102826796, 4270.316749320094, 4723.858284251478, 4830.4444988826735, 4833.613310935187, 4939.259111133215, 4686.906261874811, 4698.976505117589, 4822.252550854623, 4884.0, 5000.899982000413], "value": 4313.341172093869, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.4097667616657, 349.0958417698161, 352.9100079479734, 370.1098857248319, 371.5522795031987, 4576.107659006491, 4914.729689867056, 5105.744712764365, 5215.191645294981, 5231.352124080917, 4205.327147656376, 4428.889277768058, 4629.62962962963, 5023.497650234975, 5050.318207042048, 3362.562866827309, 3443.414619514676, 3850.3635954719202, 4037.5558688544384, 4108.465899433069, 3226.403115423654, 3356.1945133167987, 3832.463455116286, 3954.228925359556, 4093.1609020150945, 4066.1867626474823, 4090.365993271033, 4093.89765255868, 4105.50733911931, 4118.775861035037, 3369.730421566269, 3496.6503349665086, 3842.8296655259524, 4040.252553277653, 4040.5353384360883, 3500.03748969033, 3584.7490675652716, 3590.676839084495, 3608.0, 3614.5301110855685, 4728.267118596623, 4986.130201174559, 5010.549050585465, 5021.372328458942, 5053.772580233898, 4452.688311818174, 4601.768142450908, 4652.930206046912, 4652.97634520405, 4661.790219440133, 4882.681675947474, 5388.679773455528, 5407.432219616923, 5446.0, 5450.781968721247, 3633.255182687543, 3956.4263181838473, 3961.861334853295, 3967.2858885400615, 4009.8596549120934, 5317.388500322435, 5743.339515955635, 5760.452756988079, 5768.558210178181, 5800.941990580082, 3090.860911258999, 3589.192431702846, 3706.4810926470313, 3756.549214094326, 3996.300647386696, 3737.121776382548, 4086.0, 4123.773192474383, 4131.97934010334, 4156.750594964312, 3975.7415767975567, 4586.449626044896, 4610.216263235258, 4620.937184447529, 4638.930416043762, 5246.291750613695, 5388.407275199725, 5417.458254174551, 5439.102548079602, 5450.291462109901, 1255.2468518888777, 1281.2952875918209, 1285.6014635463036, 1312.094654688281, 1334.6730051137533, 835.703325319515, 919.3426699909596, 931.8462453695064, 937.0535758883576, 944.891337496183, 4430.0, 4810.470848206694, 4869.780859861244, 4884.020747344117, 4911.312416261726, 4408.236705317834, 5076.670016448919, 5197.324347834833, 5296.305182341691, 5311.088008317003, 4393.912121757611, 4823.975880120647, 4832.95167048332, 4855.368802055781, 4896.779644915916, 2503.2865633294787, 2758.462099890542, 2762.535855996325, 2784.7026203382293, 2806.368567072433, 4570.851699701135, 4671.789769460314, 4794.736289504111, 5176.430592634807, 5430.972845135749, 5018.799248030038, 5343.156610969209, 5361.463853614608, 5399.653279110354, 5403.972980135153, 4802.967362017183, 4820.39745031871, 5132.589392848488, 5359.22291267764, 5458.754356053987, 4448.9110217796115, 4784.856454306377, 5015.17249653803, 5239.633225674319, 5252.527272545489, 4509.391232183744, 4700.720150726826, 5336.733163341895, 5540.806071787468, 5546.417626149358, 5839.5036421904615, 5846.883062338815, 5855.921147992572, 5864.357979765672, 5933.821985340447, 3017.89437369691, 3779.22525882188, 3805.9238815224094, 3831.272058308912, 3855.325318069383, 5005.449400566008, 5627.071533196977, 5642.5485961122195, 5655.745491452977, 5707.20099186106, 4893.266010098514, 5344.679319240858, 5519.66881987066, 5535.39110697831, 5571.022287088187, 4260.0, 5208.921866172086, 5417.6478528895495, 5507.862303442285, 5520.475554822286, 5050.696958182521, 5134.794608215779, 5250.482176941382, 5251.030863426216, 5277.313949186581, 4559.566841150086, 4870.4155501340065, 5159.071367153948, 5424.294841670716, 5468.9179662304305, 4469.932951005672, 4629.652776041743, 4736.692115012514, 5428.579994603375, 5455.754491047833], "value": 3960.8029778956497, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.5934106570853, 741.8034220931451, 778.1323823936309, 814.6049166154418, 839.47532792005, 12261.570845020426, 14947.327370268336, 15309.0, 15543.689126217498, 15719.292631831566, 13747.58757237282, 14027.08823926444, 14079.648008799784, 14226.217558034305, 14271.71456570868, 679.2833560593572, 846.1665259719172, 860.9870851937226, 862.4221771413169, 862.9050804411542, 701.799987003704, 711.9181294151188, 842.616609442702, 873.598144853365, 875.4178471316567, 913.2511340700595, 914.4102054175053, 915.3089417489786, 916.4043371808311, 916.6929078758624, 908.2325435007408, 908.7182973278304, 909.4225167018958, 909.5952301225957, 909.7179874239007, 525.611047824607, 547.384192783119, 654.1104098426136, 671.6138220523219, 672.1094549721589, 14610.342534585863, 14630.195339256337, 14661.560153195422, 14663.853361466463, 14664.120152790867, 13171.67070823237, 13307.401166947511, 13386.598402047954, 13414.579282283054, 13432.932835335858, 9336.626534938594, 9530.428174309563, 9865.408075515421, 11924.46339914706, 12465.376731163406, 4311.1593239318345, 4337.0, 4475.552444755498, 4505.301678239878, 4507.391502147201, 96885.51557242239, 97218.0, 110102.0, 112225.0, 114493.42753286181, 8903.910960890309, 10133.391996480235, 10145.492725363702, 10482.213833962483, 10604.893951060545, 19562.8043719561, 19569.90215048944, 19614.411567652995, 19628.901855490632, 19666.70499942502, 6348.873022539523, 7374.483786134919, 7469.439792015621, 7654.923450765533, 7712.0, 3737.9252414951548, 4020.6984476164403, 4147.854825081168, 4238.851640192578, 4249.745015299092, 3405.0976491229844, 3444.5866496020135, 3481.982590087084, 3482.233908540117, 3507.596626387947, 546.3334731627408, 642.1619786178987, 642.7686033028106, 659.7130248341987, 661.3023260460164, 544.727636181909, 592.6118392452951, 622.1925306983221, 625.1966223402906, 635.6503922842418, 8533.658653653783, 8706.564671766386, 8948.955255223682, 9233.90766092344, 9481.288903332277, 597.3906615252505, 640.967951602418, 652.6019128331714, 656.27809409649, 671.9618189896621, 4256.57434256578, 4527.185106680763, 4530.61489773373, 4541.863744087683, 4632.143053535039, 86709.0, 107054.46472767586, 107342.92657073485, 107392.0, 115163.84836151698, 75206.0, 99775.0, 99913.50043249737, 99967.0, 102040.0, 82161.0, 84931.57534212289, 86455.56772216225, 86676.5666171665, 87086.0, 8382.83234335322, 8699.478031318142, 8716.956415217883, 8717.607707653298, 8771.1156024651, 46102.0, 48620.513794861596, 49379.0, 51565.742171288905, 51642.48357516527, 67167.66416167888, 72601.89090327703, 77763.66708998739, 78221.60889195517, 79588.0, 11105.944470277596, 11302.0, 11634.6509604712, 11706.180567360203, 11934.60245465561, 12542.686432838887, 12844.486220551073, 13012.284324361872, 13080.542181023618, 13205.933970330087, 11769.588064417705, 12183.634490965285, 12419.627411177678, 12487.188332758342, 12495.500179993061, 11055.83416248773, 11545.480453379787, 12942.0, 12992.610221693365, 13235.3382330885, 12738.936305318413, 12881.355932203165, 12958.935205323913, 13005.284709341076, 13147.543435451076, 10516.474176291307, 10868.456577171268, 11159.218854680095, 11178.776424471302, 11209.943950280196, 10957.342559446459, 11074.280171788809, 11309.71725706864, 11422.600208992977, 11497.482613282255], "value": 7278.352986477043, "unit": "score"}], "name": "dromaeo_css", "value": 6975.554862289711, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 114.0, 115.0, 116.0, 114.0, 116.0, 115.0, 115.0, 113.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 132.0, 177.0, 141.0, 114.0, 113.0, 109.0, 131.0, 112.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 255.0, 187.0, 185.0, 183.0, 182.0, 183.0, 182.0, 182.0, 182.0], "value": 190.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 59.0, 60.0, 86.0, 62.0, 59.0, 59.0, 58.0, 77.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 87.0, 69.0, 69.0, 68.0, 83.0, 69.0, 68.0, 83.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 110.0, 114.0, 111.0, 112.0, 155.0, 114.0, 110.0, 113.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 88.0, 84.0, 87.0, 87.0, 88.0, 86.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 69.0, 78.0, 72.0, 70.0, 69.0, 72.0, 70.0, 72.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 96.0, 111.0, 111.0, 93.0, 93.0, 93.0, 163.0, 94.0], "value": 104.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 144.0, 149.0, 148.0, 157.0, 145.0, 181.0, 154.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 177.0, 229.0, 173.0, 181.0, 178.0, 180.0, 175.0, 174.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 66.0, 68.0, 68.0, 66.0, 69.0, 79.0, 81.0, 83.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1510.1, "alertThreshold": 2.0}]} 14:47:54 INFO - Return code: 0 14:47:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:47:54 INFO - # TBPL SUCCESS # 14:47:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:47:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:47:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:47:54 INFO - 2016-12-12 14:47:54.971 screenresolution[1655:10472] starting screenresolution argv=screenresolution get 14:47:54 INFO - 2016-12-12 14:47:54.974 screenresolution[1655:10472] Display 0: 1600x1200x32@60 14:47:54 INFO - 2016-12-12 14:47:54.980 screenresolution[1656:10474] starting screenresolution argv=screenresolution list 14:47:54 INFO - Available Modes on Display 0 14:47:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:47:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:47:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:47:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:47:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:47:55 INFO - Intel Iris: 14:47:55 INFO - Chipset Model: Intel Iris 14:47:55 INFO - Type: GPU 14:47:55 INFO - Bus: Built-In 14:47:55 INFO - VRAM (Dynamic, Max): 1536 MB 14:47:55 INFO - Vendor: Intel (0x8086) 14:47:55 INFO - Device ID: 0x0a2e 14:47:55 INFO - Revision ID: 0x0009 14:47:55 INFO - Displays: 14:47:55 INFO - Display: 14:47:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:47:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:47:55 INFO - Display Serial Number: 1600x1200 60 14:47:55 INFO - Main Display: Yes 14:47:55 INFO - Mirror: Off 14:47:55 INFO - Online: Yes 14:47:55 INFO - Rotation: Supported 14:47:55 INFO - Return code: 0 14:47:55 INFO - Running post-action listener: _resource_record_post_action 14:47:55 INFO - [mozharness: 2016-12-12 22:47:55.215308Z] Finished run-tests step (success) 14:47:55 INFO - Running post-run listener: _resource_record_post_run 14:47:55 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 32177152; Write bytes: 552691712; Read time: 194; Write time: 1699 14:47:55 INFO - TinderboxPrint: CPU usage
53.6% 14:47:55 INFO - TinderboxPrint: I/O read bytes / time
32,177,152 / 194 14:47:55 INFO - TinderboxPrint: I/O write bytes / time
552,691,712 / 1,699 14:47:55 INFO - TinderboxPrint: CPU idle
2,235.4 (46.4%) 14:47:55 INFO - TinderboxPrint: CPU system
962.9 (20.0%) 14:47:55 INFO - TinderboxPrint: CPU user
1,619.3 (33.6%) 14:47:55 INFO - TinderboxPrint: Swap in / out
277,872,640 / 0 14:47:55 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245613056; Write bytes: 239859712; Read time: 17892; Write time: 542 14:47:55 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 30112768; Write bytes: 299175936; Read time: 175; Write time: 1124 14:47:55 INFO - Running post-run listener: _upload_blobber_files 14:47:55 INFO - Blob upload gear active. 14:47:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:47:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:47:55 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'] 14:47:55 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 14:47:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:47:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:47:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:56 INFO - (blobuploader) - INFO - Done attempting. 14:47:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:47:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:47:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:58 INFO - (blobuploader) - INFO - Done attempting. 14:47:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:47:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:48:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:00 INFO - (blobuploader) - INFO - Done attempting. 14:48:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:48:00 INFO - Return code: 0 14:48:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:48:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:48:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/39285714ac229c0c5210102cda65a8528fee5d4cb32e850030a2025315148e78540d60d67062e6af326ddf7796732c4d619d51f09fb4e1f60659f2c59bba488a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7d309d4426e4d83db5581d6ebcfee4f8b6bd761b6964cf7b252c4fbd4abb67f37b6f984322b1a9dd67f00f193ac48b58aba3d7cb449f98d3d5dac99608b9b3ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/576f919b3811b1be3163f6d20275e051bc7035e039b47b648f000fb8cc0ff0d8095aa72dfc6663178a03ab42fbee71153753cf6e13ae1bcd45a6d26c8ba0ba2b"} 14:48:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:48:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:48:00 INFO - Contents: 14:48:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/39285714ac229c0c5210102cda65a8528fee5d4cb32e850030a2025315148e78540d60d67062e6af326ddf7796732c4d619d51f09fb4e1f60659f2c59bba488a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7d309d4426e4d83db5581d6ebcfee4f8b6bd761b6964cf7b252c4fbd4abb67f37b6f984322b1a9dd67f00f193ac48b58aba3d7cb449f98d3d5dac99608b9b3ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/576f919b3811b1be3163f6d20275e051bc7035e039b47b648f000fb8cc0ff0d8095aa72dfc6663178a03ab42fbee71153753cf6e13ae1bcd45a6d26c8ba0ba2b"} 14:48:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:48:00 INFO - Copying logs to upload dir... 14:48:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:48:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.311737 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-12 14:48:00.728327) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 14:48:00.731793) ========= 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.2KGkMIhApP/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.uVejPCTiSe/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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/39285714ac229c0c5210102cda65a8528fee5d4cb32e850030a2025315148e78540d60d67062e6af326ddf7796732c4d619d51f09fb4e1f60659f2c59bba488a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7d309d4426e4d83db5581d6ebcfee4f8b6bd761b6964cf7b252c4fbd4abb67f37b6f984322b1a9dd67f00f193ac48b58aba3d7cb449f98d3d5dac99608b9b3ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/576f919b3811b1be3163f6d20275e051bc7035e039b47b648f000fb8cc0ff0d8095aa72dfc6663178a03ab42fbee71153753cf6e13ae1bcd45a6d26c8ba0ba2b"} build_url:https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011013 build_url: 'https://queue.taskcluster.net/v1/task/FN6yzZ-YSsC0pI8983daIg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/39285714ac229c0c5210102cda65a8528fee5d4cb32e850030a2025315148e78540d60d67062e6af326ddf7796732c4d619d51f09fb4e1f60659f2c59bba488a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7d309d4426e4d83db5581d6ebcfee4f8b6bd761b6964cf7b252c4fbd4abb67f37b6f984322b1a9dd67f00f193ac48b58aba3d7cb449f98d3d5dac99608b9b3ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/576f919b3811b1be3163f6d20275e051bc7035e039b47b648f000fb8cc0ff0d8095aa72dfc6663178a03ab42fbee71153753cf6e13ae1bcd45a6d26c8ba0ba2b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 14:48:00.766581) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 14:48:00.766922) ========= 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.2KGkMIhApP/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.uVejPCTiSe/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.005210 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 14:48:00.815172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 14:48:00.815495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 14:48:00.815809) ========= ========= Total master_lag: 0.19 =========