builder: graphics_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0193 starttime: 1484900385.7 results: success (0) buildid: 20170119222424 builduid: 8446f782c87b48efb33ec51d796060d4 revision: 309035ec7be2f9156de1deb5de6c67448837eeae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:45.699331) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:45.699875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:45.700181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:45.729410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:45.729846) ========= 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.phzmBtqGDC/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.NiLRJc4KyE/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-20 00:19:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.47M=0.001s 2017-01-20 00:19:45 (9.47 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:45.839031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:45.839363) ========= 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.phzmBtqGDC/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.NiLRJc4KyE/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.030477 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:45.899729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:45.900189) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 309035ec7be2f9156de1deb5de6c67448837eeae --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 309035ec7be2f9156de1deb5de6c67448837eeae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.phzmBtqGDC/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.NiLRJc4KyE/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-20 00:19:46,002 truncating revision to first 12 chars 2017-01-20 00:19:46,002 Setting DEBUG logging. 2017-01-20 00:19:46,002 attempt 1/10 2017-01-20 00:19:46,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/309035ec7be2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 00:19:46,660 unpacking tar archive at: graphics-309035ec7be2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.926432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:46.850282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:46.850641) ========= script_repo_revision: 309035ec7be2f9156de1deb5de6c67448837eeae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:46.851036) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:46.851305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 00:19:46.871605) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-20 00:19:46.872015) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.phzmBtqGDC/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.NiLRJc4KyE/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:19:47 INFO - MultiFileLogger online at 20170120 00:19:47 in /builds/slave/test 00:19:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 00:19:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:19:47 INFO - {'append_to_log': False, 00:19:47 INFO - 'base_work_dir': '/builds/slave/test', 00:19:47 INFO - 'blob_upload_branch': 'Graphics', 00:19:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:19:47 INFO - 'branch': 'Graphics', 00:19:47 INFO - 'buildbot_json_path': 'buildprops.json', 00:19:47 INFO - 'config_files': ('talos/mac_config.py',), 00:19:47 INFO - 'default_actions': ('clobber', 00:19:47 INFO - 'read-buildbot-config', 00:19:47 INFO - 'download-and-extract', 00:19:47 INFO - 'populate-webroot', 00:19:47 INFO - 'create-virtualenv', 00:19:47 INFO - 'install', 00:19:47 INFO - 'run-tests'), 00:19:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:19:47 INFO - 'download_minidump_stackwalk': True, 00:19:47 INFO - 'download_symbols': 'ondemand', 00:19:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:19:47 INFO - 'tooltool.py': '/tools/tooltool.py', 00:19:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:19:47 INFO - '/tools/misc-python/virtualenv.py')}, 00:19:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:19:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:19:47 INFO - 'installer_path': 'installer.exe', 00:19:47 INFO - 'log_level': 'info', 00:19:47 INFO - 'log_name': 'talos', 00:19:47 INFO - 'log_to_console': True, 00:19:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:19:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:19:47 INFO - 'opt_config_files': (), 00:19:47 INFO - 'pip_index': False, 00:19:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:19:47 INFO - 'cmd': ('bash', 00:19:47 INFO - '-c', 00:19:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:19:47 INFO - 'enabled': True, 00:19:47 INFO - 'halt_on_failure': False, 00:19:47 INFO - 'name': 'check_screen_resolution'},), 00:19:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:19:47 INFO - 'cmd': ('bash', 00:19:47 INFO - '-c', 00:19:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:19:47 INFO - 'enabled': True, 00:19:47 INFO - 'halt_on_failure': False, 00:19:47 INFO - 'name': 'check_screen_resolution'},), 00:19:47 INFO - 'run_cmd_checks_enabled': True, 00:19:47 INFO - 'sps_profile': False, 00:19:47 INFO - 'sps_profile_interval': 0, 00:19:47 INFO - 'suite': 'dromaeojs-e10s', 00:19:47 INFO - 'system_bits': '32', 00:19:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:19:47 INFO - 'title': 't-yosemite-r7-0193', 00:19:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:19:47 INFO - 'use_talos_json': True, 00:19:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:19:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:19:47 INFO - 'work_dir': 'build'} 00:19:47 INFO - [mozharness: 2017-01-20 08:19:47.085461Z] Running clobber step. 00:19:47 INFO - Running pre-action listener: _resource_record_pre_action 00:19:47 INFO - Running main action method: clobber 00:19:47 INFO - rmtree: /builds/slave/test/build 00:19:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:19:50 INFO - Running post-action listener: _resource_record_post_action 00:19:50 INFO - [mozharness: 2017-01-20 08:19:50.207472Z] Finished clobber step (success) 00:19:50 INFO - [mozharness: 2017-01-20 08:19:50.207597Z] Running read-buildbot-config step. 00:19:50 INFO - Running pre-action listener: _resource_record_pre_action 00:19:50 INFO - Running main action method: read_buildbot_config 00:19:50 INFO - Using buildbot properties: 00:19:50 INFO - { 00:19:50 INFO - "project": "", 00:19:50 INFO - "product": "firefox", 00:19:50 INFO - "script_repo_revision": "default", 00:19:50 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs-e10s", 00:19:50 INFO - "repository": "", 00:19:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs-e10s", 00:19:50 INFO - "buildid": "20170119222424", 00:19:50 INFO - "pgo_build": "False", 00:19:50 INFO - "basedir": "/builds/slave/test", 00:19:50 INFO - "buildnumber": 9, 00:19:50 INFO - "slavename": "t-yosemite-r7-0193", 00:19:50 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 00:19:50 INFO - "platform": "yosemite_r7", 00:19:50 INFO - "scheduler": "tests-graphics-macosx64-talos-8-3600", 00:19:50 INFO - "branch": "graphics", 00:19:50 INFO - "repo_path": "projects/graphics", 00:19:50 INFO - "revision": "309035ec7be2f9156de1deb5de6c67448837eeae", 00:19:50 INFO - "stage_platform": "macosx64", 00:19:50 INFO - "builduid": "8446f782c87b48efb33ec51d796060d4", 00:19:50 INFO - "slavebuilddir": "test" 00:19:50 INFO - } 00:19:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 00:19:50 INFO - Running post-action listener: _resource_record_post_action 00:19:50 INFO - [mozharness: 2017-01-20 08:19:50.211059Z] Finished read-buildbot-config step (success) 00:19:50 INFO - [mozharness: 2017-01-20 08:19:50.211188Z] Running download-and-extract step. 00:19:50 INFO - Running pre-action listener: _resource_record_pre_action 00:19:50 INFO - Running main action method: download_and_extract 00:19:50 INFO - mkdir: /builds/slave/test/build/tests 00:19: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')]} 00:19:50 INFO - trying https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 00:19:50 INFO - Downloading https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 00:19:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 00:19:51 INFO - Downloaded 1199 bytes. 00:19:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 00:19:51 INFO - Using the following test package requirements: 00:19:51 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 00:19:51 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:19:51 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 00:19:51 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:19:51 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 00:19:51 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:19:51 INFO - u'jsshell-mac.zip'], 00:19:51 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:19:51 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 00:19:51 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 00:19:51 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:19:51 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 00:19:51 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:19:51 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 00:19:51 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:19:51 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 00:19:51 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:19:51 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 00:19:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:19:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 00:19:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:19:51 INFO - Fetch https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 00:19:52 INFO - Expected file size: 16340617 00:19:52 INFO - Obtained file size: 16340617 00:19:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:19:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 00:19:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:19:58 INFO - Fetch https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 00:19:59 INFO - Expected file size: 16340617 00:19:59 INFO - Obtained file size: 16340617 00:20:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 00:20:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:20:05 INFO - Fetch https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 00:20:06 INFO - Expected file size: 14403463 00:20:06 INFO - Obtained file size: 14403463 00:20:07 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')]} 00:20:07 INFO - trying https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:20:07 INFO - Downloading https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 00:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 00:20:09 INFO - Downloaded 69935360 bytes. 00:20:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:20:09 INFO - mkdir: /builds/slave/test/properties 00:20:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:20:09 INFO - Writing to file /builds/slave/test/properties/build_url 00:20:09 INFO - Contents: 00:20:09 INFO - build_url:https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:20:09 INFO - Running post-action listener: _resource_record_post_action 00:20:09 INFO - Running post-action listener: set_extra_try_arguments 00:20:09 INFO - [mozharness: 2017-01-20 08:20:09.931005Z] Finished download-and-extract step (success) 00:20:09 INFO - [mozharness: 2017-01-20 08:20:09.931132Z] Running populate-webroot step. 00:20:09 INFO - Running pre-action listener: _resource_record_pre_action 00:20:09 INFO - Running main action method: populate_webroot 00:20:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:20:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:20:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:20:09 INFO - '--tppagecycles', 00:20:09 INFO - '7'], 00:20:09 INFO - 'tests': ['tsvgm']}}, 00:20:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:20:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:20:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:20:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:20:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:20:09 INFO - 'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:20:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:20:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:20:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:20:09 INFO - 'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['damp', 'tps']}, 00:20:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:20:09 INFO - 'tests': ['damp', 'tps']}, 00:20:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['dromaeo_dom']}, 00:20:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:20:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['basic_compositor_video']}, 00:20:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:20:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['a11yr', 00:20:09 INFO - 'ts_paint', 00:20:09 INFO - 'tpaint', 00:20:09 INFO - 'sessionrestore', 00:20:09 INFO - 'sessionrestore_no_auto_restore', 00:20:09 INFO - 'tabpaint']}, 00:20:09 INFO - 'other-e10s': {'tests': ['a11yr', 00:20:09 INFO - 'ts_paint', 00:20:09 INFO - 'tpaint', 00:20:09 INFO - 'sessionrestore', 00:20:09 INFO - 'sessionrestore_no_auto_restore', 00:20:09 INFO - 'tabpaint']}, 00:20:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:20:09 INFO - 'ts_paint', 00:20:09 INFO - 'tpaint', 00:20:09 INFO - 'sessionrestore', 00:20:09 INFO - 'sessionrestore_no_auto_restore', 00:20:09 INFO - 'tabpaint']}, 00:20:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:20:09 INFO - 'ts_paint', 00:20:09 INFO - 'tpaint', 00:20:09 INFO - 'sessionrestore', 00:20:09 INFO - 'sessionrestore_no_auto_restore', 00:20:09 INFO - 'tabpaint']}, 00:20:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['a11yr', 00:20:09 INFO - 'ts_paint', 00:20:09 INFO - 'tpaint', 00:20:09 INFO - 'sessionrestore', 00:20:09 INFO - 'sessionrestore_no_auto_restore', 00:20:09 INFO - 'tabpaint']}, 00:20:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['a11yr', 00:20:09 INFO - 'ts_paint', 00:20:09 INFO - 'tpaint', 00:20:09 INFO - 'sessionrestore', 00:20:09 INFO - 'sessionrestore_no_auto_restore', 00:20:09 INFO - 'tabpaint']}, 00:20:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['tsvgx', 00:20:09 INFO - 'tsvgr_opacity', 00:20:09 INFO - 'tart', 00:20:09 INFO - 'tscrollx', 00:20:09 INFO - 'cart', 00:20:09 INFO - 'tsvg_static']}, 00:20:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:20:09 INFO - 'tsvgr_opacity', 00:20:09 INFO - 'tart', 00:20:09 INFO - 'tscrollx', 00:20:09 INFO - 'cart', 00:20:09 INFO - 'tsvg_static']}, 00:20:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:20:09 INFO - 'talos_options': ['--disable-e10s'], 00:20:09 INFO - 'tests': ['tp5o']}, 00:20:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:20:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:20:09 INFO - 'talos_options': ['--disable-e10s', 00:20:09 INFO - '--xperf_path', 00:20:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:20:09 INFO - 'tests': ['tp5n']}, 00:20:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:20:09 INFO - 'talos_options': ['--xperf_path', 00:20:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:20:09 INFO - 'tests': ['tp5n']}}, 00:20:09 INFO - 'talos.zip': {'path': '', 00:20:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:20:09 INFO - Running post-action listener: _resource_record_post_action 00:20:09 INFO - [mozharness: 2017-01-20 08:20:09.949389Z] Finished populate-webroot step (success) 00:20:09 INFO - [mozharness: 2017-01-20 08:20:09.949508Z] Running create-virtualenv step. 00:20:09 INFO - Running pre-action listener: _resource_record_pre_action 00:20:09 INFO - Running main action method: create_virtualenv 00:20:09 INFO - Creating virtualenv /builds/slave/test/build/venv 00:20:09 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 00:20:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:20:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:20:10 INFO - Using real prefix '/tools/python27' 00:20:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:20:10 INFO - Installing distribute.............................................................................................................................................................................................done. 00:20:13 INFO - Installing pip.................done. 00:20:13 INFO - Return code: 0 00:20:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:20:13 INFO - Reading from file tmpfile_stdout 00:20:13 INFO - Output received: 00:20:13 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) 00:20:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:20: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')]} 00:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20: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')]} 00:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:13 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 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20:13 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 00:20:13 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 00:20:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:13 INFO - 'HOME': '/Users/cltbld', 00:20:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:13 INFO - 'LOGNAME': 'cltbld', 00:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:13 INFO - 'MOZ_NO_REMOTE': '1', 00:20:13 INFO - 'NO_EM_RESTART': '1', 00:20:13 INFO - 'PAGER': '/bin/cat', 00:20:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:13 INFO - 'PWD': '/builds/slave/test', 00:20:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:13 INFO - 'SHELL': '/bin/bash', 00:20:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:13 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:13 INFO - 'USER': 'cltbld', 00:20:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:13 INFO - 'XPC_FLAGS': '0x0', 00:20:13 INFO - 'XPC_SERVICE_NAME': '0', 00:20:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:14 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 00:20:14 INFO - Cleaning up... 00:20:14 INFO - Return code: 0 00:20:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:20:14 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')]} 00:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:14 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')]} 00:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:14 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 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20:14 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 00:20:14 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 00:20:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:14 INFO - 'HOME': '/Users/cltbld', 00:20:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:14 INFO - 'LOGNAME': 'cltbld', 00:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:14 INFO - 'MOZ_NO_REMOTE': '1', 00:20:14 INFO - 'NO_EM_RESTART': '1', 00:20:14 INFO - 'PAGER': '/bin/cat', 00:20:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:14 INFO - 'PWD': '/builds/slave/test', 00:20:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:14 INFO - 'SHELL': '/bin/bash', 00:20:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:14 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:14 INFO - 'USER': 'cltbld', 00:20:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:14 INFO - 'XPC_FLAGS': '0x0', 00:20:14 INFO - 'XPC_SERVICE_NAME': '0', 00:20:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:14 INFO - Downloading/unpacking psutil>=3.1.1 00:20:14 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 00:20:14 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 00:20:14 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 00:20:14 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 00:20:14 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 00:20:14 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 00:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:20:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:20:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:20:17 INFO - Installing collected packages: psutil 00:20:17 INFO - Running setup.py install for psutil 00:20:17 INFO - building 'psutil._psutil_osx' extension 00:20:17 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 00:20:18 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 00:20:18 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 00:20:18 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 00:20:18 INFO - building 'psutil._psutil_posix' extension 00:20:18 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 00:20:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:20:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:20:18 INFO - ^ 00:20:18 INFO - 1 warning generated. 00:20:18 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 00:20:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:20:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:20:19 INFO - Successfully installed psutil 00:20:19 INFO - Cleaning up... 00:20:19 INFO - Return code: 0 00:20:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:19 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 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20:19 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 00:20:19 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 00:20:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:19 INFO - 'HOME': '/Users/cltbld', 00:20:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:19 INFO - 'LOGNAME': 'cltbld', 00:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:19 INFO - 'MOZ_NO_REMOTE': '1', 00:20:19 INFO - 'NO_EM_RESTART': '1', 00:20:19 INFO - 'PAGER': '/bin/cat', 00:20:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:19 INFO - 'PWD': '/builds/slave/test', 00:20:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:19 INFO - 'SHELL': '/bin/bash', 00:20:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:19 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:19 INFO - 'USER': 'cltbld', 00:20:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:19 INFO - 'XPC_FLAGS': '0x0', 00:20:19 INFO - 'XPC_SERVICE_NAME': '0', 00:20:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:20:19 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 00:20:19 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 00:20:19 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 00:20:19 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 00:20:19 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 00:20:19 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 00:20:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:20:22 INFO - Installing collected packages: mozsystemmonitor 00:20:22 INFO - Running setup.py install for mozsystemmonitor 00:20:22 INFO - Successfully installed mozsystemmonitor 00:20:22 INFO - Cleaning up... 00:20:22 INFO - Return code: 0 00:20:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:20: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')]} 00:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20: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')]} 00:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20: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', '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 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:20: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 jsonschema==2.5.1 00:20:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:22 INFO - 'HOME': '/Users/cltbld', 00:20:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:22 INFO - 'LOGNAME': 'cltbld', 00:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:22 INFO - 'MOZ_NO_REMOTE': '1', 00:20:22 INFO - 'NO_EM_RESTART': '1', 00:20:22 INFO - 'PAGER': '/bin/cat', 00:20:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:22 INFO - 'PWD': '/builds/slave/test', 00:20:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:22 INFO - 'SHELL': '/bin/bash', 00:20:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:22 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:22 INFO - 'USER': 'cltbld', 00:20:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:22 INFO - 'XPC_FLAGS': '0x0', 00:20:22 INFO - 'XPC_SERVICE_NAME': '0', 00:20:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:22 INFO - Downloading/unpacking jsonschema==2.5.1 00:20: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 00:20: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 00:20: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 00:20: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 00:20: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 00:20: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 00:20:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:20:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:20:25 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 00:20:25 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 00:20:25 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 00:20:25 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 00:20:25 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 00:20:25 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 00:20:25 INFO - Downloading functools32-3.2.3-2.tar.gz 00:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:20:25 INFO - warning: no files found matching '*.txt' 00:20:25 INFO - no previously-included directories found matching 'build' 00:20:25 INFO - no previously-included directories found matching 'dist' 00:20:25 INFO - no previously-included directories found matching '.git*' 00:20:25 INFO - Installing collected packages: jsonschema, functools32 00:20:25 INFO - Running setup.py install for functools32 00:20:25 INFO - warning: no files found matching '*.txt' 00:20:25 INFO - no previously-included directories found matching 'build' 00:20:25 INFO - no previously-included directories found matching 'dist' 00:20:25 INFO - no previously-included directories found matching '.git*' 00:20:25 INFO - Successfully installed jsonschema functools32 00:20:25 INFO - Cleaning up... 00:20:25 INFO - Return code: 0 00:20:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:20:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:25 INFO - 'HOME': '/Users/cltbld', 00:20:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:25 INFO - 'LOGNAME': 'cltbld', 00:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:25 INFO - 'MOZ_NO_REMOTE': '1', 00:20:25 INFO - 'NO_EM_RESTART': '1', 00:20:25 INFO - 'PAGER': '/bin/cat', 00:20:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:25 INFO - 'PWD': '/builds/slave/test', 00:20:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:25 INFO - 'SHELL': '/bin/bash', 00:20:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:25 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:25 INFO - 'USER': 'cltbld', 00:20:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:25 INFO - 'XPC_FLAGS': '0x0', 00:20:25 INFO - 'XPC_SERVICE_NAME': '0', 00:20:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:20:26 INFO - Cleaning up... 00:20:26 INFO - Return code: 0 00:20:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:20:26 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')]} 00:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:26 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')]} 00:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:26 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 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20:26 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 00:20:26 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 00:20:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:26 INFO - 'HOME': '/Users/cltbld', 00:20:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:26 INFO - 'LOGNAME': 'cltbld', 00:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:26 INFO - 'MOZ_NO_REMOTE': '1', 00:20:26 INFO - 'NO_EM_RESTART': '1', 00:20:26 INFO - 'PAGER': '/bin/cat', 00:20:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:26 INFO - 'PWD': '/builds/slave/test', 00:20:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:26 INFO - 'SHELL': '/bin/bash', 00:20:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:26 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:26 INFO - 'USER': 'cltbld', 00:20:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:26 INFO - 'XPC_FLAGS': '0x0', 00:20:26 INFO - 'XPC_SERVICE_NAME': '0', 00:20:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:26 INFO - Downloading/unpacking blobuploader==1.2.4 00:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:29 INFO - Downloading blobuploader-1.2.4.tar.gz 00:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:20:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:20:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:20:30 INFO - Downloading docopt-0.6.1.tar.gz 00:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:20:30 INFO - Installing collected packages: blobuploader, requests, docopt 00:20:30 INFO - Running setup.py install for blobuploader 00:20:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:20:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:20:30 INFO - Running setup.py install for requests 00:20:31 INFO - Running setup.py install for docopt 00:20:31 INFO - Successfully installed blobuploader requests docopt 00:20:31 INFO - Cleaning up... 00:20:31 INFO - Return code: 0 00:20:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:20: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')]} 00:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20: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')]} 00:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:31 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 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20:31 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 00:20:31 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 00:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:31 INFO - 'HOME': '/Users/cltbld', 00:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:31 INFO - 'LOGNAME': 'cltbld', 00:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:31 INFO - 'MOZ_NO_REMOTE': '1', 00:20:31 INFO - 'NO_EM_RESTART': '1', 00:20:31 INFO - 'PAGER': '/bin/cat', 00:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:31 INFO - 'PWD': '/builds/slave/test', 00:20:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:31 INFO - 'SHELL': '/bin/bash', 00:20:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:31 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:31 INFO - 'USER': 'cltbld', 00:20:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:31 INFO - 'XPC_FLAGS': '0x0', 00:20:31 INFO - 'XPC_SERVICE_NAME': '0', 00:20:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:20:31 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-RZZSdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:20:31 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-wBXf_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:20:31 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-TUrY_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:20:31 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Evad1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:20:31 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-m3Wqaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:20:32 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-2AbcR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:20:32 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-uQ_IGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:20:32 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-1lpJ5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:20:32 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-9fH7Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:20:32 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-3u0Csa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:20:32 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Nd1goV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:20:32 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-3_IK00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:20:32 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-d6JS55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:20:32 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-2891dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:33 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-MPQPYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:20:33 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-d4lmsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:20:33 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-BPQ4mP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:20:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:20:33 INFO - Running setup.py install for manifestparser 00:20:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:20:33 INFO - Running setup.py install for mozcrash 00:20:33 INFO - Running setup.py install for mozdebug 00:20:33 INFO - Running setup.py install for mozdevice 00:20:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:20:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:20:33 INFO - Running setup.py install for mozfile 00:20:34 INFO - Running setup.py install for mozhttpd 00:20:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:20:34 INFO - Running setup.py install for mozinfo 00:20:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:20:34 INFO - Running setup.py install for mozInstall 00:20:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:20:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:20:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:20:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:20:34 INFO - Running setup.py install for mozleak 00:20:34 INFO - Running setup.py install for mozlog 00:20:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:20:34 INFO - Running setup.py install for moznetwork 00:20:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:20:34 INFO - Running setup.py install for mozprocess 00:20:35 INFO - Running setup.py install for mozprofile 00:20:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:20:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:20:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:20:35 INFO - Running setup.py install for mozrunner 00:20:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:20:35 INFO - Running setup.py install for mozscreenshot 00:20:35 INFO - Running setup.py install for moztest 00:20:35 INFO - Running setup.py install for mozversion 00:20:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:20:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:20:35 INFO - Cleaning up... 00:20:35 INFO - Return code: 0 00:20:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:20: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')]} 00:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20: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')]} 00:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:35 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 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20:35 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 00:20:35 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 00:20:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:35 INFO - 'HOME': '/Users/cltbld', 00:20:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:35 INFO - 'LOGNAME': 'cltbld', 00:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:35 INFO - 'MOZ_NO_REMOTE': '1', 00:20:35 INFO - 'NO_EM_RESTART': '1', 00:20:35 INFO - 'PAGER': '/bin/cat', 00:20:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:35 INFO - 'PWD': '/builds/slave/test', 00:20:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:35 INFO - 'SHELL': '/bin/bash', 00:20:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:35 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:35 INFO - 'USER': 'cltbld', 00:20:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:35 INFO - 'XPC_FLAGS': '0x0', 00:20:35 INFO - 'XPC_SERVICE_NAME': '0', 00:20:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:20:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-6ycZRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:20:36 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)) 00:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:20:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-cvYQGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:20:36 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)) 00:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:20:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Nhr_Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:20:36 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)) 00:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:20:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-I8IzUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:20:36 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)) 00:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:20:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-n6JD8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:20:36 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)) 00:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:20:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-jm7_le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:20:36 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)) 00:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:20:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-eNObcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:20:36 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)) 00:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:20:36 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-WdWNxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:20:37 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)) 00:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:20:37 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-_lNsxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:20:37 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)) 00:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:20:37 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-l3AkU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:20:37 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)) 00:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:20:37 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-sdoVfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:20:37 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)) 00:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:20:37 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-BoOpWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:20:37 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-jCXjJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:20:37 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)) 00:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:20:37 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-qpmsKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:20:37 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)) 00:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:37 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-lPnyRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:20:37 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)) 00:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:20:37 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-a8tkvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:20:37 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-QbLix4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 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)) 00:20:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:20:37 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 00:20:37 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 00:20:37 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 00:20:37 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 00:20:37 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 00:20:37 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 00:20:40 INFO - Downloading blessings-1.6.tar.gz 00:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:20:41 INFO - Installing collected packages: blessings 00:20:41 INFO - Running setup.py install for blessings 00:20:41 INFO - Successfully installed blessings 00:20:41 INFO - Cleaning up... 00:20:41 INFO - Return code: 0 00:20:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:20:41 INFO - Reading from file tmpfile_stdout 00:20:41 INFO - Current package versions: 00:20:41 INFO - blessings == 1.6 00:20:41 INFO - blobuploader == 1.2.4 00:20:41 INFO - docopt == 0.6.1 00:20:41 INFO - functools32 == 3.2.3-2 00:20:41 INFO - jsonschema == 2.5.1 00:20:41 INFO - manifestparser == 1.1 00:20:41 INFO - mozInstall == 1.12 00:20:41 INFO - mozcrash == 1.0 00:20:41 INFO - mozdebug == 0.1 00:20:41 INFO - mozdevice == 0.49 00:20:41 INFO - mozfile == 1.2 00:20:41 INFO - mozhttpd == 0.7 00:20:41 INFO - mozinfo == 0.9 00:20:41 INFO - mozleak == 0.1 00:20:41 INFO - mozlog == 3.4 00:20:41 INFO - moznetwork == 0.27 00:20:41 INFO - mozprocess == 0.24 00:20:41 INFO - mozprofile == 0.28 00:20:41 INFO - mozrunner == 6.13 00:20:41 INFO - mozscreenshot == 0.1 00:20:41 INFO - mozsystemmonitor == 0.3 00:20:41 INFO - moztest == 0.8 00:20:41 INFO - mozversion == 1.4 00:20:41 INFO - psutil == 3.1.1 00:20:41 INFO - requests == 1.2.3 00:20:41 INFO - wsgiref == 0.1.2 00:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:41 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 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20:41 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 00:20:41 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 00:20:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:41 INFO - 'HOME': '/Users/cltbld', 00:20:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:41 INFO - 'LOGNAME': 'cltbld', 00:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:41 INFO - 'MOZ_NO_REMOTE': '1', 00:20:41 INFO - 'NO_EM_RESTART': '1', 00:20:41 INFO - 'PAGER': '/bin/cat', 00:20:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:41 INFO - 'PWD': '/builds/slave/test', 00:20:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:41 INFO - 'SHELL': '/bin/bash', 00:20:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:41 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:41 INFO - 'USER': 'cltbld', 00:20:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:41 INFO - 'XPC_FLAGS': '0x0', 00:20:41 INFO - 'XPC_SERVICE_NAME': '0', 00:20:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:42 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)) 00:20:42 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)) 00:20:42 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)) 00:20:42 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)) 00:20:42 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)) 00:20:42 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)) 00:20:42 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)) 00:20:42 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)) 00:20:42 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)) 00:20:42 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)) 00:20:42 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)) 00:20:42 INFO - Cleaning up... 00:20:42 INFO - Return code: 0 00:20:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:20:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10295eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102961768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b1db7220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, '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.phzmBtqGDC/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.NiLRJc4KyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 00:20:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:20:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:20:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:20:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:20:42 INFO - 'HOME': '/Users/cltbld', 00:20:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:20:42 INFO - 'LOGNAME': 'cltbld', 00:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:20:42 INFO - 'MOZ_NO_REMOTE': '1', 00:20:42 INFO - 'NO_EM_RESTART': '1', 00:20:42 INFO - 'PAGER': '/bin/cat', 00:20:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:20:42 INFO - 'PWD': '/builds/slave/test', 00:20:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:20:42 INFO - 'SHELL': '/bin/bash', 00:20:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:20:42 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:20:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:20:42 INFO - 'USER': 'cltbld', 00:20:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:20:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:20:42 INFO - 'XPC_FLAGS': '0x0', 00:20:42 INFO - 'XPC_SERVICE_NAME': '0', 00:20:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:20:42 INFO - Cleaning up... 00:20:42 INFO - Return code: 0 00:20:42 INFO - Running post-action listener: _resource_record_post_action 00:20:42 INFO - Running post-action listener: _start_resource_monitoring 00:20:42 INFO - Starting resource monitoring. 00:20:42 INFO - [mozharness: 2017-01-20 08:20:42.562704Z] Finished create-virtualenv step (success) 00:20:42 INFO - [mozharness: 2017-01-20 08:20:42.563624Z] Running install step. 00:20:42 INFO - Running pre-action listener: _resource_record_pre_action 00:20:42 INFO - Running main action method: install 00:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:20:42 INFO - Reading from file tmpfile_stdout 00:20:42 INFO - Detecting whether we're running mozinstall >=1.0... 00:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:20:42 INFO - Reading from file tmpfile_stdout 00:20:42 INFO - Output received: 00:20:42 INFO - Usage: mozinstall [options] installer 00:20:42 INFO - Options: 00:20:42 INFO - -h, --help show this help message and exit 00:20:42 INFO - -d DEST, --destination=DEST 00:20:42 INFO - Directory to install application into. [default: 00:20:42 INFO - "/builds/slave/test"] 00:20:42 INFO - --app=APP Application being installed. [default: firefox] 00:20:42 INFO - mkdir: /builds/slave/test/build/application 00:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:21:04 INFO - Reading from file tmpfile_stdout 00:21:04 INFO - Output received: 00:21:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:21:04 INFO - Running post-action listener: _resource_record_post_action 00:21:04 INFO - [mozharness: 2017-01-20 08:21:04.836382Z] Finished install step (success) 00:21:04 INFO - [mozharness: 2017-01-20 08:21:04.836512Z] Running run-tests step. 00:21:04 INFO - Running pre-action listener: _resource_record_pre_action 00:21:04 INFO - Running main action method: run_tests 00:21:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:21:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:21:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:21:04 INFO - 2017-01-20 00:21:04.849 screenresolution[1617:7256] starting screenresolution argv=screenresolution get 00:21:04 INFO - 2017-01-20 00:21:04.851 screenresolution[1617:7256] Display 0: 1600x1200x32@60 00:21:04 INFO - 2017-01-20 00:21:04.856 screenresolution[1618:7258] starting screenresolution argv=screenresolution list 00:21:04 INFO - Available Modes on Display 0 00:21:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:21:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:21:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:21:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:21:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:21:05 INFO - Intel Iris: 00:21:05 INFO - Chipset Model: Intel Iris 00:21:05 INFO - Type: GPU 00:21:05 INFO - Bus: Built-In 00:21:05 INFO - VRAM (Dynamic, Max): 1536 MB 00:21:05 INFO - Vendor: Intel (0x8086) 00:21:05 INFO - Device ID: 0x0a2e 00:21:05 INFO - Revision ID: 0x0009 00:21:05 INFO - Displays: 00:21:05 INFO - Display: 00:21:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:21:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:21:05 INFO - Display Serial Number: 1600x1200 60 00:21:05 INFO - Main Display: Yes 00:21:05 INFO - Mirror: Off 00:21:05 INFO - Online: Yes 00:21:05 INFO - Rotation: Supported 00:21:05 INFO - Return code: 0 00:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:21:05 INFO - Python 2.7.3 00:21:05 INFO - Return code: 0 00:21:05 INFO - grabbing minidump binary from tooltool 00:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:21:05 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 0x10273cd30>, '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 0x102663db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102731be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:21:05 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 00:21:05 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 00:21:05 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 00:21:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:21:05 INFO - Return code: 0 00:21:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:21:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:21:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:21:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:21:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0193 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:21:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.phzmBtqGDC/Render', 00:21:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:05 INFO - 'HOME': '/Users/cltbld', 00:21:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:05 INFO - 'LOGNAME': 'cltbld', 00:21:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:21:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:05 INFO - 'MOZ_NO_REMOTE': '1', 00:21:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:21:05 INFO - 'NO_EM_RESTART': '1', 00:21:05 INFO - 'PAGER': '/bin/cat', 00:21:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:05 INFO - 'PWD': '/builds/slave/test', 00:21:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:21:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:05 INFO - 'SHELL': '/bin/bash', 00:21:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiLRJc4KyE/Listeners', 00:21:05 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 00:21:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:05 INFO - 'USER': 'cltbld', 00:21:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:05 INFO - 'XPC_FLAGS': '0x0', 00:21:05 INFO - 'XPC_SERVICE_NAME': '0', 00:21:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:21:05 INFO - mozversion application_buildid: 20170119222424 00:21:05 INFO - mozversion application_changeset: 309035ec7be2f9156de1deb5de6c67448837eeae 00:21:05 INFO - mozversion application_display_name: Nightly 00:21:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:21:05 INFO - mozversion application_name: Firefox 00:21:05 INFO - mozversion application_remotingname: firefox 00:21:05 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 00:21:05 INFO - mozversion application_vendor: Mozilla 00:21:05 INFO - mozversion application_version: 53.0a1 00:21:05 INFO - mozversion platform_buildid: 20170119222424 00:21:05 INFO - mozversion platform_changeset: 309035ec7be2f9156de1deb5de6c67448837eeae 00:21:05 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 00:21:05 INFO - mozversion platform_version: 53.0a1 00:21:05 INFO - using testdate: 1484900465 00:21:05 INFO - actual date: 1484900465 00:21:05 INFO - starting webserver on 'localhost:49235' 00:21:05 INFO - SUITE-START | Running 2 tests 00:21:05 INFO - TEST-START | dromaeo_css 00:21:05 INFO - operating with platform_type : mac_ 00:21:05 INFO - Initialising browser for dromaeo_css test... 00:21:05 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpyf_SbD/profile http://localhost:49235/getInfo.html) 00:21:08 INFO - PROCESS | 1628 | 2017-01-20 00:21:08.465 plugin-container[1630:7419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e37, name = 'com.apple.tsm.portname' 00:21:08 INFO - PROCESS | 1628 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:21:08 INFO - PROCESS | 1628 | 2017-01-20 00:21:08.468 plugin-container[1630:7419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 00:21:08 INFO - PROCESS | 1628 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:21:08 INFO - PROCESS | 1628 | 2017-01-20 00:21:08.468 plugin-container[1630:7419] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:21:08 INFO - PROCESS | 1628 | __metrics Screen width/height:1600/1200 00:21:08 INFO - PROCESS | 1628 | colorDepth:24 00:21:08 INFO - PROCESS | 1628 | Browser inner width/height: 1024/689 00:21:08 INFO - PROCESS | 1628 | __metrics 00:21:08 ERROR - PROCESS | 1628 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 00:21:09 INFO - TEST-INFO | 1628: exit 0 00:21:09 INFO - Browser initialized. 00:21:09 INFO - Running cycle 1/1 for dromaeo_css test... 00:21:09 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpyf_SbD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:21:11 INFO - PROCESS | 1631 | 2017-01-20 00:21:11.802 plugin-container[1632:7536] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 00:21:11 INFO - PROCESS | 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:21:11 INFO - PROCESS | 1631 | 2017-01-20 00:21:11.804 plugin-container[1632:7536] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f13, name = 'com.apple.CFPasteboardClient' 00:21:11 INFO - PROCESS | 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:21:11 INFO - PROCESS | 1631 | 2017-01-20 00:21:11.804 plugin-container[1632:7536] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:21:21 INFO - PROCESS | 1631 | RSS: Main: 232120320 00:21:21 INFO - PROCESS | 1631 | 00:24:24 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 00:24:26 INFO - PROCESS | 1631 | RSS: Main: 253194240 00:24:26 INFO - PROCESS | 1631 | 00:26:09 INFO - PROCESS | 1631 | ************************* 00:26:09 INFO - PROCESS | 1631 | A coding exception was thrown and uncaught in a Task. 00:26:09 INFO - PROCESS | 1631 | 00:26:09 ERROR - PROCESS | 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:26:09 INFO - PROCESS | 1631 | Full stack: 00:26:09 INFO - PROCESS | 1631 | ************************* 00:27:28 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 00:27:29 INFO - PROCESS | 1631 | RSS: Main: 259522560 00:27:29 INFO - PROCESS | 1631 | 00:30:31 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 00:30:31 INFO - PROCESS | 1631 | RSS: Main: 265150464 00:30:31 INFO - PROCESS | 1631 | 00:33:33 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 00:33:34 INFO - PROCESS | 1631 | RSS: Main: 266813440 00:33:34 INFO - PROCESS | 1631 | 00:36:37 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 00:36:37 INFO - PROCESS | 1631 | RSS: Main: 271269888 00:36:37 INFO - PROCESS | 1631 | 00:39:40 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 00:39:40 INFO - PROCESS | 1631 | RSS: Main: 270274560 00:39:40 INFO - PROCESS | 1631 | 00:39:40 INFO - PROCESS | 1631 | __start_tp_report 00:39:40 INFO - PROCESS | 1631 | _x_x_mozilla_page_load 00:39:40 INFO - PROCESS | 1631 | _x_x_mozilla_page_load_details 00:39:40 INFO - PROCESS | 1631 | |i|pagename|runs| 00:39:40 INFO - PROCESS | 1631 | |0;dojo.html;3040.391921615677;3389.6101948275955;3390.169408494919;3391.6269210386863;3418.7265018798466;5665.1502274658715;5714.71426428679;5749.166370876221;5801.187833703285;5822.010258256096;5695.686737229451;5718.056520674084;5752.683602401867;5866.178734977107;5879.323877754059;5145.536901678848;5152.716600586966;5198.948010519903;5294.655847369928;5321.175217841222;4506.864794056167;5180.989707007135;5339.733013349336;5375.596830237729;5389.868127693189;5185.740712964374;5194.142966410538;5279.841604751864;5312.362516498045;5323.22813192087;5193.532582067594;5243.292155558989;5286.154215325568;5303.204519322094;5329.786808527654;5194.792208311663;5198.038362902837;5217.973910130425;5230.032443997872;5256.974889896472;5564.081926482126;5578.940001399762;5656.519195868356;5811.360750317462;5864.530837532987;6143.757528502109;6182.196314479134;6216.658083805389;6241.157443745082;6263.24841019076;6292.087647291117;6296.118543403927;6298.149749783812;6304.810855674291;6311.368863113652;5894.734736936848;5910.940890591125;5926.229590153295;5926.377730338339;6012.549058820518;6173.043178307369;6240.843978900564;6258.186435763413;6271.529635277372;6351.71417286214;6239.438450539473;6249.562530622904;6273.0904018917;6275.780347687901;6284.968575157186;6302.464290535264;6309.337519560472;6312.274088479791;6327.936720632735;6337.112804207414;6140.964409184426;6145.0782382642965;6212.347703491158;6235.594686345373;6249.34381889895;6318.241810982711;6322.968385158045;6323.114763933053;6338.397852204033;6345.302016778151;4949.010197960422;5000.549950504472;5003.449620541737;5039.319691841554;5101.928594995018;4434.82260709568;4447.822087116479;4508.346289787963;4539.614132798749;4557.680962332605;5845.9707701462075;5920.259967504062;5923.289205295392;5938.703064846827;5955.404459554096;4723.976380118146;6239.937600624026;6296.087067375296;6302.905456418157;6326.557141000086;5755.510781583528;5818.418158184148;5841.211436456109;5909.793157239476;5938.435848594377;5499.752511137009;5504.339479262434;5516.641418307797;5536.031194541019;5574.9163762542785;6351.491880649629;6402.935970640234;6416.390442907917;6420.903686444707;6421.743130274736;6272.560920735505;6279.686015699288;6305.243370795534;6314.842128946813;6322.525810564134;6236.594621349598;6262.68686565679;6276.278228003838;6287.182666253358;6324.7153878076515;6280.905786413116;6290.24517057956;6301.023341382093;6321.304656487875;6342.048692696132;6162.9522981094215;6304.810855674337;6317.684115794284;6322.241331040304;6329.145565348619;6107.158472117242;6110.602810817282;6121.081837724377;6148.831721972811;6247.562670613195;6121.60540247106;6188.257409110935;6203.47270481996;6207.751689932533;6223.813285601439;5838.065909454637;5937.881242375215;6048.274207095177;6063.72713227897;6076.331603523698;6146.6170111724505;6220.03589443637;6230.813075607739;6262.248530176225;6264.404881536247;5927.911081333869;5957.106434034929;6012.398760123952;6123.418275263843;6157.9384206157365 00:39:40 INFO - PROCESS | 1631 | |1;ext.html;443.5697373547659;456.3064142503393;511.66230288009876;518.5954955134996;525.8291055406994;32371;40244;40267.39598906019;40271;40301.59698403015;41676;42026;42130.36804447936;42155;42252.57747422525;8434.40959132861;8598.742037738846;9228.723138305828;9454.385464944757;9503.192228660571;8940.329475289347;11410.600628977987;11424.828627570592;11528.827067593993;11553.133514986368;11350.035247004014;11414.771704565903;11417.771644567103;11436.142289328292;11478.942605286962;11271.605493807678;11311.830322545127;11402;11406.31562106268;11413.885861141449;11343.886561134448;11406.258593191416;11415.828762568568;11429.942850285779;11432.028277596415;33760.83119584411;38940.63707770243;39378.80310598428;39536.80231598853;39557.813265602075;3967.7222594418404;4037.858674946392;4064.9390259146135;4101.651359634435;4160.7087503874745;28291.858540707166;28577.428451431064;28955.13134605965;28974.42051158965;29010.854945725136;3157.36852629475;3225.951610725841;3240.643529211785;3318.4192766265805;3323.8171900545462;462993;484294.15705842845;487769;488998;489730;55500.722496388065;55540.72229638826;55815.44184558102;55855.44144558503;55985.44014559884;57462.42537574654;57585.712071439375;57632.13551796726;57750.42249577535;57869.4213057864;15387.692246155015;15446.065247602919;15508.906297649673;15522.5343239703;15556.922215389077;10826.837597436044;11084.778304433867;11725.882741172649;11989.76020479603;12102.455389507493;15153.924230378998;17218.655626887394;17333.826661733474;17342.959422434444;17394.82605173932;7698.653560589787;7823.726169584037;7864.174261702553;7921.049474063034;7946.920530794734;864.386285737121;892.3084609427746;908.2325435007408;917.7200953709049;926.8517037274004;29509.114726558237;29539.556906646416;29632.111036668935;30255.69744302573;30343.241418964262;1024.8718910136233;1069.342354452022;1100.1254003067581;1118.8321751737142;1167.96496105117;12698.682532936566;15086.321115549606;15394;15501.224938753017;15797.36810527589;610814;615573;616274;616578;616872;52105.739471302404;52719.47280527222;52754;52783;52849.735751321;1395.483671041721;1432.8352239492592;1453.14264583896;1454.4909281751302;1456.788765628978;25238.747612524374;25410.364740880887;25535.744642553338;27163.72836271612;28870.566941496316;36247.63752362443;41326.79336603298;51260.23109653433;51338.22992655188;53702;513088;603434;606966;608996;611222;32087.67912320847;33100.83449582833;38147.42778858264;38811.22377552489;38972.80513597414;39223.41164882472;40033.199336012534;42486;42605;43132.56867431285;32960;35658.46512302266;36225.27549448943;36719;36821;35249.82375088108;35373.46939795957;36036.81981590075;36192.638073618924;36345;34088.14779630529;34117.658823411446;34699.4795078069;35094.64905351016;35330.29339413146;30121.548176777804;31054;31104.667149963392;31214.531782023743;31215.190632843154;20327.780333180057;22064.33806985793;23720.779382781144;23779.762202377755;23779.762202378446 00:39:40 INFO - PROCESS | 1631 | |2;jquery.html;386.5979381443301;390.9198614284072;399.301222859995;405.9086705491265;418.7341038440591;20224.69662955055;21302.786972130274;21596.920153992298;21619.81091039994;21968.340949771493;21552.676709849326;21756.673649895263;22056.44858878529;22493.887530562366;22498;5691.971540142294;6003.099535069753;6011.1283863839935;6011.789587364421;6019.337872833985;5801.390853960336;5916.940830591703;5947.316058653245;5991.670458124801;6017.669028203447;5929.288485381739;5939.020061689837;5940.257467816523;5943.227380440537;5955.672438015908;5663.603547751639;5884.7940322088525;5914.142449344842;5942.405759424067;5949.077892926603;5229.980153869997;5231.372235331784;5240.659357141812;5246.81636142737;5251.212318152269;26113.869430652914;26502.46995060088;26536.86731566349;26780;26823.195304140907;2739.342557786117;2757.2968892932377;2760.406512599801;2763.06055940979;2767.488014717284;15445.691086178325;15967;15999.92000040004;16435.83564164355;16661.91669041659;1723.5174151237673;1819.5814962558554;1822.17091223493;1839.6044850357237;1845.0959030075167;111066.88933110646;133007.33496332553;134199;135978.3201083998;136519;11388.259763115371;11883.643490695293;11921.284722916653;12098.153129281041;12187.573434929735;15042.398304067934;15053.322600483005;15074.170920599472;15174.165420901956;15206.262872682802;8464.534450605153;8573.356998225157;8656.67654465135;8673.219410253107;8781.121887811296;8542.615582298811;8588;8685.478871267618;8696;8703.695370662123;4673.672842901033;4677.508861569554;4741.786619602126;4742.715437073786;4783.7129772213775;1747.336012315312;1750.3173762232739;2026.7263919370992;2069.747802579448;2088.7806780288156;925.5557332480313;1032.726327523207;1033.333499892565;1049.150188347441;1075.7418219627389;19426.320078797173;21863.45341366447;22323.218687345863;22323.776762232494;22529;875.4222213339166;922.4142669404977;933.3140141995627;962.9470379129075;964.7298756348234;6042.728077236447;7041.859162816715;7128.073350464407;7258.564486130849;7276.527025743309;462941.68529157137;703680;727811;758626.6875259314;772987;121490.78509214972;133928;153726;158777;163320.18339908225;1012.5241136665755;1029.161233594618;1055.3351388625117;1057.9259451838452;1059.2902755154066;20696.068676909876;20746;21059;21066.578668426853;21106.261280855095;60248.673524904996;61060.69469652623;61746;61848.690756545926;62150;71639.64180179065;83155;86836;90993.54503227441;91144;6983.546069505466;7379.188289288067;7480.850382992201;7664.655090520829;7893.486923349964;12258.693532661755;13471.932640336736;13546.458141674617;13817.480077191702;14008.579742607739;11510.827337589775;11696.532138714356;11873.52505899789;12079.879201207876;12099.879001209874;9612.471314077513;11400.144989126014;11643.708907277385;11673.357965311989;11986.64040078764;11463.885361146615;12007.159498834997;12068;12119.333436660716;12121.575744848888;7651.196624354363;7823.139454659869;7858.803529911798;7904.565248911365;7968.442209045311;10800.729981750519;11866.288022718665;11924.701882453008;11968.042556595277;11979.640610781691 00:39:40 INFO - PROCESS | 1631 | |3;mootools.html;1413.9717205655886;1456.6722487440334;1465.9853401465982;1496.4762333183387;1502.068717395215;7541.773746787591;7772.4947878388;7985.121636619974;8450.91549084509;8451.239388455046;7106.609136497504;8202.794930126749;8224.712135075273;8348;8353.540555269457;2281.863088214708;2329.790318871301;2342.121704360865;2345.3550273674705;2345.566070277004;2201;2303.239930822833;2333.8132949364094;2341.1220792202926;2341.2976107167865;2269.6708977198296;2288.3592594073602;2307.896144673494;2315.6410756332793;2317.5249073939804;2269.341890851651;2272.250157448038;2285;2300.976990230093;2303.055747143663;1770.5131088950513;1951.4731022623812;2171.4354267890462;2259.096361455431;2329.9767002329927;8326.70856520025;8394.160583941619;8402.663893444254;8409.32725381968;8455.74632761018;4466.106778644252;5003.724795136266;5164.896702065976;5170.25031370453;5181.922271165936;3240.368128214999;3254.739620830328;3468.202313467891;3543.1496440854007;3549.964500355015;1077.4828082520435;1195.1394995603152;1196.0969468051564;1228.263042174697;1245.7383949370644;10642.840357394567;10725.981031801966;10727.731806704816;10793.67618971432;10796.5681372745;3494.6155922848466;4390.648748100144;4691.225947718656;4695.366125573004;4712.835050773207;7639.427042971799;9379.718608441757;9382.296327775308;9389.201917837061;9389.248860091177;5176.275321454999;5210.114280572312;5211.765470553834;5218.199721096215;5221.843344699665;4301.5698430156735;4459.0413061192;4557.270836666117;4710.105080034782;4749.430068391746;3792.393217085253;3853.6531712146043;3910.804459777;3937.468441760383;3957.3272543667645;1170.590293397304;1224.7262846639574;1272.923624582528;1292.3279894455018;1300.3303298801125;929.5398777605129;936.2603543200931;939.6883666181134;947.4078700811992;986.127277359542;5376.38171610262;5569.009677001406;5700.01338031306;5725.341585717612;5762.855928601818;566.6571724106939;581.6248519704767;582.6183849578533;584.7310237290809;590.306389991758;3687.649673281034;3740.17716102457;3782.470454136368;3863.2466668999837;3927.489426374553;9313.720588382359;9561.235101191887;9714.271429642664;9721.854172187423;9726.2705297103;9594.42433453981;9678.70963871085;9688.660896868576;9690.12788849007;9704.641350210975;7429.62851857405;7676.309132178131;7757.224277572198;7840.960795196102;7863.567503787232;4775.283707443911;5648.350439699487;5824.825255242349;5858.502027327725;5928.970355148369;7683.116441609063;8755.693550725695;8929.73210803677;9084;9235.953820230856;9118.179363857285;9165.587548560465;9281.02549232321;9290.303227257848;9297.93168254461;6550.934490655223;6746.325367463411;6906.37842594169;7061.399781018466;7170.533915295698;6719.328067193242;7682.577458239851;7852.214778522102;7859.607019649109;7897.170797066455;6059.878802423838;6962.721491140298;7108.573485590674;7142.035825163536;7190;6960.547564408297;6989.720411183495;7043.225245223124;7048.436125110082;7049.647517624201;5104.642675012862;6267.592606480564;6406.935930640634;6414.839629009312;6417.39034791694;4975.527324904128;5026.296318515484;5046.1926091825135;5066.03745288394;5087.465816089258;4883.706977581356;4974.452810190804;5018.222175562793;5130.640855140105;5173.586113110867 00:39:40 INFO - PROCESS | 1631 | |4;prototype.html;329.99999999999994;347.3521881690648;368.86905148672236;370.0877337363399;374.49256257770736;4564.246899261622;5371.892562148755;5489.325755644527;5508.375029366336;5549.639273447223;4608.723476591407;5439.809606663767;5464.644798088121;5503.889922201553;5519.834404967847;3941.5467221269632;4015.9397609035886;4282.764447955361;4296.5273819879785;4305.612494875469;4209.915801683965;4224.091820258644;4225.767582782945;4232.873013809591;4245.702800803945;4230.851920182794;4232.746035237896;4238.364245363205;4253.830546421332;4263.296556068245;3587.802670853102;4061.593840615915;4114.629683328515;4271.039016221356;4277.593628605277;3395.3209358128224;3688.778673279585;3710.239400922804;3735.8879233623034;3777.3578491656485;5328.49379308965;5335.839924802262;5342.706151161685;5357.383900851374;5397.62216644835;4192.287311157111;4565.744420284415;4876.902461950741;4940.493149589373;4945.480724523909;4564.383808185886;5483.1891835174565;5566.805161819317;5657.595521903216;5784.859601947264;4134.607212314825;4146.253674338618;4159.750414975111;4164.208800327928;4186.5604111568455;5388.443627206065;5715.512249665577;6047.15339852421;6061.54538409621;6099.69501524922;3210.181403742031;3897.337452633059;4116.403121547419;4195.825168952698;4239.130978149472;3350.1122202616325;4277.871663850089;4296.21706991595;4335.458067741532;4335.523092459827;4354.755706998307;4375.365571992043;4933.28467372229;4945.307656928033;4961.8511444656715;4750.4900866026865;5131.358580177478;5422.40353561108;5635.746391412396;5759.884802303931;1315.7565850317721;1351.5877657314613;1380.758367285721;1402.6142810726928;1404.6137312239011;941.6092868328763;982.5283863745442;988.3131223799534;1000.0999100809184;1002.6190047781942;4564.97717511417;4872.78072486739;4908.239222920453;5151.0594395287635;5185.974070129625;5488.4785945335125;5974.102560258271;5999.790007349722;6007.939920600826;6033.155358249848;4993.226049962262;5221.399539052982;5438.428964958702;5462.197474833296;5481.519989602785;2508.636247744067;2897.6812550619416;2956.2506868611968;2979.806312589718;2980.552917062458;5314.086928705663;5364.111019510901;5624.521915637135;5820.76716931318;5851.239338885917;4681.344611754357;5249.396319423239;5798.652080875161;5842.38654941225;5851.64890106595;5755.884882302331;5879.911801322984;5911.881762364728;5929.733162007807;5953.970230148908;4781.976090119527;5365.490278423544;5710.5717071219;5718.742656580381;5741.62679425836;5235.214717792209;5419.512243898068;5461.590380721383;5835.2122463466885;5916.49709774674;5556.611037227355;6102.694865256631;6203.410675985774;6203.604189057426;6206.472449841814;3302.6862448067395;3947.585503522089;3952.2848522388863;3964.4251583520804;3992.2813893499447;4827.831025914076;5121.283020377075;5434.2935418395355;5927.8221653350465;5957.497850902545;5298.311219541589;5594.384617692132;5807.303123625023;5832.366937257575;5875.294964604275;5368.543673787772;5443.673379597237;5745.8563535911935;5762.913556296575;5776.862560852512;4630.837920672895;4823.975880120577;5258.843054527998;5657.066584013756;5690.231818704588;4728.834490792806;5187.29971453864;5561.916571251353;5695.857603559778;5899.67551784656;4962.851114466572;5143.61422893277;5359.901220249917;5575.358833734011;5707.773968152507 00:39:40 INFO - PROCESS | 1631 | |5;yui.html;649.8895187818072;702.7888208930779;708.7909066825287;728.8542291541689;822.9218224268694;12851.35743212838;12882.742345153092;14753.778693319595;15773.526794196192;15806.920965395171;14321.925855560849;14435.927820360883;14479.78280325796;14514.709705805877;14526.983111182222;563.7744902039196;681.6693903456819;834.6911642692212;863.7754183912197;872.9432586881865;712.5973824789004;844.5734903873536;863.874738162966;867.8828358171661;878.2841983783228;915.0529202275646;915.3912648089013;927.8608208768705;927.9977624165884;932.067932067932;916.3127654259306;920.7237828651412;922.8938672052733;924.3899026642383;928.8281667891462;686.1354693086747;686.3445409633838;686.6772616870063;688.3151264491812;689.5552368722197;14858.257087145708;14985.700285994328;15022.24888755558;15508.069515829086;15728.134952577604;11843.46704398304;14299.356528956221;14522.273886305642;14527;14587.854121458862;11795.882041179564;11819.881801181964;11874.228175168673;11932.403379830974;12202.633920982296;3727.552693676776;3741.551013878352;3745.2883952049297;3799.164183879542;3897.2984862724697;101365;101948.49025754824;102216.48891755567;102534;103704.48147759288;11107.777844443066;11204;11288.548458061585;11315.547378104948;11383.430828458544;23097.653535196987;23204.883975580015;23683.05267789269;23695.28914132579;23704;7772.805679858049;7806.3364614007305;7833.92166078332;7888.723894663774;7896.447248692536;4246.3842742802735;4304.461942257218;4305.547917468683;4325.329573916048;4325.437693099877;3615;3676.852925882935;3690.391085470921;3704.981475092607;3722.2555488902326;593.0629605223736;598.7426404550409;608.8112685067643;616.9691515424211;620.5966122020723;663.171036204744;663.3896814930275;677.9118714567173;696.5959743348845;696.6377483708544;9582.706334644734;10096.44469554167;10283.9485802572;10429.478526073666;10692.411917344465;613.5245184981675;652.8792173447928;683.4703105093593;697.1738489889395;709.5919846088519;4725.1730947084125;5064.721440320818;5078.542931136216;5088.287639730441;5148.897022059613;89372;94939;109136.90863091426;109212.36181457284;111912.4404377973;95160.91132253698;95487;96036.51981740186;96384.55423168658;96891;83164.58417707872;84952.57523712465;85230.57384713036;86299.56850215835;86977;7267.18320419895;8833.823323533365;9711.174550163316;9806.80386392254;9816.85274720894;40343.596564033985;47127.52872471231;50059.49940500548;50232.74883625558;50294;69643.60712785817;71219;71249.28750712426;71866.56266874739;72386.63806681143;10887;12769.170003949714;13449.663758406117;13468.259245741578;13847.446102155802;11844.230125041844;14925.626859328604;14961.625959351104;15430.691386172439;15776.921115394349;13764.17414955106;13833.377498012413;13898.235597041856;14013.579592612237;14475.420983160555;13741.519046833313;13863.237521936391;13898.861011389758;13983.510577129751;14328.785068224193;13491.730165396833;13722.45110195581;13847.515336963157;14196.574102776933;14211.431542738175;10948.45257737126;10963.50664220096;11060.446977651247;11131.721706957067;11520.94239528797;7615.466917315956;8758.60586273632;10918.344899306067;11165.553377864795;11191.2725672831 00:39:40 INFO - PROCESS | 1631 | __end_tp_report 00:39:40 INFO - PROCESS | 1631 | __start_cc_report 00:39:40 INFO - PROCESS | 1631 | _x_x_mozilla_cycle_collect,390 00:39:40 INFO - PROCESS | 1631 | __end_cc_report 00:39:40 INFO - PROCESS | 1631 | __startTimestamp1484901580703__endTimestamp 00:39:40 INFO - PROCESS | 1631 | 00:39:40 INFO - PROCESS | 1631 | ------- Summary: start ------- 00:39:40 INFO - PROCESS | 1631 | Number of tests: 6 00:39:40 INFO - PROCESS | 1631 | 00:39:40 INFO - PROCESS | 1631 | [#0] dojo.html Cycles:165 Average:5801.52 Median:6063.73 stddev:659.75 (10.9%) stddev-sans-first:625.20 00:39:40 INFO - PROCESS | 1631 | Values: 3040.4 3389.6 3390.2 3391.6 3418.7 5665.2 5714.7 5749.2 5801.2 5822.0 5695.7 5718.1 5752.7 5866.2 5879.3 5145.5 5152.7 5198.9 5294.7 5321.2 4506.9 5181.0 5339.7 5375.6 5389.9 5185.7 5194.1 5279.8 5312.4 5323.2 5193.5 5243.3 5286.2 5303.2 5329.8 5194.8 5198.0 5218.0 5230.0 5257.0 5564.1 5578.9 5656.5 5811.4 5864.5 6143.8 6182.2 6216.7 6241.2 6263.2 6292.1 6296.1 6298.1 6304.8 6311.4 5894.7 5910.9 5926.2 5926.4 6012.5 6173.0 6240.8 6258.2 6271.5 6351.7 6239.4 6249.6 6273.1 6275.8 6285.0 6302.5 6309.3 6312.3 6327.9 6337.1 6141.0 6145.1 6212.3 6235.6 6249.3 6318.2 6323.0 6323.1 6338.4 6345.3 4949.0 5000.5 5003.4 5039.3 5101.9 4434.8 4447.8 4508.3 4539.6 4557.7 5846.0 5920.3 5923.3 5938.7 5955.4 4724.0 6239.9 6296.1 6302.9 6326.6 5755.5 5818.4 5841.2 5909.8 5938.4 5499.8 5504.3 5516.6 5536.0 5574.9 6351.5 6402.9 6416.4 6420.9 6421.7 6272.6 6279.7 6305.2 6314.8 6322.5 6236.6 6262.7 6276.3 6287.2 6324.7 6280.9 6290.2 6301.0 6321.3 6342.0 6163.0 6304.8 6317.7 6322.2 6329.1 6107.2 6110.6 6121.1 6148.8 6247.6 6121.6 6188.3 6203.5 6207.8 6223.8 5838.1 5937.9 6048.3 6063.7 6076.3 6146.6 6220.0 6230.8 6262.2 6264.4 5927.9 5957.1 6012.4 6123.4 6157.9 00:39:40 INFO - PROCESS | 1631 | 00:39:40 INFO - PROCESS | 1631 | [#1] ext.html Cycles:180 Average:68701.85 Median:35515.97 stddev:151182.02 (425.7%) stddev-sans-first:151519.26 00:39:40 INFO - PROCESS | 1631 | Values: 443.6 456.3 511.7 518.6 525.8 32371.0 40244.0 40267.4 40271.0 40301.6 41676.0 42026.0 42130.4 42155.0 42252.6 8434.4 8598.7 9228.7 9454.4 9503.2 8940.3 11410.6 11424.8 11528.8 11553.1 11350.0 11414.8 11417.8 11436.1 11478.9 11271.6 11311.8 11402.0 11406.3 11413.9 11343.9 11406.3 11415.8 11429.9 11432.0 33760.8 38940.6 39378.8 39536.8 39557.8 3967.7 4037.9 4064.9 4101.7 4160.7 28291.9 28577.4 28955.1 28974.4 29010.9 3157.4 3226.0 3240.6 3318.4 3323.8 462993.0 484294.2 487769.0 488998.0 489730.0 55500.7 55540.7 55815.4 55855.4 55985.4 57462.4 57585.7 57632.1 57750.4 57869.4 15387.7 15446.1 15508.9 15522.5 15556.9 10826.8 11084.8 11725.9 11989.8 12102.5 15153.9 17218.7 17333.8 17343.0 17394.8 7698.7 7823.7 7864.2 7921.0 7946.9 864.4 892.3 908.2 917.7 926.9 29509.1 29539.6 29632.1 30255.7 30343.2 1024.9 1069.3 1100.1 1118.8 1168.0 12698.7 15086.3 15394.0 15501.2 15797.4 610814.0 615573.0 616274.0 616578.0 616872.0 52105.7 52719.5 52754.0 52783.0 52849.7 1395.5 1432.8 1453.1 1454.5 1456.8 25238.7 25410.4 25535.7 27163.7 28870.6 36247.6 41326.8 51260.2 51338.2 53702.0 513088.0 603434.0 606966.0 608996.0 611222.0 32087.7 33100.8 38147.4 38811.2 38972.8 39223.4 40033.2 42486.0 42605.0 43132.6 32960.0 35658.5 36225.3 36719.0 36821.0 35249.8 35373.5 36036.8 36192.6 36345.0 34088.1 34117.7 34699.5 35094.6 35330.3 30121.5 31054.0 31104.7 31214.5 31215.2 20327.8 22064.3 23720.8 23779.8 23779.8 00:39:40 INFO - PROCESS | 1631 | 00:39:40 INFO - PROCESS | 1631 | [#2] jquery.html Cycles:180 Average:39077.29 Median:26658.43 stddev:115983.89 (435.1%) stddev-sans-first:116272.87 00:39:40 INFO - PROCESS | 1631 | Values: 386.6 390.9 399.3 405.9 418.7 20224.7 21302.8 21596.9 21619.8 21968.3 21552.7 21756.7 22056.4 22493.9 22498.0 5692.0 6003.1 6011.1 6011.8 6019.3 5801.4 5916.9 5947.3 5991.7 6017.7 5929.3 5939.0 5940.3 5943.2 5955.7 5663.6 5884.8 5914.1 5942.4 5949.1 5230.0 5231.4 5240.7 5246.8 5251.2 26113.9 26502.5 26536.9 26780.0 26823.2 2739.3 2757.3 2760.4 2763.1 2767.5 15445.7 15967.0 15999.9 16435.8 16661.9 1723.5 1819.6 1822.2 1839.6 1845.1 111066.9 133007.3 134199.0 135978.3 136519.0 11388.3 11883.6 11921.3 12098.2 12187.6 15042.4 15053.3 15074.2 15174.2 15206.3 8464.5 8573.4 8656.7 8673.2 8781.1 8542.6 8588.0 8685.5 8696.0 8703.7 4673.7 4677.5 4741.8 4742.7 4783.7 1747.3 1750.3 2026.7 2069.7 2088.8 925.6 1032.7 1033.3 1049.2 1075.7 19426.3 21863.5 22323.2 22323.8 22529.0 875.4 922.4 933.3 962.9 964.7 6042.7 7041.9 7128.1 7258.6 7276.5 462941.7 703680.0 727811.0 758626.7 772987.0 121490.8 133928.0 153726.0 158777.0 163320.2 1012.5 1029.2 1055.3 1057.9 1059.3 20696.1 20746.0 21059.0 21066.6 21106.3 60248.7 61060.7 61746.0 61848.7 62150.0 71639.6 83155.0 86836.0 90993.5 91144.0 6983.5 7379.2 7480.9 7664.7 7893.5 12258.7 13471.9 13546.5 13817.5 14008.6 11510.8 11696.5 11873.5 12079.9 12099.9 9612.5 11400.1 11643.7 11673.4 11986.6 11463.9 12007.2 12068.0 12119.3 12121.6 7651.2 7823.1 7858.8 7904.6 7968.4 10800.7 11866.3 11924.7 11968.0 11979.6 00:39:40 INFO - PROCESS | 1631 | 00:39:40 INFO - PROCESS | 1631 | [#3] mootools.html Cycles:180 Average:5335.10 Median:5220.02 stddev:2896.44 (55.5%) stddev-sans-first:2889.58 00:39:40 INFO - PROCESS | 1631 | Values: 1414.0 1456.7 1466.0 1496.5 1502.1 7541.8 7772.5 7985.1 8450.9 8451.2 7106.6 8202.8 8224.7 8348.0 8353.5 2281.9 2329.8 2342.1 2345.4 2345.6 2201.0 2303.2 2333.8 2341.1 2341.3 2269.7 2288.4 2307.9 2315.6 2317.5 2269.3 2272.3 2285.0 2301.0 2303.1 1770.5 1951.5 2171.4 2259.1 2330.0 8326.7 8394.2 8402.7 8409.3 8455.7 4466.1 5003.7 5164.9 5170.3 5181.9 3240.4 3254.7 3468.2 3543.1 3550.0 1077.5 1195.1 1196.1 1228.3 1245.7 10642.8 10726.0 10727.7 10793.7 10796.6 3494.6 4390.6 4691.2 4695.4 4712.8 7639.4 9379.7 9382.3 9389.2 9389.2 5176.3 5210.1 5211.8 5218.2 5221.8 4301.6 4459.0 4557.3 4710.1 4749.4 3792.4 3853.7 3910.8 3937.5 3957.3 1170.6 1224.7 1272.9 1292.3 1300.3 929.5 936.3 939.7 947.4 986.1 5376.4 5569.0 5700.0 5725.3 5762.9 566.7 581.6 582.6 584.7 590.3 3687.6 3740.2 3782.5 3863.2 3927.5 9313.7 9561.2 9714.3 9721.9 9726.3 9594.4 9678.7 9688.7 9690.1 9704.6 7429.6 7676.3 7757.2 7841.0 7863.6 4775.3 5648.4 5824.8 5858.5 5929.0 7683.1 8755.7 8929.7 9084.0 9236.0 9118.2 9165.6 9281.0 9290.3 9297.9 6550.9 6746.3 6906.4 7061.4 7170.5 6719.3 7682.6 7852.2 7859.6 7897.2 6059.9 6962.7 7108.6 7142.0 7190.0 6960.5 6989.7 7043.2 7048.4 7049.6 5104.6 6267.6 6406.9 6414.8 6417.4 4975.5 5026.3 5046.2 5066.0 5087.5 4883.7 4974.5 5018.2 5130.6 5173.6 00:39:40 INFO - PROCESS | 1631 | 00:39:40 INFO - PROCESS | 1631 | [#4] prototype.html Cycles:180 Average:4636.57 Median:5168.52 stddev:1385.45 (26.8%) stddev-sans-first:1351.10 00:39:40 INFO - PROCESS | 1631 | Values: 330.0 347.4 368.9 370.1 374.5 4564.2 5371.9 5489.3 5508.4 5549.6 4608.7 5439.8 5464.6 5503.9 5519.8 3941.5 4015.9 4282.8 4296.5 4305.6 4209.9 4224.1 4225.8 4232.9 4245.7 4230.9 4232.7 4238.4 4253.8 4263.3 3587.8 4061.6 4114.6 4271.0 4277.6 3395.3 3688.8 3710.2 3735.9 3777.4 5328.5 5335.8 5342.7 5357.4 5397.6 4192.3 4565.7 4876.9 4940.5 4945.5 4564.4 5483.2 5566.8 5657.6 5784.9 4134.6 4146.3 4159.8 4164.2 4186.6 5388.4 5715.5 6047.2 6061.5 6099.7 3210.2 3897.3 4116.4 4195.8 4239.1 3350.1 4277.9 4296.2 4335.5 4335.5 4354.8 4375.4 4933.3 4945.3 4961.9 4750.5 5131.4 5422.4 5635.7 5759.9 1315.8 1351.6 1380.8 1402.6 1404.6 941.6 982.5 988.3 1000.1 1002.6 4565.0 4872.8 4908.2 5151.1 5186.0 5488.5 5974.1 5999.8 6007.9 6033.2 4993.2 5221.4 5438.4 5462.2 5481.5 2508.6 2897.7 2956.3 2979.8 2980.6 5314.1 5364.1 5624.5 5820.8 5851.2 4681.3 5249.4 5798.7 5842.4 5851.6 5755.9 5879.9 5911.9 5929.7 5954.0 4782.0 5365.5 5710.6 5718.7 5741.6 5235.2 5419.5 5461.6 5835.2 5916.5 5556.6 6102.7 6203.4 6203.6 6206.5 3302.7 3947.6 3952.3 3964.4 3992.3 4827.8 5121.3 5434.3 5927.8 5957.5 5298.3 5594.4 5807.3 5832.4 5875.3 5368.5 5443.7 5745.9 5762.9 5776.9 4630.8 4824.0 5258.8 5657.1 5690.2 4728.8 5187.3 5561.9 5695.9 5899.7 4962.9 5143.6 5359.9 5575.4 5707.8 00:39:40 INFO - PROCESS | 1631 | 00:39:40 INFO - PROCESS | 1631 | [#5] yui.html Cycles:180 Average:20869.46 Median:22294.99 stddev:30135.99 (135.2%) stddev-sans-first:30182.29 00:39:40 INFO - PROCESS | 1631 | Values: 649.9 702.8 708.8 728.9 822.9 12851.4 12882.7 14753.8 15773.5 15806.9 14321.9 14435.9 14479.8 14514.7 14527.0 563.8 681.7 834.7 863.8 872.9 712.6 844.6 863.9 867.9 878.3 915.1 915.4 927.9 928.0 932.1 916.3 920.7 922.9 924.4 928.8 686.1 686.3 686.7 688.3 689.6 14858.3 14985.7 15022.2 15508.1 15728.1 11843.5 14299.4 14522.3 14527.0 14587.9 11795.9 11819.9 11874.2 11932.4 12202.6 3727.6 3741.6 3745.3 3799.2 3897.3 101365.0 101948.5 102216.5 102534.0 103704.5 11107.8 11204.0 11288.5 11315.5 11383.4 23097.7 23204.9 23683.1 23695.3 23704.0 7772.8 7806.3 7833.9 7888.7 7896.4 4246.4 4304.5 4305.5 4325.3 4325.4 3615.0 3676.9 3690.4 3705.0 3722.3 593.1 598.7 608.8 617.0 620.6 663.2 663.4 677.9 696.6 696.6 9582.7 10096.4 10283.9 10429.5 10692.4 613.5 652.9 683.5 697.2 709.6 4725.2 5064.7 5078.5 5088.3 5148.9 89372.0 94939.0 109136.9 109212.4 111912.4 95160.9 95487.0 96036.5 96384.6 96891.0 83164.6 84952.6 85230.6 86299.6 86977.0 7267.2 8833.8 9711.2 9806.8 9816.9 40343.6 47127.5 50059.5 50232.7 50294.0 69643.6 71219.0 71249.3 71866.6 72386.6 10887.0 12769.2 13449.7 13468.3 13847.4 11844.2 14925.6 14961.6 15430.7 15776.9 13764.2 13833.4 13898.2 14013.6 14475.4 13741.5 13863.2 13898.9 13983.5 14328.8 13491.7 13722.5 13847.5 14196.6 14211.4 10948.5 10963.5 11060.4 11131.7 11520.9 7615.5 8758.6 10918.3 11165.6 11191.3 00:39:40 INFO - PROCESS | 1631 | -------- Summary: end -------- 00:39:40 INFO - PROCESS | 1631 | 00:39:41 INFO - TEST-INFO | 1631: exit 0 00:39:41 INFO - TEST-OK | dromaeo_css | took 1115891ms 00:39:41 INFO - TEST-START | kraken 00:39:41 INFO - operating with platform_type : mac_ 00:39:41 INFO - Initialising browser for kraken test... 00:39:41 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpjdBsao/profile http://localhost:49235/getInfo.html) 00:39:43 INFO - PROCESS | 1643 | 2017-01-20 00:39:43.920 plugin-container[1644:9847] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 00:39:43 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:39:43 INFO - PROCESS | 1643 | 2017-01-20 00:39:43.923 plugin-container[1644:9847] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 00:39:43 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:39:43 INFO - PROCESS | 1643 | 2017-01-20 00:39:43.923 plugin-container[1644:9847] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:39:43 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 00:39:43 INFO - PROCESS | 1643 | colorDepth:24 00:39:43 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 00:39:43 INFO - PROCESS | 1643 | __metrics 00:39:44 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 00:39:44 INFO - TEST-INFO | 1643: exit 0 00:39:44 INFO - Browser initialized. 00:39:44 INFO - Running cycle 1/1 for kraken test... 00:39:44 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpjdBsao/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:39:47 INFO - PROCESS | 1645 | 2017-01-20 00:39:47.204 plugin-container[1646:9962] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 00:39:47 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:39:47 INFO - PROCESS | 1645 | 2017-01-20 00:39:47.205 plugin-container[1646:9962] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 00:39:47 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:39:47 INFO - PROCESS | 1645 | 2017-01-20 00:39:47.205 plugin-container[1646:9962] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:39:56 INFO - PROCESS | 1645 | RSS: Main: 232361984 00:39:56 INFO - PROCESS | 1645 | 00:39:59 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 00:40:00 INFO - PROCESS | 1645 | RSS: Main: 245874688 00:40:00 INFO - PROCESS | 1645 | 00:40:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 00:40:04 INFO - PROCESS | 1645 | RSS: Main: 253906944 00:40:04 INFO - PROCESS | 1645 | 00:40:07 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 00:40:08 INFO - PROCESS | 1645 | RSS: Main: 256647168 00:40:08 INFO - PROCESS | 1645 | 00:40:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 00:40:10 INFO - PROCESS | 1645 | RSS: Main: 257728512 00:40:10 INFO - PROCESS | 1645 | 00:40:12 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:40:13 INFO - PROCESS | 1645 | RSS: Main: 258310144 00:40:13 INFO - PROCESS | 1645 | 00:40:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 00:40:16 INFO - PROCESS | 1645 | RSS: Main: 265572352 00:40:16 INFO - PROCESS | 1645 | 00:40:20 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 00:40:20 INFO - PROCESS | 1645 | RSS: Main: 264413184 00:40:20 INFO - PROCESS | 1645 | 00:40:23 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 00:40:24 INFO - PROCESS | 1645 | RSS: Main: 264503296 00:40:24 INFO - PROCESS | 1645 | 00:40:25 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:40:26 INFO - PROCESS | 1645 | RSS: Main: 264388608 00:40:26 INFO - PROCESS | 1645 | 00:40:28 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:40:29 INFO - PROCESS | 1645 | RSS: Main: 264019968 00:40:29 INFO - PROCESS | 1645 | 00:40:31 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:40:32 INFO - PROCESS | 1645 | RSS: Main: 264060928 00:40:32 INFO - PROCESS | 1645 | 00:40:34 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:40:35 INFO - PROCESS | 1645 | RSS: Main: 264409088 00:40:35 INFO - PROCESS | 1645 | 00:40:38 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:40:39 INFO - PROCESS | 1645 | RSS: Main: 264433664 00:40:39 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 00:40:41 INFO - PROCESS | 1645 | RSS: Main: 266481664 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | __start_tp_report 00:40:41 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 00:40:41 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 00:40:41 INFO - PROCESS | 1645 | |i|pagename|runs| 00:40:41 INFO - PROCESS | 1645 | |0;ai-astar;107;117;119;117;118;119;118;118;118;119 00:40:41 INFO - PROCESS | 1645 | |1;audio-beat-detection;146;114;129;135;139;144;143;114;132;115 00:40:41 INFO - PROCESS | 1645 | |2;audio-dft;204;206;206;200;193;198;200;198;203;175 00:40:41 INFO - PROCESS | 1645 | |3;audio-fft;80;58;68;94;58;73;84;52;73;76 00:40:41 INFO - PROCESS | 1645 | |4;audio-oscillator;89;71;103;58;71;85;116;85;56;68 00:40:41 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;90;87;89;88;90;108;128;132;91;131 00:40:41 INFO - PROCESS | 1645 | |6;imaging-darkroom;96;96;92;144;95;111;152;94;151;151 00:40:41 INFO - PROCESS | 1645 | |7;imaging-desaturate;74;143;132;92;128;113;93;94;93;91 00:40:41 INFO - PROCESS | 1645 | |8;json-parse-financial;61;62;61;64;61;61;63;63;62;60 00:40:41 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;68;74;97;84;69;80;102;60;86;104 00:40:41 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;86;90;89;91;89;89;87;90;89;95 00:40:41 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;152;159;158;141;141;139;141;137;171;160 00:40:41 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;178;243;182;244;176;225;239;200;176;176 00:40:41 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;59;80;88;67;59;57;84;89;88;88 00:40:41 INFO - PROCESS | 1645 | __end_tp_report 00:40:41 INFO - PROCESS | 1645 | __start_cc_report 00:40:41 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,915 00:40:41 INFO - PROCESS | 1645 | __end_cc_report 00:40:41 INFO - PROCESS | 1645 | __startTimestamp1484901641678__endTimestamp 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | ------- Summary: start ------- 00:40:41 INFO - PROCESS | 1645 | Number of tests: 14 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:117.00 Median:118.00 stddev:3.59 (3.0%) stddev-sans-first:0.78 00:40:41 INFO - PROCESS | 1645 | Values: 107.0 117.0 119.0 117.0 118.0 119.0 118.0 118.0 118.0 119.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:137.00 stddev:12.72 (9.3%) stddev-sans-first:12.30 00:40:41 INFO - PROCESS | 1645 | Values: 146.0 114.0 129.0 135.0 139.0 144.0 143.0 114.0 132.0 115.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:198.30 Median:201.50 stddev:9.13 (4.5%) stddev-sans-first:9.45 00:40:41 INFO - PROCESS | 1645 | Values: 204.0 206.0 206.0 200.0 193.0 198.0 200.0 198.0 203.0 175.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:71.60 Median:74.50 stddev:12.98 (17.4%) stddev-sans-first:13.41 00:40:41 INFO - PROCESS | 1645 | Values: 80.0 58.0 68.0 94.0 58.0 73.0 84.0 52.0 73.0 76.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:71.00 stddev:19.21 (27.1%) stddev-sans-first:20.11 00:40:41 INFO - PROCESS | 1645 | Values: 89.0 71.0 103.0 58.0 71.0 85.0 116.0 85.0 56.0 68.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:103.40 Median:88.50 stddev:19.53 (22.1%) stddev-sans-first:20.10 00:40:41 INFO - PROCESS | 1645 | Values: 90.0 87.0 89.0 88.0 90.0 108.0 128.0 132.0 91.0 131.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:118.20 Median:93.00 stddev:27.50 (29.6%) stddev-sans-first:27.97 00:40:41 INFO - PROCESS | 1645 | Values: 96.0 96.0 92.0 144.0 95.0 111.0 152.0 94.0 151.0 151.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:105.30 Median:91.50 stddev:22.36 (24.4%) stddev-sans-first:20.65 00:40:41 INFO - PROCESS | 1645 | Values: 74.0 143.0 132.0 92.0 128.0 113.0 93.0 94.0 93.0 91.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:1.23 (2.0%) stddev-sans-first:1.27 00:40:41 INFO - PROCESS | 1645 | Values: 61.0 62.0 61.0 64.0 61.0 61.0 63.0 63.0 62.0 60.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:82.40 Median:77.00 stddev:15.07 (19.6%) stddev-sans-first:15.06 00:40:41 INFO - PROCESS | 1645 | Values: 68.0 74.0 97.0 84.0 69.0 80.0 102.0 60.0 86.0 104.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:89.50 stddev:2.42 (2.7%) stddev-sans-first:2.20 00:40:41 INFO - PROCESS | 1645 | Values: 86.0 90.0 89.0 91.0 89.0 89.0 87.0 90.0 89.0 95.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:155.00 stddev:11.66 (7.5%) stddev-sans-first:12.34 00:40:41 INFO - PROCESS | 1645 | Values: 152.0 159.0 158.0 141.0 141.0 139.0 141.0 137.0 171.0 160.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:203.90 Median:212.50 stddev:30.40 (14.3%) stddev-sans-first:30.76 00:40:41 INFO - PROCESS | 1645 | Values: 178.0 243.0 182.0 244.0 176.0 225.0 239.0 200.0 176.0 176.0 00:40:41 INFO - PROCESS | 1645 | 00:40:41 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:86.00 stddev:13.75 (16.0%) stddev-sans-first:13.15 00:40:41 INFO - PROCESS | 1645 | Values: 59.0 80.0 88.0 67.0 59.0 57.0 84.0 89.0 88.0 88.0 00:40:41 INFO - PROCESS | 1645 | -------- Summary: end -------- 00:40:41 INFO - PROCESS | 1645 | 00:40:42 INFO - TEST-INFO | 1645: exit 0 00:40:42 INFO - TEST-OK | kraken | took 61254ms 00:40:42 INFO - SUITE-END | took 1177s 00:40:42 INFO - Completed test suite (00:19:37) 00:40:42 INFO - javascript benchmark 00:40:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7335.637073439411, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.391921615677, 3389.6101948275955, 3390.169408494919, 3391.6269210386863, 3418.7265018798466, 5665.1502274658715, 5714.71426428679, 5749.166370876221, 5801.187833703285, 5822.010258256096, 5695.686737229451, 5718.056520674084, 5752.683602401867, 5866.178734977107, 5879.323877754059, 5145.536901678848, 5152.716600586966, 5198.948010519903, 5294.655847369928, 5321.175217841222, 4506.864794056167, 5180.989707007135, 5339.733013349336, 5375.596830237729, 5389.868127693189, 5185.740712964374, 5194.142966410538, 5279.841604751864, 5312.362516498045, 5323.22813192087, 5193.532582067594, 5243.292155558989, 5286.154215325568, 5303.204519322094, 5329.786808527654, 5194.792208311663, 5198.038362902837, 5217.973910130425, 5230.032443997872, 5256.974889896472, 5564.081926482126, 5578.940001399762, 5656.519195868356, 5811.360750317462, 5864.530837532987, 6143.757528502109, 6182.196314479134, 6216.658083805389, 6241.157443745082, 6263.24841019076, 6292.087647291117, 6296.118543403927, 6298.149749783812, 6304.810855674291, 6311.368863113652, 5894.734736936848, 5910.940890591125, 5926.229590153295, 5926.377730338339, 6012.549058820518, 6173.043178307369, 6240.843978900564, 6258.186435763413, 6271.529635277372, 6351.71417286214, 6239.438450539473, 6249.562530622904, 6273.0904018917, 6275.780347687901, 6284.968575157186, 6302.464290535264, 6309.337519560472, 6312.274088479791, 6327.936720632735, 6337.112804207414, 6140.964409184426, 6145.0782382642965, 6212.347703491158, 6235.594686345373, 6249.34381889895, 6318.241810982711, 6322.968385158045, 6323.114763933053, 6338.397852204033, 6345.302016778151, 4949.010197960422, 5000.549950504472, 5003.449620541737, 5039.319691841554, 5101.928594995018, 4434.82260709568, 4447.822087116479, 4508.346289787963, 4539.614132798749, 4557.680962332605, 5845.9707701462075, 5920.259967504062, 5923.289205295392, 5938.703064846827, 5955.404459554096, 4723.976380118146, 6239.937600624026, 6296.087067375296, 6302.905456418157, 6326.557141000086, 5755.510781583528, 5818.418158184148, 5841.211436456109, 5909.793157239476, 5938.435848594377, 5499.752511137009, 5504.339479262434, 5516.641418307797, 5536.031194541019, 5574.9163762542785, 6351.491880649629, 6402.935970640234, 6416.390442907917, 6420.903686444707, 6421.743130274736, 6272.560920735505, 6279.686015699288, 6305.243370795534, 6314.842128946813, 6322.525810564134, 6236.594621349598, 6262.68686565679, 6276.278228003838, 6287.182666253358, 6324.7153878076515, 6280.905786413116, 6290.24517057956, 6301.023341382093, 6321.304656487875, 6342.048692696132, 6162.9522981094215, 6304.810855674337, 6317.684115794284, 6322.241331040304, 6329.145565348619, 6107.158472117242, 6110.602810817282, 6121.081837724377, 6148.831721972811, 6247.562670613195, 6121.60540247106, 6188.257409110935, 6203.47270481996, 6207.751689932533, 6223.813285601439, 5838.065909454637, 5937.881242375215, 6048.274207095177, 6063.72713227897, 6076.331603523698, 6146.6170111724505, 6220.03589443637, 6230.813075607739, 6262.248530176225, 6264.404881536247, 5927.911081333869, 5957.106434034929, 6012.398760123952, 6123.418275263843, 6157.9384206157365], "value": 5758.389740923965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.5697373547659, 456.3064142503393, 511.66230288009876, 518.5954955134996, 525.8291055406994, 32371.0, 40244.0, 40267.39598906019, 40271.0, 40301.59698403015, 41676.0, 42026.0, 42130.36804447936, 42155.0, 42252.57747422525, 8434.40959132861, 8598.742037738846, 9228.723138305828, 9454.385464944757, 9503.192228660571, 8940.329475289347, 11410.600628977987, 11424.828627570592, 11528.827067593993, 11553.133514986368, 11350.035247004014, 11414.771704565903, 11417.771644567103, 11436.142289328292, 11478.942605286962, 11271.605493807678, 11311.830322545127, 11402.0, 11406.31562106268, 11413.885861141449, 11343.886561134448, 11406.258593191416, 11415.828762568568, 11429.942850285779, 11432.028277596415, 33760.83119584411, 38940.63707770243, 39378.80310598428, 39536.80231598853, 39557.813265602075, 3967.7222594418404, 4037.858674946392, 4064.9390259146135, 4101.651359634435, 4160.7087503874745, 28291.858540707166, 28577.428451431064, 28955.13134605965, 28974.42051158965, 29010.854945725136, 3157.36852629475, 3225.951610725841, 3240.643529211785, 3318.4192766265805, 3323.8171900545462, 462993.0, 484294.15705842845, 487769.0, 488998.0, 489730.0, 55500.722496388065, 55540.72229638826, 55815.44184558102, 55855.44144558503, 55985.44014559884, 57462.42537574654, 57585.712071439375, 57632.13551796726, 57750.42249577535, 57869.4213057864, 15387.692246155015, 15446.065247602919, 15508.906297649673, 15522.5343239703, 15556.922215389077, 10826.837597436044, 11084.778304433867, 11725.882741172649, 11989.76020479603, 12102.455389507493, 15153.924230378998, 17218.655626887394, 17333.826661733474, 17342.959422434444, 17394.82605173932, 7698.653560589787, 7823.726169584037, 7864.174261702553, 7921.049474063034, 7946.920530794734, 864.386285737121, 892.3084609427746, 908.2325435007408, 917.7200953709049, 926.8517037274004, 29509.114726558237, 29539.556906646416, 29632.111036668935, 30255.69744302573, 30343.241418964262, 1024.8718910136233, 1069.342354452022, 1100.1254003067581, 1118.8321751737142, 1167.96496105117, 12698.682532936566, 15086.321115549606, 15394.0, 15501.224938753017, 15797.36810527589, 610814.0, 615573.0, 616274.0, 616578.0, 616872.0, 52105.739471302404, 52719.47280527222, 52754.0, 52783.0, 52849.735751321, 1395.483671041721, 1432.8352239492592, 1453.14264583896, 1454.4909281751302, 1456.788765628978, 25238.747612524374, 25410.364740880887, 25535.744642553338, 27163.72836271612, 28870.566941496316, 36247.63752362443, 41326.79336603298, 51260.23109653433, 51338.22992655188, 53702.0, 513088.0, 603434.0, 606966.0, 608996.0, 611222.0, 32087.67912320847, 33100.83449582833, 38147.42778858264, 38811.22377552489, 38972.80513597414, 39223.41164882472, 40033.199336012534, 42486.0, 42605.0, 43132.56867431285, 32960.0, 35658.46512302266, 36225.27549448943, 36719.0, 36821.0, 35249.82375088108, 35373.46939795957, 36036.81981590075, 36192.638073618924, 36345.0, 34088.14779630529, 34117.658823411446, 34699.4795078069, 35094.64905351016, 35330.29339413146, 30121.548176777804, 31054.0, 31104.667149963392, 31214.531782023743, 31215.190632843154, 20327.780333180057, 22064.33806985793, 23720.779382781144, 23779.762202377755, 23779.762202378446], "value": 19755.205579146652, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.5979381443301, 390.9198614284072, 399.301222859995, 405.9086705491265, 418.7341038440591, 20224.69662955055, 21302.786972130274, 21596.920153992298, 21619.81091039994, 21968.340949771493, 21552.676709849326, 21756.673649895263, 22056.44858878529, 22493.887530562366, 22498.0, 5691.971540142294, 6003.099535069753, 6011.1283863839935, 6011.789587364421, 6019.337872833985, 5801.390853960336, 5916.940830591703, 5947.316058653245, 5991.670458124801, 6017.669028203447, 5929.288485381739, 5939.020061689837, 5940.257467816523, 5943.227380440537, 5955.672438015908, 5663.603547751639, 5884.7940322088525, 5914.142449344842, 5942.405759424067, 5949.077892926603, 5229.980153869997, 5231.372235331784, 5240.659357141812, 5246.81636142737, 5251.212318152269, 26113.869430652914, 26502.46995060088, 26536.86731566349, 26780.0, 26823.195304140907, 2739.342557786117, 2757.2968892932377, 2760.406512599801, 2763.06055940979, 2767.488014717284, 15445.691086178325, 15967.0, 15999.92000040004, 16435.83564164355, 16661.91669041659, 1723.5174151237673, 1819.5814962558554, 1822.17091223493, 1839.6044850357237, 1845.0959030075167, 111066.88933110646, 133007.33496332553, 134199.0, 135978.3201083998, 136519.0, 11388.259763115371, 11883.643490695293, 11921.284722916653, 12098.153129281041, 12187.573434929735, 15042.398304067934, 15053.322600483005, 15074.170920599472, 15174.165420901956, 15206.262872682802, 8464.534450605153, 8573.356998225157, 8656.67654465135, 8673.219410253107, 8781.121887811296, 8542.615582298811, 8588.0, 8685.478871267618, 8696.0, 8703.695370662123, 4673.672842901033, 4677.508861569554, 4741.786619602126, 4742.715437073786, 4783.7129772213775, 1747.336012315312, 1750.3173762232739, 2026.7263919370992, 2069.747802579448, 2088.7806780288156, 925.5557332480313, 1032.726327523207, 1033.333499892565, 1049.150188347441, 1075.7418219627389, 19426.320078797173, 21863.45341366447, 22323.218687345863, 22323.776762232494, 22529.0, 875.4222213339166, 922.4142669404977, 933.3140141995627, 962.9470379129075, 964.7298756348234, 6042.728077236447, 7041.859162816715, 7128.073350464407, 7258.564486130849, 7276.527025743309, 462941.68529157137, 703680.0, 727811.0, 758626.6875259314, 772987.0, 121490.78509214972, 133928.0, 153726.0, 158777.0, 163320.18339908225, 1012.5241136665755, 1029.161233594618, 1055.3351388625117, 1057.9259451838452, 1059.2902755154066, 20696.068676909876, 20746.0, 21059.0, 21066.578668426853, 21106.261280855095, 60248.673524904996, 61060.69469652623, 61746.0, 61848.690756545926, 62150.0, 71639.64180179065, 83155.0, 86836.0, 90993.54503227441, 91144.0, 6983.546069505466, 7379.188289288067, 7480.850382992201, 7664.655090520829, 7893.486923349964, 12258.693532661755, 13471.932640336736, 13546.458141674617, 13817.480077191702, 14008.579742607739, 11510.827337589775, 11696.532138714356, 11873.52505899789, 12079.879201207876, 12099.879001209874, 9612.471314077513, 11400.144989126014, 11643.708907277385, 11673.357965311989, 11986.64040078764, 11463.885361146615, 12007.159498834997, 12068.0, 12119.333436660716, 12121.575744848888, 7651.196624354363, 7823.139454659869, 7858.803529911798, 7904.565248911365, 7968.442209045311, 10800.729981750519, 11866.288022718665, 11924.701882453008, 11968.042556595277, 11979.640610781691], "value": 10001.024557881063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.9717205655886, 1456.6722487440334, 1465.9853401465982, 1496.4762333183387, 1502.068717395215, 7541.773746787591, 7772.4947878388, 7985.121636619974, 8450.91549084509, 8451.239388455046, 7106.609136497504, 8202.794930126749, 8224.712135075273, 8348.0, 8353.540555269457, 2281.863088214708, 2329.790318871301, 2342.121704360865, 2345.3550273674705, 2345.566070277004, 2201.0, 2303.239930822833, 2333.8132949364094, 2341.1220792202926, 2341.2976107167865, 2269.6708977198296, 2288.3592594073602, 2307.896144673494, 2315.6410756332793, 2317.5249073939804, 2269.341890851651, 2272.250157448038, 2285.0, 2300.976990230093, 2303.055747143663, 1770.5131088950513, 1951.4731022623812, 2171.4354267890462, 2259.096361455431, 2329.9767002329927, 8326.70856520025, 8394.160583941619, 8402.663893444254, 8409.32725381968, 8455.74632761018, 4466.106778644252, 5003.724795136266, 5164.896702065976, 5170.25031370453, 5181.922271165936, 3240.368128214999, 3254.739620830328, 3468.202313467891, 3543.1496440854007, 3549.964500355015, 1077.4828082520435, 1195.1394995603152, 1196.0969468051564, 1228.263042174697, 1245.7383949370644, 10642.840357394567, 10725.981031801966, 10727.731806704816, 10793.67618971432, 10796.5681372745, 3494.6155922848466, 4390.648748100144, 4691.225947718656, 4695.366125573004, 4712.835050773207, 7639.427042971799, 9379.718608441757, 9382.296327775308, 9389.201917837061, 9389.248860091177, 5176.275321454999, 5210.114280572312, 5211.765470553834, 5218.199721096215, 5221.843344699665, 4301.5698430156735, 4459.0413061192, 4557.270836666117, 4710.105080034782, 4749.430068391746, 3792.393217085253, 3853.6531712146043, 3910.804459777, 3937.468441760383, 3957.3272543667645, 1170.590293397304, 1224.7262846639574, 1272.923624582528, 1292.3279894455018, 1300.3303298801125, 929.5398777605129, 936.2603543200931, 939.6883666181134, 947.4078700811992, 986.127277359542, 5376.38171610262, 5569.009677001406, 5700.01338031306, 5725.341585717612, 5762.855928601818, 566.6571724106939, 581.6248519704767, 582.6183849578533, 584.7310237290809, 590.306389991758, 3687.649673281034, 3740.17716102457, 3782.470454136368, 3863.2466668999837, 3927.489426374553, 9313.720588382359, 9561.235101191887, 9714.271429642664, 9721.854172187423, 9726.2705297103, 9594.42433453981, 9678.70963871085, 9688.660896868576, 9690.12788849007, 9704.641350210975, 7429.62851857405, 7676.309132178131, 7757.224277572198, 7840.960795196102, 7863.567503787232, 4775.283707443911, 5648.350439699487, 5824.825255242349, 5858.502027327725, 5928.970355148369, 7683.116441609063, 8755.693550725695, 8929.73210803677, 9084.0, 9235.953820230856, 9118.179363857285, 9165.587548560465, 9281.02549232321, 9290.303227257848, 9297.93168254461, 6550.934490655223, 6746.325367463411, 6906.37842594169, 7061.399781018466, 7170.533915295698, 6719.328067193242, 7682.577458239851, 7852.214778522102, 7859.607019649109, 7897.170797066455, 6059.878802423838, 6962.721491140298, 7108.573485590674, 7142.035825163536, 7190.0, 6960.547564408297, 6989.720411183495, 7043.225245223124, 7048.436125110082, 7049.647517624201, 5104.642675012862, 6267.592606480564, 6406.935930640634, 6414.839629009312, 6417.39034791694, 4975.527324904128, 5026.296318515484, 5046.1926091825135, 5066.03745288394, 5087.465816089258, 4883.706977581356, 4974.452810190804, 5018.222175562793, 5130.640855140105, 5173.586113110867], "value": 4312.781417384281, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.99999999999994, 347.3521881690648, 368.86905148672236, 370.0877337363399, 374.49256257770736, 4564.246899261622, 5371.892562148755, 5489.325755644527, 5508.375029366336, 5549.639273447223, 4608.723476591407, 5439.809606663767, 5464.644798088121, 5503.889922201553, 5519.834404967847, 3941.5467221269632, 4015.9397609035886, 4282.764447955361, 4296.5273819879785, 4305.612494875469, 4209.915801683965, 4224.091820258644, 4225.767582782945, 4232.873013809591, 4245.702800803945, 4230.851920182794, 4232.746035237896, 4238.364245363205, 4253.830546421332, 4263.296556068245, 3587.802670853102, 4061.593840615915, 4114.629683328515, 4271.039016221356, 4277.593628605277, 3395.3209358128224, 3688.778673279585, 3710.239400922804, 3735.8879233623034, 3777.3578491656485, 5328.49379308965, 5335.839924802262, 5342.706151161685, 5357.383900851374, 5397.62216644835, 4192.287311157111, 4565.744420284415, 4876.902461950741, 4940.493149589373, 4945.480724523909, 4564.383808185886, 5483.1891835174565, 5566.805161819317, 5657.595521903216, 5784.859601947264, 4134.607212314825, 4146.253674338618, 4159.750414975111, 4164.208800327928, 4186.5604111568455, 5388.443627206065, 5715.512249665577, 6047.15339852421, 6061.54538409621, 6099.69501524922, 3210.181403742031, 3897.337452633059, 4116.403121547419, 4195.825168952698, 4239.130978149472, 3350.1122202616325, 4277.871663850089, 4296.21706991595, 4335.458067741532, 4335.523092459827, 4354.755706998307, 4375.365571992043, 4933.28467372229, 4945.307656928033, 4961.8511444656715, 4750.4900866026865, 5131.358580177478, 5422.40353561108, 5635.746391412396, 5759.884802303931, 1315.7565850317721, 1351.5877657314613, 1380.758367285721, 1402.6142810726928, 1404.6137312239011, 941.6092868328763, 982.5283863745442, 988.3131223799534, 1000.0999100809184, 1002.6190047781942, 4564.97717511417, 4872.78072486739, 4908.239222920453, 5151.0594395287635, 5185.974070129625, 5488.4785945335125, 5974.102560258271, 5999.790007349722, 6007.939920600826, 6033.155358249848, 4993.226049962262, 5221.399539052982, 5438.428964958702, 5462.197474833296, 5481.519989602785, 2508.636247744067, 2897.6812550619416, 2956.2506868611968, 2979.806312589718, 2980.552917062458, 5314.086928705663, 5364.111019510901, 5624.521915637135, 5820.76716931318, 5851.239338885917, 4681.344611754357, 5249.396319423239, 5798.652080875161, 5842.38654941225, 5851.64890106595, 5755.884882302331, 5879.911801322984, 5911.881762364728, 5929.733162007807, 5953.970230148908, 4781.976090119527, 5365.490278423544, 5710.5717071219, 5718.742656580381, 5741.62679425836, 5235.214717792209, 5419.512243898068, 5461.590380721383, 5835.2122463466885, 5916.49709774674, 5556.611037227355, 6102.694865256631, 6203.410675985774, 6203.604189057426, 6206.472449841814, 3302.6862448067395, 3947.585503522089, 3952.2848522388863, 3964.4251583520804, 3992.2813893499447, 4827.831025914076, 5121.283020377075, 5434.2935418395355, 5927.8221653350465, 5957.497850902545, 5298.311219541589, 5594.384617692132, 5807.303123625023, 5832.366937257575, 5875.294964604275, 5368.543673787772, 5443.673379597237, 5745.8563535911935, 5762.913556296575, 5776.862560852512, 4630.837920672895, 4823.975880120577, 5258.843054527998, 5657.066584013756, 5690.231818704588, 4728.834490792806, 5187.29971453864, 5561.916571251353, 5695.857603559778, 5899.67551784656, 4962.851114466572, 5143.61422893277, 5359.901220249917, 5575.358833734011, 5707.773968152507], "value": 4212.846660837182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.8895187818072, 702.7888208930779, 708.7909066825287, 728.8542291541689, 822.9218224268694, 12851.35743212838, 12882.742345153092, 14753.778693319595, 15773.526794196192, 15806.920965395171, 14321.925855560849, 14435.927820360883, 14479.78280325796, 14514.709705805877, 14526.983111182222, 563.7744902039196, 681.6693903456819, 834.6911642692212, 863.7754183912197, 872.9432586881865, 712.5973824789004, 844.5734903873536, 863.874738162966, 867.8828358171661, 878.2841983783228, 915.0529202275646, 915.3912648089013, 927.8608208768705, 927.9977624165884, 932.067932067932, 916.3127654259306, 920.7237828651412, 922.8938672052733, 924.3899026642383, 928.8281667891462, 686.1354693086747, 686.3445409633838, 686.6772616870063, 688.3151264491812, 689.5552368722197, 14858.257087145708, 14985.700285994328, 15022.24888755558, 15508.069515829086, 15728.134952577604, 11843.46704398304, 14299.356528956221, 14522.273886305642, 14527.0, 14587.854121458862, 11795.882041179564, 11819.881801181964, 11874.228175168673, 11932.403379830974, 12202.633920982296, 3727.552693676776, 3741.551013878352, 3745.2883952049297, 3799.164183879542, 3897.2984862724697, 101365.0, 101948.49025754824, 102216.48891755567, 102534.0, 103704.48147759288, 11107.777844443066, 11204.0, 11288.548458061585, 11315.547378104948, 11383.430828458544, 23097.653535196987, 23204.883975580015, 23683.05267789269, 23695.28914132579, 23704.0, 7772.805679858049, 7806.3364614007305, 7833.92166078332, 7888.723894663774, 7896.447248692536, 4246.3842742802735, 4304.461942257218, 4305.547917468683, 4325.329573916048, 4325.437693099877, 3615.0, 3676.852925882935, 3690.391085470921, 3704.981475092607, 3722.2555488902326, 593.0629605223736, 598.7426404550409, 608.8112685067643, 616.9691515424211, 620.5966122020723, 663.171036204744, 663.3896814930275, 677.9118714567173, 696.5959743348845, 696.6377483708544, 9582.706334644734, 10096.44469554167, 10283.9485802572, 10429.478526073666, 10692.411917344465, 613.5245184981675, 652.8792173447928, 683.4703105093593, 697.1738489889395, 709.5919846088519, 4725.1730947084125, 5064.721440320818, 5078.542931136216, 5088.287639730441, 5148.897022059613, 89372.0, 94939.0, 109136.90863091426, 109212.36181457284, 111912.4404377973, 95160.91132253698, 95487.0, 96036.51981740186, 96384.55423168658, 96891.0, 83164.58417707872, 84952.57523712465, 85230.57384713036, 86299.56850215835, 86977.0, 7267.18320419895, 8833.823323533365, 9711.174550163316, 9806.80386392254, 9816.85274720894, 40343.596564033985, 47127.52872471231, 50059.49940500548, 50232.74883625558, 50294.0, 69643.60712785817, 71219.0, 71249.28750712426, 71866.56266874739, 72386.63806681143, 10887.0, 12769.170003949714, 13449.663758406117, 13468.259245741578, 13847.446102155802, 11844.230125041844, 14925.626859328604, 14961.625959351104, 15430.691386172439, 15776.921115394349, 13764.17414955106, 13833.377498012413, 13898.235597041856, 14013.579592612237, 14475.420983160555, 13741.519046833313, 13863.237521936391, 13898.861011389758, 13983.510577129751, 14328.785068224193, 13491.730165396833, 13722.45110195581, 13847.515336963157, 14196.574102776933, 14211.431542738175, 10948.45257737126, 10963.50664220096, 11060.446977651247, 11131.721706957067, 11520.94239528797, 7615.466917315956, 8758.60586273632, 10918.344899306067, 11165.553377864795, 11191.2725672831], "value": 7537.3696827838285, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 119.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 119.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 114.0, 129.0, 135.0, 139.0, 144.0, 143.0, 114.0, 132.0, 115.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 206.0, 206.0, 200.0, 193.0, 198.0, 200.0, 198.0, 203.0, 175.0], "value": 198.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 68.0, 94.0, 58.0, 73.0, 84.0, 52.0, 73.0, 76.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 103.0, 58.0, 71.0, 85.0, 116.0, 85.0, 56.0, 68.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 88.0, 90.0, 108.0, 128.0, 132.0, 91.0, 131.0], "value": 103.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 92.0, 144.0, 95.0, 111.0, 152.0, 94.0, 151.0, 151.0], "value": 118.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 143.0, 132.0, 92.0, 128.0, 113.0, 93.0, 94.0, 93.0, 91.0], "value": 105.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 64.0, 61.0, 61.0, 63.0, 63.0, 62.0, 60.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 97.0, 84.0, 69.0, 80.0, 102.0, 60.0, 86.0, 104.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 89.0, 91.0, 89.0, 89.0, 87.0, 90.0, 89.0, 95.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 159.0, 158.0, 141.0, 141.0, 139.0, 141.0, 137.0, 171.0, 160.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 243.0, 182.0, 244.0, 176.0, 225.0, 239.0, 200.0, 176.0, 176.0], "value": 203.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 80.0, 88.0, 67.0, 59.0, 57.0, 84.0, 89.0, 88.0, 88.0], "value": 75.9, "unit": "score"}]}]} 00:40:42 INFO - Return code: 0 00:40:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:40:42 ERROR - # TBPL SUCCESS # 00:40:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:40:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:40:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:40:42 INFO - 2017-01-20 00:40:42.994 screenresolution[1650:10350] starting screenresolution argv=screenresolution get 00:40:42 INFO - 2017-01-20 00:40:42.997 screenresolution[1650:10350] Display 0: 1600x1200x32@60 00:40:43 INFO - 2017-01-20 00:40:43.004 screenresolution[1651:10353] starting screenresolution argv=screenresolution list 00:40:43 INFO - Available Modes on Display 0 00:40:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:40:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:40:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:40:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:40:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:40:43 INFO - Intel Iris: 00:40:43 INFO - Chipset Model: Intel Iris 00:40:43 INFO - Type: GPU 00:40:43 INFO - Bus: Built-In 00:40:43 INFO - VRAM (Dynamic, Max): 1536 MB 00:40:43 INFO - Vendor: Intel (0x8086) 00:40:43 INFO - Device ID: 0x0a2e 00:40:43 INFO - Revision ID: 0x0009 00:40:43 INFO - Displays: 00:40:43 INFO - Display: 00:40:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:40:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:40:43 INFO - Display Serial Number: 1600x1200 60 00:40:43 INFO - Main Display: Yes 00:40:43 INFO - Mirror: Off 00:40:43 INFO - Online: Yes 00:40:43 INFO - Rotation: Supported 00:40:43 INFO - Return code: 0 00:40:43 INFO - Running post-action listener: _resource_record_post_action 00:40:43 INFO - [mozharness: 2017-01-20 08:40:43.241106Z] Finished run-tests step (success) 00:40:43 INFO - Running post-run listener: _resource_record_post_run 00:40:43 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39463424; Write bytes: 554519040; Read time: 391; Write time: 1681 00:40:43 INFO - TinderboxPrint: CPU usage
54.4% 00:40:43 INFO - TinderboxPrint: I/O read bytes / time
39,463,424 / 391 00:40:43 INFO - TinderboxPrint: I/O write bytes / time
554,519,040 / 1,681 00:40:43 INFO - TinderboxPrint: CPU idle
2,190.0 (45.6%) 00:40:43 INFO - TinderboxPrint: CPU system
964.0 (20.1%) 00:40:43 INFO - TinderboxPrint: CPU user
1,647.7 (34.3%) 00:40:43 INFO - TinderboxPrint: Swap in / out
290,541,568 / 0 00:40:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247605760; Write bytes: 242599424; Read time: 17994; Write time: 517 00:40:43 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35351040; Write bytes: 298251264; Read time: 352; Write time: 1128 00:40:43 INFO - Running post-run listener: _upload_blobber_files 00:40:43 INFO - Blob upload gear active. 00:40:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:40:43 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 00:40:43 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'] 00:40:43 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 00:40:44 INFO - (blobuploader) - INFO - Open directory for files ... 00:40:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:40:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:40:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:40:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:40:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:40:45 INFO - (blobuploader) - INFO - Done attempting. 00:40:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:40:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:40:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:40:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:40:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:40:46 INFO - (blobuploader) - INFO - Done attempting. 00:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:40:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:40:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:40:47 INFO - (blobuploader) - INFO - Done attempting. 00:40:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:40:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:40:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:40:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:40:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:40:50 INFO - (blobuploader) - INFO - Done attempting. 00:40:50 INFO - (blobuploader) - INFO - Iteration through files over. 00:40:50 INFO - Return code: 0 00:40:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:40:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:40:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2aedacba99b7e9b293da2df5ece179ffd41274f4dfc716ab7376e21d1b443ba78dde450547e5faa86af84a8af34256b401ae024399c0dc07af2a339d19f8aea6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/27e97c769a79a2294187bc0aa3e85b686f9875020691ff7e2d4c08e800a06dc6822e047cd937a6544e17f4a5be61edc46bf1736a1342d8377ac5c1c591b2bb57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/28b3855cc8642778131178845ffefcdddbbef84c5d54f46c4407683f2e5fa1945bd2ecb4b871fc14f541591a2b79393d125a4472d9e86400c9a9022c231c9643", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/14f51e7850de2221ab2cfac2a0131bcf742c89d947a1000b2d1cdc83c7d74fe873f3cea9045b39c09f253c62dd4368c5da71789df09ffb7797df71deab3dcfd5"} 00:40:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:40:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:40:50 INFO - Contents: 00:40:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2aedacba99b7e9b293da2df5ece179ffd41274f4dfc716ab7376e21d1b443ba78dde450547e5faa86af84a8af34256b401ae024399c0dc07af2a339d19f8aea6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/27e97c769a79a2294187bc0aa3e85b686f9875020691ff7e2d4c08e800a06dc6822e047cd937a6544e17f4a5be61edc46bf1736a1342d8377ac5c1c591b2bb57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/28b3855cc8642778131178845ffefcdddbbef84c5d54f46c4407683f2e5fa1945bd2ecb4b871fc14f541591a2b79393d125a4472d9e86400c9a9022c231c9643", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/14f51e7850de2221ab2cfac2a0131bcf742c89d947a1000b2d1cdc83c7d74fe873f3cea9045b39c09f253c62dd4368c5da71789df09ffb7797df71deab3dcfd5"} 00:40:50 INFO - Running post-run listener: copy_logs_to_upload_dir 00:40:50 INFO - Copying logs to upload dir... 00:40:50 INFO - mkdir: /builds/slave/test/build/upload/logs 00:40:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.358620 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-20 00:40:50.272168) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 00:40:50.275802) ========= 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.phzmBtqGDC/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.NiLRJc4KyE/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2aedacba99b7e9b293da2df5ece179ffd41274f4dfc716ab7376e21d1b443ba78dde450547e5faa86af84a8af34256b401ae024399c0dc07af2a339d19f8aea6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/27e97c769a79a2294187bc0aa3e85b686f9875020691ff7e2d4c08e800a06dc6822e047cd937a6544e17f4a5be61edc46bf1736a1342d8377ac5c1c591b2bb57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/28b3855cc8642778131178845ffefcdddbbef84c5d54f46c4407683f2e5fa1945bd2ecb4b871fc14f541591a2b79393d125a4472d9e86400c9a9022c231c9643", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/14f51e7850de2221ab2cfac2a0131bcf742c89d947a1000b2d1cdc83c7d74fe873f3cea9045b39c09f253c62dd4368c5da71789df09ffb7797df71deab3dcfd5"} build_url:https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/KNvp4sAgRY62N5YY-9Zm0g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2aedacba99b7e9b293da2df5ece179ffd41274f4dfc716ab7376e21d1b443ba78dde450547e5faa86af84a8af34256b401ae024399c0dc07af2a339d19f8aea6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/27e97c769a79a2294187bc0aa3e85b686f9875020691ff7e2d4c08e800a06dc6822e047cd937a6544e17f4a5be61edc46bf1736a1342d8377ac5c1c591b2bb57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/28b3855cc8642778131178845ffefcdddbbef84c5d54f46c4407683f2e5fa1945bd2ecb4b871fc14f541591a2b79393d125a4472d9e86400c9a9022c231c9643", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/14f51e7850de2221ab2cfac2a0131bcf742c89d947a1000b2d1cdc83c7d74fe873f3cea9045b39c09f253c62dd4368c5da71789df09ffb7797df71deab3dcfd5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 00:40:50.310410) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:40:50.310783) ========= 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.phzmBtqGDC/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.NiLRJc4KyE/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.005071 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 00:40:50.359624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 00:40:50.360022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 00:40:50.363478) ========= ========= Total master_lag: 0.19 =========