builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0319 starttime: 1471384651.12 results: success (0) buildid: 20160816135314 builduid: f1c3616c1aef4a1aa7ac1dcd7b5de049 revision: 5cba4a9fe4de786814cc464bdeb8de6ca3ea9329 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:31.118622) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:31.119085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:31.119373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:31.145902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:31.146441) ========= 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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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-16 14:57:31-- 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% 154M=0s 2016-08-16 14:57:31 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095583 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:31.265312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:31.265640) ========= 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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.025734 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:31.326480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 14:57:31.326862) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5cba4a9fe4de786814cc464bdeb8de6ca3ea9329 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5cba4a9fe4de786814cc464bdeb8de6ca3ea9329 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JGl3QkzR2v/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.YGLF0TO4qp/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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-16 14:57:31,413 truncating revision to first 12 chars 2016-08-16 14:57:31,414 Setting DEBUG logging. 2016-08-16 14:57:31,414 attempt 1/10 2016-08-16 14:57:31,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5cba4a9fe4de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 14:57:32,153 unpacking tar archive at: fx-team-5cba4a9fe4de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.999847 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 14:57:32.349343) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:32.349688) ========= script_repo_revision: 5cba4a9fe4de786814cc464bdeb8de6ca3ea9329 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:32.350106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:32.350449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 14:57:32.370030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-16 14:57:32.370457) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JGl3QkzR2v/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.YGLF0TO4qp/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:57:32 INFO - MultiFileLogger online at 20160816 14:57:32 in /builds/slave/test 14:57:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:57:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:57:32 INFO - {'append_to_log': False, 14:57:32 INFO - 'base_work_dir': '/builds/slave/test', 14:57:32 INFO - 'blob_upload_branch': 'Fx-Team', 14:57:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:57:32 INFO - 'branch': 'Fx-Team', 14:57:32 INFO - 'buildbot_json_path': 'buildprops.json', 14:57:32 INFO - 'config_files': ('talos/mac_config.py',), 14:57:32 INFO - 'default_actions': ('clobber', 14:57:32 INFO - 'read-buildbot-config', 14:57:32 INFO - 'download-and-extract', 14:57:32 INFO - 'populate-webroot', 14:57:32 INFO - 'create-virtualenv', 14:57:32 INFO - 'install', 14:57:32 INFO - 'run-tests'), 14:57:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:57:32 INFO - 'download_minidump_stackwalk': True, 14:57:32 INFO - 'download_symbols': 'ondemand', 14:57:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:57:32 INFO - 'tooltool.py': '/tools/tooltool.py', 14:57:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:57:32 INFO - '/tools/misc-python/virtualenv.py')}, 14:57:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:57:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:57:32 INFO - 'installer_path': 'installer.exe', 14:57:32 INFO - 'log_level': 'info', 14:57:32 INFO - 'log_name': 'talos', 14:57:32 INFO - 'log_to_console': True, 14:57:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:57:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:57:32 INFO - 'opt_config_files': (), 14:57:32 INFO - 'pip_index': False, 14:57:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:57:32 INFO - 'cmd': ('bash', 14:57:32 INFO - '-c', 14:57:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:57:32 INFO - 'enabled': True, 14:57:32 INFO - 'halt_on_failure': False, 14:57:32 INFO - 'name': 'check_screen_resolution'},), 14:57:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:57:32 INFO - 'cmd': ('bash', 14:57:32 INFO - '-c', 14:57:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:57:32 INFO - 'enabled': True, 14:57:32 INFO - 'halt_on_failure': False, 14:57:32 INFO - 'name': 'check_screen_resolution'},), 14:57:32 INFO - 'run_cmd_checks_enabled': True, 14:57:32 INFO - 'sps_profile': False, 14:57:32 INFO - 'sps_profile_interval': 0, 14:57:32 INFO - 'suite': 'dromaeojs', 14:57:32 INFO - 'system_bits': '32', 14:57:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:57:32 INFO - 'title': 't-yosemite-r7-0319', 14:57:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:57:32 INFO - 'use_talos_json': True, 14:57:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:57:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:57:32 INFO - 'work_dir': 'build'} 14:57:32 INFO - [mozharness: 2016-08-16 21:57:32.571562Z] Running clobber step. 14:57:32 INFO - Running pre-action listener: _resource_record_pre_action 14:57:32 INFO - Running main action method: clobber 14:57:32 INFO - rmtree: /builds/slave/test/build 14:57:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:57:34 INFO - Running post-action listener: _resource_record_post_action 14:57:34 INFO - [mozharness: 2016-08-16 21:57:34.456060Z] Finished clobber step (success) 14:57:34 INFO - [mozharness: 2016-08-16 21:57:34.456185Z] Running read-buildbot-config step. 14:57:34 INFO - Running pre-action listener: _resource_record_pre_action 14:57:34 INFO - Running main action method: read_buildbot_config 14:57:34 INFO - Using buildbot properties: 14:57:34 INFO - { 14:57:34 INFO - "project": "", 14:57:34 INFO - "product": "firefox", 14:57:34 INFO - "script_repo_revision": "production", 14:57:34 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:57:34 INFO - "repository": "", 14:57:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:57:34 INFO - "buildid": "20160816135314", 14:57:34 INFO - "pgo_build": "False", 14:57:34 INFO - "basedir": "/builds/slave/test", 14:57:34 INFO - "buildnumber": 132, 14:57:34 INFO - "slavename": "t-yosemite-r7-0319", 14:57:34 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:57:34 INFO - "platform": "yosemite_r7", 14:57:34 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 14:57:34 INFO - "branch": "fx-team", 14:57:34 INFO - "repo_path": "integration/fx-team", 14:57:34 INFO - "revision": "5cba4a9fe4de786814cc464bdeb8de6ca3ea9329", 14:57:34 INFO - "stage_platform": "macosx64", 14:57:34 INFO - "builduid": "f1c3616c1aef4a1aa7ac1dcd7b5de049", 14:57:34 INFO - "slavebuilddir": "test" 14:57:34 INFO - } 14:57:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:57:34 INFO - Running post-action listener: _resource_record_post_action 14:57:34 INFO - [mozharness: 2016-08-16 21:57:34.459442Z] Finished read-buildbot-config step (success) 14:57:34 INFO - [mozharness: 2016-08-16 21:57:34.459535Z] Running download-and-extract step. 14:57:34 INFO - Running pre-action listener: _resource_record_pre_action 14:57:34 INFO - Running main action method: download_and_extract 14:57:34 INFO - mkdir: /builds/slave/test/build/tests 14:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:34 INFO - trying https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:57:34 INFO - Downloading https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/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 14:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/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 14:57:35 INFO - Downloaded 1199 bytes. 14:57:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:57:35 INFO - Using the following test package requirements: 14:57:35 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:57:35 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:57:35 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:57:35 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:57:35 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:57:35 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:57:35 INFO - u'jsshell-mac.zip'], 14:57:35 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:57:35 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:57:35 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:57:35 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:57:35 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:57:35 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:57:35 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:57:35 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:57:35 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:57:35 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:57:35 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:57:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:35 INFO - trying https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:57:35 INFO - Downloading https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/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 14:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/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 14:57:36 INFO - Downloaded 16332046 bytes. 14:57:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:57:43 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 14:57: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')]} 14:57:43 INFO - trying https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:57:43 INFO - Downloading https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/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 14:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/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 14:57:44 INFO - Downloaded 16332046 bytes. 14:57:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:50 INFO - trying https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:57:50 INFO - Downloading https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/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 14:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/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 14:57:52 INFO - Downloaded 14413719 bytes. 14:57:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 14:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:52 INFO - trying https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:57:52 INFO - Downloading https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/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 14:57:55 INFO - Downloaded 111102387 bytes. 14:57:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:57:55 INFO - mkdir: /builds/slave/test/properties 14:57:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:57:55 INFO - Writing to file /builds/slave/test/properties/build_url 14:57:55 INFO - Contents: 14:57:55 INFO - build_url:https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:57:56 INFO - Running post-action listener: _resource_record_post_action 14:57:56 INFO - Running post-action listener: set_extra_try_arguments 14:57:56 INFO - [mozharness: 2016-08-16 21:57:56.269773Z] Finished download-and-extract step (success) 14:57:56 INFO - [mozharness: 2016-08-16 21:57:56.269894Z] Running populate-webroot step. 14:57:56 INFO - Running pre-action listener: _resource_record_pre_action 14:57:56 INFO - Running main action method: populate_webroot 14:57:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:57:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:57:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:57:56 INFO - '--tppagecycles', 14:57:56 INFO - '7'], 14:57:56 INFO - 'tests': ['tsvgm']}}, 14:57:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:57:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:57:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:57:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:57:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:56 INFO - 'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:56 INFO - 'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['damp', 'tps']}, 14:57:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:56 INFO - 'tests': ['damp', 'tps']}, 14:57:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['dromaeo_dom']}, 14:57:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:57:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['basic_compositor_video']}, 14:57:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:57:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['a11yr', 14:57:56 INFO - 'ts_paint', 14:57:56 INFO - 'tpaint', 14:57:56 INFO - 'sessionrestore', 14:57:56 INFO - 'sessionrestore_no_auto_restore', 14:57:56 INFO - 'tabpaint']}, 14:57:56 INFO - 'other-e10s': {'tests': ['a11yr', 14:57:56 INFO - 'ts_paint', 14:57:56 INFO - 'tpaint', 14:57:56 INFO - 'sessionrestore', 14:57:56 INFO - 'sessionrestore_no_auto_restore', 14:57:56 INFO - 'tabpaint']}, 14:57:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:57:56 INFO - 'ts_paint', 14:57:56 INFO - 'tpaint', 14:57:56 INFO - 'sessionrestore', 14:57:56 INFO - 'sessionrestore_no_auto_restore', 14:57:56 INFO - 'tabpaint']}, 14:57:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:57:56 INFO - 'ts_paint', 14:57:56 INFO - 'tpaint', 14:57:56 INFO - 'sessionrestore', 14:57:56 INFO - 'sessionrestore_no_auto_restore', 14:57:56 INFO - 'tabpaint']}, 14:57:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['a11yr', 14:57:56 INFO - 'ts_paint', 14:57:56 INFO - 'tpaint', 14:57:56 INFO - 'sessionrestore', 14:57:56 INFO - 'sessionrestore_no_auto_restore', 14:57:56 INFO - 'tabpaint']}, 14:57:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['a11yr', 14:57:56 INFO - 'ts_paint', 14:57:56 INFO - 'tpaint', 14:57:56 INFO - 'sessionrestore', 14:57:56 INFO - 'sessionrestore_no_auto_restore', 14:57:56 INFO - 'tabpaint']}, 14:57:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['tsvgx', 14:57:56 INFO - 'tsvgr_opacity', 14:57:56 INFO - 'tart', 14:57:56 INFO - 'tscrollx', 14:57:56 INFO - 'cart']}, 14:57:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:57:56 INFO - 'tsvgr_opacity', 14:57:56 INFO - 'tart', 14:57:56 INFO - 'tscrollx', 14:57:56 INFO - 'cart']}, 14:57:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:56 INFO - 'talos_options': ['--disable-e10s'], 14:57:56 INFO - 'tests': ['tp5o']}, 14:57:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:56 INFO - 'tests': ['tp5o']}, 14:57:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:56 INFO - 'talos_options': ['--disable-e10s', 14:57:56 INFO - '--xperf_path', 14:57:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:56 INFO - 'tests': ['tp5n']}, 14:57:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:56 INFO - 'talos_options': ['--xperf_path', 14:57:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:56 INFO - 'tests': ['tp5n']}}, 14:57:56 INFO - 'talos.zip': {'path': '', 14:57:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:57:56 INFO - Running post-action listener: _resource_record_post_action 14:57:56 INFO - [mozharness: 2016-08-16 21:57:56.289525Z] Finished populate-webroot step (success) 14:57:56 INFO - [mozharness: 2016-08-16 21:57:56.289640Z] Running create-virtualenv step. 14:57:56 INFO - Running pre-action listener: _resource_record_pre_action 14:57:56 INFO - Running main action method: create_virtualenv 14:57:56 INFO - Creating virtualenv /builds/slave/test/build/venv 14:57:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:57:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:57:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:57:56 INFO - Using real prefix '/tools/python27' 14:57:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:57:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:58:00 INFO - Installing pip.................done. 14:58:00 INFO - Return code: 0 14:58:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:00 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 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:00 INFO - 'HOME': '/Users/cltbld', 14:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:00 INFO - 'LOGNAME': 'cltbld', 14:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:00 INFO - 'MOZ_NO_REMOTE': '1', 14:58:00 INFO - 'NO_EM_RESTART': '1', 14:58:00 INFO - 'PAGER': '/bin/cat', 14:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:00 INFO - 'PWD': '/builds/slave/test', 14:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:00 INFO - 'SHELL': '/bin/bash', 14:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:00 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:00 INFO - 'USER': 'cltbld', 14:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:00 INFO - 'XPC_FLAGS': '0x0', 14:58:00 INFO - 'XPC_SERVICE_NAME': '0', 14:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:58:00 INFO - Cleaning up... 14:58:00 INFO - Return code: 0 14:58:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:00 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 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:00 INFO - 'HOME': '/Users/cltbld', 14:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:00 INFO - 'LOGNAME': 'cltbld', 14:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:00 INFO - 'MOZ_NO_REMOTE': '1', 14:58:00 INFO - 'NO_EM_RESTART': '1', 14:58:00 INFO - 'PAGER': '/bin/cat', 14:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:00 INFO - 'PWD': '/builds/slave/test', 14:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:00 INFO - 'SHELL': '/bin/bash', 14:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:00 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:00 INFO - 'USER': 'cltbld', 14:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:00 INFO - 'XPC_FLAGS': '0x0', 14:58:00 INFO - 'XPC_SERVICE_NAME': '0', 14:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:00 INFO - Downloading/unpacking psutil>=3.1.1 14:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:58:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:58:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:58:03 INFO - Installing collected packages: psutil 14:58:03 INFO - Running setup.py install for psutil 14:58:03 INFO - building 'psutil._psutil_osx' extension 14:58:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:58:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:58:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:58:04 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:58:04 INFO - building 'psutil._psutil_posix' extension 14:58:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:58:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:58:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:58:04 INFO - ^ 14:58:04 INFO - 1 warning generated. 14:58:04 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:58:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:58:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:58:04 INFO - Successfully installed psutil 14:58:04 INFO - Cleaning up... 14:58:04 INFO - Return code: 0 14:58:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:04 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 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:04 INFO - 'HOME': '/Users/cltbld', 14:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:04 INFO - 'LOGNAME': 'cltbld', 14:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:04 INFO - 'MOZ_NO_REMOTE': '1', 14:58:04 INFO - 'NO_EM_RESTART': '1', 14:58:04 INFO - 'PAGER': '/bin/cat', 14:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:04 INFO - 'PWD': '/builds/slave/test', 14:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:04 INFO - 'SHELL': '/bin/bash', 14:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:04 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:04 INFO - 'USER': 'cltbld', 14:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:04 INFO - 'XPC_FLAGS': '0x0', 14:58:04 INFO - 'XPC_SERVICE_NAME': '0', 14:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:58:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:58:07 INFO - Installing collected packages: mozsystemmonitor 14:58:07 INFO - Running setup.py install for mozsystemmonitor 14:58:07 INFO - Successfully installed mozsystemmonitor 14:58:07 INFO - Cleaning up... 14:58:07 INFO - Return code: 0 14:58:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:07 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 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:58:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:07 INFO - 'HOME': '/Users/cltbld', 14:58:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:07 INFO - 'LOGNAME': 'cltbld', 14:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:07 INFO - 'MOZ_NO_REMOTE': '1', 14:58:07 INFO - 'NO_EM_RESTART': '1', 14:58:07 INFO - 'PAGER': '/bin/cat', 14:58:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:07 INFO - 'PWD': '/builds/slave/test', 14:58:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:07 INFO - 'SHELL': '/bin/bash', 14:58:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:07 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:07 INFO - 'USER': 'cltbld', 14:58:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:07 INFO - 'XPC_FLAGS': '0x0', 14:58:07 INFO - 'XPC_SERVICE_NAME': '0', 14:58:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:08 INFO - Downloading/unpacking jsonschema==2.5.1 14:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:58:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:10 INFO - Downloading functools32-3.2.3-2.tar.gz 14:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:58:10 INFO - warning: no files found matching '*.txt' 14:58:10 INFO - no previously-included directories found matching 'build' 14:58:10 INFO - no previously-included directories found matching 'dist' 14:58:10 INFO - no previously-included directories found matching '.git*' 14:58:11 INFO - Installing collected packages: jsonschema, functools32 14:58:11 INFO - Running setup.py install for functools32 14:58:11 INFO - warning: no files found matching '*.txt' 14:58:11 INFO - no previously-included directories found matching 'build' 14:58:11 INFO - no previously-included directories found matching 'dist' 14:58:11 INFO - no previously-included directories found matching '.git*' 14:58:11 INFO - Successfully installed jsonschema functools32 14:58:11 INFO - Cleaning up... 14:58:11 INFO - Return code: 0 14:58:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:11 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 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:11 INFO - 'HOME': '/Users/cltbld', 14:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:11 INFO - 'LOGNAME': 'cltbld', 14:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:11 INFO - 'MOZ_NO_REMOTE': '1', 14:58:11 INFO - 'NO_EM_RESTART': '1', 14:58:11 INFO - 'PAGER': '/bin/cat', 14:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:11 INFO - 'PWD': '/builds/slave/test', 14:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:11 INFO - 'SHELL': '/bin/bash', 14:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:11 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:11 INFO - 'USER': 'cltbld', 14:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:11 INFO - 'XPC_FLAGS': '0x0', 14:58:11 INFO - 'XPC_SERVICE_NAME': '0', 14:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:58:11 INFO - Cleaning up... 14:58:11 INFO - Return code: 0 14:58:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:11 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 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:11 INFO - 'HOME': '/Users/cltbld', 14:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:11 INFO - 'LOGNAME': 'cltbld', 14:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:11 INFO - 'MOZ_NO_REMOTE': '1', 14:58:11 INFO - 'NO_EM_RESTART': '1', 14:58:11 INFO - 'PAGER': '/bin/cat', 14:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:11 INFO - 'PWD': '/builds/slave/test', 14:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:11 INFO - 'SHELL': '/bin/bash', 14:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:11 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:11 INFO - 'USER': 'cltbld', 14:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:11 INFO - 'XPC_FLAGS': '0x0', 14:58:11 INFO - 'XPC_SERVICE_NAME': '0', 14:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:11 INFO - Downloading/unpacking blobuploader==1.2.4 14:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:14 INFO - Downloading blobuploader-1.2.4.tar.gz 14:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:58:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:58:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:15 INFO - Downloading docopt-0.6.1.tar.gz 14:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:58:15 INFO - Installing collected packages: blobuploader, requests, docopt 14:58:15 INFO - Running setup.py install for blobuploader 14:58:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:58:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:58:15 INFO - Running setup.py install for requests 14:58:16 INFO - Running setup.py install for docopt 14:58:16 INFO - Successfully installed blobuploader requests docopt 14:58:16 INFO - Cleaning up... 14:58:16 INFO - Return code: 0 14:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:16 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 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:58:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:16 INFO - 'HOME': '/Users/cltbld', 14:58:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:16 INFO - 'LOGNAME': 'cltbld', 14:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:16 INFO - 'MOZ_NO_REMOTE': '1', 14:58:16 INFO - 'NO_EM_RESTART': '1', 14:58:16 INFO - 'PAGER': '/bin/cat', 14:58:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:16 INFO - 'PWD': '/builds/slave/test', 14:58:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:16 INFO - 'SHELL': '/bin/bash', 14:58:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:16 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:16 INFO - 'USER': 'cltbld', 14:58:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:16 INFO - 'XPC_FLAGS': '0x0', 14:58:16 INFO - 'XPC_SERVICE_NAME': '0', 14:58:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:58:16 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-01XV0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:58:16 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-oKvTs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:58:16 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-I7qedT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:58:16 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-It4tXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:58:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Wek6QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:58:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-v9zpdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:58:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-vPd9kX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:58:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-SnoXEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:58:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-QGLYnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:58:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-83KzW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:58:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-lhhmT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:58:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-VgPTeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:58:17 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-zHrIqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:58:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-36zLee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-bwnKSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:58:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-tzE_6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:58:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-CnfYSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:58:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:58:18 INFO - Running setup.py install for manifestparser 14:58:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:58:18 INFO - Running setup.py install for mozcrash 14:58:18 INFO - Running setup.py install for mozdebug 14:58:18 INFO - Running setup.py install for mozdevice 14:58:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:58:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:58:19 INFO - Running setup.py install for mozfile 14:58:19 INFO - Running setup.py install for mozhttpd 14:58:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:58:19 INFO - Running setup.py install for mozinfo 14:58:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:58:19 INFO - Running setup.py install for mozInstall 14:58:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:58:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:58:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:58:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:58:19 INFO - Running setup.py install for mozleak 14:58:19 INFO - Running setup.py install for mozlog 14:58:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:58:19 INFO - Running setup.py install for moznetwork 14:58:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:58:20 INFO - Running setup.py install for mozprocess 14:58:20 INFO - Running setup.py install for mozprofile 14:58:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:58:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:58:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:58:20 INFO - Running setup.py install for mozrunner 14:58:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:58:20 INFO - Running setup.py install for mozscreenshot 14:58:20 INFO - Running setup.py install for moztest 14:58:20 INFO - Running setup.py install for mozversion 14:58:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:58:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:58:21 INFO - Cleaning up... 14:58:21 INFO - Return code: 0 14:58:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:21 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 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:21 INFO - 'HOME': '/Users/cltbld', 14:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:21 INFO - 'LOGNAME': 'cltbld', 14:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:21 INFO - 'MOZ_NO_REMOTE': '1', 14:58:21 INFO - 'NO_EM_RESTART': '1', 14:58:21 INFO - 'PAGER': '/bin/cat', 14:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:21 INFO - 'PWD': '/builds/slave/test', 14:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:21 INFO - 'SHELL': '/bin/bash', 14:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:21 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:21 INFO - 'USER': 'cltbld', 14:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:21 INFO - 'XPC_FLAGS': '0x0', 14:58:21 INFO - 'XPC_SERVICE_NAME': '0', 14:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:58:21 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-uwvWTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:58:21 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-i3vkts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:58:21 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)) 14:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:58:21 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-D1QHyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:58:21 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-10Rrgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:58:21 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)) 14:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:58:21 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-TiTdpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:58:21 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-hwzPXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:58:21 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-8ZrxSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:58:22 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-KMYSFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:58:22 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-z6XBL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:58:22 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-I1c4Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:58:22 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)) 14:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:58:22 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Hzmnnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:58:22 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-5KxtCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:58:22 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-cs_4E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:58:22 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-SaYBdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:58:22 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)) 14:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:22 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-5QbzC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:58:22 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-g2niyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:58:23 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-LljlsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:58:23 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)) 14:58:23 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)) 14:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:58:23 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)) 14:58:23 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)) 14:58:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:58: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 14:58: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 14:58: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 14:58: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 14:58: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 14:58: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 14:58:25 INFO - Downloading blessings-1.6.tar.gz 14:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:58:25 INFO - Installing collected packages: blessings 14:58:25 INFO - Running setup.py install for blessings 14:58:25 INFO - Successfully installed blessings 14:58:25 INFO - Cleaning up... 14:58:25 INFO - Return code: 0 14:58:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:58:26 INFO - Reading from file tmpfile_stdout 14:58:26 INFO - Current package versions: 14:58:26 INFO - blessings == 1.6 14:58:26 INFO - blobuploader == 1.2.4 14:58:26 INFO - docopt == 0.6.1 14:58:26 INFO - functools32 == 3.2.3-2 14:58:26 INFO - jsonschema == 2.5.1 14:58:26 INFO - manifestparser == 1.1 14:58:26 INFO - mozInstall == 1.12 14:58:26 INFO - mozcrash == 0.17 14:58:26 INFO - mozdebug == 0.1 14:58:26 INFO - mozdevice == 0.48 14:58:26 INFO - mozfile == 1.2 14:58:26 INFO - mozhttpd == 0.7 14:58:26 INFO - mozinfo == 0.9 14:58:26 INFO - mozleak == 0.1 14:58:26 INFO - mozlog == 3.3 14:58:26 INFO - moznetwork == 0.27 14:58:26 INFO - mozprocess == 0.23 14:58:26 INFO - mozprofile == 0.28 14:58:26 INFO - mozrunner == 6.12 14:58:26 INFO - mozscreenshot == 0.1 14:58:26 INFO - mozsystemmonitor == 0.3 14:58:26 INFO - moztest == 0.7 14:58:26 INFO - mozversion == 1.4 14:58:26 INFO - psutil == 3.1.1 14:58:26 INFO - requests == 1.2.3 14:58:26 INFO - wsgiref == 0.1.2 14:58:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:26 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 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:26 INFO - 'HOME': '/Users/cltbld', 14:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:26 INFO - 'LOGNAME': 'cltbld', 14:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:26 INFO - 'MOZ_NO_REMOTE': '1', 14:58:26 INFO - 'NO_EM_RESTART': '1', 14:58:26 INFO - 'PAGER': '/bin/cat', 14:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:26 INFO - 'PWD': '/builds/slave/test', 14:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:26 INFO - 'SHELL': '/bin/bash', 14:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:26 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:26 INFO - 'USER': 'cltbld', 14:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:26 INFO - 'XPC_FLAGS': '0x0', 14:58:26 INFO - 'XPC_SERVICE_NAME': '0', 14:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:58:26 INFO - Cleaning up... 14:58:26 INFO - Return code: 0 14:58:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2f4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f998a57acf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, '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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:26 INFO - 'HOME': '/Users/cltbld', 14:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:26 INFO - 'LOGNAME': 'cltbld', 14:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:26 INFO - 'MOZ_NO_REMOTE': '1', 14:58:26 INFO - 'NO_EM_RESTART': '1', 14:58:26 INFO - 'PAGER': '/bin/cat', 14:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:26 INFO - 'PWD': '/builds/slave/test', 14:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:26 INFO - 'SHELL': '/bin/bash', 14:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:58:26 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:26 INFO - 'USER': 'cltbld', 14:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:26 INFO - 'XPC_FLAGS': '0x0', 14:58:26 INFO - 'XPC_SERVICE_NAME': '0', 14:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:58:26 INFO - Cleaning up... 14:58:26 INFO - Return code: 0 14:58:26 INFO - Running post-action listener: _resource_record_post_action 14:58:26 INFO - Running post-action listener: _start_resource_monitoring 14:58:26 INFO - Starting resource monitoring. 14:58:26 INFO - [mozharness: 2016-08-16 21:58:26.745333Z] Finished create-virtualenv step (success) 14:58:26 INFO - [mozharness: 2016-08-16 21:58:26.746306Z] Running install step. 14:58:26 INFO - Running pre-action listener: _resource_record_pre_action 14:58:26 INFO - Running main action method: install 14:58:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:58:27 INFO - Reading from file tmpfile_stdout 14:58:27 INFO - Detecting whether we're running mozinstall >=1.0... 14:58:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:58:27 INFO - Reading from file tmpfile_stdout 14:58:27 INFO - Output received: 14:58:27 INFO - Usage: mozinstall [options] installer 14:58:27 INFO - Options: 14:58:27 INFO - -h, --help show this help message and exit 14:58:27 INFO - -d DEST, --destination=DEST 14:58:27 INFO - Directory to install application into. [default: 14:58:27 INFO - "/builds/slave/test"] 14:58:27 INFO - --app=APP Application being installed. [default: firefox] 14:58:27 INFO - mkdir: /builds/slave/test/build/application 14:58:27 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'] 14:58:27 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 14:59:01 INFO - Reading from file tmpfile_stdout 14:59:01 INFO - Output received: 14:59:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:59:01 INFO - Running post-action listener: _resource_record_post_action 14:59:01 INFO - [mozharness: 2016-08-16 21:59:01.027118Z] Finished install step (success) 14:59:01 INFO - [mozharness: 2016-08-16 21:59:01.027245Z] Running run-tests step. 14:59:01 INFO - Running pre-action listener: _resource_record_pre_action 14:59:01 INFO - Running main action method: run_tests 14:59:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:59:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:59:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:59:01 INFO - 2016-08-16 14:59:01.041 screenresolution[1634:7440] starting screenresolution argv=screenresolution get 14:59:01 INFO - 2016-08-16 14:59:01.044 screenresolution[1634:7440] Display 0: 1600x1200x32@60 14:59:01 INFO - 2016-08-16 14:59:01.050 screenresolution[1635:7442] starting screenresolution argv=screenresolution list 14:59:01 INFO - Available Modes on Display 0 14:59:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:59:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:59:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:59:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:59:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:59:01 INFO - Intel Iris: 14:59:01 INFO - Chipset Model: Intel Iris 14:59:01 INFO - Type: GPU 14:59:01 INFO - Bus: Built-In 14:59:01 INFO - VRAM (Dynamic, Max): 1536 MB 14:59:01 INFO - Vendor: Intel (0x8086) 14:59:01 INFO - Device ID: 0x0a2e 14:59:01 INFO - Revision ID: 0x0009 14:59:01 INFO - Displays: 14:59:01 INFO - Display: 14:59:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:59:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:59:01 INFO - Display Serial Number: 1600x1200 60 14:59:01 INFO - Main Display: Yes 14:59:01 INFO - Mirror: Off 14:59:01 INFO - Online: Yes 14:59:01 INFO - Rotation: Supported 14:59:01 INFO - Return code: 0 14:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:59:01 INFO - Python 2.7.3 14:59:01 INFO - Return code: 0 14:59:01 INFO - grabbing minidump binary from tooltool 14:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:01 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 0x10b1c3d30>, '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 0x10af28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1bbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:59:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:59:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:59:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:59:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:59:01 INFO - Return code: 0 14:59:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:59:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:59:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:59:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:59:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0319 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:59:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JGl3QkzR2v/Render', 14:59:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:01 INFO - 'HOME': '/Users/cltbld', 14:59:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:01 INFO - 'LOGNAME': 'cltbld', 14:59:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:59:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:01 INFO - 'MOZ_NO_REMOTE': '1', 14:59:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:59:01 INFO - 'NO_EM_RESTART': '1', 14:59:01 INFO - 'PAGER': '/bin/cat', 14:59:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:01 INFO - 'PWD': '/builds/slave/test', 14:59:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:59:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:01 INFO - 'SHELL': '/bin/bash', 14:59:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YGLF0TO4qp/Listeners', 14:59:01 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 14:59:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:01 INFO - 'USER': 'cltbld', 14:59:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:01 INFO - 'XPC_FLAGS': '0x0', 14:59:01 INFO - 'XPC_SERVICE_NAME': '0', 14:59:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:59:01 INFO - mozversion application_buildid: 20160816135314 14:59:01 INFO - mozversion application_changeset: 5cba4a9fe4de786814cc464bdeb8de6ca3ea9329 14:59:01 INFO - mozversion application_display_name: Nightly 14:59:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:59:01 INFO - mozversion application_name: Firefox 14:59:01 INFO - mozversion application_remotingname: firefox 14:59:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:59:01 INFO - mozversion application_vendor: Mozilla 14:59:01 INFO - mozversion application_version: 51.0a1 14:59:01 INFO - mozversion platform_buildid: 20160816135314 14:59:01 INFO - mozversion platform_changeset: 5cba4a9fe4de786814cc464bdeb8de6ca3ea9329 14:59:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:59:01 INFO - mozversion platform_version: 51.0a1 14:59:01 INFO - using testdate: 1471384741 14:59:01 INFO - actual date: 1471384741 14:59:01 INFO - starting webserver on 'localhost:49269' 14:59:01 INFO - SUITE-START | Running 2 tests 14:59:01 INFO - TEST-START | dromaeo_css 14:59:01 INFO - operating with platform_type : mac_ 14:59:01 INFO - Initialising browser for dromaeo_css test... 14:59:01 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmp7oN299/profile http://localhost:49269/getInfo.html) 14:59:04 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 14:59:04 INFO - PROCESS | 1645 | colorDepth:24 14:59:04 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 14:59:04 INFO - PROCESS | 1645 | __metrics 14:59:04 INFO - PROCESS | 1645 | 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" 14:59:04 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:59:04 INFO - TEST-INFO | 1645: exit 0 14:59:04 INFO - Browser initialized. 14:59:04 INFO - Running cycle 1/1 for dromaeo_css test... 14:59:04 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmp7oN299/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:16 INFO - PROCESS | 1647 | RSS: Main: 228573184 14:59:16 INFO - PROCESS | 1647 | 15:00:08 INFO - PROCESS | 1647 | 1471384808597 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] 15:02:20 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 15:02:21 INFO - PROCESS | 1647 | RSS: Main: 373280768 15:02:21 INFO - PROCESS | 1647 | 15:05:24 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 15:05:25 INFO - PROCESS | 1647 | RSS: Main: 376504320 15:05:25 INFO - PROCESS | 1647 | 15:08:28 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 15:08:28 INFO - PROCESS | 1647 | RSS: Main: 338329600 15:08:28 INFO - PROCESS | 1647 | 15:11:31 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 15:11:31 INFO - PROCESS | 1647 | RSS: Main: 338984960 15:11:31 INFO - PROCESS | 1647 | 15:14:35 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 15:14:36 INFO - PROCESS | 1647 | RSS: Main: 334823424 15:14:36 INFO - PROCESS | 1647 | 15:17:39 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 15:17:39 INFO - PROCESS | 1647 | RSS: Main: 483532800 15:17:39 INFO - PROCESS | 1647 | 15:17:39 INFO - PROCESS | 1647 | __start_tp_report 15:17:39 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 15:17:39 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 15:17:39 INFO - PROCESS | 1647 | |i|pagename|runs| 15:17:39 INFO - PROCESS | 1647 | |0;dojo.html;3372.3086767212726;3401.2347221875075;3417.3848707232687;3450.516927630134;3471.5834099908016;4551.362809206709;5630.268065151535;5789.160571717109;5791.797287094947;5815.3893841146655;5733.512651424623;5808.157817116516;5813.563982701293;5820;5835.183074369592;5198.324217851674;5234.241035049916;5252.947470525284;5262.605304602151;5320.989012087691;5247.081760691864;5279.445658205891;5296.973515132419;5311.548518375943;5344.358676958751;5298.894022119555;5299.33758280215;5309.230161626562;5311.57507399409;5332.200169974496;5363.356397232357;5381.977424289373;5382.085045542267;5387.272718183034;5441.782328706847;5151.278820965068;5178.533931946143;5204.115300398904;5278.788848446096;5314.867128321785;5779.971100144515;5811.767529298823;5838.182654428341;5862.38444963277;5863.442972917566;6282.623042617458;6284.402981716729;6309.305976342599;6309.4636955858805;6318.368163183691;5161.27742116104;6160.1375807387;6181.289151747562;6221.066839973995;6246.500279977591;5874.823755287348;5905.320888097838;5924.792632257937;5946.375630558816;5952.077427998667;6304.716287767062;6308.400701933309;6312.147860038928;6315.210598675166;6321.620702757849;5994.910076348859;6127.3566275540425;6137.9079313810325;6224.439800417984;6231.3145553989025;6189.659568723763;6248.343923887926;6253.312135665074;6258.749650013949;6258.74965001404;6250.312465628777;6257.687115644199;6268.279147897959;6280.403361680633;6280.591761535486;6137.263528376623;6145.324014358417;6196.628202307876;6293.087502312139;6300.653464059429;4979.551840334388;4982.377202849644;4985.8005679772405;4992.525710057539;5038;4478;4485.887852803641;4489.371487991683;4497.05561832019;4523.977380113079;5666.235058267163;5738.741756620962;5754.827355179351;5868.853278667982;5869.911951320733;6169.2288463942;6227.470664993526;6229.595076320024;6247.187865577536;6254.15568898202;5855.268091488564;5875.529957603381;5878.941210587839;5883.676397798162;5925.170476133345;5370.62405631602;5428.158635411518;5438.238646589481;5504.394516603171;5511.58663100269;6274.780382686584;6329.113924050729;6346.238451385863;6443.452306553808;6452.032195170762;6185.556725047066;6218.906716399167;6234.096056071935;6242.500599951902;6253.0620406937505;6132.600268413531;6425.907595708647;6443.96778016107;6448.677566121769;6453.128827608401;6107.643995706967;6176.474999624902;6191.783287584913;6280.120783090462;6281.152044473937;6216.129741836056;6217.222847144107;6223.502119830493;6228.501719862309;6230.532710046855;5870.236869206976;6174.073888916699;6192.225971753531;6194.721237544411;6202.658853762906;5935.436133567304;6015.578909476295;6134.8159555213415;6216.875662486816;6219.595726277777;6003.2796064470795;6077.849085183674;6093.440754883049;6099.425430926805;6108.63890615289;6026.548008899438;6093.847653808691;6194.101855231056;6197.380261973766;6210.7515699373325;5961.493273071837;6049.425304596057;6060.363661815446;6060.939390606038;6061 15:17:39 INFO - PROCESS | 1647 | |1;ext.html;463.4577544273201;480.9110314591801;492.4804331430341;512.1498312800752;536.9234684457662;25034;33036.17409564762;33041.339173216555;42093;42938.355924661155;43319.566804331946;43600.90997725051;43804.34293485592;43858.56141438593;43909.7804510977;9676.951615241931;9839.114479696826;9847.556859941284;9849.212063034976;9864.802703945918;9722.22222222224;9836.360636558637;9838.90161098387;9841.852372214422;9846.113849753521;9827.557759900821;9835.31152819303;9884.505774711235;9886;9904.801903961916;8326.958365208166;9829.4102353859;9859.359141655805;9864.90135098647;9870.851937220947;9705.708828735149;9776.804463910681;9777.755556111082;9789.657361992297;9812.558434870449;41541.58458415438;41886.58113418857;41917.580824191675;42059.532260806205;42068.368974465404;3386.407378708716;3445.982770086159;3458.8616455341758;3542.5394698689006;3928.5874983126932;31084.844575777202;32095.518567221512;32275.35449291001;32302;32333.83833080843;3203.775735698502;3345.565076540034;3386.102682789038;3415.8975230743117;3416.7266618670446;468715.99999999657;500034.4998274985;502210;504158;505945;59030.22909312727;59356;59446.108308375406;59475.70262148748;59509.10736338959;61703;61728.69135654293;61849.690751546856;61858;61866.38133618696;16363;16590.253438595293;16601.169941502878;16604.83395166033;16609.501714948572;12918.935405322913;12991.805122923164;12995.545155919497;13013.414396351998;13032.869671303355;16128.354865805237;16685.081215660113;16696.582585435463;16719.832801671826;16727.080010599533;5380.381256155592;6299.370062993756;6311.211098612674;6377.362263773678;6427.164468619143;662.410454695312;702.3888174136878;785.5012067337168;891.6834523744108;958.3052287091803;20297.88361640124;20830.791692082887;23862.092222850246;24743.38141546476;25075.87462062678;919.1084647891668;935.8315503209487;952.0051546134168;961.99038009619;963.8939716631165;12255;12762;12834.229946203257;12840;12867.356632168354;666810;669990;673128;674351;674964;59196.81606367935;59458.702706487056;59501;59530.702346488855;59566.702166489755;1242.5588915934893;1357.4163109862657;1368.8288963879515;1384.5846246126123;1407.6903081322093;30869.536956945216;31480.37039259248;31824.681753183097;31827.68172318247;32549.34901302008;50477.99044019025;51074;51269.718257043874;51351;51452.48547514477;554164;557162;557418;557936;557941.4205857889;26407.471850563266;27177.320566985192;27209.86395068012;27242.5913611292;27509.86245068762;47511.28733069076;48030.03939921252;48139.277910830664;48424.757876210395;48728;38753.80623096979;38889.02777430587;39330.80334598423;40320.19359612733;41010;39925.60074399219;40113.69904538488;40390.39414408845;40875.7956210217;40953.79523102365;38062.80968595139;39169.67057800005;39464.80267598644;39517.40723889202;39741.60258397379;25832.225033249033;31406.842965785025;32832.67167328392;33464.665353347125;35020.64979350174;24486.63270050915;25603.743962560882;25617.359566011;25751;26441.471170576864 15:17:39 INFO - PROCESS | 1647 | |2;jquery.html;343.7250199840127;345.33350633277763;366.84042441537935;374.9493818334524;397.51304651801547;14744.410223591058;15854.762178567331;15926.283317250722;21515.892420537915;21698.566028679415;20566.86882221481;20630.1747930083;21024.89487552564;21324;21688.3493495195;5650.350209725893;5960.0761881908375;5968;5974.940250597482;5976.312724036727;4174.791260436981;4415.072834704716;5860.794872179475;6345.302016778151;6626.304238055007;6378.585391949531;6667.099941507883;6692.364225398604;6697.330266973312;6711;6544.181977252843;6594.340565943416;6629.071929929813;6629.204495460552;6633.4693224541925;4540.77296135192;5092.694438333675;5406.83779486616;5742.167385729046;5764.452377024176;13137.671558211121;13180.802287965687;13224.6693832654;13286.933565332112;13367.799483007762;2149.720536330283;2179.106566307806;2252.526969336441;2344.859308441482;2371.454565449956;9774.5601447935;9872.308938374317;9923.851142232872;10193.490325483695;10296.79406411875;1821.5081927879398;1911.3545816733067;1924.6054558815408;1941.175000624729;1954.482062253504;108393;109918.45040774746;110502.44748776205;118058.40970795177;120357.39821300838;11290.943545282222;11425;11502.712432189262;11517.53929842797;11719.06247500198;11322;12685.873141268468;13442;13454.52909148175;13756.65608359799;7405.1854296027395;7871.016122984627;7976.242256985577;8031.919680803117;8357.498550087013;8226.465279756796;8308.916910830936;8357.206065423776;8509.531975741394;8662.480251184823;3782.3569993101237;4376.081022985209;4513.6233448797775;4518.683692141519;4602.401687780567;1593.2272847668871;1619.2146808797725;1763.8588912886937;1784.5218855544665;1876.756021717168;861.9094995025557;915.8073721996298;933.5145724223365;988.461288597716;1011.939283642969;20947.8952605236;21764.02061907218;21787.12851485923;21806.236781712563;21861.890690546446;884.8186121845006;905.2667339455063;928.9953550232341;940.576740466779;1009.8030883977701;10965.451727413598;11425.657230283105;11545.249558778652;11553.191276610725;11589.6523104307;604397;611662;612980;628943;629473;129408;132067.33966330107;132105;132296;133070.33464832808;963.7349728824629;989.7030890732751;1000.4397537379091;1008.621766837436;1011.544804837826;18190;18440.26238950427;18632.720509192102;18921.526961826065;18934.010909506545;35873.515810523684;45862.541374585824;55641.21793910369;57113.71443142758;57294.713526432104;58508;72267;74087.88868166874;74756.87864681926;82621.76067358874;7099.467539934422;7619.238076192337;7764.883526747216;7844.254795794391;8338.499690018618;9964.601415943282;12855.29295888735;13016.479340826261;13127.474901003852;13253.867461325262;9536.332456727963;10974.067204287725;11188.66434006981;11226.55093796239;11275.267107637977;10891.455427228448;11115.166362522681;11225.550977960791;11443.828342575034;11553.942230288794;9320.860187097063;11243.60647377338;11580.536778528765;11680;11810.76378472443;7867.921320786719;7933.286004259644;8119.188081191834;8178.100408955129;8240.423170378015;8208.507489550646;10864.130869530576;11035.613753518588;11256.887431125584;11414.233303009822 15:17:39 INFO - PROCESS | 1647 | |3;mootools.html;1526.2368815592204;1550.8604225619695;1745.9301627934883;1889.896055716935;1913.9521511962207;8430.789230269238;8936.329775266848;8936.731898043061;8941.731748047552;8943;7770.494917830337;8035.116137224901;8411.200935911094;8665.436746611465;8697.52163631;2366.4675448024186;2398.4843258699375;2398.7481314461993;2398.9280321590295;2406.5186962607463;2034.328671538396;2393.066703985447;2397.6643269942224;2422.8546287222734;2424.369663887393;2061.3300677279867;2382.630692242705;2397.568437681217;2405.6511805788236;2424.2363655448567;2360.7639236076425;2381.38084098134;2389.892454839536;2391.3184742348435;2392.3540644026016;2357.823163262745;2377.595808712523;2381.535600557892;2383.1778036577352;2384.78536931677;8778.780530486725;8820.735377938672;8894.822103557957;8906.109389061106;8923.73228803137;5298.496642818926;5443.101888188444;5443.666301756056;5444.292242008513;5453.700046497441;3575.910602234939;3663.21240933198;3740.8129593520216;3745.606711295329;3761.2665530221616;1096.802575536403;1106.1537923488538;1118.6196693124377;1126.419893754717;1135.426609562174;11642.18504704671;11653.533858645644;11759.7060073498;11780.70548236301;11789.469473873696;3956.347202711578;4405.691601587858;4535.183666939916;4677.22825733757;4703.341532185496;9197.310201734897;9206;9218.124278193562;9232.492212928219;9235.1688348049;5301.867453313698;5306.09796334624;5310.893782124336;5313.57491400687;5319.042572337016;4340.457442819647;4426.490953540319;4581.175388430048;4954.578860796801;4967.155583550805;3362.747793915466;3702;3749.6250374962833;3787.4697542344093;3862;965.5944503308627;1154.7401834587151;1155.5493357590547;1175.3770501634147;1193.6478738772082;796.717165406284;882.4925667740946;887.5961437545901;895.4806212396925;925.643627203518;5763.193152958589;5862.267216597926;5910.763569457174;6032.638041717423;6100.350011932267;430.8039841871941;442.6525177735462;443.0872402850139;446.05659031149537;447.61057879644915;3874.1670540833857;4091.9386209206887;4176.979115104405;4338.240807858612;4356.49900261474;10926.071283940795;10997.725056873482;11174.888251117547;11177.552897883994;11183.049440797624;11116;11134.387608681438;11137.554497820158;11147.665570032912;11153.609623663295;7917.881231781528;8156.836863262702;8164.142765009708;8204.179582041748;8285.917140828635;5030.629844769246;5987.700614969322;6005.519558435402;6069.119977603134;6097.993831017832;7970.9202907970175;10177.18582513412;10201.132903702972;10299.691009269734;10340.689779306633;8745.387822852339;9923.354981926152;10286.485675716034;10410.167186625204;10489.685309440729;6046.486048685911;7203.459740519377;7487.700491980259;7647.158812530506;7737.187595302637;8283.710070147516;8518.82962340762;8542.914570854213;8630.136986301572;8663.653453861774;6408.519361048034;7517.661705223388;7632.580208088609;7694.846103078019;7802.21977802238;7464.253574642492;7495.213002634645;7502.962485187539;7520.059992500937;7607.4674772767585;6949.826254343682;7101.183363913009;7121.750738724119;7122.85754284901;7142.5714457132735;4936.358273424576;4978.726170060537;5045.445001049955;5052.317937078595;5105.2597373381395;4264.722793018444;4805.567498925114;4826.638002149783;5103.362079740033;5111.977604479045 15:17:39 INFO - PROCESS | 1647 | |4;prototype.html;299.70179671227123;306.47286666932865;307.3806280345105;312.6919983815941;313.53753214009356;4322.80547375368;4947.950520494798;5107.182850743877;5201.687898726079;5266.289050978116;4277.187334406461;5187.6887386756725;5227.2159176123605;5244.213367994803;5268.683878967265;3786.469894214805;3798.65812076913;3948.5459172195133;3992.840286388541;4058.3969332113797;3469.809160496184;4020.4572382728397;4023.396490526415;4055.6958228133008;4063.3295506241584;3591.6587924147293;3706.684127134869;3981.5620281768984;3986.823886953341;3995.9200815983663;3441.328940856534;3639.854405823764;3699.9445008324897;3775.2449510097954;3935.9016024599614;3315.96684033159;3472.2881809229048;3480.3027653568433;3482.4428091505492;3494.8951531453845;5079.3650793650795;5106.157484015133;5130.794768209267;5149.9485005149845;5211.635185537014;3658.396364599838;4453.888652783674;4555.681102322838;4568.383268258809;4654.509837237096;4486.4616246050355;5153.2270159476;5392.433794451605;5428.212909128154;5542.334919809608;3150.6842470783954;3294.159989202762;3677.9632203678157;3869.8645547405704;3882.301185786557;4788.121621486607;5038.773255203525;5608.597850537366;5642.576806739511;5687.639629553772;3275.4104261233206;3834.67703642243;3901.51231096113;3903.2193561287854;3916.060145565044;3315.950260746091;3625.836837342326;3868.2070175614494;3950.4271880577157;3972.3842804365368;4004.4593979812353;4038.9094944364856;4546.636269098464;4590.655700822452;4613.976930115395;4488.932666010012;4830.033993201304;5228.620977455249;5457;5497.202905578749;1151.7638884028754;1295.4429595273934;1347.905646604748;1368.2679766324968;1372.5813626843908;695.6973716433367;788.2078511096312;831.8793774902726;845.5391811462767;855.4396870050127;4487.3076154307155;4735.502772208937;4864.610831133501;4926.729029903389;5003.949960500348;5484.314460692413;5576.581756368289;5666.914996275059;5756.172145523264;5791.305043394819;4980.705016695685;5055.51972562606;5101.311322971352;5129.435762066169;5140.845774626767;2903.4483448145206;2957.985210073936;2960.763138948879;2968.0798952324417;2974.806637568551;4935.481774413634;5304.708241046779;5824;5828.970855145697;5864.208331875142;4998.250262460588;5417.539509141767;5780.826575202751;5812.970935145382;5847.853803654943;5765.308163020381;5902.822915312548;5911.9113213301835;5940.55445841555;5965.987176475852;5301.496357845998;5688.943110569007;5725.824186808986;5749.885002299847;5805.738741756547;4996.6002719783055;5644.238027866186;5760.510356619734;5779.884402311846;5788.710564471676;5293.485594342656;6079.939200608114;6087.717106085218;6114.3796893824065;6120.663363515049;3099.0166293572584;3721.0325315418727;3857.1707082976172;3859.996400935721;3907.706921980806;4708;5756.65460072397;5776.335721391925;5785.280917968548;5795.39148389413;5172.68081152227;5632.324121105494;5679.716014199356;5680.829575112753;5713.857153571194;4027.6576490998596;5021.514350396577;5511.311086114236;5608.38307786135;5669.914951275651;4550.997561073117;5445.482679145475;5528.834134975958;5565.332160140647;5565.833025009256;4471.8658440246845;5355.4376790436445;5492.80775172867;5562.3047119110115;5744.224529688438;5047.87380315495;5255.633535280778;5544.251526044094;5544.7227638617105;5552.944470555242 15:17:39 INFO - PROCESS | 1647 | |5;yui.html;675.2605896543284;746.6751962896137;771.3674786674925;786.1273985875677;821.1747194069957;14990.775138372934;16044.358225670989;16452.17739113044;16467.835321646795;17024.574385640364;14995;15406.768898466533;15412.30644620992;15417.460388886391;15437.228138593082;610.7923306075934;676.2662511175369;850.2942557677113;850.421713235;851.833892390984;671.2448495442627;825.7192554531458;852.9914700853005;857.5540718826206;863.6156910174975;922.3313098003961;922.9492377919246;923.2567782934768;923.5890028937125;924.5469719837265;917.6971599372191;917.7934964632971;917.807260475301;918.5085979001236;918.9816203675889;531.0785786660142;619.5693992675093;642.2870613618879;644.6067898581862;648.7599588152414;15414.537563873102;15464.304106315243;15466.226688665634;15467.458638947583;15521.146336951464;14033.64915877101;14180.787288190686;14378.424863005468;14454.349554270084;14609.123452592772;12857;12895.226286422845;12925.612231633066;13067.01997350193;13129.671758206026;4590.334401511762;4696.553827386393;4720.976395118037;4741.454732705749;4829.806807727687;100331.49834250782;101324.49337753264;101379.77923532273;107977;110564.89435105627;11203.271787333797;11306.208565400342;11499.482523286471;11538.423078846025;11851.525938962344;18720.812791871907;22518.774812251995;22522.66216006761;22530.21144259943;22537;7860.4890682106625;7874.7243846466245;7922.168172341936;8103.837923241502;8209.79475513117;4228.556001619786;4244.554321796229;4304.332828411601;4395.230834603932;4466.1514312281215;3412.8805491808166;3517.66582174693;3522.260325331658;3524.8942531724088;3525.823708814549;626.3423405424286;633.8558901183408;641.2753588445028;659.8880885707598;660.0528241972785;592.7865968251426;615.4399496458202;627.7206643043802;635.253577046968;646.7413034786123;9086.727398178065;9101.271898248124;9107.271418286522;9165.58754856033;9278.536073196314;535.3254898827505;581.9592628515963;585.8476796032977;590.3152343281772;592.6414519215898;3675.3568125577917;4288.356746488052;4354.782260886943;4545.818167273338;4569.9314510282375;113840;138903;143545.56454435532;156180;162624;67457.02785573772;141240.29379853036;141583;141737.29131354278;143403.28298358442;115163;116816;119683.40158299153;119834.8016519841;122647.38676306562;7325.743598974011;8605.65577376898;8640.092790256933;8737.694180703646;8967.327450441373;60448.697756510934;63043.369566305584;66190.66904665445;66595;68149.31850681629;83451;92347.53826230826;96043;98132;98865;11540.884591153981;11731.648050558497;11797.410129493663;11941.283522988648;12021.699457513632;12349.93825030869;12617.116801823784;12805.103642745291;13080.215187088805;13446.394912229169;11972.281663100242;12028.27830330183;12081.879181208427;12378.491813664335;12483.438245279165;12556.560520382109;13067.281299528617;13513.729725405241;13699.383527741475;13828.101173423694;13798.93100534491;13804.861951380759;13878.375473103533;14070.085444446488;14450.494232701805;11115.44422778874;11419.429028548706;11434.256773309708;11910.52357905674;12089.879101208875;10837.349759014169;11174.608888688857;11206.719832004264;11399.6118393948;11833.290002599872 15:17:39 INFO - PROCESS | 1647 | __end_tp_report 15:17:39 INFO - PROCESS | 1647 | __start_cc_report 15:17:39 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1404 15:17:39 INFO - PROCESS | 1647 | __end_cc_report 15:17:39 INFO - PROCESS | 1647 | __startTimestamp1471385859754__endTimestamp 15:17:39 INFO - PROCESS | 1647 | 15:17:39 INFO - PROCESS | 1647 | ------- Summary: start ------- 15:17:39 INFO - PROCESS | 1647 | Number of tests: 6 15:17:39 INFO - PROCESS | 1647 | 15:17:39 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5793.08 Median:6026.55 stddev:632.01 (10.5%) stddev-sans-first:604.74 15:17:39 INFO - PROCESS | 1647 | Values: 3372.3 3401.2 3417.4 3450.5 3471.6 4551.4 5630.3 5789.2 5791.8 5815.4 5733.5 5808.2 5813.6 5820.0 5835.2 5198.3 5234.2 5252.9 5262.6 5321.0 5247.1 5279.4 5297.0 5311.5 5344.4 5298.9 5299.3 5309.2 5311.6 5332.2 5363.4 5382.0 5382.1 5387.3 5441.8 5151.3 5178.5 5204.1 5278.8 5314.9 5780.0 5811.8 5838.2 5862.4 5863.4 6282.6 6284.4 6309.3 6309.5 6318.4 5161.3 6160.1 6181.3 6221.1 6246.5 5874.8 5905.3 5924.8 5946.4 5952.1 6304.7 6308.4 6312.1 6315.2 6321.6 5994.9 6127.4 6137.9 6224.4 6231.3 6189.7 6248.3 6253.3 6258.7 6258.7 6250.3 6257.7 6268.3 6280.4 6280.6 6137.3 6145.3 6196.6 6293.1 6300.7 4979.6 4982.4 4985.8 4992.5 5038.0 4478.0 4485.9 4489.4 4497.1 4524.0 5666.2 5738.7 5754.8 5868.9 5869.9 6169.2 6227.5 6229.6 6247.2 6254.2 5855.3 5875.5 5878.9 5883.7 5925.2 5370.6 5428.2 5438.2 5504.4 5511.6 6274.8 6329.1 6346.2 6443.5 6452.0 6185.6 6218.9 6234.1 6242.5 6253.1 6132.6 6425.9 6444.0 6448.7 6453.1 6107.6 6176.5 6191.8 6280.1 6281.2 6216.1 6217.2 6223.5 6228.5 6230.5 5870.2 6174.1 6192.2 6194.7 6202.7 5935.4 6015.6 6134.8 6216.9 6219.6 6003.3 6077.8 6093.4 6099.4 6108.6 6026.5 6093.8 6194.1 6197.4 6210.8 5961.5 6049.4 6060.4 6060.9 6061.0 15:17:39 INFO - PROCESS | 1647 | 15:17:39 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:70567.82 Median:43460.24 stddev:155045.66 (356.8%) stddev-sans-first:155391.26 15:17:39 INFO - PROCESS | 1647 | Values: 463.5 480.9 492.5 512.1 536.9 25034.0 33036.2 33041.3 42093.0 42938.4 43319.6 43600.9 43804.3 43858.6 43909.8 9677.0 9839.1 9847.6 9849.2 9864.8 9722.2 9836.4 9838.9 9841.9 9846.1 9827.6 9835.3 9884.5 9886.0 9904.8 8327.0 9829.4 9859.4 9864.9 9870.9 9705.7 9776.8 9777.8 9789.7 9812.6 41541.6 41886.6 41917.6 42059.5 42068.4 3386.4 3446.0 3458.9 3542.5 3928.6 31084.8 32095.5 32275.4 32302.0 32333.8 3203.8 3345.6 3386.1 3415.9 3416.7 468716.0 500034.5 502210.0 504158.0 505945.0 59030.2 59356.0 59446.1 59475.7 59509.1 61703.0 61728.7 61849.7 61858.0 61866.4 16363.0 16590.3 16601.2 16604.8 16609.5 12918.9 12991.8 12995.5 13013.4 13032.9 16128.4 16685.1 16696.6 16719.8 16727.1 5380.4 6299.4 6311.2 6377.4 6427.2 662.4 702.4 785.5 891.7 958.3 20297.9 20830.8 23862.1 24743.4 25075.9 919.1 935.8 952.0 962.0 963.9 12255.0 12762.0 12834.2 12840.0 12867.4 666810.0 669990.0 673128.0 674351.0 674964.0 59196.8 59458.7 59501.0 59530.7 59566.7 1242.6 1357.4 1368.8 1384.6 1407.7 30869.5 31480.4 31824.7 31827.7 32549.3 50478.0 51074.0 51269.7 51351.0 51452.5 554164.0 557162.0 557418.0 557936.0 557941.4 26407.5 27177.3 27209.9 27242.6 27509.9 47511.3 48030.0 48139.3 48424.8 48728.0 38753.8 38889.0 39330.8 40320.2 41010.0 39925.6 40113.7 40390.4 40875.8 40953.8 38062.8 39169.7 39464.8 39517.4 39741.6 25832.2 31406.8 32832.7 33464.7 35020.6 24486.6 25603.7 25617.4 25751.0 26441.5 15:17:39 INFO - PROCESS | 1647 | 15:17:39 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:34879.38 Median:2298.69 stddev:102916.45 (4477.2%) stddev-sans-first:103172.48 15:17:39 INFO - PROCESS | 1647 | Values: 343.7 345.3 366.8 374.9 397.5 14744.4 15854.8 15926.3 21515.9 21698.6 20566.9 20630.2 21024.9 21324.0 21688.3 5650.4 5960.1 5968.0 5974.9 5976.3 4174.8 4415.1 5860.8 6345.3 6626.3 6378.6 6667.1 6692.4 6697.3 6711.0 6544.2 6594.3 6629.1 6629.2 6633.5 4540.8 5092.7 5406.8 5742.2 5764.5 13137.7 13180.8 13224.7 13286.9 13367.8 2149.7 2179.1 2252.5 2344.9 2371.5 9774.6 9872.3 9923.9 10193.5 10296.8 1821.5 1911.4 1924.6 1941.2 1954.5 108393.0 109918.5 110502.4 118058.4 120357.4 11290.9 11425.0 11502.7 11517.5 11719.1 11322.0 12685.9 13442.0 13454.5 13756.7 7405.2 7871.0 7976.2 8031.9 8357.5 8226.5 8308.9 8357.2 8509.5 8662.5 3782.4 4376.1 4513.6 4518.7 4602.4 1593.2 1619.2 1763.9 1784.5 1876.8 861.9 915.8 933.5 988.5 1011.9 20947.9 21764.0 21787.1 21806.2 21861.9 884.8 905.3 929.0 940.6 1009.8 10965.5 11425.7 11545.2 11553.2 11589.7 604397.0 611662.0 612980.0 628943.0 629473.0 129408.0 132067.3 132105.0 132296.0 133070.3 963.7 989.7 1000.4 1008.6 1011.5 18190.0 18440.3 18632.7 18921.5 18934.0 35873.5 45862.5 55641.2 57113.7 57294.7 58508.0 72267.0 74087.9 74756.9 82621.8 7099.5 7619.2 7764.9 7844.3 8338.5 9964.6 12855.3 13016.5 13127.5 13253.9 9536.3 10974.1 11188.7 11226.6 11275.3 10891.5 11115.2 11225.6 11443.8 11553.9 9320.9 11243.6 11580.5 11680.0 11810.8 7867.9 7933.3 8119.2 8178.1 8240.4 8208.5 10864.1 11035.6 11256.9 11414.2 15:17:39 INFO - PROCESS | 1647 | 15:17:39 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5694.46 Median:4816.10 stddev:3236.50 (67.2%) stddev-sans-first:3230.42 15:17:39 INFO - PROCESS | 1647 | Values: 1526.2 1550.9 1745.9 1889.9 1914.0 8430.8 8936.3 8936.7 8941.7 8943.0 7770.5 8035.1 8411.2 8665.4 8697.5 2366.5 2398.5 2398.7 2398.9 2406.5 2034.3 2393.1 2397.7 2422.9 2424.4 2061.3 2382.6 2397.6 2405.7 2424.2 2360.8 2381.4 2389.9 2391.3 2392.4 2357.8 2377.6 2381.5 2383.2 2384.8 8778.8 8820.7 8894.8 8906.1 8923.7 5298.5 5443.1 5443.7 5444.3 5453.7 3575.9 3663.2 3740.8 3745.6 3761.3 1096.8 1106.2 1118.6 1126.4 1135.4 11642.2 11653.5 11759.7 11780.7 11789.5 3956.3 4405.7 4535.2 4677.2 4703.3 9197.3 9206.0 9218.1 9232.5 9235.2 5301.9 5306.1 5310.9 5313.6 5319.0 4340.5 4426.5 4581.2 4954.6 4967.2 3362.7 3702.0 3749.6 3787.5 3862.0 965.6 1154.7 1155.5 1175.4 1193.6 796.7 882.5 887.6 895.5 925.6 5763.2 5862.3 5910.8 6032.6 6100.4 430.8 442.7 443.1 446.1 447.6 3874.2 4091.9 4177.0 4338.2 4356.5 10926.1 10997.7 11174.9 11177.6 11183.0 11116.0 11134.4 11137.6 11147.7 11153.6 7917.9 8156.8 8164.1 8204.2 8285.9 5030.6 5987.7 6005.5 6069.1 6098.0 7970.9 10177.2 10201.1 10299.7 10340.7 8745.4 9923.4 10286.5 10410.2 10489.7 6046.5 7203.5 7487.7 7647.2 7737.2 8283.7 8518.8 8542.9 8630.1 8663.7 6408.5 7517.7 7632.6 7694.8 7802.2 7464.3 7495.2 7503.0 7520.1 7607.5 6949.8 7101.2 7121.8 7122.9 7142.6 4936.4 4978.7 5045.4 5052.3 5105.3 4264.7 4805.6 4826.6 5103.4 5112.0 15:17:39 INFO - PROCESS | 1647 | 15:17:39 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4461.96 Median:5030.14 stddev:1399.25 (27.8%) stddev-sans-first:1367.86 15:17:39 INFO - PROCESS | 1647 | Values: 299.7 306.5 307.4 312.7 313.5 4322.8 4948.0 5107.2 5201.7 5266.3 4277.2 5187.7 5227.2 5244.2 5268.7 3786.5 3798.7 3948.5 3992.8 4058.4 3469.8 4020.5 4023.4 4055.7 4063.3 3591.7 3706.7 3981.6 3986.8 3995.9 3441.3 3639.9 3699.9 3775.2 3935.9 3316.0 3472.3 3480.3 3482.4 3494.9 5079.4 5106.2 5130.8 5149.9 5211.6 3658.4 4453.9 4555.7 4568.4 4654.5 4486.5 5153.2 5392.4 5428.2 5542.3 3150.7 3294.2 3678.0 3869.9 3882.3 4788.1 5038.8 5608.6 5642.6 5687.6 3275.4 3834.7 3901.5 3903.2 3916.1 3316.0 3625.8 3868.2 3950.4 3972.4 4004.5 4038.9 4546.6 4590.7 4614.0 4488.9 4830.0 5228.6 5457.0 5497.2 1151.8 1295.4 1347.9 1368.3 1372.6 695.7 788.2 831.9 845.5 855.4 4487.3 4735.5 4864.6 4926.7 5003.9 5484.3 5576.6 5666.9 5756.2 5791.3 4980.7 5055.5 5101.3 5129.4 5140.8 2903.4 2958.0 2960.8 2968.1 2974.8 4935.5 5304.7 5824.0 5829.0 5864.2 4998.3 5417.5 5780.8 5813.0 5847.9 5765.3 5902.8 5911.9 5940.6 5966.0 5301.5 5688.9 5725.8 5749.9 5805.7 4996.6 5644.2 5760.5 5779.9 5788.7 5293.5 6079.9 6087.7 6114.4 6120.7 3099.0 3721.0 3857.2 3860.0 3907.7 4708.0 5756.7 5776.3 5785.3 5795.4 5172.7 5632.3 5679.7 5680.8 5713.9 4027.7 5021.5 5511.3 5608.4 5669.9 4551.0 5445.5 5528.8 5565.3 5565.8 4471.9 5355.4 5492.8 5562.3 5744.2 5047.9 5255.6 5544.3 5544.7 5552.9 15:17:39 INFO - PROCESS | 1647 | 15:17:39 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:24877.67 Median:3519.96 stddev:39787.03 (1130.3%) stddev-sans-first:39857.14 15:17:39 INFO - PROCESS | 1647 | Values: 675.3 746.7 771.4 786.1 821.2 14990.8 16044.4 16452.2 16467.8 17024.6 14995.0 15406.8 15412.3 15417.5 15437.2 610.8 676.3 850.3 850.4 851.8 671.2 825.7 853.0 857.6 863.6 922.3 922.9 923.3 923.6 924.5 917.7 917.8 917.8 918.5 919.0 531.1 619.6 642.3 644.6 648.8 15414.5 15464.3 15466.2 15467.5 15521.1 14033.6 14180.8 14378.4 14454.3 14609.1 12857.0 12895.2 12925.6 13067.0 13129.7 4590.3 4696.6 4721.0 4741.5 4829.8 100331.5 101324.5 101379.8 107977.0 110564.9 11203.3 11306.2 11499.5 11538.4 11851.5 18720.8 22518.8 22522.7 22530.2 22537.0 7860.5 7874.7 7922.2 8103.8 8209.8 4228.6 4244.6 4304.3 4395.2 4466.2 3412.9 3517.7 3522.3 3524.9 3525.8 626.3 633.9 641.3 659.9 660.1 592.8 615.4 627.7 635.3 646.7 9086.7 9101.3 9107.3 9165.6 9278.5 535.3 582.0 585.8 590.3 592.6 3675.4 4288.4 4354.8 4545.8 4569.9 113840.0 138903.0 143545.6 156180.0 162624.0 67457.0 141240.3 141583.0 141737.3 143403.3 115163.0 116816.0 119683.4 119834.8 122647.4 7325.7 8605.7 8640.1 8737.7 8967.3 60448.7 63043.4 66190.7 66595.0 68149.3 83451.0 92347.5 96043.0 98132.0 98865.0 11540.9 11731.6 11797.4 11941.3 12021.7 12349.9 12617.1 12805.1 13080.2 13446.4 11972.3 12028.3 12081.9 12378.5 12483.4 12556.6 13067.3 13513.7 13699.4 13828.1 13798.9 13804.9 13878.4 14070.1 14450.5 11115.4 11419.4 11434.3 11910.5 12089.9 10837.3 11174.6 11206.7 11399.6 11833.3 15:17:39 INFO - PROCESS | 1647 | -------- Summary: end -------- 15:17:39 INFO - PROCESS | 1647 | 15:17:40 INFO - TEST-INFO | 1647: exit 0 15:17:40 INFO - TEST-OK | dromaeo_css | took 1118752ms 15:17:40 INFO - TEST-START | kraken 15:17:40 INFO - operating with platform_type : mac_ 15:17:40 INFO - Initialising browser for kraken test... 15:17:40 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmplBOQI9/profile http://localhost:49269/getInfo.html) 15:17:42 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 15:17:42 INFO - PROCESS | 1657 | colorDepth:24 15:17:42 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 15:17:42 INFO - PROCESS | 1657 | __metrics 15:17:42 INFO - PROCESS | 1657 | 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" 15:17:42 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:17:43 INFO - TEST-INFO | 1657: exit 0 15:17:43 INFO - Browser initialized. 15:17:43 INFO - Running cycle 1/1 for kraken test... 15:17:43 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmplBOQI9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:55 INFO - PROCESS | 1658 | RSS: Main: 228597760 15:17:55 INFO - PROCESS | 1658 | 15:17:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 15:17:59 INFO - PROCESS | 1658 | RSS: Main: 285388800 15:17:59 INFO - PROCESS | 1658 | 15:18:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 15:18:02 INFO - PROCESS | 1658 | RSS: Main: 296591360 15:18:02 INFO - PROCESS | 1658 | 15:18:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 15:18:06 INFO - PROCESS | 1658 | RSS: Main: 388575232 15:18:06 INFO - PROCESS | 1658 | 15:18:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 15:18:09 INFO - PROCESS | 1658 | RSS: Main: 287559680 15:18:09 INFO - PROCESS | 1658 | 15:18:11 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:18:12 INFO - PROCESS | 1658 | RSS: Main: 291418112 15:18:12 INFO - PROCESS | 1658 | 15:18:15 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 15:18:15 INFO - PROCESS | 1658 | RSS: Main: 329469952 15:18:15 INFO - PROCESS | 1658 | 15:18:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 15:18:19 INFO - PROCESS | 1658 | RSS: Main: 331141120 15:18:19 INFO - PROCESS | 1658 | 15:18:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 15:18:23 INFO - PROCESS | 1658 | RSS: Main: 331685888 15:18:23 INFO - PROCESS | 1658 | 15:18:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:18:25 INFO - PROCESS | 1658 | RSS: Main: 300888064 15:18:25 INFO - PROCESS | 1658 | 15:18:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:18:27 INFO - PROCESS | 1658 | RSS: Main: 307560448 15:18:27 INFO - PROCESS | 1658 | 15:18:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:18:30 INFO - PROCESS | 1658 | RSS: Main: 305090560 15:18:30 INFO - PROCESS | 1658 | 15:18:33 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:18:34 INFO - PROCESS | 1658 | RSS: Main: 314028032 15:18:34 INFO - PROCESS | 1658 | 15:18:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:18:37 INFO - PROCESS | 1658 | RSS: Main: 316600320 15:18:37 INFO - PROCESS | 1658 | 15:18:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 15:18:40 INFO - PROCESS | 1658 | RSS: Main: 359522304 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | __start_tp_report 15:18:40 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 15:18:40 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 15:18:40 INFO - PROCESS | 1658 | |i|pagename|runs| 15:18:40 INFO - PROCESS | 1658 | |0;ai-astar;103;114;115;114;107;112;112;114;113;113 15:18:40 INFO - PROCESS | 1658 | |1;audio-beat-detection;140;111;109;191;140;127;127;105;144;111 15:18:40 INFO - PROCESS | 1658 | |2;audio-dft;191;262;198;186;181;182;177;183;179;183 15:18:40 INFO - PROCESS | 1658 | |3;audio-fft;76;58;60;87;59;57;109;85;85;57 15:18:40 INFO - PROCESS | 1658 | |4;audio-oscillator;83;69;102;70;75;68;96;70;68;102 15:18:40 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;88;85;89;86;132;121;89;85;90;84 15:18:40 INFO - PROCESS | 1658 | |6;imaging-darkroom;93;95;89;125;148;92;93;94;108;147 15:18:40 INFO - PROCESS | 1658 | |7;imaging-desaturate;124;141;90;84;89;97;86;85;83;84 15:18:40 INFO - PROCESS | 1658 | |8;json-parse-financial;55;52;55;52;52;56;54;54;55;53 15:18:40 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;65;70;71;65;77;75;68;68;68;69 15:18:40 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;84;85;85;84;87;87;101;104;103;80 15:18:40 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;139;137;138;136;143;156;132;140;214;153 15:18:40 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;176;168;170;166;169;169;169;166;165;231 15:18:40 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;67;68;67;67;66;78;83;73;68 15:18:40 INFO - PROCESS | 1658 | __end_tp_report 15:18:40 INFO - PROCESS | 1658 | __start_cc_report 15:18:40 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2091 15:18:40 INFO - PROCESS | 1658 | __end_cc_report 15:18:40 INFO - PROCESS | 1658 | __startTimestamp1471385919996__endTimestamp 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | ------- Summary: start ------- 15:18:40 INFO - PROCESS | 1658 | Number of tests: 14 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.50 stddev:3.77 (3.3%) stddev-sans-first:2.35 15:18:40 INFO - PROCESS | 1658 | Values: 103.0 114.0 115.0 114.0 107.0 112.0 112.0 114.0 113.0 113.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:133.50 stddev:25.65 (19.2%) stddev-sans-first:26.97 15:18:40 INFO - PROCESS | 1658 | Values: 140.0 111.0 109.0 191.0 140.0 127.0 127.0 105.0 144.0 111.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:192.20 Median:184.50 stddev:25.28 (13.7%) stddev-sans-first:26.80 15:18:40 INFO - PROCESS | 1658 | Values: 191.0 262.0 198.0 186.0 181.0 182.0 177.0 183.0 179.0 183.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:73.30 Median:68.00 stddev:17.92 (26.4%) stddev-sans-first:18.98 15:18:40 INFO - PROCESS | 1658 | Values: 76.0 58.0 60.0 87.0 59.0 57.0 109.0 85.0 85.0 57.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:80.30 Median:70.00 stddev:14.40 (20.6%) stddev-sans-first:15.24 15:18:40 INFO - PROCESS | 1658 | Values: 83.0 69.0 102.0 70.0 75.0 68.0 96.0 70.0 68.0 102.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:87.00 stddev:16.97 (19.5%) stddev-sans-first:17.82 15:18:40 INFO - PROCESS | 1658 | Values: 88.0 85.0 89.0 86.0 132.0 121.0 89.0 85.0 90.0 84.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:108.40 Median:92.50 stddev:23.19 (25.1%) stddev-sans-first:23.92 15:18:40 INFO - PROCESS | 1658 | Values: 93.0 95.0 89.0 125.0 148.0 92.0 93.0 94.0 108.0 147.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:85.50 stddev:19.92 (23.3%) stddev-sans-first:18.44 15:18:40 INFO - PROCESS | 1658 | Values: 124.0 141.0 90.0 84.0 89.0 97.0 86.0 85.0 83.0 84.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.50 stddev:1.48 (2.7%) stddev-sans-first:1.50 15:18:40 INFO - PROCESS | 1658 | Values: 55.0 52.0 55.0 52.0 52.0 56.0 54.0 54.0 55.0 53.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:3.89 (5.6%) stddev-sans-first:3.76 15:18:40 INFO - PROCESS | 1658 | Values: 65.0 70.0 71.0 65.0 77.0 75.0 68.0 68.0 68.0 69.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:84.50 stddev:8.98 (10.6%) stddev-sans-first:9.26 15:18:40 INFO - PROCESS | 1658 | Values: 84.0 85.0 85.0 84.0 87.0 87.0 101.0 104.0 103.0 80.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:148.80 Median:141.50 stddev:24.11 (17.0%) stddev-sans-first:25.31 15:18:40 INFO - PROCESS | 1658 | Values: 139.0 137.0 138.0 136.0 143.0 156.0 132.0 140.0 214.0 153.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:169.00 stddev:19.95 (11.8%) stddev-sans-first:21.15 15:18:40 INFO - PROCESS | 1658 | Values: 176.0 168.0 170.0 166.0 169.0 169.0 169.0 166.0 165.0 231.0 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:68.00 stddev:5.72 (8.4%) stddev-sans-first:6.00 15:18:40 INFO - PROCESS | 1658 | Values: 68.0 67.0 68.0 67.0 67.0 66.0 78.0 83.0 73.0 68.0 15:18:40 INFO - PROCESS | 1658 | -------- Summary: end -------- 15:18:40 INFO - PROCESS | 1658 | 15:18:40 INFO - TEST-INFO | 1658: exit 0 15:18:40 INFO - TEST-OK | kraken | took 60452ms 15:18:40 INFO - SUITE-END | took 1179s 15:18:41 INFO - Completed test suite (00:19:39) 15:18:41 INFO - javascript benchmark 15:18:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3372.3086767212726, 3401.2347221875075, 3417.3848707232687, 3450.516927630134, 3471.5834099908016, 4551.362809206709, 5630.268065151535, 5789.160571717109, 5791.797287094947, 5815.3893841146655, 5733.512651424623, 5808.157817116516, 5813.563982701293, 5820.0, 5835.183074369592, 5198.324217851674, 5234.241035049916, 5252.947470525284, 5262.605304602151, 5320.989012087691, 5247.081760691864, 5279.445658205891, 5296.973515132419, 5311.548518375943, 5344.358676958751, 5298.894022119555, 5299.33758280215, 5309.230161626562, 5311.57507399409, 5332.200169974496, 5363.356397232357, 5381.977424289373, 5382.085045542267, 5387.272718183034, 5441.782328706847, 5151.278820965068, 5178.533931946143, 5204.115300398904, 5278.788848446096, 5314.867128321785, 5779.971100144515, 5811.767529298823, 5838.182654428341, 5862.38444963277, 5863.442972917566, 6282.623042617458, 6284.402981716729, 6309.305976342599, 6309.4636955858805, 6318.368163183691, 5161.27742116104, 6160.1375807387, 6181.289151747562, 6221.066839973995, 6246.500279977591, 5874.823755287348, 5905.320888097838, 5924.792632257937, 5946.375630558816, 5952.077427998667, 6304.716287767062, 6308.400701933309, 6312.147860038928, 6315.210598675166, 6321.620702757849, 5994.910076348859, 6127.3566275540425, 6137.9079313810325, 6224.439800417984, 6231.3145553989025, 6189.659568723763, 6248.343923887926, 6253.312135665074, 6258.749650013949, 6258.74965001404, 6250.312465628777, 6257.687115644199, 6268.279147897959, 6280.403361680633, 6280.591761535486, 6137.263528376623, 6145.324014358417, 6196.628202307876, 6293.087502312139, 6300.653464059429, 4979.551840334388, 4982.377202849644, 4985.8005679772405, 4992.525710057539, 5038.0, 4478.0, 4485.887852803641, 4489.371487991683, 4497.05561832019, 4523.977380113079, 5666.235058267163, 5738.741756620962, 5754.827355179351, 5868.853278667982, 5869.911951320733, 6169.2288463942, 6227.470664993526, 6229.595076320024, 6247.187865577536, 6254.15568898202, 5855.268091488564, 5875.529957603381, 5878.941210587839, 5883.676397798162, 5925.170476133345, 5370.62405631602, 5428.158635411518, 5438.238646589481, 5504.394516603171, 5511.58663100269, 6274.780382686584, 6329.113924050729, 6346.238451385863, 6443.452306553808, 6452.032195170762, 6185.556725047066, 6218.906716399167, 6234.096056071935, 6242.500599951902, 6253.0620406937505, 6132.600268413531, 6425.907595708647, 6443.96778016107, 6448.677566121769, 6453.128827608401, 6107.643995706967, 6176.474999624902, 6191.783287584913, 6280.120783090462, 6281.152044473937, 6216.129741836056, 6217.222847144107, 6223.502119830493, 6228.501719862309, 6230.532710046855, 5870.236869206976, 6174.073888916699, 6192.225971753531, 6194.721237544411, 6202.658853762906, 5935.436133567304, 6015.578909476295, 6134.8159555213415, 6216.875662486816, 6219.595726277777, 6003.2796064470795, 6077.849085183674, 6093.440754883049, 6099.425430926805, 6108.63890615289, 6026.548008899438, 6093.847653808691, 6194.101855231056, 6197.380261973766, 6210.7515699373325, 5961.493273071837, 6049.425304596057, 6060.363661815446, 6060.939390606038, 6061.0], "value": 5753.656279577815, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.4577544273201, 480.9110314591801, 492.4804331430341, 512.1498312800752, 536.9234684457662, 25034.0, 33036.17409564762, 33041.339173216555, 42093.0, 42938.355924661155, 43319.566804331946, 43600.90997725051, 43804.34293485592, 43858.56141438593, 43909.7804510977, 9676.951615241931, 9839.114479696826, 9847.556859941284, 9849.212063034976, 9864.802703945918, 9722.22222222224, 9836.360636558637, 9838.90161098387, 9841.852372214422, 9846.113849753521, 9827.557759900821, 9835.31152819303, 9884.505774711235, 9886.0, 9904.801903961916, 8326.958365208166, 9829.4102353859, 9859.359141655805, 9864.90135098647, 9870.851937220947, 9705.708828735149, 9776.804463910681, 9777.755556111082, 9789.657361992297, 9812.558434870449, 41541.58458415438, 41886.58113418857, 41917.580824191675, 42059.532260806205, 42068.368974465404, 3386.407378708716, 3445.982770086159, 3458.8616455341758, 3542.5394698689006, 3928.5874983126932, 31084.844575777202, 32095.518567221512, 32275.35449291001, 32302.0, 32333.83833080843, 3203.775735698502, 3345.565076540034, 3386.102682789038, 3415.8975230743117, 3416.7266618670446, 468715.99999999657, 500034.4998274985, 502210.0, 504158.0, 505945.0, 59030.22909312727, 59356.0, 59446.108308375406, 59475.70262148748, 59509.10736338959, 61703.0, 61728.69135654293, 61849.690751546856, 61858.0, 61866.38133618696, 16363.0, 16590.253438595293, 16601.169941502878, 16604.83395166033, 16609.501714948572, 12918.935405322913, 12991.805122923164, 12995.545155919497, 13013.414396351998, 13032.869671303355, 16128.354865805237, 16685.081215660113, 16696.582585435463, 16719.832801671826, 16727.080010599533, 5380.381256155592, 6299.370062993756, 6311.211098612674, 6377.362263773678, 6427.164468619143, 662.410454695312, 702.3888174136878, 785.5012067337168, 891.6834523744108, 958.3052287091803, 20297.88361640124, 20830.791692082887, 23862.092222850246, 24743.38141546476, 25075.87462062678, 919.1084647891668, 935.8315503209487, 952.0051546134168, 961.99038009619, 963.8939716631165, 12255.0, 12762.0, 12834.229946203257, 12840.0, 12867.356632168354, 666810.0, 669990.0, 673128.0, 674351.0, 674964.0, 59196.81606367935, 59458.702706487056, 59501.0, 59530.702346488855, 59566.702166489755, 1242.5588915934893, 1357.4163109862657, 1368.8288963879515, 1384.5846246126123, 1407.6903081322093, 30869.536956945216, 31480.37039259248, 31824.681753183097, 31827.68172318247, 32549.34901302008, 50477.99044019025, 51074.0, 51269.718257043874, 51351.0, 51452.48547514477, 554164.0, 557162.0, 557418.0, 557936.0, 557941.4205857889, 26407.471850563266, 27177.320566985192, 27209.86395068012, 27242.5913611292, 27509.86245068762, 47511.28733069076, 48030.03939921252, 48139.277910830664, 48424.757876210395, 48728.0, 38753.80623096979, 38889.02777430587, 39330.80334598423, 40320.19359612733, 41010.0, 39925.60074399219, 40113.69904538488, 40390.39414408845, 40875.7956210217, 40953.79523102365, 38062.80968595139, 39169.67057800005, 39464.80267598644, 39517.40723889202, 39741.60258397379, 25832.225033249033, 31406.842965785025, 32832.67167328392, 33464.665353347125, 35020.64979350174, 24486.63270050915, 25603.743962560882, 25617.359566011, 25751.0, 26441.471170576864], "value": 19568.466715312123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.7250199840127, 345.33350633277763, 366.84042441537935, 374.9493818334524, 397.51304651801547, 14744.410223591058, 15854.762178567331, 15926.283317250722, 21515.892420537915, 21698.566028679415, 20566.86882221481, 20630.1747930083, 21024.89487552564, 21324.0, 21688.3493495195, 5650.350209725893, 5960.0761881908375, 5968.0, 5974.940250597482, 5976.312724036727, 4174.791260436981, 4415.072834704716, 5860.794872179475, 6345.302016778151, 6626.304238055007, 6378.585391949531, 6667.099941507883, 6692.364225398604, 6697.330266973312, 6711.0, 6544.181977252843, 6594.340565943416, 6629.071929929813, 6629.204495460552, 6633.4693224541925, 4540.77296135192, 5092.694438333675, 5406.83779486616, 5742.167385729046, 5764.452377024176, 13137.671558211121, 13180.802287965687, 13224.6693832654, 13286.933565332112, 13367.799483007762, 2149.720536330283, 2179.106566307806, 2252.526969336441, 2344.859308441482, 2371.454565449956, 9774.5601447935, 9872.308938374317, 9923.851142232872, 10193.490325483695, 10296.79406411875, 1821.5081927879398, 1911.3545816733067, 1924.6054558815408, 1941.175000624729, 1954.482062253504, 108393.0, 109918.45040774746, 110502.44748776205, 118058.40970795177, 120357.39821300838, 11290.943545282222, 11425.0, 11502.712432189262, 11517.53929842797, 11719.06247500198, 11322.0, 12685.873141268468, 13442.0, 13454.52909148175, 13756.65608359799, 7405.1854296027395, 7871.016122984627, 7976.242256985577, 8031.919680803117, 8357.498550087013, 8226.465279756796, 8308.916910830936, 8357.206065423776, 8509.531975741394, 8662.480251184823, 3782.3569993101237, 4376.081022985209, 4513.6233448797775, 4518.683692141519, 4602.401687780567, 1593.2272847668871, 1619.2146808797725, 1763.8588912886937, 1784.5218855544665, 1876.756021717168, 861.9094995025557, 915.8073721996298, 933.5145724223365, 988.461288597716, 1011.939283642969, 20947.8952605236, 21764.02061907218, 21787.12851485923, 21806.236781712563, 21861.890690546446, 884.8186121845006, 905.2667339455063, 928.9953550232341, 940.576740466779, 1009.8030883977701, 10965.451727413598, 11425.657230283105, 11545.249558778652, 11553.191276610725, 11589.6523104307, 604397.0, 611662.0, 612980.0, 628943.0, 629473.0, 129408.0, 132067.33966330107, 132105.0, 132296.0, 133070.33464832808, 963.7349728824629, 989.7030890732751, 1000.4397537379091, 1008.621766837436, 1011.544804837826, 18190.0, 18440.26238950427, 18632.720509192102, 18921.526961826065, 18934.010909506545, 35873.515810523684, 45862.541374585824, 55641.21793910369, 57113.71443142758, 57294.713526432104, 58508.0, 72267.0, 74087.88868166874, 74756.87864681926, 82621.76067358874, 7099.467539934422, 7619.238076192337, 7764.883526747216, 7844.254795794391, 8338.499690018618, 9964.601415943282, 12855.29295888735, 13016.479340826261, 13127.474901003852, 13253.867461325262, 9536.332456727963, 10974.067204287725, 11188.66434006981, 11226.55093796239, 11275.267107637977, 10891.455427228448, 11115.166362522681, 11225.550977960791, 11443.828342575034, 11553.942230288794, 9320.860187097063, 11243.60647377338, 11580.536778528765, 11680.0, 11810.76378472443, 7867.921320786719, 7933.286004259644, 8119.188081191834, 8178.100408955129, 8240.423170378015, 8208.507489550646, 10864.130869530576, 11035.613753518588, 11256.887431125584, 11414.233303009822], "value": 9278.208091531384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.2368815592204, 1550.8604225619695, 1745.9301627934883, 1889.896055716935, 1913.9521511962207, 8430.789230269238, 8936.329775266848, 8936.731898043061, 8941.731748047552, 8943.0, 7770.494917830337, 8035.116137224901, 8411.200935911094, 8665.436746611465, 8697.52163631, 2366.4675448024186, 2398.4843258699375, 2398.7481314461993, 2398.9280321590295, 2406.5186962607463, 2034.328671538396, 2393.066703985447, 2397.6643269942224, 2422.8546287222734, 2424.369663887393, 2061.3300677279867, 2382.630692242705, 2397.568437681217, 2405.6511805788236, 2424.2363655448567, 2360.7639236076425, 2381.38084098134, 2389.892454839536, 2391.3184742348435, 2392.3540644026016, 2357.823163262745, 2377.595808712523, 2381.535600557892, 2383.1778036577352, 2384.78536931677, 8778.780530486725, 8820.735377938672, 8894.822103557957, 8906.109389061106, 8923.73228803137, 5298.496642818926, 5443.101888188444, 5443.666301756056, 5444.292242008513, 5453.700046497441, 3575.910602234939, 3663.21240933198, 3740.8129593520216, 3745.606711295329, 3761.2665530221616, 1096.802575536403, 1106.1537923488538, 1118.6196693124377, 1126.419893754717, 1135.426609562174, 11642.18504704671, 11653.533858645644, 11759.7060073498, 11780.70548236301, 11789.469473873696, 3956.347202711578, 4405.691601587858, 4535.183666939916, 4677.22825733757, 4703.341532185496, 9197.310201734897, 9206.0, 9218.124278193562, 9232.492212928219, 9235.1688348049, 5301.867453313698, 5306.09796334624, 5310.893782124336, 5313.57491400687, 5319.042572337016, 4340.457442819647, 4426.490953540319, 4581.175388430048, 4954.578860796801, 4967.155583550805, 3362.747793915466, 3702.0, 3749.6250374962833, 3787.4697542344093, 3862.0, 965.5944503308627, 1154.7401834587151, 1155.5493357590547, 1175.3770501634147, 1193.6478738772082, 796.717165406284, 882.4925667740946, 887.5961437545901, 895.4806212396925, 925.643627203518, 5763.193152958589, 5862.267216597926, 5910.763569457174, 6032.638041717423, 6100.350011932267, 430.8039841871941, 442.6525177735462, 443.0872402850139, 446.05659031149537, 447.61057879644915, 3874.1670540833857, 4091.9386209206887, 4176.979115104405, 4338.240807858612, 4356.49900261474, 10926.071283940795, 10997.725056873482, 11174.888251117547, 11177.552897883994, 11183.049440797624, 11116.0, 11134.387608681438, 11137.554497820158, 11147.665570032912, 11153.609623663295, 7917.881231781528, 8156.836863262702, 8164.142765009708, 8204.179582041748, 8285.917140828635, 5030.629844769246, 5987.700614969322, 6005.519558435402, 6069.119977603134, 6097.993831017832, 7970.9202907970175, 10177.18582513412, 10201.132903702972, 10299.691009269734, 10340.689779306633, 8745.387822852339, 9923.354981926152, 10286.485675716034, 10410.167186625204, 10489.685309440729, 6046.486048685911, 7203.459740519377, 7487.700491980259, 7647.158812530506, 7737.187595302637, 8283.710070147516, 8518.82962340762, 8542.914570854213, 8630.136986301572, 8663.653453861774, 6408.519361048034, 7517.661705223388, 7632.580208088609, 7694.846103078019, 7802.21977802238, 7464.253574642492, 7495.213002634645, 7502.962485187539, 7520.059992500937, 7607.4674772767585, 6949.826254343682, 7101.183363913009, 7121.750738724119, 7122.85754284901, 7142.5714457132735, 4936.358273424576, 4978.726170060537, 5045.445001049955, 5052.317937078595, 5105.2597373381395, 4264.722793018444, 4805.567498925114, 4826.638002149783, 5103.362079740033, 5111.977604479045], "value": 4489.053177368795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.70179671227123, 306.47286666932865, 307.3806280345105, 312.6919983815941, 313.53753214009356, 4322.80547375368, 4947.950520494798, 5107.182850743877, 5201.687898726079, 5266.289050978116, 4277.187334406461, 5187.6887386756725, 5227.2159176123605, 5244.213367994803, 5268.683878967265, 3786.469894214805, 3798.65812076913, 3948.5459172195133, 3992.840286388541, 4058.3969332113797, 3469.809160496184, 4020.4572382728397, 4023.396490526415, 4055.6958228133008, 4063.3295506241584, 3591.6587924147293, 3706.684127134869, 3981.5620281768984, 3986.823886953341, 3995.9200815983663, 3441.328940856534, 3639.854405823764, 3699.9445008324897, 3775.2449510097954, 3935.9016024599614, 3315.96684033159, 3472.2881809229048, 3480.3027653568433, 3482.4428091505492, 3494.8951531453845, 5079.3650793650795, 5106.157484015133, 5130.794768209267, 5149.9485005149845, 5211.635185537014, 3658.396364599838, 4453.888652783674, 4555.681102322838, 4568.383268258809, 4654.509837237096, 4486.4616246050355, 5153.2270159476, 5392.433794451605, 5428.212909128154, 5542.334919809608, 3150.6842470783954, 3294.159989202762, 3677.9632203678157, 3869.8645547405704, 3882.301185786557, 4788.121621486607, 5038.773255203525, 5608.597850537366, 5642.576806739511, 5687.639629553772, 3275.4104261233206, 3834.67703642243, 3901.51231096113, 3903.2193561287854, 3916.060145565044, 3315.950260746091, 3625.836837342326, 3868.2070175614494, 3950.4271880577157, 3972.3842804365368, 4004.4593979812353, 4038.9094944364856, 4546.636269098464, 4590.655700822452, 4613.976930115395, 4488.932666010012, 4830.033993201304, 5228.620977455249, 5457.0, 5497.202905578749, 1151.7638884028754, 1295.4429595273934, 1347.905646604748, 1368.2679766324968, 1372.5813626843908, 695.6973716433367, 788.2078511096312, 831.8793774902726, 845.5391811462767, 855.4396870050127, 4487.3076154307155, 4735.502772208937, 4864.610831133501, 4926.729029903389, 5003.949960500348, 5484.314460692413, 5576.581756368289, 5666.914996275059, 5756.172145523264, 5791.305043394819, 4980.705016695685, 5055.51972562606, 5101.311322971352, 5129.435762066169, 5140.845774626767, 2903.4483448145206, 2957.985210073936, 2960.763138948879, 2968.0798952324417, 2974.806637568551, 4935.481774413634, 5304.708241046779, 5824.0, 5828.970855145697, 5864.208331875142, 4998.250262460588, 5417.539509141767, 5780.826575202751, 5812.970935145382, 5847.853803654943, 5765.308163020381, 5902.822915312548, 5911.9113213301835, 5940.55445841555, 5965.987176475852, 5301.496357845998, 5688.943110569007, 5725.824186808986, 5749.885002299847, 5805.738741756547, 4996.6002719783055, 5644.238027866186, 5760.510356619734, 5779.884402311846, 5788.710564471676, 5293.485594342656, 6079.939200608114, 6087.717106085218, 6114.3796893824065, 6120.663363515049, 3099.0166293572584, 3721.0325315418727, 3857.1707082976172, 3859.996400935721, 3907.706921980806, 4708.0, 5756.65460072397, 5776.335721391925, 5785.280917968548, 5795.39148389413, 5172.68081152227, 5632.324121105494, 5679.716014199356, 5680.829575112753, 5713.857153571194, 4027.6576490998596, 5021.514350396577, 5511.311086114236, 5608.38307786135, 5669.914951275651, 4550.997561073117, 5445.482679145475, 5528.834134975958, 5565.332160140647, 5565.833025009256, 4471.8658440246845, 5355.4376790436445, 5492.80775172867, 5562.3047119110115, 5744.224529688438, 5047.87380315495, 5255.633535280778, 5544.251526044094, 5544.7227638617105, 5552.944470555242], "value": 4015.996921530846, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.2605896543284, 746.6751962896137, 771.3674786674925, 786.1273985875677, 821.1747194069957, 14990.775138372934, 16044.358225670989, 16452.17739113044, 16467.835321646795, 17024.574385640364, 14995.0, 15406.768898466533, 15412.30644620992, 15417.460388886391, 15437.228138593082, 610.7923306075934, 676.2662511175369, 850.2942557677113, 850.421713235, 851.833892390984, 671.2448495442627, 825.7192554531458, 852.9914700853005, 857.5540718826206, 863.6156910174975, 922.3313098003961, 922.9492377919246, 923.2567782934768, 923.5890028937125, 924.5469719837265, 917.6971599372191, 917.7934964632971, 917.807260475301, 918.5085979001236, 918.9816203675889, 531.0785786660142, 619.5693992675093, 642.2870613618879, 644.6067898581862, 648.7599588152414, 15414.537563873102, 15464.304106315243, 15466.226688665634, 15467.458638947583, 15521.146336951464, 14033.64915877101, 14180.787288190686, 14378.424863005468, 14454.349554270084, 14609.123452592772, 12857.0, 12895.226286422845, 12925.612231633066, 13067.01997350193, 13129.671758206026, 4590.334401511762, 4696.553827386393, 4720.976395118037, 4741.454732705749, 4829.806807727687, 100331.49834250782, 101324.49337753264, 101379.77923532273, 107977.0, 110564.89435105627, 11203.271787333797, 11306.208565400342, 11499.482523286471, 11538.423078846025, 11851.525938962344, 18720.812791871907, 22518.774812251995, 22522.66216006761, 22530.21144259943, 22537.0, 7860.4890682106625, 7874.7243846466245, 7922.168172341936, 8103.837923241502, 8209.79475513117, 4228.556001619786, 4244.554321796229, 4304.332828411601, 4395.230834603932, 4466.1514312281215, 3412.8805491808166, 3517.66582174693, 3522.260325331658, 3524.8942531724088, 3525.823708814549, 626.3423405424286, 633.8558901183408, 641.2753588445028, 659.8880885707598, 660.0528241972785, 592.7865968251426, 615.4399496458202, 627.7206643043802, 635.253577046968, 646.7413034786123, 9086.727398178065, 9101.271898248124, 9107.271418286522, 9165.58754856033, 9278.536073196314, 535.3254898827505, 581.9592628515963, 585.8476796032977, 590.3152343281772, 592.6414519215898, 3675.3568125577917, 4288.356746488052, 4354.782260886943, 4545.818167273338, 4569.9314510282375, 113840.0, 138903.0, 143545.56454435532, 156180.0, 162624.0, 67457.02785573772, 141240.29379853036, 141583.0, 141737.29131354278, 143403.28298358442, 115163.0, 116816.0, 119683.40158299153, 119834.8016519841, 122647.38676306562, 7325.743598974011, 8605.65577376898, 8640.092790256933, 8737.694180703646, 8967.327450441373, 60448.697756510934, 63043.369566305584, 66190.66904665445, 66595.0, 68149.31850681629, 83451.0, 92347.53826230826, 96043.0, 98132.0, 98865.0, 11540.884591153981, 11731.648050558497, 11797.410129493663, 11941.283522988648, 12021.699457513632, 12349.93825030869, 12617.116801823784, 12805.103642745291, 13080.215187088805, 13446.394912229169, 11972.281663100242, 12028.27830330183, 12081.879181208427, 12378.491813664335, 12483.438245279165, 12556.560520382109, 13067.281299528617, 13513.729725405241, 13699.383527741475, 13828.101173423694, 13798.93100534491, 13804.861951380759, 13878.375473103533, 14070.085444446488, 14450.494232701805, 11115.44422778874, 11419.429028548706, 11434.256773309708, 11910.52357905674, 12089.879101208875, 10837.349759014169, 11174.608888688857, 11206.719832004264, 11399.6118393948, 11833.290002599872], "value": 7785.66997591334, "unit": "score"}], "name": "dromaeo_css", "value": 7261.770835056847, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 115.0, 114.0, 107.0, 112.0, 112.0, 114.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 111.0, 109.0, 191.0, 140.0, 127.0, 127.0, 105.0, 144.0, 111.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 262.0, 198.0, 186.0, 181.0, 182.0, 177.0, 183.0, 179.0, 183.0], "value": 192.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 58.0, 60.0, 87.0, 59.0, 57.0, 109.0, 85.0, 85.0, 57.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 102.0, 70.0, 75.0, 68.0, 96.0, 70.0, 68.0, 102.0], "value": 80.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 132.0, 121.0, 89.0, 85.0, 90.0, 84.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 89.0, 125.0, 148.0, 92.0, 93.0, 94.0, 108.0, 147.0], "value": 108.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 141.0, 90.0, 84.0, 89.0, 97.0, 86.0, 85.0, 83.0, 84.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 55.0, 52.0, 52.0, 56.0, 54.0, 54.0, 55.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 71.0, 65.0, 77.0, 75.0, 68.0, 68.0, 68.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 87.0, 87.0, 101.0, 104.0, 103.0, 80.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 138.0, 136.0, 143.0, 156.0, 132.0, 140.0, 214.0, 153.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 168.0, 170.0, 166.0, 169.0, 169.0, 169.0, 166.0, 165.0, 231.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 67.0, 66.0, 78.0, 83.0, 73.0, 68.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1495.2, "alertThreshold": 2.0}]} 15:18:41 INFO - Return code: 0 15:18:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:18:41 INFO - # TBPL SUCCESS # 15:18:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:18:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:18:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:18:41 INFO - 2016-08-16 15:18:41.308 screenresolution[1662:10020] starting screenresolution argv=screenresolution get 15:18:41 INFO - 2016-08-16 15:18:41.311 screenresolution[1662:10020] Display 0: 1600x1200x32@60 15:18:41 INFO - 2016-08-16 15:18:41.318 screenresolution[1663:10023] starting screenresolution argv=screenresolution list 15:18:41 INFO - Available Modes on Display 0 15:18:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:18:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:18:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:18:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:18:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:18:41 INFO - Intel Iris: 15:18:41 INFO - Chipset Model: Intel Iris 15:18:41 INFO - Type: GPU 15:18:41 INFO - Bus: Built-In 15:18:41 INFO - VRAM (Dynamic, Max): 1536 MB 15:18:41 INFO - Vendor: Intel (0x8086) 15:18:41 INFO - Device ID: 0x0a2e 15:18:41 INFO - Revision ID: 0x0009 15:18:41 INFO - Displays: 15:18:41 INFO - Display: 15:18:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:18:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:18:41 INFO - Display Serial Number: 1600x1200 60 15:18:41 INFO - Main Display: Yes 15:18:41 INFO - Mirror: Off 15:18:41 INFO - Online: Yes 15:18:41 INFO - Rotation: Supported 15:18:41 INFO - Return code: 0 15:18:41 INFO - Running post-action listener: _resource_record_post_action 15:18:41 INFO - [mozharness: 2016-08-16 22:18:41.564011Z] Finished run-tests step (success) 15:18:41 INFO - Running post-run listener: _resource_record_post_run 15:18:41 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 37176320; Write bytes: 703138816; Read time: 240; Write time: 1964 15:18:41 INFO - TinderboxPrint: CPU usage
53.5% 15:18:41 INFO - TinderboxPrint: I/O read bytes / time
37,176,320 / 240 15:18:41 INFO - TinderboxPrint: I/O write bytes / time
703,138,816 / 1,964 15:18:41 INFO - TinderboxPrint: CPU idle
2,259.2 (46.5%) 15:18:41 INFO - TinderboxPrint: CPU system
972.5 (20.0%) 15:18:41 INFO - TinderboxPrint: CPU user
1,626.1 (33.5%) 15:18:41 INFO - TinderboxPrint: Swap in / out
442,146,816 / 0 15:18:41 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402743808; Write bytes: 396002816; Read time: 29789; Write time: 807 15:18:41 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 34464768; Write bytes: 295118336; Read time: 216; Write time: 1118 15:18:42 INFO - Running post-run listener: _upload_blobber_files 15:18:42 INFO - Blob upload gear active. 15:18:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:18:42 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 15:18:42 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:18:42 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:18:42 INFO - (blobuploader) - INFO - Open directory for files ... 15:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:18:43 INFO - (blobuploader) - INFO - Done attempting. 15:18:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:18:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:18:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:18:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:18:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:18:44 INFO - (blobuploader) - INFO - Done attempting. 15:18:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:18:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:18:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:18:46 INFO - (blobuploader) - INFO - Done attempting. 15:18:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:18:46 INFO - Return code: 0 15:18:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:18:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:18:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/068175e11344deb83b6e8a79734f93ce8a1010b57b48b90e30756be7e1a2b4317503f9bebc73ce8496db107a011c6d9832ce51e35e118be35f961b1c90fbf11f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d96406366cf00ca61cfa1c4e24e63e823ac79e3f6b28f33cea448c2bfa979b11098ac8fdd48d4643a95143f71a159f7f28397feb60ef569b977f2b0c08832adb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3342b4fa4fe7b649f5a20dfd2847ba3b70aa78c0e4cdb1b6439fefa50788554a9eaa3adf98ad120545648c47df5373cd7e282def361eb09730754328eef0bf40"} 15:18:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:18:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:18:46 INFO - Contents: 15:18:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/068175e11344deb83b6e8a79734f93ce8a1010b57b48b90e30756be7e1a2b4317503f9bebc73ce8496db107a011c6d9832ce51e35e118be35f961b1c90fbf11f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d96406366cf00ca61cfa1c4e24e63e823ac79e3f6b28f33cea448c2bfa979b11098ac8fdd48d4643a95143f71a159f7f28397feb60ef569b977f2b0c08832adb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3342b4fa4fe7b649f5a20dfd2847ba3b70aa78c0e4cdb1b6439fefa50788554a9eaa3adf98ad120545648c47df5373cd7e282def361eb09730754328eef0bf40"} 15:18:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:18:46 INFO - Copying logs to upload dir... 15:18:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:18:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.610002 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-16 15:18:47.022692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 15:18:47.026593) ========= 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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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/Fx-Team/sha512/068175e11344deb83b6e8a79734f93ce8a1010b57b48b90e30756be7e1a2b4317503f9bebc73ce8496db107a011c6d9832ce51e35e118be35f961b1c90fbf11f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d96406366cf00ca61cfa1c4e24e63e823ac79e3f6b28f33cea448c2bfa979b11098ac8fdd48d4643a95143f71a159f7f28397feb60ef569b977f2b0c08832adb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3342b4fa4fe7b649f5a20dfd2847ba3b70aa78c0e4cdb1b6439fefa50788554a9eaa3adf98ad120545648c47df5373cd7e282def361eb09730754328eef0bf40"} build_url:https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011010 build_url: 'https://queue.taskcluster.net/v1/task/UgBLfIJWR16E_h90a-_zJQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/068175e11344deb83b6e8a79734f93ce8a1010b57b48b90e30756be7e1a2b4317503f9bebc73ce8496db107a011c6d9832ce51e35e118be35f961b1c90fbf11f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d96406366cf00ca61cfa1c4e24e63e823ac79e3f6b28f33cea448c2bfa979b11098ac8fdd48d4643a95143f71a159f7f28397feb60ef569b977f2b0c08832adb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3342b4fa4fe7b649f5a20dfd2847ba3b70aa78c0e4cdb1b6439fefa50788554a9eaa3adf98ad120545648c47df5373cd7e282def361eb09730754328eef0bf40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 15:18:47.059747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 15:18:47.060068) ========= 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.JGl3QkzR2v/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.YGLF0TO4qp/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.005172 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 15:18:47.109083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 15:18:47.109419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 15:18:47.109773) ========= ========= Total master_lag: 0.19 =========