builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0203 starttime: 1472051085.57 results: success (0) buildid: 20160824060437 builduid: 7d125245b1724493a9e2d0ae89a3944a revision: 8bcfd9dda91cd024bdebba5c599b8710e55ee829 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:45.571084) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:45.571471) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:45.571770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:45.683825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:45.684343) ========= 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.ktMZUx4dKk/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.9GkdlxmACx/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-24 08:04:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-08-24 08:04:46 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.732499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:46.439786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:46.440090) ========= 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.ktMZUx4dKk/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.9GkdlxmACx/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.026031 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:46.488440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:46.488805) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8bcfd9dda91cd024bdebba5c599b8710e55ee829 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8bcfd9dda91cd024bdebba5c599b8710e55ee829 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ktMZUx4dKk/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.9GkdlxmACx/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-24 08:04:46,571 truncating revision to first 12 chars 2016-08-24 08:04:46,571 Setting DEBUG logging. 2016-08-24 08:04:46,571 attempt 1/10 2016-08-24 08:04:46,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8bcfd9dda91c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 08:04:46,863 unpacking tar archive at: mozilla-central-8bcfd9dda91c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566892 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:47.078506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:47.078978) ========= script_repo_revision: 8bcfd9dda91cd024bdebba5c599b8710e55ee829 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:47.079375) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:47.079661) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 08:04:47.098717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-24 08:04:47.099051) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ktMZUx4dKk/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.9GkdlxmACx/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:04:47 INFO - MultiFileLogger online at 20160824 08:04:47 in /builds/slave/test 08:04:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:04:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:04:47 INFO - {'append_to_log': False, 08:04:47 INFO - 'base_work_dir': '/builds/slave/test', 08:04:47 INFO - 'blob_upload_branch': 'Firefox', 08:04:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:04:47 INFO - 'branch': 'Firefox', 08:04:47 INFO - 'buildbot_json_path': 'buildprops.json', 08:04:47 INFO - 'config_files': ('talos/mac_config.py',), 08:04:47 INFO - 'default_actions': ('clobber', 08:04:47 INFO - 'read-buildbot-config', 08:04:47 INFO - 'download-and-extract', 08:04:47 INFO - 'populate-webroot', 08:04:47 INFO - 'create-virtualenv', 08:04:47 INFO - 'install', 08:04:47 INFO - 'run-tests'), 08:04:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:04:47 INFO - 'download_minidump_stackwalk': True, 08:04:47 INFO - 'download_symbols': 'ondemand', 08:04:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:04:47 INFO - 'tooltool.py': '/tools/tooltool.py', 08:04:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:04:47 INFO - '/tools/misc-python/virtualenv.py')}, 08:04:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:04:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:04:47 INFO - 'installer_path': 'installer.exe', 08:04:47 INFO - 'log_level': 'info', 08:04:47 INFO - 'log_name': 'talos', 08:04:47 INFO - 'log_to_console': True, 08:04:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:04:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:04:47 INFO - 'opt_config_files': (), 08:04:47 INFO - 'pip_index': False, 08:04:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:04:47 INFO - 'cmd': ('bash', 08:04:47 INFO - '-c', 08:04:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:04:47 INFO - 'enabled': True, 08:04:47 INFO - 'halt_on_failure': False, 08:04:47 INFO - 'name': 'check_screen_resolution'},), 08:04:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:04:47 INFO - 'cmd': ('bash', 08:04:47 INFO - '-c', 08:04:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:04:47 INFO - 'enabled': True, 08:04:47 INFO - 'halt_on_failure': False, 08:04:47 INFO - 'name': 'check_screen_resolution'},), 08:04:47 INFO - 'run_cmd_checks_enabled': True, 08:04:47 INFO - 'sps_profile': False, 08:04:47 INFO - 'sps_profile_interval': 0, 08:04:47 INFO - 'suite': 'dromaeojs', 08:04:47 INFO - 'system_bits': '32', 08:04:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:47 INFO - 'title': 't-yosemite-r7-0203', 08:04:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:47 INFO - 'use_talos_json': True, 08:04:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:04:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:47 INFO - 'work_dir': 'build'} 08:04:47 INFO - [mozharness: 2016-08-24 15:04:47.306773Z] Running clobber step. 08:04:47 INFO - Running pre-action listener: _resource_record_pre_action 08:04:47 INFO - Running main action method: clobber 08:04:47 INFO - rmtree: /builds/slave/test/build 08:04:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:04:49 INFO - Running post-action listener: _resource_record_post_action 08:04:49 INFO - [mozharness: 2016-08-24 15:04:49.454097Z] Finished clobber step (success) 08:04:49 INFO - [mozharness: 2016-08-24 15:04:49.454350Z] Running read-buildbot-config step. 08:04:49 INFO - Running pre-action listener: _resource_record_pre_action 08:04:49 INFO - Running main action method: read_buildbot_config 08:04:49 INFO - Using buildbot properties: 08:04:49 INFO - { 08:04:49 INFO - "project": "", 08:04:49 INFO - "product": "firefox", 08:04:49 INFO - "script_repo_revision": "production", 08:04:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:04:49 INFO - "repository": "", 08:04:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:04:49 INFO - "buildid": "20160824060437", 08:04:49 INFO - "pgo_build": "False", 08:04:49 INFO - "basedir": "/builds/slave/test", 08:04:49 INFO - "buildnumber": 41, 08:04:49 INFO - "slavename": "t-yosemite-r7-0203", 08:04:49 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:04:49 INFO - "platform": "yosemite_r7", 08:04:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:04:49 INFO - "branch": "mozilla-central", 08:04:49 INFO - "repo_path": "mozilla-central", 08:04:49 INFO - "revision": "8bcfd9dda91cd024bdebba5c599b8710e55ee829", 08:04:49 INFO - "stage_platform": "macosx64", 08:04:49 INFO - "builduid": "7d125245b1724493a9e2d0ae89a3944a", 08:04:49 INFO - "slavebuilddir": "test" 08:04:49 INFO - } 08:04:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:04:49 INFO - Running post-action listener: _resource_record_post_action 08:04:49 INFO - [mozharness: 2016-08-24 15:04:49.460595Z] Finished read-buildbot-config step (success) 08:04:49 INFO - [mozharness: 2016-08-24 15:04:49.460819Z] Running download-and-extract step. 08:04:49 INFO - Running pre-action listener: _resource_record_pre_action 08:04:49 INFO - Running main action method: download_and_extract 08:04:49 INFO - mkdir: /builds/slave/test/build/tests 08:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:49 INFO - trying https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:04:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 08:04:50 INFO - Downloaded 1199 bytes. 08:04:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:04:50 INFO - Using the following test package requirements: 08:04:50 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:04:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:04:50 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:04:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:04:50 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:04:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:04:50 INFO - u'jsshell-mac.zip'], 08:04:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:04:50 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:04:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:04:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:04:50 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:04:50 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:04:50 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:04:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:04:50 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:04:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:04:50 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:04:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:04: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')]} 08:04:50 INFO - trying https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:04:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:04:51 INFO - Downloaded 16346183 bytes. 08:04:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:04:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:58 INFO - trying https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:04:58 INFO - Downloading https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:04:59 INFO - Downloaded 16346183 bytes. 08:04:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:05: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')]} 08:05:05 INFO - trying https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:05:05 INFO - Downloading https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:05:07 INFO - Downloaded 14413981 bytes. 08:05:07 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 08:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:08 INFO - trying https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:05:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 08:05:12 INFO - Downloaded 111523256 bytes. 08:05:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:05:12 INFO - mkdir: /builds/slave/test/properties 08:05:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:12 INFO - Contents: 08:05:12 INFO - build_url:https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:05:13 INFO - Running post-action listener: _resource_record_post_action 08:05:13 INFO - Running post-action listener: set_extra_try_arguments 08:05:13 INFO - [mozharness: 2016-08-24 15:05:13.610156Z] Finished download-and-extract step (success) 08:05:13 INFO - [mozharness: 2016-08-24 15:05:13.610309Z] Running populate-webroot step. 08:05:13 INFO - Running pre-action listener: _resource_record_pre_action 08:05:13 INFO - Running main action method: populate_webroot 08:05:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:13 INFO - '--tppagecycles', 08:05:13 INFO - '7'], 08:05:13 INFO - 'tests': ['tsvgm']}}, 08:05:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['damp', 'tps']}, 08:05:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'tests': ['damp', 'tps']}, 08:05:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['dromaeo_dom']}, 08:05:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['basic_compositor_video']}, 08:05:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:05:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['tsvgx', 08:05:13 INFO - 'tsvgr_opacity', 08:05:13 INFO - 'tart', 08:05:13 INFO - 'tscrollx', 08:05:13 INFO - 'cart']}, 08:05:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:13 INFO - 'tsvgr_opacity', 08:05:13 INFO - 'tart', 08:05:13 INFO - 'tscrollx', 08:05:13 INFO - 'cart']}, 08:05:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['tp5o']}, 08:05:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'tests': ['tp5o']}, 08:05:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--disable-e10s', 08:05:13 INFO - '--xperf_path', 08:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:13 INFO - 'tests': ['tp5n']}, 08:05:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--xperf_path', 08:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:13 INFO - 'tests': ['tp5n']}}, 08:05:13 INFO - 'talos.zip': {'path': '', 08:05:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:13 INFO - Running post-action listener: _resource_record_post_action 08:05:13 INFO - [mozharness: 2016-08-24 15:05:13.629120Z] Finished populate-webroot step (success) 08:05:13 INFO - [mozharness: 2016-08-24 15:05:13.629233Z] Running create-virtualenv step. 08:05:13 INFO - Running pre-action listener: _resource_record_pre_action 08:05:13 INFO - Running main action method: create_virtualenv 08:05:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:05:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:13 INFO - Using real prefix '/tools/python27' 08:05:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:17 INFO - Installing pip.................done. 08:05:17 INFO - Return code: 0 08:05:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:05:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:17 INFO - 'HOME': '/Users/cltbld', 08:05:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:17 INFO - 'LOGNAME': 'cltbld', 08:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:17 INFO - 'MOZ_NO_REMOTE': '1', 08:05:17 INFO - 'NO_EM_RESTART': '1', 08:05:17 INFO - 'PAGER': '/bin/cat', 08:05:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:17 INFO - 'PWD': '/builds/slave/test', 08:05:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:17 INFO - 'SHELL': '/bin/bash', 08:05:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:17 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:17 INFO - 'USER': 'cltbld', 08:05:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:17 INFO - 'XPC_FLAGS': '0x0', 08:05:17 INFO - 'XPC_SERVICE_NAME': '0', 08:05:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:05:17 INFO - Cleaning up... 08:05:17 INFO - Return code: 0 08:05:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:05:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:17 INFO - 'HOME': '/Users/cltbld', 08:05:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:17 INFO - 'LOGNAME': 'cltbld', 08:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:17 INFO - 'MOZ_NO_REMOTE': '1', 08:05:17 INFO - 'NO_EM_RESTART': '1', 08:05:17 INFO - 'PAGER': '/bin/cat', 08:05:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:17 INFO - 'PWD': '/builds/slave/test', 08:05:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:17 INFO - 'SHELL': '/bin/bash', 08:05:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:17 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:17 INFO - 'USER': 'cltbld', 08:05:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:17 INFO - 'XPC_FLAGS': '0x0', 08:05:17 INFO - 'XPC_SERVICE_NAME': '0', 08:05:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:17 INFO - Downloading/unpacking psutil>=3.1.1 08:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:21 INFO - Installing collected packages: psutil 08:05:21 INFO - Running setup.py install for psutil 08:05:21 INFO - building 'psutil._psutil_osx' extension 08:05:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:05:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:05:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:05:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:05:22 INFO - building 'psutil._psutil_posix' extension 08:05:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:05:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:05:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:05:22 INFO - ^ 08:05:22 INFO - 1 warning generated. 08:05:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:05:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:22 INFO - Successfully installed psutil 08:05:22 INFO - Cleaning up... 08:05:22 INFO - Return code: 0 08:05:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:05: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 mozsystemmonitor==0.3 08:05:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:22 INFO - 'HOME': '/Users/cltbld', 08:05:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:22 INFO - 'LOGNAME': 'cltbld', 08:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:22 INFO - 'MOZ_NO_REMOTE': '1', 08:05:22 INFO - 'NO_EM_RESTART': '1', 08:05:22 INFO - 'PAGER': '/bin/cat', 08:05:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:22 INFO - 'PWD': '/builds/slave/test', 08:05:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:22 INFO - 'SHELL': '/bin/bash', 08:05:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:22 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:22 INFO - 'USER': 'cltbld', 08:05:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:22 INFO - 'XPC_FLAGS': '0x0', 08:05:22 INFO - 'XPC_SERVICE_NAME': '0', 08:05:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:25 INFO - Installing collected packages: mozsystemmonitor 08:05:25 INFO - Running setup.py install for mozsystemmonitor 08:05:25 INFO - Successfully installed mozsystemmonitor 08:05:25 INFO - Cleaning up... 08:05:25 INFO - Return code: 0 08:05:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:05:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:05:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:25 INFO - 'HOME': '/Users/cltbld', 08:05:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:25 INFO - 'LOGNAME': 'cltbld', 08:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:25 INFO - 'MOZ_NO_REMOTE': '1', 08:05:25 INFO - 'NO_EM_RESTART': '1', 08:05:25 INFO - 'PAGER': '/bin/cat', 08:05:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:25 INFO - 'PWD': '/builds/slave/test', 08:05:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:25 INFO - 'SHELL': '/bin/bash', 08:05:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:25 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:25 INFO - 'USER': 'cltbld', 08:05:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:25 INFO - 'XPC_FLAGS': '0x0', 08:05:25 INFO - 'XPC_SERVICE_NAME': '0', 08:05:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:25 INFO - Downloading/unpacking jsonschema==2.5.1 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:28 INFO - warning: no files found matching '*.txt' 08:05:28 INFO - no previously-included directories found matching 'build' 08:05:28 INFO - no previously-included directories found matching 'dist' 08:05:28 INFO - no previously-included directories found matching '.git*' 08:05:28 INFO - Installing collected packages: jsonschema, functools32 08:05:28 INFO - Running setup.py install for functools32 08:05:28 INFO - warning: no files found matching '*.txt' 08:05:28 INFO - no previously-included directories found matching 'build' 08:05:28 INFO - no previously-included directories found matching 'dist' 08:05:28 INFO - no previously-included directories found matching '.git*' 08:05:28 INFO - Successfully installed jsonschema functools32 08:05:28 INFO - Cleaning up... 08:05:29 INFO - Return code: 0 08:05:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:29 INFO - 'HOME': '/Users/cltbld', 08:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:29 INFO - 'LOGNAME': 'cltbld', 08:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:29 INFO - 'MOZ_NO_REMOTE': '1', 08:05:29 INFO - 'NO_EM_RESTART': '1', 08:05:29 INFO - 'PAGER': '/bin/cat', 08:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:29 INFO - 'PWD': '/builds/slave/test', 08:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:29 INFO - 'SHELL': '/bin/bash', 08:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:29 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:29 INFO - 'USER': 'cltbld', 08:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:29 INFO - 'XPC_FLAGS': '0x0', 08:05:29 INFO - 'XPC_SERVICE_NAME': '0', 08:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:05:29 INFO - Cleaning up... 08:05:29 INFO - Return code: 0 08:05:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:29 INFO - 'HOME': '/Users/cltbld', 08:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:29 INFO - 'LOGNAME': 'cltbld', 08:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:29 INFO - 'MOZ_NO_REMOTE': '1', 08:05:29 INFO - 'NO_EM_RESTART': '1', 08:05:29 INFO - 'PAGER': '/bin/cat', 08:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:29 INFO - 'PWD': '/builds/slave/test', 08:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:29 INFO - 'SHELL': '/bin/bash', 08:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:29 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:29 INFO - 'USER': 'cltbld', 08:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:29 INFO - 'XPC_FLAGS': '0x0', 08:05:29 INFO - 'XPC_SERVICE_NAME': '0', 08:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:33 INFO - Downloading docopt-0.6.1.tar.gz 08:05:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:33 INFO - Running setup.py install for blobuploader 08:05:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:33 INFO - Running setup.py install for requests 08:05:33 INFO - Running setup.py install for docopt 08:05:34 INFO - Successfully installed blobuploader requests docopt 08:05:34 INFO - Cleaning up... 08:05:34 INFO - Return code: 0 08:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:34 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 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:34 INFO - 'HOME': '/Users/cltbld', 08:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:34 INFO - 'LOGNAME': 'cltbld', 08:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:34 INFO - 'MOZ_NO_REMOTE': '1', 08:05:34 INFO - 'NO_EM_RESTART': '1', 08:05:34 INFO - 'PAGER': '/bin/cat', 08:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:34 INFO - 'PWD': '/builds/slave/test', 08:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:34 INFO - 'SHELL': '/bin/bash', 08:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:34 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:34 INFO - 'USER': 'cltbld', 08:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:34 INFO - 'XPC_FLAGS': '0x0', 08:05:34 INFO - 'XPC_SERVICE_NAME': '0', 08:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:34 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-jlf1aN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:34 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Su0MB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:34 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-HfNI4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:34 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-l6Dt1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:34 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-lX3hS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:34 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-dVnJbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-4Fkykn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-K4gl59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-CNi_nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-OWwbr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-bn8KWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-zuEltP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-iIAc8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-WHeaxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Ip5Y8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:35 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-DCGzEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:36 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Bg4WKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:36 INFO - Running setup.py install for manifestparser 08:05:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:36 INFO - Running setup.py install for mozcrash 08:05:36 INFO - Running setup.py install for mozdebug 08:05:36 INFO - Running setup.py install for mozdevice 08:05:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:36 INFO - Running setup.py install for mozfile 08:05:36 INFO - Running setup.py install for mozhttpd 08:05:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:37 INFO - Running setup.py install for mozinfo 08:05:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:37 INFO - Running setup.py install for mozInstall 08:05:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:37 INFO - Running setup.py install for mozleak 08:05:37 INFO - Running setup.py install for mozlog 08:05:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:37 INFO - Running setup.py install for moznetwork 08:05:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:37 INFO - Running setup.py install for mozprocess 08:05:37 INFO - Running setup.py install for mozprofile 08:05:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:38 INFO - Running setup.py install for mozrunner 08:05:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:38 INFO - Running setup.py install for mozscreenshot 08:05:38 INFO - Running setup.py install for moztest 08:05:38 INFO - Running setup.py install for mozversion 08:05:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:38 INFO - Cleaning up... 08:05:38 INFO - Return code: 0 08:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:38 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 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:38 INFO - 'HOME': '/Users/cltbld', 08:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:38 INFO - 'LOGNAME': 'cltbld', 08:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:38 INFO - 'MOZ_NO_REMOTE': '1', 08:05:38 INFO - 'NO_EM_RESTART': '1', 08:05:38 INFO - 'PAGER': '/bin/cat', 08:05:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:38 INFO - 'PWD': '/builds/slave/test', 08:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:38 INFO - 'SHELL': '/bin/bash', 08:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:38 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:38 INFO - 'USER': 'cltbld', 08:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:38 INFO - 'XPC_FLAGS': '0x0', 08:05:38 INFO - 'XPC_SERVICE_NAME': '0', 08:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-0iSlue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-mUzmEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-vKDEmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-iQBb6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-D0Xz5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-6XBbIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-DelHUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-JUGzG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-C8YeLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:39 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-5gGbfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:40 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-CHi0Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:40 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-gFT5Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:40 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-GoJxJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:40 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-dXiNNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:40 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-hEZr1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:40 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-43Uv8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:40 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-wr_4Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:40 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:40 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:43 INFO - Downloading blessings-1.6.tar.gz 08:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:43 INFO - Installing collected packages: blessings 08:05:43 INFO - Running setup.py install for blessings 08:05:43 INFO - Successfully installed blessings 08:05:43 INFO - Cleaning up... 08:05:43 INFO - Return code: 0 08:05:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:43 INFO - Reading from file tmpfile_stdout 08:05:43 INFO - Current package versions: 08:05:43 INFO - blessings == 1.6 08:05:43 INFO - blobuploader == 1.2.4 08:05:43 INFO - docopt == 0.6.1 08:05:43 INFO - functools32 == 3.2.3-2 08:05:43 INFO - jsonschema == 2.5.1 08:05:43 INFO - manifestparser == 1.1 08:05:43 INFO - mozInstall == 1.12 08:05:43 INFO - mozcrash == 0.17 08:05:43 INFO - mozdebug == 0.1 08:05:43 INFO - mozdevice == 0.48 08:05:43 INFO - mozfile == 1.2 08:05:43 INFO - mozhttpd == 0.7 08:05:43 INFO - mozinfo == 0.9 08:05:43 INFO - mozleak == 0.1 08:05:43 INFO - mozlog == 3.3 08:05:43 INFO - moznetwork == 0.27 08:05:43 INFO - mozprocess == 0.23 08:05:43 INFO - mozprofile == 0.28 08:05:43 INFO - mozrunner == 6.12 08:05:43 INFO - mozscreenshot == 0.1 08:05:43 INFO - mozsystemmonitor == 0.3 08:05:43 INFO - moztest == 0.7 08:05:43 INFO - mozversion == 1.4 08:05:43 INFO - psutil == 3.1.1 08:05:43 INFO - requests == 1.2.3 08:05:43 INFO - wsgiref == 0.1.2 08:05:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:43 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 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:43 INFO - 'HOME': '/Users/cltbld', 08:05:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:43 INFO - 'LOGNAME': 'cltbld', 08:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:43 INFO - 'MOZ_NO_REMOTE': '1', 08:05:43 INFO - 'NO_EM_RESTART': '1', 08:05:43 INFO - 'PAGER': '/bin/cat', 08:05:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:43 INFO - 'PWD': '/builds/slave/test', 08:05:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:43 INFO - 'SHELL': '/bin/bash', 08:05:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:43 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:43 INFO - 'USER': 'cltbld', 08:05:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:43 INFO - 'XPC_FLAGS': '0x0', 08:05:43 INFO - 'XPC_SERVICE_NAME': '0', 08:05:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:05:44 INFO - Cleaning up... 08:05:44 INFO - Return code: 0 08:05:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:44 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 0x10c3c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f876a594090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, '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.ktMZUx4dKk/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.9GkdlxmACx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:44 INFO - 'HOME': '/Users/cltbld', 08:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:44 INFO - 'LOGNAME': 'cltbld', 08:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:44 INFO - 'MOZ_NO_REMOTE': '1', 08:05:44 INFO - 'NO_EM_RESTART': '1', 08:05:44 INFO - 'PAGER': '/bin/cat', 08:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:44 INFO - 'PWD': '/builds/slave/test', 08:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:44 INFO - 'SHELL': '/bin/bash', 08:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:05:44 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:44 INFO - 'USER': 'cltbld', 08:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:44 INFO - 'XPC_FLAGS': '0x0', 08:05:44 INFO - 'XPC_SERVICE_NAME': '0', 08:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:44 INFO - Cleaning up... 08:05:44 INFO - Return code: 0 08:05:44 INFO - Running post-action listener: _resource_record_post_action 08:05:44 INFO - Running post-action listener: _start_resource_monitoring 08:05:44 INFO - Starting resource monitoring. 08:05:44 INFO - [mozharness: 2016-08-24 15:05:44.411708Z] Finished create-virtualenv step (success) 08:05:44 INFO - [mozharness: 2016-08-24 15:05:44.412521Z] Running install step. 08:05:44 INFO - Running pre-action listener: _resource_record_pre_action 08:05:44 INFO - Running main action method: install 08:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:44 INFO - Reading from file tmpfile_stdout 08:05:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:44 INFO - Reading from file tmpfile_stdout 08:05:44 INFO - Output received: 08:05:44 INFO - Usage: mozinstall [options] installer 08:05:44 INFO - Options: 08:05:44 INFO - -h, --help show this help message and exit 08:05:44 INFO - -d DEST, --destination=DEST 08:05:44 INFO - Directory to install application into. [default: 08:05:44 INFO - "/builds/slave/test"] 08:05:44 INFO - --app=APP Application being installed. [default: firefox] 08:05:44 INFO - mkdir: /builds/slave/test/build/application 08:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:06:19 INFO - Reading from file tmpfile_stdout 08:06:19 INFO - Output received: 08:06:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:06:19 INFO - Running post-action listener: _resource_record_post_action 08:06:19 INFO - [mozharness: 2016-08-24 15:06:19.012371Z] Finished install step (success) 08:06:19 INFO - [mozharness: 2016-08-24 15:06:19.012503Z] Running run-tests step. 08:06:19 INFO - Running pre-action listener: _resource_record_pre_action 08:06:19 INFO - Running main action method: run_tests 08:06:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:06:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:06:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:06:19 INFO - 2016-08-24 08:06:19.026 screenresolution[1641:8331] starting screenresolution argv=screenresolution get 08:06:19 INFO - 2016-08-24 08:06:19.029 screenresolution[1641:8331] Display 0: 1600x1200x32@60 08:06:19 INFO - 2016-08-24 08:06:19.035 screenresolution[1642:8333] starting screenresolution argv=screenresolution list 08:06:19 INFO - Available Modes on Display 0 08:06:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:06:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:06:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:06:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:06:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:06:19 INFO - Intel Iris: 08:06:19 INFO - Chipset Model: Intel Iris 08:06:19 INFO - Type: GPU 08:06:19 INFO - Bus: Built-In 08:06:19 INFO - VRAM (Dynamic, Max): 1536 MB 08:06:19 INFO - Vendor: Intel (0x8086) 08:06:19 INFO - Device ID: 0x0a2e 08:06:19 INFO - Revision ID: 0x0009 08:06:19 INFO - Displays: 08:06:19 INFO - Display: 08:06:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:06:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:06:19 INFO - Display Serial Number: 1600x1200 60 08:06:19 INFO - Main Display: Yes 08:06:19 INFO - Mirror: Off 08:06:19 INFO - Online: Yes 08:06:19 INFO - Rotation: Supported 08:06:19 INFO - Return code: 0 08:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:06:19 INFO - Python 2.7.3 08:06:19 INFO - Return code: 0 08:06:19 INFO - grabbing minidump binary from tooltool 08:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:19 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 0x10c326d30>, '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 0x10c08bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c31eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:06:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:06:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:06:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:06:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:06:19 INFO - Return code: 0 08:06:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:06:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:06:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:06:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:06:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0203 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ktMZUx4dKk/Render', 08:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:06:19 INFO - 'HOME': '/Users/cltbld', 08:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:06:19 INFO - 'LOGNAME': 'cltbld', 08:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:19 INFO - 'MOZ_NO_REMOTE': '1', 08:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:19 INFO - 'NO_EM_RESTART': '1', 08:06:19 INFO - 'PAGER': '/bin/cat', 08:06:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:19 INFO - 'PWD': '/builds/slave/test', 08:06:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:06:19 INFO - 'SHELL': '/bin/bash', 08:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GkdlxmACx/Listeners', 08:06:19 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 08:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:06:19 INFO - 'USER': 'cltbld', 08:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:19 INFO - 'XPC_FLAGS': '0x0', 08:06:19 INFO - 'XPC_SERVICE_NAME': '0', 08:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:06:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:06:19 INFO - mozversion application_buildid: 20160824060437 08:06:19 INFO - mozversion application_changeset: 8bcfd9dda91cd024bdebba5c599b8710e55ee829 08:06:19 INFO - mozversion application_display_name: Nightly 08:06:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:06:19 INFO - mozversion application_name: Firefox 08:06:19 INFO - mozversion application_remotingname: firefox 08:06:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:06:19 INFO - mozversion application_vendor: Mozilla 08:06:19 INFO - mozversion application_version: 51.0a1 08:06:19 INFO - mozversion platform_buildid: 20160824060437 08:06:19 INFO - mozversion platform_changeset: 8bcfd9dda91cd024bdebba5c599b8710e55ee829 08:06:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:06:19 INFO - mozversion platform_version: 51.0a1 08:06:19 INFO - using testdate: 1472051179 08:06:19 INFO - actual date: 1472051179 08:06:19 INFO - starting webserver on 'localhost:49266' 08:06:19 INFO - SUITE-START | Running 2 tests 08:06:19 INFO - TEST-START | dromaeo_css 08:06:19 INFO - operating with platform_type : mac_ 08:06:19 INFO - Initialising browser for dromaeo_css test... 08:06:19 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpsfANNw/profile http://localhost:49266/getInfo.html) 08:06:21 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:06:21 INFO - PROCESS | 1652 | colorDepth:24 08:06:21 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:06:21 INFO - PROCESS | 1652 | __metrics 08:06:22 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:06:22 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:22 INFO - TEST-INFO | 1652: exit 0 08:06:22 INFO - Browser initialized. 08:06:22 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:22 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpsfANNw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:34 INFO - PROCESS | 1655 | RSS: Main: 235143168 08:06:34 INFO - PROCESS | 1655 | 08:07:25 INFO - PROCESS | 1655 | 1472051245932 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:09:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 08:09:39 INFO - PROCESS | 1655 | RSS: Main: 370925568 08:09:39 INFO - PROCESS | 1655 | 08:12:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 08:12:42 INFO - PROCESS | 1655 | RSS: Main: 391061504 08:12:42 INFO - PROCESS | 1655 | 08:15:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 08:15:45 INFO - PROCESS | 1655 | RSS: Main: 341405696 08:15:45 INFO - PROCESS | 1655 | 08:18:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 08:18:48 INFO - PROCESS | 1655 | RSS: Main: 349200384 08:18:48 INFO - PROCESS | 1655 | 08:21:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 08:21:52 INFO - PROCESS | 1655 | RSS: Main: 333955072 08:21:52 INFO - PROCESS | 1655 | 08:24:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 08:24:56 INFO - PROCESS | 1655 | RSS: Main: 531902464 08:24:56 INFO - PROCESS | 1655 | 08:24:56 INFO - PROCESS | 1655 | __start_tp_report 08:24:56 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 08:24:56 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 08:24:56 INFO - PROCESS | 1655 | |i|pagename|runs| 08:24:56 INFO - PROCESS | 1655 | |0;dojo.html;2766.3360793409583;3305.7355411567078;3339.0984434202765;3377.5271461995308;3393.032985599103;5587.7485513151905;5589.776408943642;5661.8584535386635;5699.943000569993;5752.338481074672;5658.462446067617;5696.914546281809;5707.14392841074;5707.77168913244;5709.486146246837;5181.378234611842;5206.609504287194;5219.243209734605;5241.056609810233;5285.947140528584;5234;5257.23770053342;5260.500252476008;5263.947210557884;5270.947290527084;5172.40517340505;5177.896442071156;5191.221316802472;5207.713575753332;5239.266502689627;5263.36839579253;5284.973575132119;5301.3373328333955;5302.257683924254;5350.0904846176245;5097.898042039175;5104.591632669378;5114.028334616411;5220.399654039796;5224.738763061831;5567.916481252784;5570.610057295991;5614.354349249807;5624.128260119647;5634.577406694514;6216.036514340284;6235.968820155916;6242.469390101847;6246.906296405557;6257.061440783873;6095.347660937622;6204.441600255954;6232.189815323979;6259.749610015594;6297.937020629826;5762.250907382014;5798.246227990334;5835.416458354215;5839.620424672383;5887;5208.661437006583;6316.336784637547;6324.019776934582;6331.461825744771;6339.366063393716;5946.494547963385;6017.638941663514;6086.817395478142;6121.8200435426415;6172.598781079216;6229.657368844757;6285.151504546919;6300.495960323163;6302.212223472066;6307.873842523124;5666.008448521575;5754.251947246915;6192.752289908353;6206.627602343874;6232.844178895564;6078.240219972504;6130.153553065376;6207.844803879939;6250.1874756281395;6254;4893.828715994923;4964.230544265644;4984.352034235599;4993.90012199754;4995.725235112031;4445.3998710174355;4463.174312752151;4468.285074388147;4474.530174331713;4503.121891231179;5542.39033706292;5593.356763972114;5668.51817595509;5691.886162276731;5718.771249149988;5054.21659642756;6237.532185086136;6254.3745625438005;6306.558540902093;6318.4313411793155;5689.573282003867;5691.345495268097;5691.402402747652;5714.228579141846;5741.62679425836;5287.841364759063;5427.972860135674;5431.755570999315;5441.5102640762525;5451.4276001019325;6229.3770622937345;6269.749210031548;6284.811455656338;6302.3067462578165;6303.086052522359;6291.056341548621;6298.559100863079;6307.274663413583;6307.7476900925285;6317.684115794284;6254.21822272216;6268.749250029948;6288.245410550763;6300.464460520724;6308.148399965946;5965;6104.3075792339105;6116.633002019893;6119.663418511846;6138.419052470106;6299.779507717208;6317.5893566918;6329.019002054689;6329.968350158219;6340.461060809883;6101;6113.02191649334;6134.846628834136;6143.078538219303;6146.477549408171;5990;6040.667763272886;6057.545684073801;6089.939100608937;6154.446099850856;5967.731452084579;5975.850603734942;5988.101784732325;5992.370801065999;6014.308354539109;5906.70466476683;6123.8162855114415;6143.631382116909;6149.169862068564;6174.228221472316;5796.913046304393;5867.061270196748;5926.111083337534;5949.6430214187285;6007.639541627516 08:24:56 INFO - PROCESS | 1655 | |1;ext.html;435.27743945051213;460.4957571459253;473.13888722524973;481.6989381636477;540.5324394398845;30811.22971925703;32200.67799322009;39646.80176599113;40939;40998.79500602493;41869.371959420634;42252.94367640803;42307.15385692284;42324.57675423245;42445;9655.517224138783;9815.214782817393;9829.311948163631;9837.90162098377;9840.212782977345;9734.707958761248;9845.55694993727;9860.408375497493;9869.555869985832;9874.456904870229;9793;9868.654597089104;9869.901300987007;9874.061964113398;9898.901010989906;9785.461799601018;9841.901580984206;9865.457399843006;9877.851832222523;9899.257555683353;9651.420914745067;9732.367396119229;9738.805223895482;9756.4633945133;9758.975307592671;39335.8033209835;39552.80223598864;39706;39721.80139099315;39749.20501589981;3314.1548905029304;3367.44437167867;3912.7456715313415;3933.606639336072;4136.793160342001;30744.980259166845;31480;31890.88381906622;31915.84042079798;31926.20184495383;3238.4656531672244;3286.8520916558814;3303.9174020649434;3323.4350160472777;3417.4019546579248;470980;471975;473079;473828;476562;55997;56391.71804141035;56406;56454.43545564574;56530.717346413;59564.70217648971;59565;59657.701711491165;59810.70094649499;59954.700226498586;15291;15469.922650386676;15504.759619230434;15515.379384824706;15521.301541430437;12445.875541244654;12529.874701253053;12543.12198146121;12564.246145231315;12567.622971310875;13298.667533311746;15649.139297338756;15664.843351566338;15689;15922.283497242652;6293.465055470245;6381.8085457436355;6399.328070552525;6462.741490340428;6477.190351206099;730.2760702579409;764.9158592554815;882.4749274181852;939.1406862720535;1081.9188560857967;29621.851890740407;30196;30367.69632303693;30781;30902.845485772876;830.6386721776047;979.2019504104132;1023.1150055202345;1129.2885482146196;1139.9487023083982;14811.111333320036;15405.22973851303;15438.221120198472;15445.996010259521;15872.047677139408;653950;654418;657705;659007;660212;57351.71324143353;57683.71158144182;57784.999999999156;57869.42130578725;57887;1279.6161151654467;1347.3398034962993;1400.43982407038;1406.8382136054486;1408.1691801836964;26933.96297054291;27274.181774546796;29885.551716723832;29890.47953146474;29890.551641724956;47750.522494776;48158.5184148154;48302.5169748298;48366.516334836204;48375.75812120917;559356;560209.1989540026;565283;566107;567190;36199.457008144374;38763.61236387713;39233.60766392414;39568.40647390234;39835.00412489595;45567.77216113898;46597.767011164724;46883;47359.28961065656;48184.27723584079;38161.80919095387;38199;38278;39413.408798867466;39810.402843956785;38738.891832184905;38740;39000.2199956005;40038.79980600078;40236.59763402446;32342.83828580842;32944.83527582347;32992.340153197285;34434;38034.8098259518;28238.576421353286;34450.594301869234;34613.65386346104;34755.82622086874;34968.475472867416;21264.78735212628;25077.87461062756;25111;25579.744202557737;26141.477170456863 08:24:56 INFO - PROCESS | 1655 | |2;jquery.html;315.65593503081635;345.78561291998966;376.91142581493364;377.2511564544379;405.3838165987699;14983.387727499914;15585.532434026984;20056.799432005675;20777.584448311023;22340.553188936254;17364;20833.791662083375;21288.89355553224;21376.465588360297;21652.783472165273;5805.622634528752;6143.10924915887;6145.692715364236;6147.846303842395;6148.538859585527;4233.851815186469;6034.849128771794;6053.273607167146;6862.142232220973;6862.7598034068815;6578.1448411706415;6741.056252124682;6749.190097188344;6755.729770809162;6872.793816185523;6468.547201695883;6679.198496180441;6714.899276510856;6732.057511948331;6738.22510411304;5559.972200138974;5710.172025056385;5808.390119037483;5815.505682016991;5819.476247137778;26449.471010579873;26662.6000609991;26742.732572674413;26763.732362676317;26789.598156027674;2309.8960546775265;2421.9273421797375;2427.1383658801046;2553.872306384692;3129.9530507042414;10073.294869359148;10583.841242381293;10590.62321898156;15528.456504022419;15856.36574537017;1798.2896755781524;1901.7527721396268;1910.2645481489587;1930.5656227348734;2007.648661484249;118732.40633796863;121518;122353.38823305827;122828.38585807104;124055;11350.602728904449;11375.488103035383;11503.252288601214;11529.020033297096;11720.941395292968;12965;13495.662608434868;13544.59366219015;14254.786178207336;14256.786148207786;7959.681612735426;8017;8353.872227249243;8440;8470.195331443503;8236.752897413087;8251.381146414044;8258.298044666271;8416.326693864476;8418.200270974248;4411.955880441219;4499.572540608637;4516.1419330327135;4577.130345234395;4587.220172570671;1867.915943782533;1915.7126431035456;1917.3001854323072;1917.8588739699856;1925.2876435718874;867.2931560777946;875.4397185801092;917.1424717888796;956.8995255498072;980.068934512202;21505.462363440725;22170.44573885666;22185.889070554545;22188.778112218995;22246.998885050212;902.9638814447349;921.6635927886273;933.9766505837408;954.4082668745423;996.850472429127;11089.778204436028;11449.313041217554;11456.885431145749;11490.827637585442;11498.080153587693;516731;533906;560666;596908.0463793046;599568;129773;134270.3145937076;134292;135687;140683.29658351644;923.9953800230955;932.128459890005;951.0917074194128;954.8472244440856;955.6082006377352;17677.38129165473;19060.237590496225;19299.324523641604;19407.708884367028;19419.708704369164;52757;53413.19880201722;53438.66403339947;53789.73105134449;54051;80657.59671201606;82011;83186.58406707928;84223;84284;6528.37980391862;7875.606219688878;8036.718714844952;8300;8561.88695469585;8230.135835737161;12787;12792.296423696785;13626.727465450835;13733.656658583215;9220.8012958315;11068.612598559012;11146.442677865913;11355;11469;10816.56733730642;10981.176411768989;11325.830112548483;11451.541938322707;11588.768224635629;11233.943830280796;11247.887521124683;11529.423528823358;11548.538058477903;11770.94061534466;7855.175206603224;7882.9605851972665;7985.680572777024;8069.435139540175;8159.79600509992;8788.91211087881;10333.328333658288;10406.895931040593;10459.95400459948;11245.325280483197 08:24:56 INFO - PROCESS | 1655 | |3;mootools.html;1341.1483707845528;1474.8598883106101;1499.1529785671096;1536.815582130144;1853.7034074548067;7719;8574.399792014554;8738.257248133916;8751.562421878913;8933.55332233389;8681.913180868189;8758.036615972238;8763.780905477366;8773.517456539888;8777.824443511126;2364.4443555764383;2377.667126602277;2378.2984019714227;2387.4628208653003;2391.641253811925;2328.2316835444262;2364.0898254172093;2375.833691641577;2377.1679912030736;2377.2630484549845;2333.0667732906804;2351.929442116739;2363.9669883899833;2366.491204391064;2368.7986521145635;2319.7796209360085;2348.835581509295;2349.5888219561507;2356.175338631482;2359.504504054151;2297.310806757966;2326.3137374474572;2332.0671731307443;2332.685087513198;2335.241046659842;8651.913480865174;8689.82620347596;8857.468551886908;8894.110588941054;8901.198892099743;5164.302819119408;5352.464753524655;5352.705601191933;5354.250404943311;5367.651102678314;3585.8386372613295;3595.7842529448317;3667.468217108504;3667.8166091695307;3673.0633688409553;948.5399581203111;1092.3445932440552;1096.714854137922;1097.4019159557981;1129.8757136714955;9815.90184098157;11545.307281563133;11684.357360345177;11689.064874809996;11690.357030363326;4327.653787696977;4421.7789110544345;4564.863054108382;4598.356230127785;4605.792739326738;9139.81720365589;9152.588133534007;9153.725388238363;9162.633494660273;9166.541672916328;5187.403448603459;5191.896162076738;5192.273081768555;5202.92195617066;5204.271402003723;4290.635295999812;4356.76037817923;4501.437320334958;4734.692245004064;4865.0756356292195;3693.9445908311395;3718.5537735471917;3791.6777073949024;3796.2787070457075;3817.408301713239;1133.982990255147;1160.2922217447351;1167.737259116692;1170.7716995185856;1173.4602083041725;793.6428607126701;800.7677773445752;884.9469031858109;928.456852741154;931.5761328595473;5134.871628209325;5432.804525853533;5626.2967129108865;5638.915416268759;5959.731812068468;414.36601998941666;414.991700165995;423.7309308589068;425.4490434886829;442.52649664858933;3751.2309976454762;3928.253631809947;3938.1729836734035;4040.5151381834366;4072.6131017553284;10246.6413675521;10757.78484430307;10766.56933722658;10768.784624307627;10858;10339.276250662531;10762.730931726614;10767.78464430707;10773.83839242412;10781.299215550964;7986.760397187977;8224.013118425828;8231.4649547778;8234.258916697527;8235.38234632393;5649.745761440663;5803.7968671096305;5825.854353641193;5874.060150375919;5892.970535147297;9891.010898910052;9953.800923981624;9982.60069597208;10008.44953527563;10043.196544276294;9133.31500137479;9295.349325547148;9677.225821934087;10328;10334.966503349606;5730;6625.17185351831;6977.825554361181;7096.396806271318;7174.497785154989;8301.252887240178;8320.958395207985;8327.042390125212;8401.075881653136;8420.031696354998;7455.440841936768;7460.216677248811;7525.17223105447;7554.773356799305;7632.771016869503;7283.635818209174;7294.452916031213;7362.079550389033;7369.96315018443;7443.292887175709;6936.583804971718;6959.721611135498;7031.718731250693;7037.049998250171;7046.330598593126;4435.756033418063;4964;4992.825251116194;4994.775235114501;5018.146915024382;4295.441592593068;4987.251912213052;5006.424261210008;5148.1248187808915;5233.39815921174 08:24:56 INFO - PROCESS | 1655 | |4;prototype.html;260.27643152037336;262.8134024842363;301.34006525708685;309.2809218566832;314.5093653899915;5055.974720126404;5212.706409179958;5300.257963885059;5316.5215130638235;5341.465853414652;4260.913467065901;4568.281872285985;5069.251108367616;5192.454792246807;5251.107311757001;3630.0017495188904;3902.2780785554764;3942.1327307992196;4067.227226826908;4067.8576249831262;3951.9407208891744;4079.4900637420324;4087.550369459357;4104.076582768883;4105.220008198433;3370.5112758650102;4031.2743706132883;4041.939370909439;4052.696047796412;4064.5732198119217;4044.6157615026527;4054.5337286212166;4067.715259931806;4075.2069089600777;4088.632023117934;3532.028692109665;3551.875684351061;3554.608993010767;3566.5006899034156;3581.7313701472494;4404.097160082176;4823.660524645544;4915.5330243626795;5096.298961550384;5122.8463146105305;4633.293365307741;4635.69867958585;4642;4647.581717645428;4666.603338716213;4171.933628782842;4572.839950601713;4621.37611422457;5525.198846167324;5564.219449776073;3756.7602691112143;3877.379619260933;3914.2758589661003;3916.2559113768293;3922.313595120871;4780.972091000452;5748.511376532958;5752.252207213036;5770.7691692332255;5776.249087618625;3499.7900125992523;3566.3045706087064;3748.981255093707;3906.7265291429894;3958.762474251554;3775.565809931838;3900.941485877714;3996.460477835455;4000.2799496090984;4013.177298653769;3966.305896468164;4075.8573449929704;4170.791460427027;4607.953920460753;4615.815367385267;4723.669343145947;4871.878203044881;5590.944090559124;5595.888082238333;5616.410276920946;1221.3038568016145;1289.1620446709526;1340.6782372230593;1352.2157148853642;1376.3599926034442;844.3456321351002;910.9453432794054;924.4961495984704;938.7746940734311;939.2201777631486;4507.90382472152;5039.0929632666475;5081.466446023188;5149.897002059938;5197.29836472079;4733.231059830038;4787.4494433139935;5349.973250133802;5657.80197693087;5658.405867383948;4867.756612169377;4876.171050921352;5092.772998411309;5106.259592359087;5141.562967147759;2531.4430825218424;2936.588877557144;2996.4456575533595;3025.9546106807975;3034.484137696597;4635.397398338195;5220.582353411718;5948.7323070461935;5949.25634295713;5963.850903727354;5136.5890728741615;5701.756561682976;5770.711464426762;5886.117082437669;5915.674637894957;5232.476752324737;5262.50006249421;5419.918701219485;5896.2016584942;5903.162944086293;4851.878703032452;4977.9751101244265;5727.742251598771;5768.798092066758;5796.275465566804;4751.50109238525;5293.788248470172;5424;5729.28383952006;5772.682502462405;4521.2087884619405;5406.648567843077;5957.49361304294;5995.310539288038;6057;3470.3689266044917;3900.6294402031763;4043.6950937965075;4071.959280407158;4074.3073677475495;4845.563899249085;5087.974560127176;5415.891682166256;5715.771369145187;5740.569457290637;5378.327709036371;5486.369067557282;5530.253415788817;5572.832815015556;5668.404817494104;4747.667663263676;5617.230572369691;5646.576506761927;5660.575456840836;5663.405342438985;4360.585744354281;4776.641751868554;5168.870778230575;5527.336719593674;5580.218769372373;5017.899642007213;5359.812406565751;5634.464725851038;5644.8024319148635;5673.77304907799;4519.38988236597;5369.617141201018;5502.8349149525575;5537.141743029837;5540.889182216414 08:24:56 INFO - PROCESS | 1655 | |5;yui.html;729.7810656802961;731.8792399254123;777.9144294127649;833.5040650812766;836;15191.240437978098;16257.430989915356;16261.268242929067;16262.674746505092;16293.511194664165;14505.564833055;14640.4875829346;14669.706605867903;14680.926595367035;14704.117752934832;672.5393105722571;692.8960655901604;830.6303694855792;839.8068444257824;858.7638399440142;856.4689892266804;860.7761981884723;863.3999370437548;869.7564681889081;872.1278721278721;887.60057973912;888.2760550151638;890.1810334492251;890.8396488632044;891.0510306523564;706.6502081469705;884.1423818895661;884.4383816276646;885.1325700813206;886.7428445750725;661.8775526527608;673.7944926797325;676.6109487044969;678.8065401360637;680.3774546290188;14752.3361448734;14791.33438995237;14792.260386980715;14806.777898331533;14810;13683.452661893512;13897.720856981596;14176.858231417656;14178.14931104137;14313.57059288223;12716.491340346374;12750.936245318806;12758.36208189596;12938.094333396666;13075.738485230242;4219.261629214906;4220.2192594369835;4312.482502099737;4340.587644173798;4406.361077643755;114484;114705;114849;114946.42526787313;115105.42447287793;10964.232503724823;11012.834807477733;11014.44927753609;11116.166287528467;11434.133550520979;22355.21756738539;22371.552568948857;22375.88812055929;22389.44026399353;22474;7847.84304313922;7930;7963.8805417918775;8137.877931831027;8168.142345053802;4339.609435150788;4427;4458.331250312479;4489.88775280614;4504.909901801946;3309.7352211822995;3377.67912048355;3451.050960985699;3492.738044646662;3507.3511400391008;661.503872095928;665.1087542692718;667.1027468055457;669.4075742967509;681.918169819615;525.6163001009285;549.9670019798825;576.5089949294945;577.8642019125502;587.4389957590491;7527.021487206628;8348.165183481724;9127.954360228288;9262.259019278576;9294.535273236312;601.1613798750718;626.6240255846546;636.9745210191633;639.8880195965687;649.1917562634455;4289.656827453796;4495.393121928563;4504.144212599661;4578.381918441034;4633.235516139866;92453.23139764437;123020;131096;156936;168396.1603839606;105919;141435;142445.28777356047;143967;145130;105189.47405262924;118368;120113;121705.39147304207;122829;8795.208431241219;8802.207801297915;8815.206631403205;8849.646014159362;8978.236849867573;67464.6626766863;67522.66238668775;67678.32321676917;68076.6596167016;68519;79072.20927790648;79940.60029699815;100573.49713251388;102098.46852297072;108663;13152.079354445097;13379.264140472367;13541.729165416833;13766.24285664258;13985.58043258704;14819.40722371093;15039.548813535612;15059.397624094914;15190.72791800047;15375.073188642911;11261.49323280438;11299.774004519699;11613.477393517143;11755.177137600285;14063.437462501386;11046.889531104585;12111.212771170198;12418.068644851492;14128.646783830487;14602.488912887999;13695.657608559866;13721.519746808814;14107.153570785786;14110.647233818827;14168.079074860101;10880.891191088305;11005;11311.547538098384;11482.598109066477;11513.400754148654;10049.346792458759;10475.952404759462;11341.319520828776;11389.829152562885;11488.655340339803 08:24:56 INFO - PROCESS | 1655 | __end_tp_report 08:24:56 INFO - PROCESS | 1655 | __start_cc_report 08:24:56 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1306 08:24:56 INFO - PROCESS | 1655 | __end_cc_report 08:24:56 INFO - PROCESS | 1655 | __startTimestamp1472052296204__endTimestamp 08:24:56 INFO - PROCESS | 1655 | 08:24:56 INFO - PROCESS | 1655 | ------- Summary: start ------- 08:24:56 INFO - PROCESS | 1655 | Number of tests: 6 08:24:56 INFO - PROCESS | 1655 | 08:24:56 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5726.06 Median:5926.11 stddev:648.47 (10.9%) stddev-sans-first:607.47 08:24:56 INFO - PROCESS | 1655 | Values: 2766.3 3305.7 3339.1 3377.5 3393.0 5587.7 5589.8 5661.9 5699.9 5752.3 5658.5 5696.9 5707.1 5707.8 5709.5 5181.4 5206.6 5219.2 5241.1 5285.9 5234.0 5257.2 5260.5 5263.9 5270.9 5172.4 5177.9 5191.2 5207.7 5239.3 5263.4 5285.0 5301.3 5302.3 5350.1 5097.9 5104.6 5114.0 5220.4 5224.7 5567.9 5570.6 5614.4 5624.1 5634.6 6216.0 6236.0 6242.5 6246.9 6257.1 6095.3 6204.4 6232.2 6259.7 6297.9 5762.3 5798.2 5835.4 5839.6 5887.0 5208.7 6316.3 6324.0 6331.5 6339.4 5946.5 6017.6 6086.8 6121.8 6172.6 6229.7 6285.2 6300.5 6302.2 6307.9 5666.0 5754.3 6192.8 6206.6 6232.8 6078.2 6130.2 6207.8 6250.2 6254.0 4893.8 4964.2 4984.4 4993.9 4995.7 4445.4 4463.2 4468.3 4474.5 4503.1 5542.4 5593.4 5668.5 5691.9 5718.8 5054.2 6237.5 6254.4 6306.6 6318.4 5689.6 5691.3 5691.4 5714.2 5741.6 5287.8 5428.0 5431.8 5441.5 5451.4 6229.4 6269.7 6284.8 6302.3 6303.1 6291.1 6298.6 6307.3 6307.7 6317.7 6254.2 6268.7 6288.2 6300.5 6308.1 5965.0 6104.3 6116.6 6119.7 6138.4 6299.8 6317.6 6329.0 6330.0 6340.5 6101.0 6113.0 6134.8 6143.1 6146.5 5990.0 6040.7 6057.5 6089.9 6154.4 5967.7 5975.9 5988.1 5992.4 6014.3 5906.7 6123.8 6143.6 6149.2 6174.2 5796.9 5867.1 5926.1 5949.6 6007.6 08:24:56 INFO - PROCESS | 1655 | 08:24:56 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:69619.76 Median:40587.80 stddev:152254.23 (375.1%) stddev-sans-first:152592.74 08:24:56 INFO - PROCESS | 1655 | Values: 435.3 460.5 473.1 481.7 540.5 30811.2 32200.7 39646.8 40939.0 40998.8 41869.4 42252.9 42307.2 42324.6 42445.0 9655.5 9815.2 9829.3 9837.9 9840.2 9734.7 9845.6 9860.4 9869.6 9874.5 9793.0 9868.7 9869.9 9874.1 9898.9 9785.5 9841.9 9865.5 9877.9 9899.3 9651.4 9732.4 9738.8 9756.5 9759.0 39335.8 39552.8 39706.0 39721.8 39749.2 3314.2 3367.4 3912.7 3933.6 4136.8 30745.0 31480.0 31890.9 31915.8 31926.2 3238.5 3286.9 3303.9 3323.4 3417.4 470980.0 471975.0 473079.0 473828.0 476562.0 55997.0 56391.7 56406.0 56454.4 56530.7 59564.7 59565.0 59657.7 59810.7 59954.7 15291.0 15469.9 15504.8 15515.4 15521.3 12445.9 12529.9 12543.1 12564.2 12567.6 13298.7 15649.1 15664.8 15689.0 15922.3 6293.5 6381.8 6399.3 6462.7 6477.2 730.3 764.9 882.5 939.1 1081.9 29621.9 30196.0 30367.7 30781.0 30902.8 830.6 979.2 1023.1 1129.3 1139.9 14811.1 15405.2 15438.2 15446.0 15872.0 653950.0 654418.0 657705.0 659007.0 660212.0 57351.7 57683.7 57785.0 57869.4 57887.0 1279.6 1347.3 1400.4 1406.8 1408.2 26934.0 27274.2 29885.6 29890.5 29890.6 47750.5 48158.5 48302.5 48366.5 48375.8 559356.0 560209.2 565283.0 566107.0 567190.0 36199.5 38763.6 39233.6 39568.4 39835.0 45567.8 46597.8 46883.0 47359.3 48184.3 38161.8 38199.0 38278.0 39413.4 39810.4 38738.9 38740.0 39000.2 40038.8 40236.6 32342.8 32944.8 32992.3 34434.0 38034.8 28238.6 34450.6 34613.7 34755.8 34968.5 21264.8 25077.9 25111.0 25579.7 26141.5 08:24:56 INFO - PROCESS | 1655 | 08:24:56 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34572.32 Median:14959.78 stddev:94590.19 (632.3%) stddev-sans-first:94820.57 08:24:56 INFO - PROCESS | 1655 | Values: 315.7 345.8 376.9 377.3 405.4 14983.4 15585.5 20056.8 20777.6 22340.6 17364.0 20833.8 21288.9 21376.5 21652.8 5805.6 6143.1 6145.7 6147.8 6148.5 4233.9 6034.8 6053.3 6862.1 6862.8 6578.1 6741.1 6749.2 6755.7 6872.8 6468.5 6679.2 6714.9 6732.1 6738.2 5560.0 5710.2 5808.4 5815.5 5819.5 26449.5 26662.6 26742.7 26763.7 26789.6 2309.9 2421.9 2427.1 2553.9 3130.0 10073.3 10583.8 10590.6 15528.5 15856.4 1798.3 1901.8 1910.3 1930.6 2007.6 118732.4 121518.0 122353.4 122828.4 124055.0 11350.6 11375.5 11503.3 11529.0 11720.9 12965.0 13495.7 13544.6 14254.8 14256.8 7959.7 8017.0 8353.9 8440.0 8470.2 8236.8 8251.4 8258.3 8416.3 8418.2 4412.0 4499.6 4516.1 4577.1 4587.2 1867.9 1915.7 1917.3 1917.9 1925.3 867.3 875.4 917.1 956.9 980.1 21505.5 22170.4 22185.9 22188.8 22247.0 903.0 921.7 934.0 954.4 996.9 11089.8 11449.3 11456.9 11490.8 11498.1 516731.0 533906.0 560666.0 596908.0 599568.0 129773.0 134270.3 134292.0 135687.0 140683.3 924.0 932.1 951.1 954.8 955.6 17677.4 19060.2 19299.3 19407.7 19419.7 52757.0 53413.2 53438.7 53789.7 54051.0 80657.6 82011.0 83186.6 84223.0 84284.0 6528.4 7875.6 8036.7 8300.0 8561.9 8230.1 12787.0 12792.3 13626.7 13733.7 9220.8 11068.6 11146.4 11355.0 11469.0 10816.6 10981.2 11325.8 11451.5 11588.8 11233.9 11247.9 11529.4 11548.5 11770.9 7855.2 7883.0 7985.7 8069.4 8159.8 8788.9 10333.3 10406.9 10460.0 11245.3 08:24:56 INFO - PROCESS | 1655 | 08:24:56 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5602.83 Median:4990.04 stddev:3170.47 (63.5%) stddev-sans-first:3163.19 08:24:56 INFO - PROCESS | 1655 | Values: 1341.1 1474.9 1499.2 1536.8 1853.7 7719.0 8574.4 8738.3 8751.6 8933.6 8681.9 8758.0 8763.8 8773.5 8777.8 2364.4 2377.7 2378.3 2387.5 2391.6 2328.2 2364.1 2375.8 2377.2 2377.3 2333.1 2351.9 2364.0 2366.5 2368.8 2319.8 2348.8 2349.6 2356.2 2359.5 2297.3 2326.3 2332.1 2332.7 2335.2 8651.9 8689.8 8857.5 8894.1 8901.2 5164.3 5352.5 5352.7 5354.3 5367.7 3585.8 3595.8 3667.5 3667.8 3673.1 948.5 1092.3 1096.7 1097.4 1129.9 9815.9 11545.3 11684.4 11689.1 11690.4 4327.7 4421.8 4564.9 4598.4 4605.8 9139.8 9152.6 9153.7 9162.6 9166.5 5187.4 5191.9 5192.3 5202.9 5204.3 4290.6 4356.8 4501.4 4734.7 4865.1 3693.9 3718.6 3791.7 3796.3 3817.4 1134.0 1160.3 1167.7 1170.8 1173.5 793.6 800.8 884.9 928.5 931.6 5134.9 5432.8 5626.3 5638.9 5959.7 414.4 415.0 423.7 425.4 442.5 3751.2 3928.3 3938.2 4040.5 4072.6 10246.6 10757.8 10766.6 10768.8 10858.0 10339.3 10762.7 10767.8 10773.8 10781.3 7986.8 8224.0 8231.5 8234.3 8235.4 5649.7 5803.8 5825.9 5874.1 5893.0 9891.0 9953.8 9982.6 10008.4 10043.2 9133.3 9295.3 9677.2 10328.0 10335.0 5730.0 6625.2 6977.8 7096.4 7174.5 8301.3 8321.0 8327.0 8401.1 8420.0 7455.4 7460.2 7525.2 7554.8 7632.8 7283.6 7294.5 7362.1 7370.0 7443.3 6936.6 6959.7 7031.7 7037.0 7046.3 4435.8 4964.0 4992.8 4994.8 5018.1 4295.4 4987.3 5006.4 5148.1 5233.4 08:24:56 INFO - PROCESS | 1655 | 08:24:56 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4463.51 Median:4859.82 stddev:1346.60 (27.7%) stddev-sans-first:1312.90 08:24:56 INFO - PROCESS | 1655 | Values: 260.3 262.8 301.3 309.3 314.5 5056.0 5212.7 5300.3 5316.5 5341.5 4260.9 4568.3 5069.3 5192.5 5251.1 3630.0 3902.3 3942.1 4067.2 4067.9 3951.9 4079.5 4087.6 4104.1 4105.2 3370.5 4031.3 4041.9 4052.7 4064.6 4044.6 4054.5 4067.7 4075.2 4088.6 3532.0 3551.9 3554.6 3566.5 3581.7 4404.1 4823.7 4915.5 5096.3 5122.8 4633.3 4635.7 4642.0 4647.6 4666.6 4171.9 4572.8 4621.4 5525.2 5564.2 3756.8 3877.4 3914.3 3916.3 3922.3 4781.0 5748.5 5752.3 5770.8 5776.2 3499.8 3566.3 3749.0 3906.7 3958.8 3775.6 3900.9 3996.5 4000.3 4013.2 3966.3 4075.9 4170.8 4608.0 4615.8 4723.7 4871.9 5590.9 5595.9 5616.4 1221.3 1289.2 1340.7 1352.2 1376.4 844.3 910.9 924.5 938.8 939.2 4507.9 5039.1 5081.5 5149.9 5197.3 4733.2 4787.4 5350.0 5657.8 5658.4 4867.8 4876.2 5092.8 5106.3 5141.6 2531.4 2936.6 2996.4 3026.0 3034.5 4635.4 5220.6 5948.7 5949.3 5963.9 5136.6 5701.8 5770.7 5886.1 5915.7 5232.5 5262.5 5419.9 5896.2 5903.2 4851.9 4978.0 5727.7 5768.8 5796.3 4751.5 5293.8 5424.0 5729.3 5772.7 4521.2 5406.6 5957.5 5995.3 6057.0 3470.4 3900.6 4043.7 4072.0 4074.3 4845.6 5088.0 5415.9 5715.8 5740.6 5378.3 5486.4 5530.3 5572.8 5668.4 4747.7 5617.2 5646.6 5660.6 5663.4 4360.6 4776.6 5168.9 5527.3 5580.2 5017.9 5359.8 5634.5 5644.8 5673.8 4519.4 5369.6 5502.8 5537.1 5540.9 08:24:56 INFO - PROCESS | 1655 | 08:24:56 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:25251.03 Median:22431.72 stddev:40348.08 (179.9%) stddev-sans-first:40419.26 08:24:56 INFO - PROCESS | 1655 | Values: 729.8 731.9 777.9 833.5 836.0 15191.2 16257.4 16261.3 16262.7 16293.5 14505.6 14640.5 14669.7 14680.9 14704.1 672.5 692.9 830.6 839.8 858.8 856.5 860.8 863.4 869.8 872.1 887.6 888.3 890.2 890.8 891.1 706.7 884.1 884.4 885.1 886.7 661.9 673.8 676.6 678.8 680.4 14752.3 14791.3 14792.3 14806.8 14810.0 13683.5 13897.7 14176.9 14178.1 14313.6 12716.5 12750.9 12758.4 12938.1 13075.7 4219.3 4220.2 4312.5 4340.6 4406.4 114484.0 114705.0 114849.0 114946.4 115105.4 10964.2 11012.8 11014.4 11116.2 11434.1 22355.2 22371.6 22375.9 22389.4 22474.0 7847.8 7930.0 7963.9 8137.9 8168.1 4339.6 4427.0 4458.3 4489.9 4504.9 3309.7 3377.7 3451.1 3492.7 3507.4 661.5 665.1 667.1 669.4 681.9 525.6 550.0 576.5 577.9 587.4 7527.0 8348.2 9128.0 9262.3 9294.5 601.2 626.6 637.0 639.9 649.2 4289.7 4495.4 4504.1 4578.4 4633.2 92453.2 123020.0 131096.0 156936.0 168396.2 105919.0 141435.0 142445.3 143967.0 145130.0 105189.5 118368.0 120113.0 121705.4 122829.0 8795.2 8802.2 8815.2 8849.6 8978.2 67464.7 67522.7 67678.3 68076.7 68519.0 79072.2 79940.6 100573.5 102098.5 108663.0 13152.1 13379.3 13541.7 13766.2 13985.6 14819.4 15039.5 15059.4 15190.7 15375.1 11261.5 11299.8 11613.5 11755.2 14063.4 11046.9 12111.2 12418.1 14128.6 14602.5 13695.7 13721.5 14107.2 14110.6 14168.1 10880.9 11005.0 11311.5 11482.6 11513.4 10049.3 10476.0 11341.3 11389.8 11488.7 08:24:56 INFO - PROCESS | 1655 | -------- Summary: end -------- 08:24:56 INFO - PROCESS | 1655 | 08:24:56 INFO - TEST-INFO | 1655: exit 0 08:24:56 INFO - TEST-OK | dromaeo_css | took 1117229ms 08:24:56 INFO - TEST-START | kraken 08:24:56 INFO - operating with platform_type : mac_ 08:24:56 INFO - Initialising browser for kraken test... 08:24:56 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpzDD0QI/profile http://localhost:49266/getInfo.html) 08:24:59 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 08:24:59 INFO - PROCESS | 1661 | colorDepth:24 08:24:59 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 08:24:59 INFO - PROCESS | 1661 | __metrics 08:24:59 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:24:59 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:59 INFO - TEST-INFO | 1661: exit 0 08:24:59 INFO - Browser initialized. 08:24:59 INFO - Running cycle 1/1 for kraken test... 08:24:59 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpzDD0QI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:11 INFO - PROCESS | 1662 | RSS: Main: 234885120 08:25:11 INFO - PROCESS | 1662 | 08:25:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:15 INFO - PROCESS | 1662 | RSS: Main: 294400000 08:25:15 INFO - PROCESS | 1662 | 08:25:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 08:25:18 INFO - PROCESS | 1662 | RSS: Main: 290299904 08:25:18 INFO - PROCESS | 1662 | 08:25:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 08:25:22 INFO - PROCESS | 1662 | RSS: Main: 379224064 08:25:22 INFO - PROCESS | 1662 | 08:25:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 08:25:25 INFO - PROCESS | 1662 | RSS: Main: 280858624 08:25:25 INFO - PROCESS | 1662 | 08:25:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:28 INFO - PROCESS | 1662 | RSS: Main: 285360128 08:25:28 INFO - PROCESS | 1662 | 08:25:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:31 INFO - PROCESS | 1662 | RSS: Main: 324587520 08:25:31 INFO - PROCESS | 1662 | 08:25:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:35 INFO - PROCESS | 1662 | RSS: Main: 326680576 08:25:35 INFO - PROCESS | 1662 | 08:25:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 08:25:38 INFO - PROCESS | 1662 | RSS: Main: 323665920 08:25:38 INFO - PROCESS | 1662 | 08:25:40 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:40 INFO - PROCESS | 1662 | RSS: Main: 300957696 08:25:40 INFO - PROCESS | 1662 | 08:25:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:43 INFO - PROCESS | 1662 | RSS: Main: 306884608 08:25:43 INFO - PROCESS | 1662 | 08:25:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:46 INFO - PROCESS | 1662 | RSS: Main: 309256192 08:25:46 INFO - PROCESS | 1662 | 08:25:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:49 INFO - PROCESS | 1662 | RSS: Main: 314494976 08:25:49 INFO - PROCESS | 1662 | 08:25:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:53 INFO - PROCESS | 1662 | RSS: Main: 315793408 08:25:53 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 08:25:55 INFO - PROCESS | 1662 | RSS: Main: 358916096 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | __start_tp_report 08:25:55 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 08:25:55 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 08:25:55 INFO - PROCESS | 1662 | |i|pagename|runs| 08:25:55 INFO - PROCESS | 1662 | |0;ai-astar;114;113;114;111;113;113;112;113;114;120 08:25:55 INFO - PROCESS | 1662 | |1;audio-beat-detection;143;107;130;158;108;127;129;107;159;107 08:25:55 INFO - PROCESS | 1662 | |2;audio-dft;187;183;183;182;184;182;186;183;174;185 08:25:55 INFO - PROCESS | 1662 | |3;audio-fft;78;72;75;149;58;57;57;69;139;57 08:25:55 INFO - PROCESS | 1662 | |4;audio-oscillator;84;83;136;71;78;80;115;70;69;120 08:25:55 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;88;86;89;86;89;84;90;86;89;85 08:25:55 INFO - PROCESS | 1662 | |6;imaging-darkroom;127;147;93;102;150;126;94;95;93;93 08:25:55 INFO - PROCESS | 1662 | |7;imaging-desaturate;89;86;84;87;84;84;85;85;87;86 08:25:55 INFO - PROCESS | 1662 | |8;json-parse-financial;55;56;57;57;54;56;54;55;55;54 08:25:55 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;70;66;67;72;73;78;71;70;69;70 08:25:55 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;85;85;84;86;89;86;88;90;84;84 08:25:55 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;138;138;135;140;147;149;134;143;176;149 08:25:55 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;171;172;169;166;171;229;177;168;168;167 08:25:55 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;66;67;67;68;68;66;67;67;65;66 08:25:55 INFO - PROCESS | 1662 | __end_tp_report 08:25:55 INFO - PROCESS | 1662 | __start_cc_report 08:25:55 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2093 08:25:55 INFO - PROCESS | 1662 | __end_cc_report 08:25:55 INFO - PROCESS | 1662 | __startTimestamp1472052355265__endTimestamp 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | ------- Summary: start ------- 08:25:55 INFO - PROCESS | 1662 | Number of tests: 14 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:113.70 Median:113.50 stddev:2.41 (2.1%) stddev-sans-first:2.55 08:25:55 INFO - PROCESS | 1662 | Values: 114.0 113.0 114.0 111.0 113.0 113.0 112.0 113.0 114.0 120.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:129.50 stddev:20.58 (15.9%) stddev-sans-first:21.05 08:25:55 INFO - PROCESS | 1662 | Values: 143.0 107.0 130.0 158.0 108.0 127.0 129.0 107.0 159.0 107.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:3.54 (1.9%) stddev-sans-first:3.43 08:25:55 INFO - PROCESS | 1662 | Values: 187.0 183.0 183.0 182.0 184.0 182.0 186.0 183.0 174.0 185.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:81.10 Median:63.50 stddev:34.18 (53.8%) stddev-sans-first:36.24 08:25:55 INFO - PROCESS | 1662 | Values: 78.0 72.0 75.0 149.0 58.0 57.0 57.0 69.0 139.0 57.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:74.50 stddev:23.96 (32.2%) stddev-sans-first:25.30 08:25:55 INFO - PROCESS | 1662 | Values: 84.0 83.0 136.0 71.0 78.0 80.0 115.0 70.0 69.0 120.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.50 stddev:2.04 (2.3%) stddev-sans-first:2.15 08:25:55 INFO - PROCESS | 1662 | Values: 88.0 86.0 89.0 86.0 89.0 84.0 90.0 86.0 89.0 85.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:112.00 Median:93.00 stddev:23.30 (25.1%) stddev-sans-first:24.07 08:25:55 INFO - PROCESS | 1662 | Values: 127.0 147.0 93.0 102.0 150.0 126.0 94.0 95.0 93.0 93.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.64 (1.9%) stddev-sans-first:1.22 08:25:55 INFO - PROCESS | 1662 | Values: 89.0 86.0 84.0 87.0 84.0 84.0 85.0 85.0 87.0 86.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.16 (2.1%) stddev-sans-first:1.22 08:25:55 INFO - PROCESS | 1662 | Values: 55.0 56.0 57.0 57.0 54.0 56.0 54.0 55.0 55.0 54.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.50 stddev:3.34 (4.7%) stddev-sans-first:3.54 08:25:55 INFO - PROCESS | 1662 | Values: 70.0 66.0 67.0 72.0 73.0 78.0 71.0 70.0 69.0 70.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:2.18 (2.5%) stddev-sans-first:2.28 08:25:55 INFO - PROCESS | 1662 | Values: 85.0 85.0 84.0 86.0 89.0 86.0 88.0 90.0 84.0 84.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:145.00 stddev:12.22 (8.4%) stddev-sans-first:12.71 08:25:55 INFO - PROCESS | 1662 | Values: 138.0 138.0 135.0 140.0 147.0 149.0 134.0 143.0 176.0 149.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:171.00 stddev:18.95 (11.1%) stddev-sans-first:20.02 08:25:55 INFO - PROCESS | 1662 | Values: 171.0 172.0 169.0 166.0 171.0 229.0 177.0 168.0 168.0 167.0 08:25:55 INFO - PROCESS | 1662 | 08:25:55 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 08:25:55 INFO - PROCESS | 1662 | Values: 66.0 67.0 67.0 68.0 68.0 66.0 67.0 67.0 65.0 66.0 08:25:55 INFO - PROCESS | 1662 | -------- Summary: end -------- 08:25:55 INFO - PROCESS | 1662 | 08:25:56 INFO - TEST-INFO | 1662: exit 0 08:25:56 INFO - TEST-OK | kraken | took 59367ms 08:25:56 INFO - SUITE-END | took 1176s 08:25:56 INFO - Completed test suite (00:19:36) 08:25:56 INFO - javascript benchmark 08:25:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2766.3360793409583, 3305.7355411567078, 3339.0984434202765, 3377.5271461995308, 3393.032985599103, 5587.7485513151905, 5589.776408943642, 5661.8584535386635, 5699.943000569993, 5752.338481074672, 5658.462446067617, 5696.914546281809, 5707.14392841074, 5707.77168913244, 5709.486146246837, 5181.378234611842, 5206.609504287194, 5219.243209734605, 5241.056609810233, 5285.947140528584, 5234.0, 5257.23770053342, 5260.500252476008, 5263.947210557884, 5270.947290527084, 5172.40517340505, 5177.896442071156, 5191.221316802472, 5207.713575753332, 5239.266502689627, 5263.36839579253, 5284.973575132119, 5301.3373328333955, 5302.257683924254, 5350.0904846176245, 5097.898042039175, 5104.591632669378, 5114.028334616411, 5220.399654039796, 5224.738763061831, 5567.916481252784, 5570.610057295991, 5614.354349249807, 5624.128260119647, 5634.577406694514, 6216.036514340284, 6235.968820155916, 6242.469390101847, 6246.906296405557, 6257.061440783873, 6095.347660937622, 6204.441600255954, 6232.189815323979, 6259.749610015594, 6297.937020629826, 5762.250907382014, 5798.246227990334, 5835.416458354215, 5839.620424672383, 5887.0, 5208.661437006583, 6316.336784637547, 6324.019776934582, 6331.461825744771, 6339.366063393716, 5946.494547963385, 6017.638941663514, 6086.817395478142, 6121.8200435426415, 6172.598781079216, 6229.657368844757, 6285.151504546919, 6300.495960323163, 6302.212223472066, 6307.873842523124, 5666.008448521575, 5754.251947246915, 6192.752289908353, 6206.627602343874, 6232.844178895564, 6078.240219972504, 6130.153553065376, 6207.844803879939, 6250.1874756281395, 6254.0, 4893.828715994923, 4964.230544265644, 4984.352034235599, 4993.90012199754, 4995.725235112031, 4445.3998710174355, 4463.174312752151, 4468.285074388147, 4474.530174331713, 4503.121891231179, 5542.39033706292, 5593.356763972114, 5668.51817595509, 5691.886162276731, 5718.771249149988, 5054.21659642756, 6237.532185086136, 6254.3745625438005, 6306.558540902093, 6318.4313411793155, 5689.573282003867, 5691.345495268097, 5691.402402747652, 5714.228579141846, 5741.62679425836, 5287.841364759063, 5427.972860135674, 5431.755570999315, 5441.5102640762525, 5451.4276001019325, 6229.3770622937345, 6269.749210031548, 6284.811455656338, 6302.3067462578165, 6303.086052522359, 6291.056341548621, 6298.559100863079, 6307.274663413583, 6307.7476900925285, 6317.684115794284, 6254.21822272216, 6268.749250029948, 6288.245410550763, 6300.464460520724, 6308.148399965946, 5965.0, 6104.3075792339105, 6116.633002019893, 6119.663418511846, 6138.419052470106, 6299.779507717208, 6317.5893566918, 6329.019002054689, 6329.968350158219, 6340.461060809883, 6101.0, 6113.02191649334, 6134.846628834136, 6143.078538219303, 6146.477549408171, 5990.0, 6040.667763272886, 6057.545684073801, 6089.939100608937, 6154.446099850856, 5967.731452084579, 5975.850603734942, 5988.101784732325, 5992.370801065999, 6014.308354539109, 5906.70466476683, 6123.8162855114415, 6143.631382116909, 6149.169862068564, 6174.228221472316, 5796.913046304393, 5867.061270196748, 5926.111083337534, 5949.6430214187285, 6007.639541627516], "value": 5683.593109337477, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.27743945051213, 460.4957571459253, 473.13888722524973, 481.6989381636477, 540.5324394398845, 30811.22971925703, 32200.67799322009, 39646.80176599113, 40939.0, 40998.79500602493, 41869.371959420634, 42252.94367640803, 42307.15385692284, 42324.57675423245, 42445.0, 9655.517224138783, 9815.214782817393, 9829.311948163631, 9837.90162098377, 9840.212782977345, 9734.707958761248, 9845.55694993727, 9860.408375497493, 9869.555869985832, 9874.456904870229, 9793.0, 9868.654597089104, 9869.901300987007, 9874.061964113398, 9898.901010989906, 9785.461799601018, 9841.901580984206, 9865.457399843006, 9877.851832222523, 9899.257555683353, 9651.420914745067, 9732.367396119229, 9738.805223895482, 9756.4633945133, 9758.975307592671, 39335.8033209835, 39552.80223598864, 39706.0, 39721.80139099315, 39749.20501589981, 3314.1548905029304, 3367.44437167867, 3912.7456715313415, 3933.606639336072, 4136.793160342001, 30744.980259166845, 31480.0, 31890.88381906622, 31915.84042079798, 31926.20184495383, 3238.4656531672244, 3286.8520916558814, 3303.9174020649434, 3323.4350160472777, 3417.4019546579248, 470980.0, 471975.0, 473079.0, 473828.0, 476562.0, 55997.0, 56391.71804141035, 56406.0, 56454.43545564574, 56530.717346413, 59564.70217648971, 59565.0, 59657.701711491165, 59810.70094649499, 59954.700226498586, 15291.0, 15469.922650386676, 15504.759619230434, 15515.379384824706, 15521.301541430437, 12445.875541244654, 12529.874701253053, 12543.12198146121, 12564.246145231315, 12567.622971310875, 13298.667533311746, 15649.139297338756, 15664.843351566338, 15689.0, 15922.283497242652, 6293.465055470245, 6381.8085457436355, 6399.328070552525, 6462.741490340428, 6477.190351206099, 730.2760702579409, 764.9158592554815, 882.4749274181852, 939.1406862720535, 1081.9188560857967, 29621.851890740407, 30196.0, 30367.69632303693, 30781.0, 30902.845485772876, 830.6386721776047, 979.2019504104132, 1023.1150055202345, 1129.2885482146196, 1139.9487023083982, 14811.111333320036, 15405.22973851303, 15438.221120198472, 15445.996010259521, 15872.047677139408, 653950.0, 654418.0, 657705.0, 659007.0, 660212.0, 57351.71324143353, 57683.71158144182, 57784.999999999156, 57869.42130578725, 57887.0, 1279.6161151654467, 1347.3398034962993, 1400.43982407038, 1406.8382136054486, 1408.1691801836964, 26933.96297054291, 27274.181774546796, 29885.551716723832, 29890.47953146474, 29890.551641724956, 47750.522494776, 48158.5184148154, 48302.5169748298, 48366.516334836204, 48375.75812120917, 559356.0, 560209.1989540026, 565283.0, 566107.0, 567190.0, 36199.457008144374, 38763.61236387713, 39233.60766392414, 39568.40647390234, 39835.00412489595, 45567.77216113898, 46597.767011164724, 46883.0, 47359.28961065656, 48184.27723584079, 38161.80919095387, 38199.0, 38278.0, 39413.408798867466, 39810.402843956785, 38738.891832184905, 38740.0, 39000.2199956005, 40038.79980600078, 40236.59763402446, 32342.83828580842, 32944.83527582347, 32992.340153197285, 34434.0, 38034.8098259518, 28238.576421353286, 34450.594301869234, 34613.65386346104, 34755.82622086874, 34968.475472867416, 21264.78735212628, 25077.87461062756, 25111.0, 25579.744202557737, 26141.477170456863], "value": 19731.141366329695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.65593503081635, 345.78561291998966, 376.91142581493364, 377.2511564544379, 405.3838165987699, 14983.387727499914, 15585.532434026984, 20056.799432005675, 20777.584448311023, 22340.553188936254, 17364.0, 20833.791662083375, 21288.89355553224, 21376.465588360297, 21652.783472165273, 5805.622634528752, 6143.10924915887, 6145.692715364236, 6147.846303842395, 6148.538859585527, 4233.851815186469, 6034.849128771794, 6053.273607167146, 6862.142232220973, 6862.7598034068815, 6578.1448411706415, 6741.056252124682, 6749.190097188344, 6755.729770809162, 6872.793816185523, 6468.547201695883, 6679.198496180441, 6714.899276510856, 6732.057511948331, 6738.22510411304, 5559.972200138974, 5710.172025056385, 5808.390119037483, 5815.505682016991, 5819.476247137778, 26449.471010579873, 26662.6000609991, 26742.732572674413, 26763.732362676317, 26789.598156027674, 2309.8960546775265, 2421.9273421797375, 2427.1383658801046, 2553.872306384692, 3129.9530507042414, 10073.294869359148, 10583.841242381293, 10590.62321898156, 15528.456504022419, 15856.36574537017, 1798.2896755781524, 1901.7527721396268, 1910.2645481489587, 1930.5656227348734, 2007.648661484249, 118732.40633796863, 121518.0, 122353.38823305827, 122828.38585807104, 124055.0, 11350.602728904449, 11375.488103035383, 11503.252288601214, 11529.020033297096, 11720.941395292968, 12965.0, 13495.662608434868, 13544.59366219015, 14254.786178207336, 14256.786148207786, 7959.681612735426, 8017.0, 8353.872227249243, 8440.0, 8470.195331443503, 8236.752897413087, 8251.381146414044, 8258.298044666271, 8416.326693864476, 8418.200270974248, 4411.955880441219, 4499.572540608637, 4516.1419330327135, 4577.130345234395, 4587.220172570671, 1867.915943782533, 1915.7126431035456, 1917.3001854323072, 1917.8588739699856, 1925.2876435718874, 867.2931560777946, 875.4397185801092, 917.1424717888796, 956.8995255498072, 980.068934512202, 21505.462363440725, 22170.44573885666, 22185.889070554545, 22188.778112218995, 22246.998885050212, 902.9638814447349, 921.6635927886273, 933.9766505837408, 954.4082668745423, 996.850472429127, 11089.778204436028, 11449.313041217554, 11456.885431145749, 11490.827637585442, 11498.080153587693, 516731.0, 533906.0, 560666.0, 596908.0463793046, 599568.0, 129773.0, 134270.3145937076, 134292.0, 135687.0, 140683.29658351644, 923.9953800230955, 932.128459890005, 951.0917074194128, 954.8472244440856, 955.6082006377352, 17677.38129165473, 19060.237590496225, 19299.324523641604, 19407.708884367028, 19419.708704369164, 52757.0, 53413.19880201722, 53438.66403339947, 53789.73105134449, 54051.0, 80657.59671201606, 82011.0, 83186.58406707928, 84223.0, 84284.0, 6528.37980391862, 7875.606219688878, 8036.718714844952, 8300.0, 8561.88695469585, 8230.135835737161, 12787.0, 12792.296423696785, 13626.727465450835, 13733.656658583215, 9220.8012958315, 11068.612598559012, 11146.442677865913, 11355.0, 11469.0, 10816.56733730642, 10981.176411768989, 11325.830112548483, 11451.541938322707, 11588.768224635629, 11233.943830280796, 11247.887521124683, 11529.423528823358, 11548.538058477903, 11770.94061534466, 7855.175206603224, 7882.9605851972665, 7985.680572777024, 8069.435139540175, 8159.79600509992, 8788.91211087881, 10333.328333658288, 10406.895931040593, 10459.95400459948, 11245.325280483197], "value": 9717.404511969058, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.1483707845528, 1474.8598883106101, 1499.1529785671096, 1536.815582130144, 1853.7034074548067, 7719.0, 8574.399792014554, 8738.257248133916, 8751.562421878913, 8933.55332233389, 8681.913180868189, 8758.036615972238, 8763.780905477366, 8773.517456539888, 8777.824443511126, 2364.4443555764383, 2377.667126602277, 2378.2984019714227, 2387.4628208653003, 2391.641253811925, 2328.2316835444262, 2364.0898254172093, 2375.833691641577, 2377.1679912030736, 2377.2630484549845, 2333.0667732906804, 2351.929442116739, 2363.9669883899833, 2366.491204391064, 2368.7986521145635, 2319.7796209360085, 2348.835581509295, 2349.5888219561507, 2356.175338631482, 2359.504504054151, 2297.310806757966, 2326.3137374474572, 2332.0671731307443, 2332.685087513198, 2335.241046659842, 8651.913480865174, 8689.82620347596, 8857.468551886908, 8894.110588941054, 8901.198892099743, 5164.302819119408, 5352.464753524655, 5352.705601191933, 5354.250404943311, 5367.651102678314, 3585.8386372613295, 3595.7842529448317, 3667.468217108504, 3667.8166091695307, 3673.0633688409553, 948.5399581203111, 1092.3445932440552, 1096.714854137922, 1097.4019159557981, 1129.8757136714955, 9815.90184098157, 11545.307281563133, 11684.357360345177, 11689.064874809996, 11690.357030363326, 4327.653787696977, 4421.7789110544345, 4564.863054108382, 4598.356230127785, 4605.792739326738, 9139.81720365589, 9152.588133534007, 9153.725388238363, 9162.633494660273, 9166.541672916328, 5187.403448603459, 5191.896162076738, 5192.273081768555, 5202.92195617066, 5204.271402003723, 4290.635295999812, 4356.76037817923, 4501.437320334958, 4734.692245004064, 4865.0756356292195, 3693.9445908311395, 3718.5537735471917, 3791.6777073949024, 3796.2787070457075, 3817.408301713239, 1133.982990255147, 1160.2922217447351, 1167.737259116692, 1170.7716995185856, 1173.4602083041725, 793.6428607126701, 800.7677773445752, 884.9469031858109, 928.456852741154, 931.5761328595473, 5134.871628209325, 5432.804525853533, 5626.2967129108865, 5638.915416268759, 5959.731812068468, 414.36601998941666, 414.991700165995, 423.7309308589068, 425.4490434886829, 442.52649664858933, 3751.2309976454762, 3928.253631809947, 3938.1729836734035, 4040.5151381834366, 4072.6131017553284, 10246.6413675521, 10757.78484430307, 10766.56933722658, 10768.784624307627, 10858.0, 10339.276250662531, 10762.730931726614, 10767.78464430707, 10773.83839242412, 10781.299215550964, 7986.760397187977, 8224.013118425828, 8231.4649547778, 8234.258916697527, 8235.38234632393, 5649.745761440663, 5803.7968671096305, 5825.854353641193, 5874.060150375919, 5892.970535147297, 9891.010898910052, 9953.800923981624, 9982.60069597208, 10008.44953527563, 10043.196544276294, 9133.31500137479, 9295.349325547148, 9677.225821934087, 10328.0, 10334.966503349606, 5730.0, 6625.17185351831, 6977.825554361181, 7096.396806271318, 7174.497785154989, 8301.252887240178, 8320.958395207985, 8327.042390125212, 8401.075881653136, 8420.031696354998, 7455.440841936768, 7460.216677248811, 7525.17223105447, 7554.773356799305, 7632.771016869503, 7283.635818209174, 7294.452916031213, 7362.079550389033, 7369.96315018443, 7443.292887175709, 6936.583804971718, 6959.721611135498, 7031.718731250693, 7037.049998250171, 7046.330598593126, 4435.756033418063, 4964.0, 4992.825251116194, 4994.775235114501, 5018.146915024382, 4295.441592593068, 4987.251912213052, 5006.424261210008, 5148.1248187808915, 5233.39815921174], "value": 4414.3150732161685, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.27643152037336, 262.8134024842363, 301.34006525708685, 309.2809218566832, 314.5093653899915, 5055.974720126404, 5212.706409179958, 5300.257963885059, 5316.5215130638235, 5341.465853414652, 4260.913467065901, 4568.281872285985, 5069.251108367616, 5192.454792246807, 5251.107311757001, 3630.0017495188904, 3902.2780785554764, 3942.1327307992196, 4067.227226826908, 4067.8576249831262, 3951.9407208891744, 4079.4900637420324, 4087.550369459357, 4104.076582768883, 4105.220008198433, 3370.5112758650102, 4031.2743706132883, 4041.939370909439, 4052.696047796412, 4064.5732198119217, 4044.6157615026527, 4054.5337286212166, 4067.715259931806, 4075.2069089600777, 4088.632023117934, 3532.028692109665, 3551.875684351061, 3554.608993010767, 3566.5006899034156, 3581.7313701472494, 4404.097160082176, 4823.660524645544, 4915.5330243626795, 5096.298961550384, 5122.8463146105305, 4633.293365307741, 4635.69867958585, 4642.0, 4647.581717645428, 4666.603338716213, 4171.933628782842, 4572.839950601713, 4621.37611422457, 5525.198846167324, 5564.219449776073, 3756.7602691112143, 3877.379619260933, 3914.2758589661003, 3916.2559113768293, 3922.313595120871, 4780.972091000452, 5748.511376532958, 5752.252207213036, 5770.7691692332255, 5776.249087618625, 3499.7900125992523, 3566.3045706087064, 3748.981255093707, 3906.7265291429894, 3958.762474251554, 3775.565809931838, 3900.941485877714, 3996.460477835455, 4000.2799496090984, 4013.177298653769, 3966.305896468164, 4075.8573449929704, 4170.791460427027, 4607.953920460753, 4615.815367385267, 4723.669343145947, 4871.878203044881, 5590.944090559124, 5595.888082238333, 5616.410276920946, 1221.3038568016145, 1289.1620446709526, 1340.6782372230593, 1352.2157148853642, 1376.3599926034442, 844.3456321351002, 910.9453432794054, 924.4961495984704, 938.7746940734311, 939.2201777631486, 4507.90382472152, 5039.0929632666475, 5081.466446023188, 5149.897002059938, 5197.29836472079, 4733.231059830038, 4787.4494433139935, 5349.973250133802, 5657.80197693087, 5658.405867383948, 4867.756612169377, 4876.171050921352, 5092.772998411309, 5106.259592359087, 5141.562967147759, 2531.4430825218424, 2936.588877557144, 2996.4456575533595, 3025.9546106807975, 3034.484137696597, 4635.397398338195, 5220.582353411718, 5948.7323070461935, 5949.25634295713, 5963.850903727354, 5136.5890728741615, 5701.756561682976, 5770.711464426762, 5886.117082437669, 5915.674637894957, 5232.476752324737, 5262.50006249421, 5419.918701219485, 5896.2016584942, 5903.162944086293, 4851.878703032452, 4977.9751101244265, 5727.742251598771, 5768.798092066758, 5796.275465566804, 4751.50109238525, 5293.788248470172, 5424.0, 5729.28383952006, 5772.682502462405, 4521.2087884619405, 5406.648567843077, 5957.49361304294, 5995.310539288038, 6057.0, 3470.3689266044917, 3900.6294402031763, 4043.6950937965075, 4071.959280407158, 4074.3073677475495, 4845.563899249085, 5087.974560127176, 5415.891682166256, 5715.771369145187, 5740.569457290637, 5378.327709036371, 5486.369067557282, 5530.253415788817, 5572.832815015556, 5668.404817494104, 4747.667663263676, 5617.230572369691, 5646.576506761927, 5660.575456840836, 5663.405342438985, 4360.585744354281, 4776.641751868554, 5168.870778230575, 5527.336719593674, 5580.218769372373, 5017.899642007213, 5359.812406565751, 5634.464725851038, 5644.8024319148635, 5673.77304907799, 4519.38988236597, 5369.617141201018, 5502.8349149525575, 5537.141743029837, 5540.889182216414], "value": 4035.3786400834006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.7810656802961, 731.8792399254123, 777.9144294127649, 833.5040650812766, 836.0, 15191.240437978098, 16257.430989915356, 16261.268242929067, 16262.674746505092, 16293.511194664165, 14505.564833055, 14640.4875829346, 14669.706605867903, 14680.926595367035, 14704.117752934832, 672.5393105722571, 692.8960655901604, 830.6303694855792, 839.8068444257824, 858.7638399440142, 856.4689892266804, 860.7761981884723, 863.3999370437548, 869.7564681889081, 872.1278721278721, 887.60057973912, 888.2760550151638, 890.1810334492251, 890.8396488632044, 891.0510306523564, 706.6502081469705, 884.1423818895661, 884.4383816276646, 885.1325700813206, 886.7428445750725, 661.8775526527608, 673.7944926797325, 676.6109487044969, 678.8065401360637, 680.3774546290188, 14752.3361448734, 14791.33438995237, 14792.260386980715, 14806.777898331533, 14810.0, 13683.452661893512, 13897.720856981596, 14176.858231417656, 14178.14931104137, 14313.57059288223, 12716.491340346374, 12750.936245318806, 12758.36208189596, 12938.094333396666, 13075.738485230242, 4219.261629214906, 4220.2192594369835, 4312.482502099737, 4340.587644173798, 4406.361077643755, 114484.0, 114705.0, 114849.0, 114946.42526787313, 115105.42447287793, 10964.232503724823, 11012.834807477733, 11014.44927753609, 11116.166287528467, 11434.133550520979, 22355.21756738539, 22371.552568948857, 22375.88812055929, 22389.44026399353, 22474.0, 7847.84304313922, 7930.0, 7963.8805417918775, 8137.877931831027, 8168.142345053802, 4339.609435150788, 4427.0, 4458.331250312479, 4489.88775280614, 4504.909901801946, 3309.7352211822995, 3377.67912048355, 3451.050960985699, 3492.738044646662, 3507.3511400391008, 661.503872095928, 665.1087542692718, 667.1027468055457, 669.4075742967509, 681.918169819615, 525.6163001009285, 549.9670019798825, 576.5089949294945, 577.8642019125502, 587.4389957590491, 7527.021487206628, 8348.165183481724, 9127.954360228288, 9262.259019278576, 9294.535273236312, 601.1613798750718, 626.6240255846546, 636.9745210191633, 639.8880195965687, 649.1917562634455, 4289.656827453796, 4495.393121928563, 4504.144212599661, 4578.381918441034, 4633.235516139866, 92453.23139764437, 123020.0, 131096.0, 156936.0, 168396.1603839606, 105919.0, 141435.0, 142445.28777356047, 143967.0, 145130.0, 105189.47405262924, 118368.0, 120113.0, 121705.39147304207, 122829.0, 8795.208431241219, 8802.207801297915, 8815.206631403205, 8849.646014159362, 8978.236849867573, 67464.6626766863, 67522.66238668775, 67678.32321676917, 68076.6596167016, 68519.0, 79072.20927790648, 79940.60029699815, 100573.49713251388, 102098.46852297072, 108663.0, 13152.079354445097, 13379.264140472367, 13541.729165416833, 13766.24285664258, 13985.58043258704, 14819.40722371093, 15039.548813535612, 15059.397624094914, 15190.72791800047, 15375.073188642911, 11261.49323280438, 11299.774004519699, 11613.477393517143, 11755.177137600285, 14063.437462501386, 11046.889531104585, 12111.212771170198, 12418.068644851492, 14128.646783830487, 14602.488912887999, 13695.657608559866, 13721.519746808814, 14107.153570785786, 14110.647233818827, 14168.079074860101, 10880.891191088305, 11005.0, 11311.547538098384, 11482.598109066477, 11513.400754148654, 10049.346792458759, 10475.952404759462, 11341.319520828776, 11389.829152562885, 11488.655340339803], "value": 7839.305391984505, "unit": "score"}], "name": "dromaeo_css", "value": 7306.898815204102, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 111.0, 113.0, 113.0, 112.0, 113.0, 114.0, 120.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 130.0, 158.0, 108.0, 127.0, 129.0, 107.0, 159.0, 107.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 183.0, 182.0, 184.0, 182.0, 186.0, 183.0, 174.0, 185.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 75.0, 149.0, 58.0, 57.0, 57.0, 69.0, 139.0, 57.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 136.0, 71.0, 78.0, 80.0, 115.0, 70.0, 69.0, 120.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 89.0, 84.0, 90.0, 86.0, 89.0, 85.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 147.0, 93.0, 102.0, 150.0, 126.0, 94.0, 95.0, 93.0, 93.0], "value": 112.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 84.0, 87.0, 84.0, 84.0, 85.0, 85.0, 87.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 57.0, 54.0, 56.0, 54.0, 55.0, 55.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 67.0, 72.0, 73.0, 78.0, 71.0, 70.0, 69.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 86.0, 89.0, 86.0, 88.0, 90.0, 84.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 135.0, 140.0, 147.0, 149.0, 134.0, 143.0, 176.0, 149.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 169.0, 166.0, 171.0, 229.0, 177.0, 168.0, 168.0, 167.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 68.0, 66.0, 67.0, 67.0, 65.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1480.1000000000001, "alertThreshold": 2.0}]} 08:25:56 INFO - Return code: 0 08:25:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:25:56 INFO - # TBPL SUCCESS # 08:25:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:25:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:25:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:25:56 INFO - 2016-08-24 08:25:56.603 screenresolution[1666:10453] starting screenresolution argv=screenresolution get 08:25:56 INFO - 2016-08-24 08:25:56.605 screenresolution[1666:10453] Display 0: 1600x1200x32@60 08:25:56 INFO - 2016-08-24 08:25:56.611 screenresolution[1667:10456] starting screenresolution argv=screenresolution list 08:25:56 INFO - Available Modes on Display 0 08:25:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:25:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:25:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:25:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:25:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:25:56 INFO - Intel Iris: 08:25:56 INFO - Chipset Model: Intel Iris 08:25:56 INFO - Type: GPU 08:25:56 INFO - Bus: Built-In 08:25:56 INFO - VRAM (Dynamic, Max): 1536 MB 08:25:56 INFO - Vendor: Intel (0x8086) 08:25:56 INFO - Device ID: 0x0a2e 08:25:56 INFO - Revision ID: 0x0009 08:25:56 INFO - Displays: 08:25:56 INFO - Display: 08:25:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:25:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:25:56 INFO - Display Serial Number: 1600x1200 60 08:25:56 INFO - Main Display: Yes 08:25:56 INFO - Mirror: Off 08:25:56 INFO - Online: Yes 08:25:56 INFO - Rotation: Supported 08:25:56 INFO - Return code: 0 08:25:56 INFO - Running post-action listener: _resource_record_post_action 08:25:56 INFO - [mozharness: 2016-08-24 15:25:56.848645Z] Finished run-tests step (success) 08:25:56 INFO - Running post-run listener: _resource_record_post_run 08:25:56 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 31935488; Write bytes: 703292416; Read time: 194; Write time: 1965 08:25:56 INFO - TinderboxPrint: CPU usage
53.5% 08:25:56 INFO - TinderboxPrint: I/O read bytes / time
31,935,488 / 194 08:25:56 INFO - TinderboxPrint: I/O write bytes / time
703,292,416 / 1,965 08:25:56 INFO - TinderboxPrint: CPU idle
2,253.6 (46.5%) 08:25:56 INFO - TinderboxPrint: CPU system
972.0 (20.1%) 08:25:56 INFO - TinderboxPrint: CPU user
1,620.1 (33.4%) 08:25:56 INFO - TinderboxPrint: Swap in / out
434,110,464 / 0 08:25:56 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394951168; Write bytes: 389367296; Read time: 29912; Write time: 822 08:25:56 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30166016; Write bytes: 293924352; Read time: 180; Write time: 1095 08:25:57 INFO - Running post-run listener: _upload_blobber_files 08:25:57 INFO - Blob upload gear active. 08:25:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:25:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:25:57 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:25:57 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:25:57 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:25:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:59 INFO - (blobuploader) - INFO - Done attempting. 08:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:00 INFO - (blobuploader) - INFO - Done attempting. 08:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:03 INFO - (blobuploader) - INFO - Done attempting. 08:26:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:03 INFO - Return code: 0 08:26:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32d6146c0c5d0ce787061c87316bed2885cfa07c2878b2357cbef4621b3307bfe3399ae44fde0c6d20f73787d9ab09ce9247a9cd343b34ed4a9f6af5521a53d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f65c2b05cd6410ddd2fce746374bec36a9d1cd19324609d222ec09c783006dec7133e713980a964cf09e9e04f54b1e7d4e2052e494f72013adf3e1b29c50e4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e7e8f0d20e5987985c8434612410d58a32089b97dc2f697868f1f90f69fab5b975687f53c9c5764f211770e16d5342eb8ea14bfe564dc8598e2bcbc0b7146a4"} 08:26:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:03 INFO - Contents: 08:26:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32d6146c0c5d0ce787061c87316bed2885cfa07c2878b2357cbef4621b3307bfe3399ae44fde0c6d20f73787d9ab09ce9247a9cd343b34ed4a9f6af5521a53d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f65c2b05cd6410ddd2fce746374bec36a9d1cd19324609d222ec09c783006dec7133e713980a964cf09e9e04f54b1e7d4e2052e494f72013adf3e1b29c50e4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e7e8f0d20e5987985c8434612410d58a32089b97dc2f697868f1f90f69fab5b975687f53c9c5764f211770e16d5342eb8ea14bfe564dc8598e2bcbc0b7146a4"} 08:26:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:03 INFO - Copying logs to upload dir... 08:26:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.603405 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-24 08:26:03.741925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 08:26:03.745112) ========= 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.ktMZUx4dKk/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.9GkdlxmACx/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32d6146c0c5d0ce787061c87316bed2885cfa07c2878b2357cbef4621b3307bfe3399ae44fde0c6d20f73787d9ab09ce9247a9cd343b34ed4a9f6af5521a53d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f65c2b05cd6410ddd2fce746374bec36a9d1cd19324609d222ec09c783006dec7133e713980a964cf09e9e04f54b1e7d4e2052e494f72013adf3e1b29c50e4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e7e8f0d20e5987985c8434612410d58a32089b97dc2f697868f1f90f69fab5b975687f53c9c5764f211770e16d5342eb8ea14bfe564dc8598e2bcbc0b7146a4"} build_url:https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/ebvNkAHDSAWI9eRbwVgN8g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32d6146c0c5d0ce787061c87316bed2885cfa07c2878b2357cbef4621b3307bfe3399ae44fde0c6d20f73787d9ab09ce9247a9cd343b34ed4a9f6af5521a53d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f65c2b05cd6410ddd2fce746374bec36a9d1cd19324609d222ec09c783006dec7133e713980a964cf09e9e04f54b1e7d4e2052e494f72013adf3e1b29c50e4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e7e8f0d20e5987985c8434612410d58a32089b97dc2f697868f1f90f69fab5b975687f53c9c5764f211770e16d5342eb8ea14bfe564dc8598e2bcbc0b7146a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 08:26:03.778807) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:26:03.779201) ========= 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.ktMZUx4dKk/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.9GkdlxmACx/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.004886 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:26:03.827277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 08:26:03.827586) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 08:26:03.827895) ========= ========= Total master_lag: 0.17 =========