builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0002 starttime: 1470982828.23 results: success (0) buildid: 20160811201315 builduid: 588a92d1cc6b4a498c758c510411ca10 revision: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:28.225515) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:28.225908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:28.226170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:28.497893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:28.498198) ========= 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.izyy2CVY2x/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.gy54WY6khF/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-11 23:20:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.53M=0.001s 2016-08-11 23:20:29 (8.53 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.508845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:29.029439) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:29.029757) ========= 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.izyy2CVY2x/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.gy54WY6khF/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.020840 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:29.078000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 23:20:29.078323) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6f2ba7787816fd01f77c30e3bdb68400db74bf0c --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 6f2ba7787816fd01f77c30e3bdb68400db74bf0c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.izyy2CVY2x/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.gy54WY6khF/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-11 23:20:29,147 truncating revision to first 12 chars 2016-08-11 23:20:29,147 Setting DEBUG logging. 2016-08-11 23:20:29,147 attempt 1/10 2016-08-11 23:20:29,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6f2ba7787816?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 23:20:30,678 unpacking tar archive at: fx-team-6f2ba7787816/testing/mozharness/ program finished with exit code 0 elapsedTime=1.780926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 23:20:30.881202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:30.881496) ========= script_repo_revision: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:30.881926) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:30.882195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 23:20:30.900551) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-11 23:20:30.900820) ========= /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.izyy2CVY2x/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.gy54WY6khF/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:20:31 INFO - MultiFileLogger online at 20160811 23:20:31 in /builds/slave/test 23:20:31 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 23:20:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:20:31 INFO - {'append_to_log': False, 23:20:31 INFO - 'base_work_dir': '/builds/slave/test', 23:20:31 INFO - 'blob_upload_branch': 'Fx-Team', 23:20:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:20:31 INFO - 'branch': 'Fx-Team', 23:20:31 INFO - 'buildbot_json_path': 'buildprops.json', 23:20:31 INFO - 'config_files': ('talos/mac_config.py',), 23:20:31 INFO - 'default_actions': ('clobber', 23:20:31 INFO - 'read-buildbot-config', 23:20:31 INFO - 'download-and-extract', 23:20:31 INFO - 'populate-webroot', 23:20:31 INFO - 'create-virtualenv', 23:20:31 INFO - 'install', 23:20:31 INFO - 'run-tests'), 23:20:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:20:31 INFO - 'download_minidump_stackwalk': True, 23:20:31 INFO - 'download_symbols': 'ondemand', 23:20:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:20:31 INFO - 'tooltool.py': '/tools/tooltool.py', 23:20:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:20:31 INFO - '/tools/misc-python/virtualenv.py')}, 23:20:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:20:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:20:31 INFO - 'installer_path': 'installer.exe', 23:20:31 INFO - 'log_level': 'info', 23:20:31 INFO - 'log_name': 'talos', 23:20:31 INFO - 'log_to_console': True, 23:20:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:20:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:20:31 INFO - 'opt_config_files': (), 23:20:31 INFO - 'pip_index': False, 23:20:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:20:31 INFO - 'cmd': ('bash', 23:20:31 INFO - '-c', 23:20:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:20:31 INFO - 'enabled': True, 23:20:31 INFO - 'halt_on_failure': False, 23:20:31 INFO - 'name': 'check_screen_resolution'},), 23:20:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:20:31 INFO - 'cmd': ('bash', 23:20:31 INFO - '-c', 23:20:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:20:31 INFO - 'enabled': True, 23:20:31 INFO - 'halt_on_failure': False, 23:20:31 INFO - 'name': 'check_screen_resolution'},), 23:20:31 INFO - 'run_cmd_checks_enabled': True, 23:20:31 INFO - 'sps_profile': False, 23:20:31 INFO - 'sps_profile_interval': 0, 23:20:31 INFO - 'suite': 'dromaeojs', 23:20:31 INFO - 'system_bits': '32', 23:20:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:20:31 INFO - 'title': 't-yosemite-r7-0002', 23:20:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:20:31 INFO - 'use_talos_json': True, 23:20:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:20:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:20:31 INFO - 'work_dir': 'build'} 23:20:31 INFO - [mozharness: 2016-08-12 06:20:31.090343Z] Running clobber step. 23:20:31 INFO - Running pre-action listener: _resource_record_pre_action 23:20:31 INFO - Running main action method: clobber 23:20:31 INFO - rmtree: /builds/slave/test/build 23:20:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:20:32 INFO - Running post-action listener: _resource_record_post_action 23:20:32 INFO - [mozharness: 2016-08-12 06:20:32.070250Z] Finished clobber step (success) 23:20:32 INFO - [mozharness: 2016-08-12 06:20:32.070369Z] Running read-buildbot-config step. 23:20:32 INFO - Running pre-action listener: _resource_record_pre_action 23:20:32 INFO - Running main action method: read_buildbot_config 23:20:32 INFO - Using buildbot properties: 23:20:32 INFO - { 23:20:32 INFO - "project": "", 23:20:32 INFO - "product": "firefox", 23:20:32 INFO - "script_repo_revision": "production", 23:20:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 23:20:32 INFO - "repository": "", 23:20:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 23:20:32 INFO - "buildid": "20160811201315", 23:20:32 INFO - "pgo_build": "False", 23:20:32 INFO - "basedir": "/builds/slave/test", 23:20:32 INFO - "buildnumber": 129, 23:20:32 INFO - "slavename": "t-yosemite-r7-0002", 23:20:32 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 23:20:32 INFO - "platform": "yosemite_r7", 23:20:32 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 23:20:32 INFO - "branch": "fx-team", 23:20:32 INFO - "repo_path": "integration/fx-team", 23:20:32 INFO - "revision": "6f2ba7787816fd01f77c30e3bdb68400db74bf0c", 23:20:32 INFO - "stage_platform": "macosx64", 23:20:32 INFO - "builduid": "588a92d1cc6b4a498c758c510411ca10", 23:20:32 INFO - "slavebuilddir": "test" 23:20:32 INFO - } 23:20:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 23:20:32 INFO - Running post-action listener: _resource_record_post_action 23:20:32 INFO - [mozharness: 2016-08-12 06:20:32.073302Z] Finished read-buildbot-config step (success) 23:20:32 INFO - [mozharness: 2016-08-12 06:20:32.073410Z] Running download-and-extract step. 23:20:32 INFO - Running pre-action listener: _resource_record_pre_action 23:20:32 INFO - Running main action method: download_and_extract 23:20:32 INFO - mkdir: /builds/slave/test/build/tests 23:20:32 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')]} 23:20:32 INFO - trying https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 23:20:32 INFO - Downloading https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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 23:20:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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 23:20:32 INFO - Downloaded 1199 bytes. 23:20:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 23:20:32 INFO - Using the following test package requirements: 23:20:32 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 23:20:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:20:32 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 23:20:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:20:32 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 23:20:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:20:32 INFO - u'jsshell-mac.zip'], 23:20:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:20:32 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 23:20:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 23:20:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:20:32 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 23:20:32 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:20:32 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 23:20:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:20:32 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 23:20:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:20:32 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 23:20:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:20:32 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')]} 23:20:32 INFO - trying https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 23:20:32 INFO - Downloading https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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 23:20:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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 23:20:33 INFO - Downloaded 16328374 bytes. 23:20:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:20:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:20:36 INFO - Return code: 0 23:20:36 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 23:20:36 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')]} 23:20:36 INFO - trying https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 23:20:36 INFO - Downloading https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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 23:20:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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 23:20:37 INFO - Downloaded 16328374 bytes. 23:20:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:20:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:20:40 INFO - Return code: 0 23:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:40 INFO - trying https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 23:20:40 INFO - Downloading https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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 23:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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 23:20:43 INFO - Downloaded 14413719 bytes. 23:20:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:20:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 23:20:43 INFO - Return code: 0 23:20: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')]} 23:20:43 INFO - trying https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:20:43 INFO - Downloading https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 23:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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 23:20:55 INFO - Downloaded 110899948 bytes. 23:20:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:20:55 INFO - mkdir: /builds/slave/test/properties 23:20:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:20:55 INFO - Writing to file /builds/slave/test/properties/build_url 23:20:55 INFO - Contents: 23:20:55 INFO - build_url:https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:20:56 INFO - Running post-action listener: _resource_record_post_action 23:20:56 INFO - Running post-action listener: set_extra_try_arguments 23:20:56 INFO - [mozharness: 2016-08-12 06:20:56.502188Z] Finished download-and-extract step (success) 23:20:56 INFO - [mozharness: 2016-08-12 06:20:56.502333Z] Running populate-webroot step. 23:20:56 INFO - Running pre-action listener: _resource_record_pre_action 23:20:56 INFO - Running main action method: populate_webroot 23:20:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:20:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:20:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:20:56 INFO - '--tppagecycles', 23:20:56 INFO - '7'], 23:20:56 INFO - 'tests': ['tsvgm']}}, 23:20:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:20:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:20:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:20:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:20:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:56 INFO - 'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:20:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:20:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:56 INFO - 'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['damp', 'tps']}, 23:20:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:56 INFO - 'tests': ['damp', 'tps']}, 23:20:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['dromaeo_dom']}, 23:20:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:20:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['basic_compositor_video']}, 23:20:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:20:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['a11yr', 23:20:56 INFO - 'ts_paint', 23:20:56 INFO - 'tpaint', 23:20:56 INFO - 'sessionrestore', 23:20:56 INFO - 'sessionrestore_no_auto_restore', 23:20:56 INFO - 'tabpaint']}, 23:20:56 INFO - 'other-e10s': {'tests': ['a11yr', 23:20:56 INFO - 'ts_paint', 23:20:56 INFO - 'tpaint', 23:20:56 INFO - 'sessionrestore', 23:20:56 INFO - 'sessionrestore_no_auto_restore', 23:20:56 INFO - 'tabpaint']}, 23:20:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:20:56 INFO - 'ts_paint', 23:20:56 INFO - 'tpaint', 23:20:56 INFO - 'sessionrestore', 23:20:56 INFO - 'sessionrestore_no_auto_restore', 23:20:56 INFO - 'tabpaint']}, 23:20:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:20:56 INFO - 'ts_paint', 23:20:56 INFO - 'tpaint', 23:20:56 INFO - 'sessionrestore', 23:20:56 INFO - 'sessionrestore_no_auto_restore', 23:20:56 INFO - 'tabpaint']}, 23:20:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['a11yr', 23:20:56 INFO - 'ts_paint', 23:20:56 INFO - 'tpaint', 23:20:56 INFO - 'sessionrestore', 23:20:56 INFO - 'sessionrestore_no_auto_restore', 23:20:56 INFO - 'tabpaint']}, 23:20:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['a11yr', 23:20:56 INFO - 'ts_paint', 23:20:56 INFO - 'tpaint', 23:20:56 INFO - 'sessionrestore', 23:20:56 INFO - 'sessionrestore_no_auto_restore', 23:20:56 INFO - 'tabpaint']}, 23:20:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['tsvgx', 23:20:56 INFO - 'tsvgr_opacity', 23:20:56 INFO - 'tart', 23:20:56 INFO - 'tscrollx', 23:20:56 INFO - 'cart']}, 23:20:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:20:56 INFO - 'tsvgr_opacity', 23:20:56 INFO - 'tart', 23:20:56 INFO - 'tscrollx', 23:20:56 INFO - 'cart']}, 23:20:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:56 INFO - 'talos_options': ['--disable-e10s'], 23:20:56 INFO - 'tests': ['tp5o']}, 23:20:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:56 INFO - 'tests': ['tp5o']}, 23:20:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:56 INFO - 'talos_options': ['--disable-e10s', 23:20:56 INFO - '--xperf_path', 23:20:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:20:56 INFO - 'tests': ['tp5n']}, 23:20:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:56 INFO - 'talos_options': ['--xperf_path', 23:20:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:20:56 INFO - 'tests': ['tp5n']}}, 23:20:56 INFO - 'talos.zip': {'path': '', 23:20:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:20:56 INFO - Running post-action listener: _resource_record_post_action 23:20:56 INFO - [mozharness: 2016-08-12 06:20:56.521120Z] Finished populate-webroot step (success) 23:20:56 INFO - [mozharness: 2016-08-12 06:20:56.521234Z] Running create-virtualenv step. 23:20:56 INFO - Running pre-action listener: _resource_record_pre_action 23:20:56 INFO - Running main action method: create_virtualenv 23:20:56 INFO - Creating virtualenv /builds/slave/test/build/venv 23:20: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 23:20:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:20:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:20:56 INFO - Using real prefix '/tools/python27' 23:20:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:20:57 INFO - Installing distribute.............................................................................................................................................................................................done. 23:21:00 INFO - Installing pip.................done. 23:21:00 INFO - Return code: 0 23:21:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21: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 23:21: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 23:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:00 INFO - 'HOME': '/Users/cltbld', 23:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:00 INFO - 'LOGNAME': 'cltbld', 23:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:00 INFO - 'MOZ_NO_REMOTE': '1', 23:21:00 INFO - 'NO_EM_RESTART': '1', 23:21:00 INFO - 'PAGER': '/bin/cat', 23:21:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:00 INFO - 'PWD': '/builds/slave/test', 23:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:00 INFO - 'SHELL': '/bin/bash', 23:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:00 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:00 INFO - 'USER': 'cltbld', 23:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:00 INFO - 'XPC_FLAGS': '0x0', 23:21:00 INFO - 'XPC_SERVICE_NAME': '0', 23:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21: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 23:21:00 INFO - Cleaning up... 23:21:00 INFO - Return code: 0 23:21:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21: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 23:21: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 23:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:00 INFO - 'HOME': '/Users/cltbld', 23:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:00 INFO - 'LOGNAME': 'cltbld', 23:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:00 INFO - 'MOZ_NO_REMOTE': '1', 23:21:00 INFO - 'NO_EM_RESTART': '1', 23:21:00 INFO - 'PAGER': '/bin/cat', 23:21:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:00 INFO - 'PWD': '/builds/slave/test', 23:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:00 INFO - 'SHELL': '/bin/bash', 23:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:00 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:00 INFO - 'USER': 'cltbld', 23:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:00 INFO - 'XPC_FLAGS': '0x0', 23:21:00 INFO - 'XPC_SERVICE_NAME': '0', 23:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:00 INFO - Downloading/unpacking psutil>=3.1.1 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:21:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:21:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:21:04 INFO - Installing collected packages: psutil 23:21:04 INFO - Running setup.py install for psutil 23:21:04 INFO - building 'psutil._psutil_osx' extension 23:21: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 23:21: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 23:21: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 23:21:05 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 23:21:05 INFO - building 'psutil._psutil_posix' extension 23:21:05 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 23:21:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:21:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:21:05 INFO - ^ 23:21:05 INFO - 1 warning generated. 23:21:05 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 23:21:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:21:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:21:05 INFO - Successfully installed psutil 23:21:05 INFO - Cleaning up... 23:21:05 INFO - Return code: 0 23:21:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:05 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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21:05 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 23:21:05 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 23:21:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:05 INFO - 'HOME': '/Users/cltbld', 23:21:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:05 INFO - 'LOGNAME': 'cltbld', 23:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:05 INFO - 'MOZ_NO_REMOTE': '1', 23:21:05 INFO - 'NO_EM_RESTART': '1', 23:21:05 INFO - 'PAGER': '/bin/cat', 23:21:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:05 INFO - 'PWD': '/builds/slave/test', 23:21:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:05 INFO - 'SHELL': '/bin/bash', 23:21:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:05 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:05 INFO - 'USER': 'cltbld', 23:21:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:05 INFO - 'XPC_FLAGS': '0x0', 23:21:05 INFO - 'XPC_SERVICE_NAME': '0', 23:21:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:21:08 INFO - Installing collected packages: mozsystemmonitor 23:21:08 INFO - Running setup.py install for mozsystemmonitor 23:21:08 INFO - Successfully installed mozsystemmonitor 23:21:08 INFO - Cleaning up... 23:21:08 INFO - Return code: 0 23:21:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:08 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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21:08 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 23:21:08 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 23:21:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:08 INFO - 'HOME': '/Users/cltbld', 23:21:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:08 INFO - 'LOGNAME': 'cltbld', 23:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:08 INFO - 'MOZ_NO_REMOTE': '1', 23:21:08 INFO - 'NO_EM_RESTART': '1', 23:21:08 INFO - 'PAGER': '/bin/cat', 23:21:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:08 INFO - 'PWD': '/builds/slave/test', 23:21:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:08 INFO - 'SHELL': '/bin/bash', 23:21:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:08 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:08 INFO - 'USER': 'cltbld', 23:21:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:08 INFO - 'XPC_FLAGS': '0x0', 23:21:08 INFO - 'XPC_SERVICE_NAME': '0', 23:21:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:08 INFO - Downloading/unpacking jsonschema==2.5.1 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:21:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:11 INFO - Downloading functools32-3.2.3-2.tar.gz 23:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:21:11 INFO - warning: no files found matching '*.txt' 23:21:11 INFO - no previously-included directories found matching 'build' 23:21:11 INFO - no previously-included directories found matching 'dist' 23:21:11 INFO - no previously-included directories found matching '.git*' 23:21:11 INFO - Installing collected packages: jsonschema, functools32 23:21:11 INFO - Running setup.py install for functools32 23:21:11 INFO - warning: no files found matching '*.txt' 23:21:11 INFO - no previously-included directories found matching 'build' 23:21:11 INFO - no previously-included directories found matching 'dist' 23:21:11 INFO - no previously-included directories found matching '.git*' 23:21:11 INFO - Successfully installed jsonschema functools32 23:21:11 INFO - Cleaning up... 23:21:11 INFO - Return code: 0 23:21:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21: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 23:21: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 23:21:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:11 INFO - 'HOME': '/Users/cltbld', 23:21:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:11 INFO - 'LOGNAME': 'cltbld', 23:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:11 INFO - 'MOZ_NO_REMOTE': '1', 23:21:11 INFO - 'NO_EM_RESTART': '1', 23:21:11 INFO - 'PAGER': '/bin/cat', 23:21:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:11 INFO - 'PWD': '/builds/slave/test', 23:21:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:11 INFO - 'SHELL': '/bin/bash', 23:21:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:11 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:11 INFO - 'USER': 'cltbld', 23:21:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:11 INFO - 'XPC_FLAGS': '0x0', 23:21:11 INFO - 'XPC_SERVICE_NAME': '0', 23:21:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:21:11 INFO - Cleaning up... 23:21:12 INFO - Return code: 0 23:21:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:21:12 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')]} 23:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:12 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')]} 23:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:12 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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21:12 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 23:21:12 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 23:21:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:12 INFO - 'HOME': '/Users/cltbld', 23:21:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:12 INFO - 'LOGNAME': 'cltbld', 23:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:12 INFO - 'MOZ_NO_REMOTE': '1', 23:21:12 INFO - 'NO_EM_RESTART': '1', 23:21:12 INFO - 'PAGER': '/bin/cat', 23:21:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:12 INFO - 'PWD': '/builds/slave/test', 23:21:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:12 INFO - 'SHELL': '/bin/bash', 23:21:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:12 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:12 INFO - 'USER': 'cltbld', 23:21:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:12 INFO - 'XPC_FLAGS': '0x0', 23:21:12 INFO - 'XPC_SERVICE_NAME': '0', 23:21:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:12 INFO - Downloading/unpacking blobuploader==1.2.4 23:21:12 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 23:21:12 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 23:21:12 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 23:21:12 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 23:21:12 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 23:21:12 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 23:21:14 INFO - Downloading blobuploader-1.2.4.tar.gz 23:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:21:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:21:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:15 INFO - Downloading docopt-0.6.1.tar.gz 23:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:21:15 INFO - Installing collected packages: blobuploader, requests, docopt 23:21:15 INFO - Running setup.py install for blobuploader 23:21:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:21:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:21:16 INFO - Running setup.py install for requests 23:21:16 INFO - Running setup.py install for docopt 23:21:16 INFO - Successfully installed blobuploader requests docopt 23:21:16 INFO - Cleaning up... 23:21:16 INFO - Return code: 0 23:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21: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 23:21: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 23:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:16 INFO - 'HOME': '/Users/cltbld', 23:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:16 INFO - 'LOGNAME': 'cltbld', 23:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:16 INFO - 'MOZ_NO_REMOTE': '1', 23:21:16 INFO - 'NO_EM_RESTART': '1', 23:21:16 INFO - 'PAGER': '/bin/cat', 23:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:16 INFO - 'PWD': '/builds/slave/test', 23:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:16 INFO - 'SHELL': '/bin/bash', 23:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:16 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:16 INFO - 'USER': 'cltbld', 23:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:16 INFO - 'XPC_FLAGS': '0x0', 23:21:16 INFO - 'XPC_SERVICE_NAME': '0', 23:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vt337f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-One9b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-7QGlO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-5VsWNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Oj8PPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-T_Iog4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-qjcnNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-zBThvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UINrLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:21:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-oHwLXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:21:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vNd9h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:21:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-A04a8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:21:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-zVEQsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:21:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-CDkjey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-hzaexr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:21:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-dJLEtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:21:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-2VCvmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:21:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:21:18 INFO - Running setup.py install for manifestparser 23:21:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:21:18 INFO - Running setup.py install for mozcrash 23:21:19 INFO - Running setup.py install for mozdebug 23:21:19 INFO - Running setup.py install for mozdevice 23:21:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:21:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:21:19 INFO - Running setup.py install for mozfile 23:21:19 INFO - Running setup.py install for mozhttpd 23:21:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:21:19 INFO - Running setup.py install for mozinfo 23:21:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:21:19 INFO - Running setup.py install for mozInstall 23:21:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:21:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:21:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:21:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:21:19 INFO - Running setup.py install for mozleak 23:21:20 INFO - Running setup.py install for mozlog 23:21:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:21:20 INFO - Running setup.py install for moznetwork 23:21:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:21:20 INFO - Running setup.py install for mozprocess 23:21:20 INFO - Running setup.py install for mozprofile 23:21:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:21:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:21:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:21:20 INFO - Running setup.py install for mozrunner 23:21:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:21:20 INFO - Running setup.py install for mozscreenshot 23:21:21 INFO - Running setup.py install for moztest 23:21:21 INFO - Running setup.py install for mozversion 23:21:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:21:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:21:21 INFO - Cleaning up... 23:21:21 INFO - Return code: 0 23:21:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21: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 23:21: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 23:21:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:21 INFO - 'HOME': '/Users/cltbld', 23:21:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:21 INFO - 'LOGNAME': 'cltbld', 23:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:21 INFO - 'MOZ_NO_REMOTE': '1', 23:21:21 INFO - 'NO_EM_RESTART': '1', 23:21:21 INFO - 'PAGER': '/bin/cat', 23:21:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:21 INFO - 'PWD': '/builds/slave/test', 23:21:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:21 INFO - 'SHELL': '/bin/bash', 23:21:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:21 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:21 INFO - 'USER': 'cltbld', 23:21:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:21 INFO - 'XPC_FLAGS': '0x0', 23:21:21 INFO - 'XPC_SERVICE_NAME': '0', 23:21:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:21:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-PhJXUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:21: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)) 23:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:21:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-wFi5i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:21: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)) 23:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:21:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-wLHotK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:21: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)) 23:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-jXQmjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:21:22 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)) 23:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-kvWGVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:21:22 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)) 23:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vnC0Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:21:22 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)) 23:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-T_FFfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:21: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)) 23:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-eXOksn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:21: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)) 23:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-bkxnlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:21: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)) 23:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-qiLooT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:21: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)) 23:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Z7l88X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:21: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)) 23:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-EA4RdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:21: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)) 23:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:21:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-2WzP9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:21:23 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)) 23:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:21:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-CJPzrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:21:23 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)) 23:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-eUxmpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:23 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)) 23:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:21:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-zeWeiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:21: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)) 23:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:21:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ILQlJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:25 INFO - Downloading blessings-1.6.tar.gz 23:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:21:25 INFO - Installing collected packages: blessings 23:21:25 INFO - Running setup.py install for blessings 23:21:26 INFO - Successfully installed blessings 23:21:26 INFO - Cleaning up... 23:21:26 INFO - Return code: 0 23:21:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:21:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:21:26 INFO - Reading from file tmpfile_stdout 23:21:26 INFO - Current package versions: 23:21:26 INFO - blessings == 1.6 23:21:26 INFO - blobuploader == 1.2.4 23:21:26 INFO - docopt == 0.6.1 23:21:26 INFO - functools32 == 3.2.3-2 23:21:26 INFO - jsonschema == 2.5.1 23:21:26 INFO - manifestparser == 1.1 23:21:26 INFO - mozInstall == 1.12 23:21:26 INFO - mozcrash == 0.17 23:21:26 INFO - mozdebug == 0.1 23:21:26 INFO - mozdevice == 0.48 23:21:26 INFO - mozfile == 1.2 23:21:26 INFO - mozhttpd == 0.7 23:21:26 INFO - mozinfo == 0.9 23:21:26 INFO - mozleak == 0.1 23:21:26 INFO - mozlog == 3.3 23:21:26 INFO - moznetwork == 0.27 23:21:26 INFO - mozprocess == 0.23 23:21:26 INFO - mozprofile == 0.28 23:21:26 INFO - mozrunner == 6.12 23:21:26 INFO - mozscreenshot == 0.1 23:21:26 INFO - mozsystemmonitor == 0.3 23:21:26 INFO - moztest == 0.7 23:21:26 INFO - mozversion == 1.4 23:21:26 INFO - psutil == 3.1.1 23:21:26 INFO - requests == 1.2.3 23:21:26 INFO - wsgiref == 0.1.2 23:21:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21: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 23:21: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 23:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:26 INFO - 'HOME': '/Users/cltbld', 23:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:26 INFO - 'LOGNAME': 'cltbld', 23:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:26 INFO - 'MOZ_NO_REMOTE': '1', 23:21:26 INFO - 'NO_EM_RESTART': '1', 23:21:26 INFO - 'PAGER': '/bin/cat', 23:21:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:26 INFO - 'PWD': '/builds/slave/test', 23:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:26 INFO - 'SHELL': '/bin/bash', 23:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:26 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:26 INFO - 'USER': 'cltbld', 23:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:26 INFO - 'XPC_FLAGS': '0x0', 23:21:26 INFO - 'XPC_SERVICE_NAME': '0', 23:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21:26 INFO - Cleaning up... 23:21:26 INFO - Return code: 0 23:21:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x10ce18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cead618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf7a463ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, '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.izyy2CVY2x/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.gy54WY6khF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 23:21: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 23:21: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 23:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:26 INFO - 'HOME': '/Users/cltbld', 23:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:26 INFO - 'LOGNAME': 'cltbld', 23:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:26 INFO - 'MOZ_NO_REMOTE': '1', 23:21:26 INFO - 'NO_EM_RESTART': '1', 23:21:26 INFO - 'PAGER': '/bin/cat', 23:21:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:26 INFO - 'PWD': '/builds/slave/test', 23:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:26 INFO - 'SHELL': '/bin/bash', 23:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:21:26 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:26 INFO - 'USER': 'cltbld', 23:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:26 INFO - 'XPC_FLAGS': '0x0', 23:21:26 INFO - 'XPC_SERVICE_NAME': '0', 23:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:21:27 INFO - Cleaning up... 23:21:27 INFO - Return code: 0 23:21:27 INFO - Running post-action listener: _resource_record_post_action 23:21:27 INFO - Running post-action listener: _start_resource_monitoring 23:21:27 INFO - Starting resource monitoring. 23:21:27 INFO - [mozharness: 2016-08-12 06:21:27.057299Z] Finished create-virtualenv step (success) 23:21:27 INFO - [mozharness: 2016-08-12 06:21:27.058265Z] Running install step. 23:21:27 INFO - Running pre-action listener: _resource_record_pre_action 23:21:27 INFO - Running main action method: install 23:21:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:21:27 INFO - Reading from file tmpfile_stdout 23:21:27 INFO - Detecting whether we're running mozinstall >=1.0... 23:21:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:21:27 INFO - Reading from file tmpfile_stdout 23:21:27 INFO - Output received: 23:21:27 INFO - Usage: mozinstall [options] installer 23:21:27 INFO - Options: 23:21:27 INFO - -h, --help show this help message and exit 23:21:27 INFO - -d DEST, --destination=DEST 23:21:27 INFO - Directory to install application into. [default: 23:21:27 INFO - "/builds/slave/test"] 23:21:27 INFO - --app=APP Application being installed. [default: firefox] 23:21:27 INFO - mkdir: /builds/slave/test/build/application 23:21: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'] 23:21: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 23:22:01 INFO - Reading from file tmpfile_stdout 23:22:01 INFO - Output received: 23:22:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:22:01 INFO - Running post-action listener: _resource_record_post_action 23:22:01 INFO - [mozharness: 2016-08-12 06:22:01.606486Z] Finished install step (success) 23:22:01 INFO - [mozharness: 2016-08-12 06:22:01.606615Z] Running run-tests step. 23:22:01 INFO - Running pre-action listener: _resource_record_pre_action 23:22:01 INFO - Running main action method: run_tests 23:22:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:22:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:22:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:22:01 INFO - 2016-08-11 23:22:01.621 screenresolution[1976:15638] starting screenresolution argv=screenresolution get 23:22:01 INFO - 2016-08-11 23:22:01.623 screenresolution[1976:15638] Display 0: 1600x1200x32@60 23:22:01 INFO - 2016-08-11 23:22:01.629 screenresolution[1977:15640] starting screenresolution argv=screenresolution list 23:22:01 INFO - Available Modes on Display 0 23:22:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:22:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:22:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:22:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:22:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:22:01 INFO - Intel Iris: 23:22:01 INFO - Chipset Model: Intel Iris 23:22:01 INFO - Type: GPU 23:22:01 INFO - Bus: Built-In 23:22:01 INFO - VRAM (Dynamic, Max): 1536 MB 23:22:01 INFO - Vendor: Intel (0x8086) 23:22:01 INFO - Device ID: 0x0a2e 23:22:01 INFO - Revision ID: 0x0009 23:22:01 INFO - Displays: 23:22:01 INFO - Display: 23:22:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:22:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:22:01 INFO - Display Serial Number: 1600x1200 60 23:22:01 INFO - Main Display: Yes 23:22:01 INFO - Mirror: Off 23:22:01 INFO - Online: Yes 23:22:01 INFO - Rotation: Supported 23:22:01 INFO - Return code: 0 23:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:22:01 INFO - Python 2.7.3 23:22:01 INFO - Return code: 0 23:22:01 INFO - grabbing minidump binary from tooltool 23:22: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')]} 23:22: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 0x10cd7cd30>, '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 0x10cae1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd74b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:22: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 23:22: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 23:22: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 23:22:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:22:02 INFO - Return code: 0 23:22:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:22:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:22:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:22:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:22:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:22:02 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/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 23:22:02 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/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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 23:22:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.izyy2CVY2x/Render', 23:22:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:22:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:22:02 INFO - 'HOME': '/Users/cltbld', 23:22:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:22:02 INFO - 'LOGNAME': 'cltbld', 23:22:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:22:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:02 INFO - 'MOZ_NO_REMOTE': '1', 23:22:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:22:02 INFO - 'NO_EM_RESTART': '1', 23:22:02 INFO - 'PAGER': '/bin/cat', 23:22:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:02 INFO - 'PWD': '/builds/slave/test', 23:22:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:22:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:22:02 INFO - 'SHELL': '/bin/bash', 23:22:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gy54WY6khF/Listeners', 23:22:02 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 23:22:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:22:02 INFO - 'USER': 'cltbld', 23:22:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:22:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:02 INFO - 'XPC_FLAGS': '0x0', 23:22:02 INFO - 'XPC_SERVICE_NAME': '0', 23:22:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:22:02 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/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 23:22:02 INFO - mozversion application_buildid: 20160811201315 23:22:02 INFO - mozversion application_changeset: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c 23:22:02 INFO - mozversion application_display_name: Nightly 23:22:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:22:02 INFO - mozversion application_name: Firefox 23:22:02 INFO - mozversion application_remotingname: firefox 23:22:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:22:02 INFO - mozversion application_vendor: Mozilla 23:22:02 INFO - mozversion application_version: 51.0a1 23:22:02 INFO - mozversion platform_buildid: 20160811201315 23:22:02 INFO - mozversion platform_changeset: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c 23:22:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:22:02 INFO - mozversion platform_version: 51.0a1 23:22:02 INFO - using testdate: 1470982922 23:22:02 INFO - actual date: 1470982922 23:22:02 INFO - starting webserver on 'localhost:49541' 23:22:02 INFO - SUITE-START | Running 2 tests 23:22:02 INFO - TEST-START | dromaeo_css 23:22:02 INFO - operating with platform_type : mac_ 23:22:02 INFO - Initialising browser for dromaeo_css test... 23:22:02 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpsfQg9W/profile http://localhost:49541/getInfo.html) 23:22:04 INFO - PROCESS | 1987 | __metrics Screen width/height:1600/1200 23:22:04 INFO - PROCESS | 1987 | colorDepth:24 23:22:04 INFO - PROCESS | 1987 | Browser inner width/height: 1024/689 23:22:04 INFO - PROCESS | 1987 | __metrics 23:22:04 INFO - PROCESS | 1987 | 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" 23:22:04 INFO - PROCESS | 1987 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:22:05 INFO - TEST-INFO | 1987: exit 0 23:22:05 INFO - Browser initialized. 23:22:05 INFO - Running cycle 1/1 for dromaeo_css test... 23:22:05 INFO - TEST-INFO | started process 1989 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpsfQg9W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:17 INFO - PROCESS | 1989 | RSS: Main: 243400704 23:22:17 INFO - PROCESS | 1989 | 23:23:09 INFO - PROCESS | 1989 | 1470982989216 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] 23:25:20 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49541/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49541/tests/dromaeo/cssquery-ext.html) 23:25:21 INFO - PROCESS | 1989 | RSS: Main: 367628288 23:25:21 INFO - PROCESS | 1989 | 23:28:24 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49541/tests/dromaeo/cssquery-ext.html (next: http://localhost:49541/tests/dromaeo/cssquery-jquery.html) 23:28:25 INFO - PROCESS | 1989 | RSS: Main: 402341888 23:28:25 INFO - PROCESS | 1989 | 23:31:27 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49541/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49541/tests/dromaeo/cssquery-mootools.html) 23:31:28 INFO - PROCESS | 1989 | RSS: Main: 350515200 23:31:28 INFO - PROCESS | 1989 | 23:34:30 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49541/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49541/tests/dromaeo/cssquery-prototype.html) 23:34:31 INFO - PROCESS | 1989 | RSS: Main: 373964800 23:34:31 INFO - PROCESS | 1989 | 23:37:34 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49541/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49541/tests/dromaeo/cssquery-yui.html) 23:37:35 INFO - PROCESS | 1989 | RSS: Main: 340385792 23:37:35 INFO - PROCESS | 1989 | 23:40:38 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49541/tests/dromaeo/cssquery-yui.html (next: http://localhost:49541/tests/dromaeo/cssquery-dojo.html) 23:40:38 INFO - PROCESS | 1989 | RSS: Main: 450277376 23:40:38 INFO - PROCESS | 1989 | 23:40:38 INFO - PROCESS | 1989 | __start_tp_report 23:40:38 INFO - PROCESS | 1989 | _x_x_mozilla_page_load 23:40:38 INFO - PROCESS | 1989 | _x_x_mozilla_page_load_details 23:40:38 INFO - PROCESS | 1989 | |i|pagename|runs| 23:40:38 INFO - PROCESS | 1989 | |0;dojo.html;2683.9194824155275;3305.603327600687;3332.1836150143217;3333.2666813301066;3385.864565417382;5518.420565840589;5582.5254853337465;5593.720313984305;5641;5678.57410694198;4737.313089602014;5647.237622920905;5721.485066344028;5732.684702341369;5763.9711801440935;5162;5170.922436163461;5234.92147617786;5253.500917412859;5404.189371594253;5303.575713942875;5311.49540793624;5336.759845806948;5357.624966252364;5361.839144825662;5119.820806271781;5137.768800403991;5153.742312884378;5180.870478238036;5219.45195754446;5170.922436163461;5210.400803907562;5260.079486089957;5284.630075894689;5325.707086110262;4732.763361831929;5186.196139598368;5216.217567364888;5231.450697676727;5293.523582877521;5752.769889204426;5780.71096445176;5791.420857914217;5821.417858214187;5826.592138550261;6095.08573713942;6157.014877619604;6214.5960512566535;6221.004639257697;6262.843428914268;6207.906881396782;6275.2783429905685;6275.780347687809;6296.685165741695;6302.40127187921;5901.822945311647;5908.468237858528;5911.55663325248;5913.733881975321;5914.994450943393;6174.660393678301;6251.812445626639;6261.812145635638;6301.527385446018;6302.905456418157;6018.277806663228;6069.431674163202;6095.177151084636;6118.1434599156155;6125.571210015345;6208.782692605737;6241.563090583706;6291.087792270187;6298.527610429236;6300.086487459293;6138.109974053827;6209.161763161916;6224.502039836802;6238.719257633326;6240.282367527701;6041.9395806041375;6135.478484328882;6172.969135154295;6232.127502149703;6241.21984751906;4655.5102367242835;4708.976455117702;5010.799568017239;5015.172496538104;5050.469700681376;3709.9443508347395;4461.330800379904;4478.596926276651;4486.282194848874;4505.05393867285;5526.613137080366;5592.5805564582815;5694.829155125353;5710.086386178192;5718.370979192286;6195.597286176384;6256.061590761422;6298.118263443122;6298.181236439325;6342.365763423621;5648.378678345379;5659.066254068115;5661.490465858093;5667.574931880125;5693.743781529841;5245.26566280721;5431.755570999315;5442.482964118402;5455.536279416215;5457.808976685797;6202.131701561785;6230.034344676401;6239.906401404073;6245.594036387621;6247.750089996349;6227.782027629011;6257.843553911189;6265.530085243534;6278.748850045947;6296.842578935563;6311.990081586924;6341.714622842075;6348.206474190726;6363.204599425072;6376.617402955838;6034.396560344106;6090.695465226632;6108.35862234459;6134.069235337226;6180.938190618036;6223.688815559113;6259.6870156492905;6271.059341098689;6273.37266273369;6277.2153480814895;4834.613230941586;6068.575199736153;6072.089186622042;6082.148499210202;6091.847703807441;5883.235179426647;5943.910841337297;5988.101784732325;6040.939590604214;6079;5446.918296225481;5937.703114844327;5983.940160598512;5986.551008674454;5996.730147143302;6038.909416358846;6060.484858787053;6063.454289114001;6076.726547305293;6098.969505152446;5704.572157088318;5816.9127463088935;5887.852803679943;5892.410758924073;5906.350301466921 23:40:38 INFO - PROCESS | 1989 | |1;ext.html;466.8949486365568;521.6348556010794;522.9660072095313;530.7054584705487;537.8601563593467;30817.845910770444;31203.531947020783;35391.646083539155;41780;41987.74036778902;35670;42771.50299739502;42982.57017429825;43105;43156.3526547102;9642.903570964289;9830.410175389463;9838.01619838014;9840.458774767385;9845.310828242025;8716.912830871674;8947.418417802855;11865.16943813929;12156.270623762603;12168.878311216908;12094.153409261355;12169.087318451151;12170.148089633729;12181.269123852553;12242.755144897097;12109.212901161396;12173.330466824322;12174.756504869942;12182.329971851545;12206.938965305206;12034.33811140387;12109.636710898687;12119.515219391214;12131.575394861138;12140.210886292363;40465;40733;40787.38818917719;40810;40896.1820763586;3462.7056700180515;3652.853885844563;3656.6160553141804;3671.7429779915415;3915.745476544044;32515.837420812983;32790.83604581986;33125.6687433125;33275;33326.33347333064;3216.7748257621975;3263.3473305339026;3289.786163899339;3309.189248634076;3422.5550678411896;523885;526700;527079;527987;529724;59673.70163149157;60127;60154;60165.39834601598;60205;34879.4768078479;35413.114672132884;35581.82209088938;36482.452763208574;36582.81708591493;16901.23944422504;17021.148942552823;17034.914825425793;17055.573610659583;17061.7440738389;11659.475323610457;11904.940475297568;12807.743845123045;12915.418806153746;12943.546975855988;17012.149392530326;17148.31406743741;17179.711521635927;19112.808871911104;19545.511362216057;7918.802029949297;7980.920190798134;8021.438499304993;8057.315128214167;8084.312833409109;878.6397576993402;887.9467231966103;932.3473568502076;942.7171848445439;957.8036502516967;29705.554416683768;30044.849775750983;30093;30903.690963090532;30931.226719331746;1072.2601405030505;1185.1407729396292;1196.9640910772691;1210.116614871149;1210.4673943464848;15530.990485618398;15819.367225311089;15842.841571584368;15993.68012639764;16119.95690171195;674402;678791;679696;680177;687598;59727.805443891746;59829.700851495465;59922.70038649779;59978;60000.69999649974;1269.911106222574;1316.4470922212693;1379.7654398752236;1403.0879928046647;1404.3680343845106;29142.27144321409;29602.851985739933;29716.405671886874;30379.2405189872;30462.933797317874;50917.74541127271;51221.97556048933;51281.48718512916;51333.48666513287;51513.484865150866;575241;577133.1143344257;577549;578911;580731;24107.879460602584;24483.755162448146;26561.46877062409;26921.86539067292;26990.460190795682;42426.1514769709;48084.557463276156;48691.269630956274;49164.26253606127;49227.75386123046;36755.26489470249;37872.24255514929;39349;39870.40194397145;40807.591924081564;39260.21479570335;39445.60554394419;40590;40690.1861962765;40832.38751418672;39103.41344879886;39351.01622459347;40580;41391.58608413998;41528.377074343305;32936;34572.13569660779;34637.82681086579;35554.46668299926;36316.370962500856;24330.07315521589;25336.98652053971;25452;26300.605490917267;27093.72906270912 23:40:38 INFO - PROCESS | 1989 | |2;jquery.html;347.31925426164713;371.25748502993997;371.61909043230685;376.73063759412014;401.5582858855258;15512.379504819808;16408.179591020446;20637;20922.790772092274;21036.57926841464;20713.482162945933;20964.89517552414;21030.369088927317;21040.894795526;21348.99999999996;5163.251328557357;5846.970765146169;5874.9412505874825;6057.454829065383;6134.04922237054;5951.345352011297;6015.0676645120075;6049.062395328731;6064.06007068905;6086.269647642289;4156.916861662765;4358.237308471021;5257.658252213594;6645.169353830771;6734.427573656245;6454.838629034265;6689.765858194988;6690.330966903295;6695.029220762986;6717.227518835299;5790.507806836382;5836.824895253107;5849.093390524433;5851.882962340729;5866.442687944638;23589.528209435888;24010;24554.386140346633;25172.11897583594;25971;2384.499255156419;2390.9282721518384;2401.3876461502205;2773.9320361660907;3029.3789773096464;8015;10372.481375931173;10381.013803688638;10430.68707938763;10468.42423666698;1907.523119220195;1912.9808701912941;1953.394447721211;1956.8923709195988;1966.3904189701238;102039.97960020379;108046.45976770144;108848;109141.45429272803;110580;10874.728131796768;11274.605388811353;11369.658910232707;11425.485853136628;11510.654680359603;14136.787948180785;14150.86793056553;14158.867290616727;14168.716625667636;14263.572092837232;8289.129641387688;8414.6213420395;8418.705345312885;8446.915530844613;8536.8719469208;8385.874211886827;8397.370197235232;8401.03388110375;8614.44006139599;8630.26642735362;4451.688381813242;4464.129494748493;4474.597286244189;4488.910221795546;4534.841280555164;1866.7293242479764;1867.8785878917827;1893.9526511837314;1894.128700797621;1913.933012344589;857.4340934983006;867.5358683104508;909.2589539525266;935.4013431403907;944.9086305317369;20299.391018269474;20770.130688238132;20853.270135545183;20908;21104.804620055987;892.8169725206317;937.4515908193783;941.4915945389413;973.177664873181;1024.5645600619855;8861;10674.839877401846;11069.72325691848;11163;11206.607768728218;510958;545148;579152;583953;599918;76501.61749191218;126072.1089183663;127791;129621;130842;937.4234845569925;951.8572214167792;971.5676523946776;974.1281553010016;977.6578197630772;13843.930780346034;18403;18780.624387512446;18804.529886752392;19059.14233859452;54758.45241547534;54877.90244195174;55007;55157.06950256722;55343.44656553544;61331.693341533006;74741;79501;79635.60182199052;80476.19523804921;6501.869962600627;6601.669916504252;6956;8082.555459449787;8326.542040187605;10689.9465502672;12801.167924084904;13299.135556189203;13312.733745325233;13404.061715679809;11181.664550063511;11579.88420115788;11590.42047897585;11593.478293476644;11657.825132622847;10680;10942.124630029419;11272.887271127513;11380.487878045342;11492.770144596894;9999.600015999278;10959.671209863716;11353.205275630957;11596.710082248012;11614.954654081173;7642.8089297768;7725.884111738441;7943.046834379911;8010.919890801018;8141.9185808141165;9896.851547226654;10865.728356791144;11358.375289359165;11363.829542557034;11437.970582647602 23:40:38 INFO - PROCESS | 1989 | |3;mootools.html;1361.9863801361982;1498.7377208988423;1518.8329283778783;1705.9232334544945;1899.078946710845;7925.2867241948215;8725.127487251271;8943.150400711922;8967.01362850086;9101.044390339019;8818.338624603148;8914.643414263437;8917.33120015998;8925.419847709894;8936.374453788238;2321.117975169433;2347.8943447544816;2351.1535847095033;2355.199232261031;2356.528694261146;2293.873836938976;2327.627579587266;2353.6351865460797;2354.1878052072007;2357.3281614739803;2280.144945645383;2287.142321629389;2296.2766728480474;2337.1419721321504;2337.544178885118;2263.2531264682616;2274.772522747712;2276;2276.9203077892275;2278;2300;2300.643400272944;2305.2853615379286;2306.042992158252;2310.445493081665;8757.956210218908;8793.164649358301;8869.290456763443;8948.73153805387;9004.414713043696;5096.362954630671;5306.893862122774;5319.5478384337375;5330.200469929503;5335.413104558495;3573.714102871764;3589.569251689814;3657.140571965586;3658.835352409148;3672.1003354178397;1042.8725400183616;1056.3292309383519;1061.3950048472375;1066.9306495077794;1077.6228320087985;10065.446400447972;10927.508262128224;11108.944455277753;11997.460114294878;12029.879701202875;4334.1981733379425;4443.422355093817;4546.477155127202;4620.768961551909;4642.187617166982;9193.218576420946;9210.263178945668;9212.309076819265;9213.401128926598;9285.25717942563;5033.245013247969;5046.167382381939;5051.974740126349;5058.46886076964;5063.594912407072;4322.459692538433;4477.776111194427;4663.930041049387;4678.157931572349;4792.616590672737;3692.3722967095123;3740.8503659853845;3814.294355544233;3853.0560012797046;3862.439946207784;981.4994352880083;1134.2400591603646;1146.4267866066966;1167.1538134852333;1168.6085161471003;842.2714352085402;866.7486428935664;868.9000764912116;931.5901003558413;994.7413672445072;5453.481919217747;5809.82570522885;6054.727537260834;6064.696765161724;6137.9079313810325;797.2505844506146;806.4072906413782;894.190757364586;906.4425378392241;939.9154076133044;3979.9801000994808;3984.641382275609;3985.222881538072;4125.278076336689;4137.193247316804;10649.094826939641;10881.401522916316;11005.834912476319;11040.061594764535;11054.060404865677;10935.945320273348;10940.507677154546;10942.343459392461;10944.23390362683;10944.56221751137;6829.829254268683;7834.373250139975;8240.917590824016;8361.205685459872;8361.456505327256;5784.479396854304;5977.551683623658;6144.692765361803;6162.784302549389;6190.659513726608;9692.854607180758;9939.353941993748;10109.848352274576;10120.848187277345;10144.898551014396;10276.845847312446;10325.63860264887;10344.431056291976;10351.378917264989;10352.378857268588;7015.298470152944;7235.095613048369;7249.637518123967;7649.732259371118;7787.29914307715;8142.592870356577;8228.42401031922;8392.03491598474;8489.235968762841;8542.658293668432;6432.871342573216;7390.150132734804;7520.548767073774;7641.656125474478;7689.154193038873;7398.704051838082;7402.740904068547;7419.146798118286;7467.701291948479;7571.545707257582;6968.512204145661;7121.181064177478;7131.215566287808;7133.536320139175;7137.714491420285;4920.335754673073;4985.277134815504;5005.649604527648;5041.621878359065;5116.079105760999;4848.442429120696;4996.125678006261;5007.122329126578;5182.222666600041;5192.792288308426 23:40:39 INFO - PROCESS | 1989 | |4;prototype.html;288.64640815001627;298.79980413123207;309.82185243485;313.2622673603665;316.5046701911508;5034.244863270511;5286.474446231902;5305.840824775263;5365.041759757684;5366.919496207555;5107.719075450848;5189.325387699603;5224.92162617561;5238.292830467895;5246.711430871301;4021.6983726220506;4080.9795951020205;4082.5917408259234;4087.9386809197813;4116.608922152405;3615.788710781878;4112.609302116294;4125.979370103145;4130.8554200602985;4135.1936372407245;3708.4993525873933;3900.3174444472247;3942.3100957332495;3973.582773808752;4026.3155263605113;3464.6881780639737;3965.524137103537;3990.20195960809;4002.2795896738576;4011.4785077939973;3430.2624935638955;3438.7764795288476;3438.8796392126405;3451.861925522976;3468.497067925137;4537.507867211437;4870.805167793319;5050.419201791804;5133.948660513422;5161.896762064775;4481.775911204427;4505.617022553087;4517.570830771071;4523.208438523278;4550.7724613769515;4510.458744950594;5471.79620483493;5476.397596264408;5477.917831232535;5478.698671573062;3795.4876091727815;3797.145642230476;3800.20195758891;3807.5240594925635;3815.5993620669706;4482.663800214997;5442.809501667462;5748.281464816898;5787.913181302284;5848.7075646217945;3703.685186759156;3853.8265778040054;3864.555576108727;3868.3230434674383;3872;3907.5701672815967;3924.8626298080003;3927.273454410943;3941.5270167580074;3956.5449973253444;3566.4293713006314;4394.736315820997;4473;4586.954130458719;4599.5400459953735;5115.5396014358885;5269.814291784318;5351.591783697352;5538.972305138448;5558.583106266965;1314.547425095275;1334.733053389326;1336.3562817734048;1337.9331033448484;1340.2963444191878;723.6200994477836;753.4198667026359;769.8575763483661;801.354909298009;807.5719868469721;3664.5785734640326;3824;4217.493900731932;4263.4031235627035;4307.483102027777;3857;4556.066006468666;4572.908541829145;4683.367745354401;4687.10944920464;3990.5856956541456;4131.752094874317;4193.7693426861815;4247.851325203603;4260.893477663083;2194.452910697954;2270.92051778187;2414.9374275318805;2478.615814548748;2510.560651885949;4732.810687572527;4789.377380940456;4801.68789028712;4859.1010663027455;4886.364772579542;4108.465899433055;4257.297545904953;4761.4524329701835;4781.545753153515;4795.657215979531;4794.633529444091;4923.556879880684;4940.011293167582;5239.607029472729;5897.882042359214;5736.311642602747;5740.3685594585395;5756.079027355603;5776.682282474336;5797.710114494343;5458.479280863741;5674.829755107354;5703.948387612607;5704.890834495127;5787.987102257004;5353.277307563585;5452.372977107525;5813.854653633523;5895.764169433174;5940.693047529537;3862.4785653937483;3872.612738726105;3886.145048089416;3906.4140378943384;3924.6075392460525;5366.087765080024;5825.592208545361;5836.474717275466;5838.095095260242;5960.552958528041;5258.447862974485;5398.568114550748;5599.796043850592;5610.933922554702;5654.6889921054735;4474.463064432289;5090.363704536933;5490.80782172622;5563.082091454865;5597.692126933058;4584.77076146198;5189.351331083614;5265.368155821326;5482.205080263419;5486.890262194814;4342.522322544454;4657.300085468847;5488.655279456399;5557.777688892399;5605.831825045255;4522.389477420637;5438.646487978269;5447.564194864322;5448.610604296037;5478.287822583039 23:40:39 INFO - PROCESS | 1989 | |5;yui.html;718.6334969165725;741.8330875552998;774.9961250193749;782.2920257167266;818.7175424478555;15162.696746065087;16612.16939153042;16667.499975000756;16674;16700.58248543787;15047.623809404771;15205.315760790763;15232.466863659774;15236.542903712907;15242.161681107535;677.2144312597388;698.9231184569693;822.4201937633984;833.5332213960171;857.3312816003527;822.6174828704651;839.8200528257807;840.2731637133896;841.7853447370942;844.9788755281106;897.4615230861464;898.8112496375769;899.4603238057178;900.4057322167371;901.4861528928514;711.2141084102096;732.6702983657375;892.9776755581163;893.6916763716507;895.4314010603249;536.0458384076351;537.5780012690019;538.8437353167577;649.1690635985946;650.6779144323543;12667.30329831859;15439.922800385926;15446.150461724601;15449.5365139046;15452.768208476882;13737.587872363845;13935.442582296697;14268.357923893345;14301.284935753274;14421.278936053155;12716.936415317865;12837.614871553867;12862.614121576367;12929.418176182095;13047.934760326138;4216.7259128156575;4547.18150732868;4702.741349225791;4730.8344207952905;4778.737169455679;108876;112493.87506124916;113262;113363.43318283439;113584;10841.49255071343;11010.889891100986;11068.501917413574;11179.552817887356;11541.711457213469;22258.109675612795;22283.10867565279;22283.665745013837;22296.996635151456;22320.330390088322;7909.762707118795;7966.402519811038;8010.399220058519;8242.29940455068;8250.669973201126;4370.781460926941;4386.539413361615;4430.778461076998;4509.278515437514;4601.987562736193;3038.5442183672185;3360.2103505676146;3426.2462258303135;3436.9828150859585;3475.2701932594437;625.9092431597484;628.6228263042138;634.2864277687602;634.7365843175123;651.371426573359;507.41647105828594;539.2962184349461;560.8177342363748;627.7896904537031;651.3811878715239;6956.339147780953;8689.826203475895;9046.728598142066;9129.863052054225;9562.665306714232;598.1804927249609;632.4023797511308;636.6625688385163;644.3009334871623;644.3298969072206;4226.704130710821;4334.176506463762;4434.977825110854;4478.7760611969925;4492.505033932421;88580.5570972141;120383.39808300903;127778;144392.27803860913;147476;114915;115917.42041289908;117056.8294317046;119467;122006;119086;120518;123273;123455;123620.2913912584;8401.873971890549;8552.657893684433;8552.828943421222;8570.26444194882;8726.781830454289;41751;65442.8997020854;65963;68377.65811170913;68573.48551887563;87164;95284;99301.50349248208;100045.49977250067;102829.48585257026;11728.237664552118;11787.823182652095;11870.465829037541;12213.511459541518;12266.509339626315;12221.572244971383;12335.568255111028;12345.074119440898;12428.62714118578;12443.626691199279;11915.76168476643;11917.165798394375;11985.64043078709;12080.939595301967;12189.878101218874;11624.593139240085;11685.182037257311;11880.217462345297;11906;12375.319357435428;10176.135028522362;11800.763984720086;12098.879011210127;12329.630111096682;12343.19769214998;9487.146156845916;9709.6601618943;9720.368176068532;9925.699278919123;10205.336653117523;9118.452892826452;9920.107190352903;9958.502074896081;9968.072726549333;10071.34536255141 23:40:39 INFO - PROCESS | 1989 | __end_tp_report 23:40:39 INFO - PROCESS | 1989 | __start_cc_report 23:40:39 INFO - PROCESS | 1989 | _x_x_mozilla_cycle_collect,1366 23:40:39 INFO - PROCESS | 1989 | __end_cc_report 23:40:39 INFO - PROCESS | 1989 | __startTimestamp1470984038989__endTimestamp 23:40:39 INFO - PROCESS | 1989 | 23:40:39 INFO - PROCESS | 1989 | ------- Summary: start ------- 23:40:39 INFO - PROCESS | 1989 | Number of tests: 6 23:40:39 INFO - PROCESS | 1989 | 23:40:39 INFO - PROCESS | 1989 | [#0] dojo.html Cycles:165 Average:5716.32 Median:5914.99 stddev:671.18 (11.3%) stddev-sans-first:629.68 23:40:39 INFO - PROCESS | 1989 | Values: 2683.9 3305.6 3332.2 3333.3 3385.9 5518.4 5582.5 5593.7 5641.0 5678.6 4737.3 5647.2 5721.5 5732.7 5764.0 5162.0 5170.9 5234.9 5253.5 5404.2 5303.6 5311.5 5336.8 5357.6 5361.8 5119.8 5137.8 5153.7 5180.9 5219.5 5170.9 5210.4 5260.1 5284.6 5325.7 4732.8 5186.2 5216.2 5231.5 5293.5 5752.8 5780.7 5791.4 5821.4 5826.6 6095.1 6157.0 6214.6 6221.0 6262.8 6207.9 6275.3 6275.8 6296.7 6302.4 5901.8 5908.5 5911.6 5913.7 5915.0 6174.7 6251.8 6261.8 6301.5 6302.9 6018.3 6069.4 6095.2 6118.1 6125.6 6208.8 6241.6 6291.1 6298.5 6300.1 6138.1 6209.2 6224.5 6238.7 6240.3 6041.9 6135.5 6173.0 6232.1 6241.2 4655.5 4709.0 5010.8 5015.2 5050.5 3709.9 4461.3 4478.6 4486.3 4505.1 5526.6 5592.6 5694.8 5710.1 5718.4 6195.6 6256.1 6298.1 6298.2 6342.4 5648.4 5659.1 5661.5 5667.6 5693.7 5245.3 5431.8 5442.5 5455.5 5457.8 6202.1 6230.0 6239.9 6245.6 6247.8 6227.8 6257.8 6265.5 6278.7 6296.8 6312.0 6341.7 6348.2 6363.2 6376.6 6034.4 6090.7 6108.4 6134.1 6180.9 6223.7 6259.7 6271.1 6273.4 6277.2 4834.6 6068.6 6072.1 6082.1 6091.8 5883.2 5943.9 5988.1 6040.9 6079.0 5446.9 5937.7 5983.9 5986.6 5996.7 6038.9 6060.5 6063.5 6076.7 6099.0 5704.6 5816.9 5887.9 5892.4 5906.4 23:40:39 INFO - PROCESS | 1989 | 23:40:39 INFO - PROCESS | 1989 | [#1] ext.html Cycles:180 Average:72123.56 Median:36399.41 stddev:160063.70 (439.7%) stddev-sans-first:160422.30 23:40:39 INFO - PROCESS | 1989 | Values: 466.9 521.6 523.0 530.7 537.9 30817.8 31203.5 35391.6 41780.0 41987.7 35670.0 42771.5 42982.6 43105.0 43156.4 9642.9 9830.4 9838.0 9840.5 9845.3 8716.9 8947.4 11865.2 12156.3 12168.9 12094.2 12169.1 12170.1 12181.3 12242.8 12109.2 12173.3 12174.8 12182.3 12206.9 12034.3 12109.6 12119.5 12131.6 12140.2 40465.0 40733.0 40787.4 40810.0 40896.2 3462.7 3652.9 3656.6 3671.7 3915.7 32515.8 32790.8 33125.7 33275.0 33326.3 3216.8 3263.3 3289.8 3309.2 3422.6 523885.0 526700.0 527079.0 527987.0 529724.0 59673.7 60127.0 60154.0 60165.4 60205.0 34879.5 35413.1 35581.8 36482.5 36582.8 16901.2 17021.1 17034.9 17055.6 17061.7 11659.5 11904.9 12807.7 12915.4 12943.5 17012.1 17148.3 17179.7 19112.8 19545.5 7918.8 7980.9 8021.4 8057.3 8084.3 878.6 887.9 932.3 942.7 957.8 29705.6 30044.8 30093.0 30903.7 30931.2 1072.3 1185.1 1197.0 1210.1 1210.5 15531.0 15819.4 15842.8 15993.7 16120.0 674402.0 678791.0 679696.0 680177.0 687598.0 59727.8 59829.7 59922.7 59978.0 60000.7 1269.9 1316.4 1379.8 1403.1 1404.4 29142.3 29602.9 29716.4 30379.2 30462.9 50917.7 51222.0 51281.5 51333.5 51513.5 575241.0 577133.1 577549.0 578911.0 580731.0 24107.9 24483.8 26561.5 26921.9 26990.5 42426.2 48084.6 48691.3 49164.3 49227.8 36755.3 37872.2 39349.0 39870.4 40807.6 39260.2 39445.6 40590.0 40690.2 40832.4 39103.4 39351.0 40580.0 41391.6 41528.4 32936.0 34572.1 34637.8 35554.5 36316.4 24330.1 25337.0 25452.0 26300.6 27093.7 23:40:39 INFO - PROCESS | 1989 | 23:40:39 INFO - PROCESS | 1989 | [#2] jquery.html Cycles:180 Average:33401.57 Median:1688.35 stddev:94150.09 (5576.5%) stddev-sans-first:94381.49 23:40:39 INFO - PROCESS | 1989 | Values: 347.3 371.3 371.6 376.7 401.6 15512.4 16408.2 20637.0 20922.8 21036.6 20713.5 20964.9 21030.4 21040.9 21349.0 5163.3 5847.0 5874.9 6057.5 6134.0 5951.3 6015.1 6049.1 6064.1 6086.3 4156.9 4358.2 5257.7 6645.2 6734.4 6454.8 6689.8 6690.3 6695.0 6717.2 5790.5 5836.8 5849.1 5851.9 5866.4 23589.5 24010.0 24554.4 25172.1 25971.0 2384.5 2390.9 2401.4 2773.9 3029.4 8015.0 10372.5 10381.0 10430.7 10468.4 1907.5 1913.0 1953.4 1956.9 1966.4 102040.0 108046.5 108848.0 109141.5 110580.0 10874.7 11274.6 11369.7 11425.5 11510.7 14136.8 14150.9 14158.9 14168.7 14263.6 8289.1 8414.6 8418.7 8446.9 8536.9 8385.9 8397.4 8401.0 8614.4 8630.3 4451.7 4464.1 4474.6 4488.9 4534.8 1866.7 1867.9 1894.0 1894.1 1913.9 857.4 867.5 909.3 935.4 944.9 20299.4 20770.1 20853.3 20908.0 21104.8 892.8 937.5 941.5 973.2 1024.6 8861.0 10674.8 11069.7 11163.0 11206.6 510958.0 545148.0 579152.0 583953.0 599918.0 76501.6 126072.1 127791.0 129621.0 130842.0 937.4 951.9 971.6 974.1 977.7 13843.9 18403.0 18780.6 18804.5 19059.1 54758.5 54877.9 55007.0 55157.1 55343.4 61331.7 74741.0 79501.0 79635.6 80476.2 6501.9 6601.7 6956.0 8082.6 8326.5 10689.9 12801.2 13299.1 13312.7 13404.1 11181.7 11579.9 11590.4 11593.5 11657.8 10680.0 10942.1 11272.9 11380.5 11492.8 9999.6 10959.7 11353.2 11596.7 11615.0 7642.8 7725.9 7943.0 8010.9 8141.9 9896.9 10865.7 11358.4 11363.8 11438.0 23:40:39 INFO - PROCESS | 1989 | 23:40:39 INFO - PROCESS | 1989 | [#3] mootools.html Cycles:180 Average:5687.36 Median:5000.89 stddev:3212.39 (64.2%) stddev-sans-first:3204.95 23:40:39 INFO - PROCESS | 1989 | Values: 1362.0 1498.7 1518.8 1705.9 1899.1 7925.3 8725.1 8943.2 8967.0 9101.0 8818.3 8914.6 8917.3 8925.4 8936.4 2321.1 2347.9 2351.2 2355.2 2356.5 2293.9 2327.6 2353.6 2354.2 2357.3 2280.1 2287.1 2296.3 2337.1 2337.5 2263.3 2274.8 2276.0 2276.9 2278.0 2300.0 2300.6 2305.3 2306.0 2310.4 8758.0 8793.2 8869.3 8948.7 9004.4 5096.4 5306.9 5319.5 5330.2 5335.4 3573.7 3589.6 3657.1 3658.8 3672.1 1042.9 1056.3 1061.4 1066.9 1077.6 10065.4 10927.5 11108.9 11997.5 12029.9 4334.2 4443.4 4546.5 4620.8 4642.2 9193.2 9210.3 9212.3 9213.4 9285.3 5033.2 5046.2 5052.0 5058.5 5063.6 4322.5 4477.8 4663.9 4678.2 4792.6 3692.4 3740.9 3814.3 3853.1 3862.4 981.5 1134.2 1146.4 1167.2 1168.6 842.3 866.7 868.9 931.6 994.7 5453.5 5809.8 6054.7 6064.7 6137.9 797.3 806.4 894.2 906.4 939.9 3980.0 3984.6 3985.2 4125.3 4137.2 10649.1 10881.4 11005.8 11040.1 11054.1 10935.9 10940.5 10942.3 10944.2 10944.6 6829.8 7834.4 8240.9 8361.2 8361.5 5784.5 5977.6 6144.7 6162.8 6190.7 9692.9 9939.4 10109.8 10120.8 10144.9 10276.8 10325.6 10344.4 10351.4 10352.4 7015.3 7235.1 7249.6 7649.7 7787.3 8142.6 8228.4 8392.0 8489.2 8542.7 6432.9 7390.2 7520.5 7641.7 7689.2 7398.7 7402.7 7419.1 7467.7 7571.5 6968.5 7121.2 7131.2 7133.5 7137.7 4920.3 4985.3 5005.6 5041.6 5116.1 4848.4 4996.1 5007.1 5182.2 5192.8 23:40:39 INFO - PROCESS | 1989 | 23:40:39 INFO - PROCESS | 1989 | [#4] prototype.html Cycles:180 Average:4344.39 Median:4593.25 stddev:1342.83 (29.2%) stddev-sans-first:1311.64 23:40:39 INFO - PROCESS | 1989 | Values: 288.6 298.8 309.8 313.3 316.5 5034.2 5286.5 5305.8 5365.0 5366.9 5107.7 5189.3 5224.9 5238.3 5246.7 4021.7 4081.0 4082.6 4087.9 4116.6 3615.8 4112.6 4126.0 4130.9 4135.2 3708.5 3900.3 3942.3 3973.6 4026.3 3464.7 3965.5 3990.2 4002.3 4011.5 3430.3 3438.8 3438.9 3451.9 3468.5 4537.5 4870.8 5050.4 5133.9 5161.9 4481.8 4505.6 4517.6 4523.2 4550.8 4510.5 5471.8 5476.4 5477.9 5478.7 3795.5 3797.1 3800.2 3807.5 3815.6 4482.7 5442.8 5748.3 5787.9 5848.7 3703.7 3853.8 3864.6 3868.3 3872.0 3907.6 3924.9 3927.3 3941.5 3956.5 3566.4 4394.7 4473.0 4587.0 4599.5 5115.5 5269.8 5351.6 5539.0 5558.6 1314.5 1334.7 1336.4 1337.9 1340.3 723.6 753.4 769.9 801.4 807.6 3664.6 3824.0 4217.5 4263.4 4307.5 3857.0 4556.1 4572.9 4683.4 4687.1 3990.6 4131.8 4193.8 4247.9 4260.9 2194.5 2270.9 2414.9 2478.6 2510.6 4732.8 4789.4 4801.7 4859.1 4886.4 4108.5 4257.3 4761.5 4781.5 4795.7 4794.6 4923.6 4940.0 5239.6 5897.9 5736.3 5740.4 5756.1 5776.7 5797.7 5458.5 5674.8 5703.9 5704.9 5788.0 5353.3 5452.4 5813.9 5895.8 5940.7 3862.5 3872.6 3886.1 3906.4 3924.6 5366.1 5825.6 5836.5 5838.1 5960.6 5258.4 5398.6 5599.8 5610.9 5654.7 4474.5 5090.4 5490.8 5563.1 5597.7 4584.8 5189.4 5265.4 5482.2 5486.9 4342.5 4657.3 5488.7 5557.8 5605.8 4522.4 5438.6 5447.6 5448.6 5478.3 23:40:39 INFO - PROCESS | 1989 | 23:40:39 INFO - PROCESS | 1989 | [#5] yui.html Cycles:180 Average:24221.50 Median:4280.44 stddev:38412.51 (897.4%) stddev-sans-first:38479.73 23:40:39 INFO - PROCESS | 1989 | Values: 718.6 741.8 775.0 782.3 818.7 15162.7 16612.2 16667.5 16674.0 16700.6 15047.6 15205.3 15232.5 15236.5 15242.2 677.2 698.9 822.4 833.5 857.3 822.6 839.8 840.3 841.8 845.0 897.5 898.8 899.5 900.4 901.5 711.2 732.7 893.0 893.7 895.4 536.0 537.6 538.8 649.2 650.7 12667.3 15439.9 15446.2 15449.5 15452.8 13737.6 13935.4 14268.4 14301.3 14421.3 12716.9 12837.6 12862.6 12929.4 13047.9 4216.7 4547.2 4702.7 4730.8 4778.7 108876.0 112493.9 113262.0 113363.4 113584.0 10841.5 11010.9 11068.5 11179.6 11541.7 22258.1 22283.1 22283.7 22297.0 22320.3 7909.8 7966.4 8010.4 8242.3 8250.7 4370.8 4386.5 4430.8 4509.3 4602.0 3038.5 3360.2 3426.2 3437.0 3475.3 625.9 628.6 634.3 634.7 651.4 507.4 539.3 560.8 627.8 651.4 6956.3 8689.8 9046.7 9129.9 9562.7 598.2 632.4 636.7 644.3 644.3 4226.7 4334.2 4435.0 4478.8 4492.5 88580.6 120383.4 127778.0 144392.3 147476.0 114915.0 115917.4 117056.8 119467.0 122006.0 119086.0 120518.0 123273.0 123455.0 123620.3 8401.9 8552.7 8552.8 8570.3 8726.8 41751.0 65442.9 65963.0 68377.7 68573.5 87164.0 95284.0 99301.5 100045.5 102829.5 11728.2 11787.8 11870.5 12213.5 12266.5 12221.6 12335.6 12345.1 12428.6 12443.6 11915.8 11917.2 11985.6 12080.9 12189.9 11624.6 11685.2 11880.2 11906.0 12375.3 10176.1 11800.8 12098.9 12329.6 12343.2 9487.1 9709.7 9720.4 9925.7 10205.3 9118.5 9920.1 9958.5 9968.1 10071.3 23:40:39 INFO - PROCESS | 1989 | -------- Summary: end -------- 23:40:39 INFO - PROCESS | 1989 | 23:40:39 INFO - TEST-INFO | 1989: exit 0 23:40:39 INFO - TEST-OK | dromaeo_css | took 1117470ms 23:40:39 INFO - TEST-START | kraken 23:40:39 INFO - operating with platform_type : mac_ 23:40:39 INFO - Initialising browser for kraken test... 23:40:39 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpV3G77n/profile http://localhost:49541/getInfo.html) 23:40:42 INFO - PROCESS | 1993 | __metrics Screen width/height:1600/1200 23:40:42 INFO - PROCESS | 1993 | colorDepth:24 23:40:42 INFO - PROCESS | 1993 | Browser inner width/height: 1024/689 23:40:42 INFO - PROCESS | 1993 | __metrics 23:40:42 INFO - PROCESS | 1993 | 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" 23:40:42 INFO - PROCESS | 1993 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:40:42 INFO - TEST-INFO | 1993: exit 0 23:40:42 INFO - Browser initialized. 23:40:42 INFO - Running cycle 1/1 for kraken test... 23:40:42 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpV3G77n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:40:54 INFO - PROCESS | 1994 | RSS: Main: 243322880 23:40:54 INFO - PROCESS | 1994 | 23:40:57 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49541/tests/kraken/driver.html?testName=audio-beat-detection) 23:40:58 INFO - PROCESS | 1994 | RSS: Main: 293044224 23:40:58 INFO - PROCESS | 1994 | 23:41:00 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49541/tests/kraken/driver.html?testName=audio-dft) 23:41:01 INFO - PROCESS | 1994 | RSS: Main: 299855872 23:41:01 INFO - PROCESS | 1994 | 23:41:05 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49541/tests/kraken/driver.html?testName=audio-fft) 23:41:05 INFO - PROCESS | 1994 | RSS: Main: 395517952 23:41:05 INFO - PROCESS | 1994 | 23:41:07 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49541/tests/kraken/driver.html?testName=audio-oscillator) 23:41:08 INFO - PROCESS | 1994 | RSS: Main: 296022016 23:41:08 INFO - PROCESS | 1994 | 23:41:10 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49541/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:41:10 INFO - PROCESS | 1994 | RSS: Main: 300634112 23:41:10 INFO - PROCESS | 1994 | 23:41:13 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49541/tests/kraken/driver.html?testName=imaging-darkroom) 23:41:14 INFO - PROCESS | 1994 | RSS: Main: 335822848 23:41:14 INFO - PROCESS | 1994 | 23:41:17 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49541/tests/kraken/driver.html?testName=imaging-desaturate) 23:41:17 INFO - PROCESS | 1994 | RSS: Main: 340480000 23:41:17 INFO - PROCESS | 1994 | 23:41:20 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49541/tests/kraken/driver.html?testName=json-parse-financial) 23:41:21 INFO - PROCESS | 1994 | RSS: Main: 338882560 23:41:21 INFO - PROCESS | 1994 | 23:41:22 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49541/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:41:23 INFO - PROCESS | 1994 | RSS: Main: 316186624 23:41:23 INFO - PROCESS | 1994 | 23:41:25 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49541/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:41:26 INFO - PROCESS | 1994 | RSS: Main: 318939136 23:41:26 INFO - PROCESS | 1994 | 23:41:28 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49541/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:41:29 INFO - PROCESS | 1994 | RSS: Main: 321441792 23:41:29 INFO - PROCESS | 1994 | 23:41:32 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:41:32 INFO - PROCESS | 1994 | RSS: Main: 329293824 23:41:32 INFO - PROCESS | 1994 | 23:41:35 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:41:36 INFO - PROCESS | 1994 | RSS: Main: 330600448 23:41:36 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:49541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49541/tests/kraken/driver.html?testName=ai-astar) 23:41:38 INFO - PROCESS | 1994 | RSS: Main: 373526528 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | __start_tp_report 23:41:38 INFO - PROCESS | 1994 | _x_x_mozilla_page_load 23:41:38 INFO - PROCESS | 1994 | _x_x_mozilla_page_load_details 23:41:38 INFO - PROCESS | 1994 | |i|pagename|runs| 23:41:38 INFO - PROCESS | 1994 | |0;ai-astar;105;115;114;114;114;115;114;115;113;113 23:41:38 INFO - PROCESS | 1994 | |1;audio-beat-detection;142;107;106;167;106;106;132;106;142;106 23:41:38 INFO - PROCESS | 1994 | |2;audio-dft;183;188;185;182;185;179;182;184;183;186 23:41:38 INFO - PROCESS | 1994 | |3;audio-fft;80;58;64;89;59;58;66;64;84;57 23:41:38 INFO - PROCESS | 1994 | |4;audio-oscillator;81;68;103;70;77;67;95;72;66;101 23:41:38 INFO - PROCESS | 1994 | |5;imaging-gaussian-blur;87;84;87;85;87;84;88;85;87;84 23:41:38 INFO - PROCESS | 1994 | |6;imaging-darkroom;93;94;95;96;93;99;146;147;94;94 23:41:38 INFO - PROCESS | 1994 | |7;imaging-desaturate;86;91;83;85;85;85;87;84;82;92 23:41:38 INFO - PROCESS | 1994 | |8;json-parse-financial;53;51;55;52;51;54;53;52;54;54 23:41:38 INFO - PROCESS | 1994 | |9;json-stringify-tinderbox;66;107;103;113;77;72;72;74;73;74 23:41:38 INFO - PROCESS | 1994 | |10;stanford-crypto-aes;84;87;86;102;105;87;88;88;85;81 23:41:38 INFO - PROCESS | 1994 | |11;stanford-crypto-ccm;138;140;140;147;169;163;140;144;193;166 23:41:38 INFO - PROCESS | 1994 | |12;stanford-crypto-pbkdf2;193;190;192;194;191;203;288;199;192;190 23:41:38 INFO - PROCESS | 1994 | |13;stanford-crypto-sha256-iterative;71;69;70;67;65;70;70;70;69;68 23:41:38 INFO - PROCESS | 1994 | __end_tp_report 23:41:38 INFO - PROCESS | 1994 | __start_cc_report 23:41:38 INFO - PROCESS | 1994 | _x_x_mozilla_cycle_collect,2078 23:41:38 INFO - PROCESS | 1994 | __end_cc_report 23:41:38 INFO - PROCESS | 1994 | __startTimestamp1470984098623__endTimestamp 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | ------- Summary: start ------- 23:41:38 INFO - PROCESS | 1994 | Number of tests: 14 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:2.97 (2.6%) stddev-sans-first:0.78 23:41:38 INFO - PROCESS | 1994 | Values: 105.0 115.0 114.0 114.0 114.0 115.0 114.0 115.0 113.0 113.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:119.50 stddev:22.19 (18.6%) stddev-sans-first:22.32 23:41:38 INFO - PROCESS | 1994 | Values: 142.0 107.0 106.0 167.0 106.0 106.0 132.0 106.0 142.0 106.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:2.50 (1.4%) stddev-sans-first:2.64 23:41:38 INFO - PROCESS | 1994 | Values: 183.0 188.0 185.0 182.0 185.0 179.0 182.0 184.0 183.0 186.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#3] audio-fft Cycles:10 Average:67.90 Median:65.00 stddev:11.92 (18.3%) stddev-sans-first:11.81 23:41:38 INFO - PROCESS | 1994 | Values: 80.0 58.0 64.0 89.0 59.0 58.0 66.0 64.0 84.0 57.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:71.00 stddev:14.45 (20.3%) stddev-sans-first:15.32 23:41:38 INFO - PROCESS | 1994 | Values: 81.0 68.0 103.0 70.0 77.0 67.0 95.0 72.0 66.0 101.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.55 (1.8%) stddev-sans-first:1.58 23:41:38 INFO - PROCESS | 1994 | Values: 87.0 84.0 87.0 85.0 87.0 84.0 88.0 85.0 87.0 84.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#6] imaging-darkroom Cycles:10 Average:105.10 Median:94.00 stddev:21.89 (23.3%) stddev-sans-first:22.78 23:41:38 INFO - PROCESS | 1994 | Values: 93.0 94.0 95.0 96.0 93.0 99.0 146.0 147.0 94.0 94.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:85.50 stddev:3.23 (3.8%) stddev-sans-first:3.43 23:41:38 INFO - PROCESS | 1994 | Values: 86.0 91.0 83.0 85.0 85.0 85.0 87.0 84.0 82.0 92.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.50 stddev:1.37 (2.6%) stddev-sans-first:1.45 23:41:38 INFO - PROCESS | 1994 | Values: 53.0 51.0 55.0 52.0 51.0 54.0 53.0 52.0 54.0 54.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#9] json-stringify-tinderbox Cycles:10 Average:83.10 Median:72.50 stddev:17.34 (23.9%) stddev-sans-first:17.25 23:41:38 INFO - PROCESS | 1994 | Values: 66.0 107.0 103.0 113.0 77.0 72.0 72.0 74.0 73.0 74.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:86.50 stddev:7.80 (9.0%) stddev-sans-first:8.04 23:41:38 INFO - PROCESS | 1994 | Values: 84.0 87.0 86.0 102.0 105.0 87.0 88.0 88.0 85.0 81.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#11] stanford-crypto-ccm Cycles:10 Average:154.00 Median:155.00 stddev:18.15 (11.7%) stddev-sans-first:18.30 23:41:38 INFO - PROCESS | 1994 | Values: 138.0 140.0 140.0 147.0 169.0 163.0 140.0 144.0 193.0 166.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:203.20 Median:193.50 stddev:30.08 (15.5%) stddev-sans-first:31.68 23:41:38 INFO - PROCESS | 1994 | Values: 193.0 190.0 192.0 194.0 191.0 203.0 288.0 199.0 192.0 190.0 23:41:38 INFO - PROCESS | 1994 | 23:41:38 INFO - PROCESS | 1994 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:70.00 stddev:1.79 (2.6%) stddev-sans-first:1.73 23:41:38 INFO - PROCESS | 1994 | Values: 71.0 69.0 70.0 67.0 65.0 70.0 70.0 70.0 69.0 68.0 23:41:38 INFO - PROCESS | 1994 | -------- Summary: end -------- 23:41:38 INFO - PROCESS | 1994 | 23:41:39 INFO - TEST-INFO | 1994: exit 0 23:41:39 INFO - TEST-OK | kraken | took 59936ms 23:41:39 INFO - SUITE-END | took 1177s 23:41:39 INFO - Completed test suite (00:19:37) 23:41:39 INFO - javascript benchmark 23:41:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2683.9194824155275, 3305.603327600687, 3332.1836150143217, 3333.2666813301066, 3385.864565417382, 5518.420565840589, 5582.5254853337465, 5593.720313984305, 5641.0, 5678.57410694198, 4737.313089602014, 5647.237622920905, 5721.485066344028, 5732.684702341369, 5763.9711801440935, 5162.0, 5170.922436163461, 5234.92147617786, 5253.500917412859, 5404.189371594253, 5303.575713942875, 5311.49540793624, 5336.759845806948, 5357.624966252364, 5361.839144825662, 5119.820806271781, 5137.768800403991, 5153.742312884378, 5180.870478238036, 5219.45195754446, 5170.922436163461, 5210.400803907562, 5260.079486089957, 5284.630075894689, 5325.707086110262, 4732.763361831929, 5186.196139598368, 5216.217567364888, 5231.450697676727, 5293.523582877521, 5752.769889204426, 5780.71096445176, 5791.420857914217, 5821.417858214187, 5826.592138550261, 6095.08573713942, 6157.014877619604, 6214.5960512566535, 6221.004639257697, 6262.843428914268, 6207.906881396782, 6275.2783429905685, 6275.780347687809, 6296.685165741695, 6302.40127187921, 5901.822945311647, 5908.468237858528, 5911.55663325248, 5913.733881975321, 5914.994450943393, 6174.660393678301, 6251.812445626639, 6261.812145635638, 6301.527385446018, 6302.905456418157, 6018.277806663228, 6069.431674163202, 6095.177151084636, 6118.1434599156155, 6125.571210015345, 6208.782692605737, 6241.563090583706, 6291.087792270187, 6298.527610429236, 6300.086487459293, 6138.109974053827, 6209.161763161916, 6224.502039836802, 6238.719257633326, 6240.282367527701, 6041.9395806041375, 6135.478484328882, 6172.969135154295, 6232.127502149703, 6241.21984751906, 4655.5102367242835, 4708.976455117702, 5010.799568017239, 5015.172496538104, 5050.469700681376, 3709.9443508347395, 4461.330800379904, 4478.596926276651, 4486.282194848874, 4505.05393867285, 5526.613137080366, 5592.5805564582815, 5694.829155125353, 5710.086386178192, 5718.370979192286, 6195.597286176384, 6256.061590761422, 6298.118263443122, 6298.181236439325, 6342.365763423621, 5648.378678345379, 5659.066254068115, 5661.490465858093, 5667.574931880125, 5693.743781529841, 5245.26566280721, 5431.755570999315, 5442.482964118402, 5455.536279416215, 5457.808976685797, 6202.131701561785, 6230.034344676401, 6239.906401404073, 6245.594036387621, 6247.750089996349, 6227.782027629011, 6257.843553911189, 6265.530085243534, 6278.748850045947, 6296.842578935563, 6311.990081586924, 6341.714622842075, 6348.206474190726, 6363.204599425072, 6376.617402955838, 6034.396560344106, 6090.695465226632, 6108.35862234459, 6134.069235337226, 6180.938190618036, 6223.688815559113, 6259.6870156492905, 6271.059341098689, 6273.37266273369, 6277.2153480814895, 4834.613230941586, 6068.575199736153, 6072.089186622042, 6082.148499210202, 6091.847703807441, 5883.235179426647, 5943.910841337297, 5988.101784732325, 6040.939590604214, 6079.0, 5446.918296225481, 5937.703114844327, 5983.940160598512, 5986.551008674454, 5996.730147143302, 6038.909416358846, 6060.484858787053, 6063.454289114001, 6076.726547305293, 6098.969505152446, 5704.572157088318, 5816.9127463088935, 5887.852803679943, 5892.410758924073, 5906.350301466921], "value": 5671.055701331263, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.8949486365568, 521.6348556010794, 522.9660072095313, 530.7054584705487, 537.8601563593467, 30817.845910770444, 31203.531947020783, 35391.646083539155, 41780.0, 41987.74036778902, 35670.0, 42771.50299739502, 42982.57017429825, 43105.0, 43156.3526547102, 9642.903570964289, 9830.410175389463, 9838.01619838014, 9840.458774767385, 9845.310828242025, 8716.912830871674, 8947.418417802855, 11865.16943813929, 12156.270623762603, 12168.878311216908, 12094.153409261355, 12169.087318451151, 12170.148089633729, 12181.269123852553, 12242.755144897097, 12109.212901161396, 12173.330466824322, 12174.756504869942, 12182.329971851545, 12206.938965305206, 12034.33811140387, 12109.636710898687, 12119.515219391214, 12131.575394861138, 12140.210886292363, 40465.0, 40733.0, 40787.38818917719, 40810.0, 40896.1820763586, 3462.7056700180515, 3652.853885844563, 3656.6160553141804, 3671.7429779915415, 3915.745476544044, 32515.837420812983, 32790.83604581986, 33125.6687433125, 33275.0, 33326.33347333064, 3216.7748257621975, 3263.3473305339026, 3289.786163899339, 3309.189248634076, 3422.5550678411896, 523885.0, 526700.0, 527079.0, 527987.0, 529724.0, 59673.70163149157, 60127.0, 60154.0, 60165.39834601598, 60205.0, 34879.4768078479, 35413.114672132884, 35581.82209088938, 36482.452763208574, 36582.81708591493, 16901.23944422504, 17021.148942552823, 17034.914825425793, 17055.573610659583, 17061.7440738389, 11659.475323610457, 11904.940475297568, 12807.743845123045, 12915.418806153746, 12943.546975855988, 17012.149392530326, 17148.31406743741, 17179.711521635927, 19112.808871911104, 19545.511362216057, 7918.802029949297, 7980.920190798134, 8021.438499304993, 8057.315128214167, 8084.312833409109, 878.6397576993402, 887.9467231966103, 932.3473568502076, 942.7171848445439, 957.8036502516967, 29705.554416683768, 30044.849775750983, 30093.0, 30903.690963090532, 30931.226719331746, 1072.2601405030505, 1185.1407729396292, 1196.9640910772691, 1210.116614871149, 1210.4673943464848, 15530.990485618398, 15819.367225311089, 15842.841571584368, 15993.68012639764, 16119.95690171195, 674402.0, 678791.0, 679696.0, 680177.0, 687598.0, 59727.805443891746, 59829.700851495465, 59922.70038649779, 59978.0, 60000.69999649974, 1269.911106222574, 1316.4470922212693, 1379.7654398752236, 1403.0879928046647, 1404.3680343845106, 29142.27144321409, 29602.851985739933, 29716.405671886874, 30379.2405189872, 30462.933797317874, 50917.74541127271, 51221.97556048933, 51281.48718512916, 51333.48666513287, 51513.484865150866, 575241.0, 577133.1143344257, 577549.0, 578911.0, 580731.0, 24107.879460602584, 24483.755162448146, 26561.46877062409, 26921.86539067292, 26990.460190795682, 42426.1514769709, 48084.557463276156, 48691.269630956274, 49164.26253606127, 49227.75386123046, 36755.26489470249, 37872.24255514929, 39349.0, 39870.40194397145, 40807.591924081564, 39260.21479570335, 39445.60554394419, 40590.0, 40690.1861962765, 40832.38751418672, 39103.41344879886, 39351.01622459347, 40580.0, 41391.58608413998, 41528.377074343305, 32936.0, 34572.13569660779, 34637.82681086579, 35554.46668299926, 36316.370962500856, 24330.07315521589, 25336.98652053971, 25452.0, 26300.605490917267, 27093.72906270912], "value": 20425.0276417315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.31925426164713, 371.25748502993997, 371.61909043230685, 376.73063759412014, 401.5582858855258, 15512.379504819808, 16408.179591020446, 20637.0, 20922.790772092274, 21036.57926841464, 20713.482162945933, 20964.89517552414, 21030.369088927317, 21040.894795526, 21348.99999999996, 5163.251328557357, 5846.970765146169, 5874.9412505874825, 6057.454829065383, 6134.04922237054, 5951.345352011297, 6015.0676645120075, 6049.062395328731, 6064.06007068905, 6086.269647642289, 4156.916861662765, 4358.237308471021, 5257.658252213594, 6645.169353830771, 6734.427573656245, 6454.838629034265, 6689.765858194988, 6690.330966903295, 6695.029220762986, 6717.227518835299, 5790.507806836382, 5836.824895253107, 5849.093390524433, 5851.882962340729, 5866.442687944638, 23589.528209435888, 24010.0, 24554.386140346633, 25172.11897583594, 25971.0, 2384.499255156419, 2390.9282721518384, 2401.3876461502205, 2773.9320361660907, 3029.3789773096464, 8015.0, 10372.481375931173, 10381.013803688638, 10430.68707938763, 10468.42423666698, 1907.523119220195, 1912.9808701912941, 1953.394447721211, 1956.8923709195988, 1966.3904189701238, 102039.97960020379, 108046.45976770144, 108848.0, 109141.45429272803, 110580.0, 10874.728131796768, 11274.605388811353, 11369.658910232707, 11425.485853136628, 11510.654680359603, 14136.787948180785, 14150.86793056553, 14158.867290616727, 14168.716625667636, 14263.572092837232, 8289.129641387688, 8414.6213420395, 8418.705345312885, 8446.915530844613, 8536.8719469208, 8385.874211886827, 8397.370197235232, 8401.03388110375, 8614.44006139599, 8630.26642735362, 4451.688381813242, 4464.129494748493, 4474.597286244189, 4488.910221795546, 4534.841280555164, 1866.7293242479764, 1867.8785878917827, 1893.9526511837314, 1894.128700797621, 1913.933012344589, 857.4340934983006, 867.5358683104508, 909.2589539525266, 935.4013431403907, 944.9086305317369, 20299.391018269474, 20770.130688238132, 20853.270135545183, 20908.0, 21104.804620055987, 892.8169725206317, 937.4515908193783, 941.4915945389413, 973.177664873181, 1024.5645600619855, 8861.0, 10674.839877401846, 11069.72325691848, 11163.0, 11206.607768728218, 510958.0, 545148.0, 579152.0, 583953.0, 599918.0, 76501.61749191218, 126072.1089183663, 127791.0, 129621.0, 130842.0, 937.4234845569925, 951.8572214167792, 971.5676523946776, 974.1281553010016, 977.6578197630772, 13843.930780346034, 18403.0, 18780.624387512446, 18804.529886752392, 19059.14233859452, 54758.45241547534, 54877.90244195174, 55007.0, 55157.06950256722, 55343.44656553544, 61331.693341533006, 74741.0, 79501.0, 79635.60182199052, 80476.19523804921, 6501.869962600627, 6601.669916504252, 6956.0, 8082.555459449787, 8326.542040187605, 10689.9465502672, 12801.167924084904, 13299.135556189203, 13312.733745325233, 13404.061715679809, 11181.664550063511, 11579.88420115788, 11590.42047897585, 11593.478293476644, 11657.825132622847, 10680.0, 10942.124630029419, 11272.887271127513, 11380.487878045342, 11492.770144596894, 9999.600015999278, 10959.671209863716, 11353.205275630957, 11596.710082248012, 11614.954654081173, 7642.8089297768, 7725.884111738441, 7943.046834379911, 8010.919890801018, 8141.9185808141165, 9896.851547226654, 10865.728356791144, 11358.375289359165, 11363.829542557034, 11437.970582647602], "value": 9478.87685630552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.9863801361982, 1498.7377208988423, 1518.8329283778783, 1705.9232334544945, 1899.078946710845, 7925.2867241948215, 8725.127487251271, 8943.150400711922, 8967.01362850086, 9101.044390339019, 8818.338624603148, 8914.643414263437, 8917.33120015998, 8925.419847709894, 8936.374453788238, 2321.117975169433, 2347.8943447544816, 2351.1535847095033, 2355.199232261031, 2356.528694261146, 2293.873836938976, 2327.627579587266, 2353.6351865460797, 2354.1878052072007, 2357.3281614739803, 2280.144945645383, 2287.142321629389, 2296.2766728480474, 2337.1419721321504, 2337.544178885118, 2263.2531264682616, 2274.772522747712, 2276.0, 2276.9203077892275, 2278.0, 2300.0, 2300.643400272944, 2305.2853615379286, 2306.042992158252, 2310.445493081665, 8757.956210218908, 8793.164649358301, 8869.290456763443, 8948.73153805387, 9004.414713043696, 5096.362954630671, 5306.893862122774, 5319.5478384337375, 5330.200469929503, 5335.413104558495, 3573.714102871764, 3589.569251689814, 3657.140571965586, 3658.835352409148, 3672.1003354178397, 1042.8725400183616, 1056.3292309383519, 1061.3950048472375, 1066.9306495077794, 1077.6228320087985, 10065.446400447972, 10927.508262128224, 11108.944455277753, 11997.460114294878, 12029.879701202875, 4334.1981733379425, 4443.422355093817, 4546.477155127202, 4620.768961551909, 4642.187617166982, 9193.218576420946, 9210.263178945668, 9212.309076819265, 9213.401128926598, 9285.25717942563, 5033.245013247969, 5046.167382381939, 5051.974740126349, 5058.46886076964, 5063.594912407072, 4322.459692538433, 4477.776111194427, 4663.930041049387, 4678.157931572349, 4792.616590672737, 3692.3722967095123, 3740.8503659853845, 3814.294355544233, 3853.0560012797046, 3862.439946207784, 981.4994352880083, 1134.2400591603646, 1146.4267866066966, 1167.1538134852333, 1168.6085161471003, 842.2714352085402, 866.7486428935664, 868.9000764912116, 931.5901003558413, 994.7413672445072, 5453.481919217747, 5809.82570522885, 6054.727537260834, 6064.696765161724, 6137.9079313810325, 797.2505844506146, 806.4072906413782, 894.190757364586, 906.4425378392241, 939.9154076133044, 3979.9801000994808, 3984.641382275609, 3985.222881538072, 4125.278076336689, 4137.193247316804, 10649.094826939641, 10881.401522916316, 11005.834912476319, 11040.061594764535, 11054.060404865677, 10935.945320273348, 10940.507677154546, 10942.343459392461, 10944.23390362683, 10944.56221751137, 6829.829254268683, 7834.373250139975, 8240.917590824016, 8361.205685459872, 8361.456505327256, 5784.479396854304, 5977.551683623658, 6144.692765361803, 6162.784302549389, 6190.659513726608, 9692.854607180758, 9939.353941993748, 10109.848352274576, 10120.848187277345, 10144.898551014396, 10276.845847312446, 10325.63860264887, 10344.431056291976, 10351.378917264989, 10352.378857268588, 7015.298470152944, 7235.095613048369, 7249.637518123967, 7649.732259371118, 7787.29914307715, 8142.592870356577, 8228.42401031922, 8392.03491598474, 8489.235968762841, 8542.658293668432, 6432.871342573216, 7390.150132734804, 7520.548767073774, 7641.656125474478, 7689.154193038873, 7398.704051838082, 7402.740904068547, 7419.146798118286, 7467.701291948479, 7571.545707257582, 6968.512204145661, 7121.181064177478, 7131.215566287808, 7133.536320139175, 7137.714491420285, 4920.335754673073, 4985.277134815504, 5005.649604527648, 5041.621878359065, 5116.079105760999, 4848.442429120696, 4996.125678006261, 5007.122329126578, 5182.222666600041, 5192.792288308426], "value": 4542.472606884111, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.64640815001627, 298.79980413123207, 309.82185243485, 313.2622673603665, 316.5046701911508, 5034.244863270511, 5286.474446231902, 5305.840824775263, 5365.041759757684, 5366.919496207555, 5107.719075450848, 5189.325387699603, 5224.92162617561, 5238.292830467895, 5246.711430871301, 4021.6983726220506, 4080.9795951020205, 4082.5917408259234, 4087.9386809197813, 4116.608922152405, 3615.788710781878, 4112.609302116294, 4125.979370103145, 4130.8554200602985, 4135.1936372407245, 3708.4993525873933, 3900.3174444472247, 3942.3100957332495, 3973.582773808752, 4026.3155263605113, 3464.6881780639737, 3965.524137103537, 3990.20195960809, 4002.2795896738576, 4011.4785077939973, 3430.2624935638955, 3438.7764795288476, 3438.8796392126405, 3451.861925522976, 3468.497067925137, 4537.507867211437, 4870.805167793319, 5050.419201791804, 5133.948660513422, 5161.896762064775, 4481.775911204427, 4505.617022553087, 4517.570830771071, 4523.208438523278, 4550.7724613769515, 4510.458744950594, 5471.79620483493, 5476.397596264408, 5477.917831232535, 5478.698671573062, 3795.4876091727815, 3797.145642230476, 3800.20195758891, 3807.5240594925635, 3815.5993620669706, 4482.663800214997, 5442.809501667462, 5748.281464816898, 5787.913181302284, 5848.7075646217945, 3703.685186759156, 3853.8265778040054, 3864.555576108727, 3868.3230434674383, 3872.0, 3907.5701672815967, 3924.8626298080003, 3927.273454410943, 3941.5270167580074, 3956.5449973253444, 3566.4293713006314, 4394.736315820997, 4473.0, 4586.954130458719, 4599.5400459953735, 5115.5396014358885, 5269.814291784318, 5351.591783697352, 5538.972305138448, 5558.583106266965, 1314.547425095275, 1334.733053389326, 1336.3562817734048, 1337.9331033448484, 1340.2963444191878, 723.6200994477836, 753.4198667026359, 769.8575763483661, 801.354909298009, 807.5719868469721, 3664.5785734640326, 3824.0, 4217.493900731932, 4263.4031235627035, 4307.483102027777, 3857.0, 4556.066006468666, 4572.908541829145, 4683.367745354401, 4687.10944920464, 3990.5856956541456, 4131.752094874317, 4193.7693426861815, 4247.851325203603, 4260.893477663083, 2194.452910697954, 2270.92051778187, 2414.9374275318805, 2478.615814548748, 2510.560651885949, 4732.810687572527, 4789.377380940456, 4801.68789028712, 4859.1010663027455, 4886.364772579542, 4108.465899433055, 4257.297545904953, 4761.4524329701835, 4781.545753153515, 4795.657215979531, 4794.633529444091, 4923.556879880684, 4940.011293167582, 5239.607029472729, 5897.882042359214, 5736.311642602747, 5740.3685594585395, 5756.079027355603, 5776.682282474336, 5797.710114494343, 5458.479280863741, 5674.829755107354, 5703.948387612607, 5704.890834495127, 5787.987102257004, 5353.277307563585, 5452.372977107525, 5813.854653633523, 5895.764169433174, 5940.693047529537, 3862.4785653937483, 3872.612738726105, 3886.145048089416, 3906.4140378943384, 3924.6075392460525, 5366.087765080024, 5825.592208545361, 5836.474717275466, 5838.095095260242, 5960.552958528041, 5258.447862974485, 5398.568114550748, 5599.796043850592, 5610.933922554702, 5654.6889921054735, 4474.463064432289, 5090.363704536933, 5490.80782172622, 5563.082091454865, 5597.692126933058, 4584.77076146198, 5189.351331083614, 5265.368155821326, 5482.205080263419, 5486.890262194814, 4342.522322544454, 4657.300085468847, 5488.655279456399, 5557.777688892399, 5605.831825045255, 4522.389477420637, 5438.646487978269, 5447.564194864322, 5448.610604296037, 5478.287822583039], "value": 3914.860585597938, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.6334969165725, 741.8330875552998, 774.9961250193749, 782.2920257167266, 818.7175424478555, 15162.696746065087, 16612.16939153042, 16667.499975000756, 16674.0, 16700.58248543787, 15047.623809404771, 15205.315760790763, 15232.466863659774, 15236.542903712907, 15242.161681107535, 677.2144312597388, 698.9231184569693, 822.4201937633984, 833.5332213960171, 857.3312816003527, 822.6174828704651, 839.8200528257807, 840.2731637133896, 841.7853447370942, 844.9788755281106, 897.4615230861464, 898.8112496375769, 899.4603238057178, 900.4057322167371, 901.4861528928514, 711.2141084102096, 732.6702983657375, 892.9776755581163, 893.6916763716507, 895.4314010603249, 536.0458384076351, 537.5780012690019, 538.8437353167577, 649.1690635985946, 650.6779144323543, 12667.30329831859, 15439.922800385926, 15446.150461724601, 15449.5365139046, 15452.768208476882, 13737.587872363845, 13935.442582296697, 14268.357923893345, 14301.284935753274, 14421.278936053155, 12716.936415317865, 12837.614871553867, 12862.614121576367, 12929.418176182095, 13047.934760326138, 4216.7259128156575, 4547.18150732868, 4702.741349225791, 4730.8344207952905, 4778.737169455679, 108876.0, 112493.87506124916, 113262.0, 113363.43318283439, 113584.0, 10841.49255071343, 11010.889891100986, 11068.501917413574, 11179.552817887356, 11541.711457213469, 22258.109675612795, 22283.10867565279, 22283.665745013837, 22296.996635151456, 22320.330390088322, 7909.762707118795, 7966.402519811038, 8010.399220058519, 8242.29940455068, 8250.669973201126, 4370.781460926941, 4386.539413361615, 4430.778461076998, 4509.278515437514, 4601.987562736193, 3038.5442183672185, 3360.2103505676146, 3426.2462258303135, 3436.9828150859585, 3475.2701932594437, 625.9092431597484, 628.6228263042138, 634.2864277687602, 634.7365843175123, 651.371426573359, 507.41647105828594, 539.2962184349461, 560.8177342363748, 627.7896904537031, 651.3811878715239, 6956.339147780953, 8689.826203475895, 9046.728598142066, 9129.863052054225, 9562.665306714232, 598.1804927249609, 632.4023797511308, 636.6625688385163, 644.3009334871623, 644.3298969072206, 4226.704130710821, 4334.176506463762, 4434.977825110854, 4478.7760611969925, 4492.505033932421, 88580.5570972141, 120383.39808300903, 127778.0, 144392.27803860913, 147476.0, 114915.0, 115917.42041289908, 117056.8294317046, 119467.0, 122006.0, 119086.0, 120518.0, 123273.0, 123455.0, 123620.2913912584, 8401.873971890549, 8552.657893684433, 8552.828943421222, 8570.26444194882, 8726.781830454289, 41751.0, 65442.8997020854, 65963.0, 68377.65811170913, 68573.48551887563, 87164.0, 95284.0, 99301.50349248208, 100045.49977250067, 102829.48585257026, 11728.237664552118, 11787.823182652095, 11870.465829037541, 12213.511459541518, 12266.509339626315, 12221.572244971383, 12335.568255111028, 12345.074119440898, 12428.62714118578, 12443.626691199279, 11915.76168476643, 11917.165798394375, 11985.64043078709, 12080.939595301967, 12189.878101218874, 11624.593139240085, 11685.182037257311, 11880.217462345297, 11906.0, 12375.319357435428, 10176.135028522362, 11800.763984720086, 12098.879011210127, 12329.630111096682, 12343.19769214998, 9487.146156845916, 9709.6601618943, 9720.368176068532, 9925.699278919123, 10205.336653117523, 9118.452892826452, 9920.107190352903, 9958.502074896081, 9968.072726549333, 10071.34536255141], "value": 7570.794172623621, "unit": "score"}], "name": "dromaeo_css", "value": 7271.6078812680225, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 107.0, 106.0, 167.0, 106.0, 106.0, 132.0, 106.0, 142.0, 106.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 188.0, 185.0, 182.0, 185.0, 179.0, 182.0, 184.0, 183.0, 186.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 64.0, 89.0, 59.0, 58.0, 66.0, 64.0, 84.0, 57.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 68.0, 103.0, 70.0, 77.0, 67.0, 95.0, 72.0, 66.0, 101.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 87.0, 84.0, 88.0, 85.0, 87.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 96.0, 93.0, 99.0, 146.0, 147.0, 94.0, 94.0], "value": 105.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 83.0, 85.0, 85.0, 85.0, 87.0, 84.0, 82.0, 92.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 55.0, 52.0, 51.0, 54.0, 53.0, 52.0, 54.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 107.0, 103.0, 113.0, 77.0, 72.0, 72.0, 74.0, 73.0, 74.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 86.0, 102.0, 105.0, 87.0, 88.0, 88.0, 85.0, 81.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 140.0, 147.0, 169.0, 163.0, 140.0, 144.0, 193.0, 166.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 190.0, 192.0, 194.0, 191.0, 203.0, 288.0, 199.0, 192.0, 190.0], "value": 203.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 67.0, 65.0, 70.0, 70.0, 70.0, 69.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1495.1000000000001, "alertThreshold": 2.0}]} 23:41:39 INFO - Return code: 0 23:41:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:41:39 INFO - # TBPL SUCCESS # 23:41:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:41:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:41:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:41:39 INFO - 2016-08-11 23:41:39.926 screenresolution[1998:17662] starting screenresolution argv=screenresolution get 23:41:39 INFO - 2016-08-11 23:41:39.929 screenresolution[1998:17662] Display 0: 1600x1200x32@60 23:41:39 INFO - 2016-08-11 23:41:39.935 screenresolution[1999:17665] starting screenresolution argv=screenresolution list 23:41:39 INFO - Available Modes on Display 0 23:41:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:41:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:41:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:41:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:41:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:41:40 INFO - Intel Iris: 23:41:40 INFO - Chipset Model: Intel Iris 23:41:40 INFO - Type: GPU 23:41:40 INFO - Bus: Built-In 23:41:40 INFO - VRAM (Dynamic, Max): 1536 MB 23:41:40 INFO - Vendor: Intel (0x8086) 23:41:40 INFO - Device ID: 0x0a2e 23:41:40 INFO - Revision ID: 0x0009 23:41:40 INFO - Displays: 23:41:40 INFO - Display: 23:41:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:41:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:41:40 INFO - Display Serial Number: 1600x1200 60 23:41:40 INFO - Main Display: Yes 23:41:40 INFO - Mirror: Off 23:41:40 INFO - Online: Yes 23:41:40 INFO - Rotation: Supported 23:41:40 INFO - Return code: 0 23:41:40 INFO - Running post-action listener: _resource_record_post_action 23:41:40 INFO - [mozharness: 2016-08-12 06:41:40.187590Z] Finished run-tests step (success) 23:41:40 INFO - Running post-run listener: _resource_record_post_run 23:41:40 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 2469888; Write bytes: 705232896; Read time: 15; Write time: 1998 23:41:40 INFO - TinderboxPrint: CPU usage
53.5% 23:41:40 INFO - TinderboxPrint: I/O read bytes / time
2,469,888 / 15 23:41:40 INFO - TinderboxPrint: I/O write bytes / time
705,232,896 / 1,998 23:41:40 INFO - TinderboxPrint: CPU idle
2,256.0 (46.5%) 23:41:40 INFO - TinderboxPrint: CPU system
973.5 (20.1%) 23:41:40 INFO - TinderboxPrint: CPU user
1,620.1 (33.4%) 23:41:40 INFO - TinderboxPrint: Swap in / out
406,089,728 / 0 23:41:40 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395149824; Write bytes: 388978176; Read time: 29396; Write time: 666 23:41:40 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 2469888; Write bytes: 295223808; Read time: 15; Write time: 1247 23:41:40 INFO - Running post-run listener: _upload_blobber_files 23:41:40 INFO - Blob upload gear active. 23:41:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:41:40 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 23:41:40 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'] 23:41:40 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 23:41:41 INFO - (blobuploader) - INFO - Open directory for files ... 23:41:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:41:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:41:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:41:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:41:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:41:42 INFO - (blobuploader) - INFO - Done attempting. 23:41:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:41:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:41:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:41:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:41:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:41:42 INFO - (blobuploader) - INFO - Done attempting. 23:41:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:41:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:41:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:41:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:41:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:41:45 INFO - (blobuploader) - INFO - Done attempting. 23:41:45 INFO - (blobuploader) - INFO - Iteration through files over. 23:41:45 INFO - Return code: 0 23:41:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:41:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:41:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15bea43c129442736bd1ce46b0ab3f5d73148b65a84a98cea5661d07892cccbf586319ca8b8affaa5aa3ce8793ea1ad52fbee506ccc14b98b2674c665177116d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adebe9f0144466049813e9eb3669977220d52b4690c41801c4bcdd8fe2f63dfb6aa7f08319f01580f7bb26954f2a03304d7134f4f3fa645921533ef7f61a5d75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74901f4948849b052e63f8760ede8beb0a3be9c68c0b993634d89da781befc709578b0c6a2ec04e57614b00a0ac170e4ef9a0b57798c8ffb8347cff961dcfad5"} 23:41:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:41:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:41:45 INFO - Contents: 23:41:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15bea43c129442736bd1ce46b0ab3f5d73148b65a84a98cea5661d07892cccbf586319ca8b8affaa5aa3ce8793ea1ad52fbee506ccc14b98b2674c665177116d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adebe9f0144466049813e9eb3669977220d52b4690c41801c4bcdd8fe2f63dfb6aa7f08319f01580f7bb26954f2a03304d7134f4f3fa645921533ef7f61a5d75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74901f4948849b052e63f8760ede8beb0a3be9c68c0b993634d89da781befc709578b0c6a2ec04e57614b00a0ac170e4ef9a0b57798c8ffb8347cff961dcfad5"} 23:41:45 INFO - Running post-run listener: copy_logs_to_upload_dir 23:41:45 INFO - Copying logs to upload dir... 23:41:45 INFO - mkdir: /builds/slave/test/build/upload/logs 23:41:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.290651 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-11 23:41:45.234745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 23:41:45.240317) ========= 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.izyy2CVY2x/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.gy54WY6khF/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/15bea43c129442736bd1ce46b0ab3f5d73148b65a84a98cea5661d07892cccbf586319ca8b8affaa5aa3ce8793ea1ad52fbee506ccc14b98b2674c665177116d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adebe9f0144466049813e9eb3669977220d52b4690c41801c4bcdd8fe2f63dfb6aa7f08319f01580f7bb26954f2a03304d7134f4f3fa645921533ef7f61a5d75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74901f4948849b052e63f8760ede8beb0a3be9c68c0b993634d89da781befc709578b0c6a2ec04e57614b00a0ac170e4ef9a0b57798c8ffb8347cff961dcfad5"} build_url:https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/EzZy0FeITlm9zePyasmb5A/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/15bea43c129442736bd1ce46b0ab3f5d73148b65a84a98cea5661d07892cccbf586319ca8b8affaa5aa3ce8793ea1ad52fbee506ccc14b98b2674c665177116d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adebe9f0144466049813e9eb3669977220d52b4690c41801c4bcdd8fe2f63dfb6aa7f08319f01580f7bb26954f2a03304d7134f4f3fa645921533ef7f61a5d75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74901f4948849b052e63f8760ede8beb0a3be9c68c0b993634d89da781befc709578b0c6a2ec04e57614b00a0ac170e4ef9a0b57798c8ffb8347cff961dcfad5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 23:41:45.275152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:41:45.276116) ========= 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.izyy2CVY2x/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.gy54WY6khF/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005085 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:41:45.324104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 23:41:45.324404) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 23:41:45.324817) ========= ========= Total master_lag: 0.18 =========