builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0268 starttime: 1470836933.87 results: success (0) buildid: 20160810055414 builduid: 3fca104e23644e8e8297d21637338d52 revision: c2463be000652c901f160910b4075d081b6c664f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:53.866094) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:53.866577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:53.866867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:53.894054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:53.894395) ========= 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.6YMB8W5u3O/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.E3sToBV0nA/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-10 06:48:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.63M=0.001s 2016-08-10 06:48:54 (8.63 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:54.049272) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:54.049577) ========= 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.6YMB8W5u3O/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.E3sToBV0nA/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.026534 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:54.100743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-10 06:48:54.104125) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c2463be000652c901f160910b4075d081b6c664f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev c2463be000652c901f160910b4075d081b6c664f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6YMB8W5u3O/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.E3sToBV0nA/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-10 06:48:54,189 truncating revision to first 12 chars 2016-08-10 06:48:54,189 Setting DEBUG logging. 2016-08-10 06:48:54,190 attempt 1/10 2016-08-10 06:48:54,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c2463be00065?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 06:48:55,975 unpacking tar archive at: autoland-c2463be00065/testing/mozharness/ program finished with exit code 0 elapsedTime=2.060736 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-10 06:48:56.189975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:56.190402) ========= script_repo_revision: c2463be000652c901f160910b4075d081b6c664f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:56.190852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:56.191122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 06:48:56.210615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-10 06:48:56.211027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6YMB8W5u3O/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.E3sToBV0nA/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:48:56 INFO - MultiFileLogger online at 20160810 06:48:56 in /builds/slave/test 06:48:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 06:48:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:48:56 INFO - {'append_to_log': False, 06:48:56 INFO - 'base_work_dir': '/builds/slave/test', 06:48:56 INFO - 'blob_upload_branch': 'Autoland', 06:48:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:48:56 INFO - 'branch': 'Autoland', 06:48:56 INFO - 'buildbot_json_path': 'buildprops.json', 06:48:56 INFO - 'config_files': ('talos/mac_config.py',), 06:48:56 INFO - 'default_actions': ('clobber', 06:48:56 INFO - 'read-buildbot-config', 06:48:56 INFO - 'download-and-extract', 06:48:56 INFO - 'populate-webroot', 06:48:56 INFO - 'create-virtualenv', 06:48:56 INFO - 'install', 06:48:56 INFO - 'run-tests'), 06:48:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:48:56 INFO - 'download_minidump_stackwalk': True, 06:48:56 INFO - 'download_symbols': 'ondemand', 06:48:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:48:56 INFO - 'tooltool.py': '/tools/tooltool.py', 06:48:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:48:56 INFO - '/tools/misc-python/virtualenv.py')}, 06:48:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:48:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:48:56 INFO - 'installer_path': 'installer.exe', 06:48:56 INFO - 'log_level': 'info', 06:48:56 INFO - 'log_name': 'talos', 06:48:56 INFO - 'log_to_console': True, 06:48:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:48:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:48:56 INFO - 'opt_config_files': (), 06:48:56 INFO - 'pip_index': False, 06:48:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:48:56 INFO - 'cmd': ('bash', 06:48:56 INFO - '-c', 06:48:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:48:56 INFO - 'enabled': True, 06:48:56 INFO - 'halt_on_failure': False, 06:48:56 INFO - 'name': 'check_screen_resolution'},), 06:48:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:48:56 INFO - 'cmd': ('bash', 06:48:56 INFO - '-c', 06:48:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:48:56 INFO - 'enabled': True, 06:48:56 INFO - 'halt_on_failure': False, 06:48:56 INFO - 'name': 'check_screen_resolution'},), 06:48:56 INFO - 'run_cmd_checks_enabled': True, 06:48:56 INFO - 'sps_profile': False, 06:48:56 INFO - 'sps_profile_interval': 0, 06:48:56 INFO - 'suite': 'dromaeojs', 06:48:56 INFO - 'system_bits': '32', 06:48:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:48:56 INFO - 'title': 't-yosemite-r7-0268', 06:48:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:48:56 INFO - 'use_talos_json': True, 06:48:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:48:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:48:56 INFO - 'work_dir': 'build'} 06:48:56 INFO - [mozharness: 2016-08-10 13:48:56.422910Z] Running clobber step. 06:48:56 INFO - Running pre-action listener: _resource_record_pre_action 06:48:56 INFO - Running main action method: clobber 06:48:56 INFO - rmtree: /builds/slave/test/build 06:48:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:48:58 INFO - Running post-action listener: _resource_record_post_action 06:48:58 INFO - [mozharness: 2016-08-10 13:48:58.475659Z] Finished clobber step (success) 06:48:58 INFO - [mozharness: 2016-08-10 13:48:58.475784Z] Running read-buildbot-config step. 06:48:58 INFO - Running pre-action listener: _resource_record_pre_action 06:48:58 INFO - Running main action method: read_buildbot_config 06:48:58 INFO - Using buildbot properties: 06:48:58 INFO - { 06:48:58 INFO - "project": "", 06:48:58 INFO - "product": "firefox", 06:48:58 INFO - "script_repo_revision": "production", 06:48:58 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 06:48:58 INFO - "repository": "", 06:48:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 06:48:58 INFO - "buildid": "20160810055414", 06:48:58 INFO - "pgo_build": "False", 06:48:58 INFO - "basedir": "/builds/slave/test", 06:48:58 INFO - "buildnumber": 125, 06:48:58 INFO - "slavename": "t-yosemite-r7-0268", 06:48:58 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:48:58 INFO - "platform": "yosemite_r7", 06:48:58 INFO - "scheduler": "tests-autoland-macosx64-talos", 06:48:58 INFO - "branch": "autoland", 06:48:58 INFO - "repo_path": "integration/autoland", 06:48:58 INFO - "revision": "c2463be000652c901f160910b4075d081b6c664f", 06:48:58 INFO - "stage_platform": "macosx64", 06:48:58 INFO - "builduid": "3fca104e23644e8e8297d21637338d52", 06:48:58 INFO - "slavebuilddir": "test" 06:48:58 INFO - } 06:48:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 06:48:58 INFO - Running post-action listener: _resource_record_post_action 06:48:58 INFO - [mozharness: 2016-08-10 13:48:58.479031Z] Finished read-buildbot-config step (success) 06:48:58 INFO - [mozharness: 2016-08-10 13:48:58.479152Z] Running download-and-extract step. 06:48:58 INFO - Running pre-action listener: _resource_record_pre_action 06:48:58 INFO - Running main action method: download_and_extract 06:48:58 INFO - mkdir: /builds/slave/test/build/tests 06:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:58 INFO - trying https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 06:48:58 INFO - Downloading https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/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 06:48:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/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 06:48:59 INFO - Downloaded 1199 bytes. 06:48:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:48:59 INFO - Using the following test package requirements: 06:48:59 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:48:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:48:59 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 06:48:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:48:59 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 06:48:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:48:59 INFO - u'jsshell-mac.zip'], 06:48:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:48:59 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 06:48:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:48:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:48:59 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 06:48:59 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:48:59 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 06:48:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:48:59 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 06:48:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:48:59 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 06:48:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:48:59 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')]} 06:48:59 INFO - trying https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:48:59 INFO - Downloading https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/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 06:48:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/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 06:49:00 INFO - Downloaded 16326335 bytes. 06:49:00 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'] 06:49:00 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 06:49:03 INFO - Return code: 0 06:49:03 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 06:49:03 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')]} 06:49:03 INFO - trying https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:49:03 INFO - Downloading https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/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 06:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/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 06:49:04 INFO - Downloaded 16326335 bytes. 06:49:04 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'] 06:49:04 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 06:49:08 INFO - Return code: 0 06:49: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')]} 06:49:08 INFO - trying https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:49:08 INFO - Downloading https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/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 06:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/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 06:49:08 INFO - Downloaded 14413723 bytes. 06:49:08 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'] 06:49:08 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 06:49:09 INFO - Return code: 0 06:49:09 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')]} 06:49:09 INFO - trying https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:49:09 INFO - Downloading https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 06:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/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 06:49:12 INFO - Downloaded 110937193 bytes. 06:49:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:49:12 INFO - mkdir: /builds/slave/test/properties 06:49:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:49:12 INFO - Writing to file /builds/slave/test/properties/build_url 06:49:12 INFO - Contents: 06:49:12 INFO - build_url:https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:49:13 INFO - Running post-action listener: _resource_record_post_action 06:49:13 INFO - Running post-action listener: set_extra_try_arguments 06:49:13 INFO - [mozharness: 2016-08-10 13:49:13.275731Z] Finished download-and-extract step (success) 06:49:13 INFO - [mozharness: 2016-08-10 13:49:13.275866Z] Running populate-webroot step. 06:49:13 INFO - Running pre-action listener: _resource_record_pre_action 06:49:13 INFO - Running main action method: populate_webroot 06:49:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:13 INFO - '--tppagecycles', 06:49:13 INFO - '7'], 06:49:13 INFO - 'tests': ['tsvgm']}}, 06:49:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:49:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:49:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:49:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:13 INFO - 'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:13 INFO - 'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['damp', 'tps']}, 06:49:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:13 INFO - 'tests': ['damp', 'tps']}, 06:49:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['dromaeo_dom']}, 06:49:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['basic_compositor_video']}, 06:49:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:49:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['a11yr', 06:49:13 INFO - 'ts_paint', 06:49:13 INFO - 'tpaint', 06:49:13 INFO - 'sessionrestore', 06:49:13 INFO - 'sessionrestore_no_auto_restore', 06:49:13 INFO - 'tabpaint']}, 06:49:13 INFO - 'other-e10s': {'tests': ['a11yr', 06:49:13 INFO - 'ts_paint', 06:49:13 INFO - 'tpaint', 06:49:13 INFO - 'sessionrestore', 06:49:13 INFO - 'sessionrestore_no_auto_restore', 06:49:13 INFO - 'tabpaint']}, 06:49:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:49:13 INFO - 'ts_paint', 06:49:13 INFO - 'tpaint', 06:49:13 INFO - 'sessionrestore', 06:49:13 INFO - 'sessionrestore_no_auto_restore', 06:49:13 INFO - 'tabpaint']}, 06:49:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:49:13 INFO - 'ts_paint', 06:49:13 INFO - 'tpaint', 06:49:13 INFO - 'sessionrestore', 06:49:13 INFO - 'sessionrestore_no_auto_restore', 06:49:13 INFO - 'tabpaint']}, 06:49:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['a11yr', 06:49:13 INFO - 'ts_paint', 06:49:13 INFO - 'tpaint', 06:49:13 INFO - 'sessionrestore', 06:49:13 INFO - 'sessionrestore_no_auto_restore', 06:49:13 INFO - 'tabpaint']}, 06:49:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['a11yr', 06:49:13 INFO - 'ts_paint', 06:49:13 INFO - 'tpaint', 06:49:13 INFO - 'sessionrestore', 06:49:13 INFO - 'sessionrestore_no_auto_restore', 06:49:13 INFO - 'tabpaint']}, 06:49:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['tsvgx', 06:49:13 INFO - 'tsvgr_opacity', 06:49:13 INFO - 'tart', 06:49:13 INFO - 'tscrollx', 06:49:13 INFO - 'cart']}, 06:49:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:49:13 INFO - 'tsvgr_opacity', 06:49:13 INFO - 'tart', 06:49:13 INFO - 'tscrollx', 06:49:13 INFO - 'cart']}, 06:49:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:13 INFO - 'talos_options': ['--disable-e10s'], 06:49:13 INFO - 'tests': ['tp5o']}, 06:49:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:13 INFO - 'tests': ['tp5o']}, 06:49:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:13 INFO - 'talos_options': ['--disable-e10s', 06:49:13 INFO - '--xperf_path', 06:49:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:13 INFO - 'tests': ['tp5n']}, 06:49:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:13 INFO - 'talos_options': ['--xperf_path', 06:49:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:13 INFO - 'tests': ['tp5n']}}, 06:49:13 INFO - 'talos.zip': {'path': '', 06:49:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:13 INFO - Running post-action listener: _resource_record_post_action 06:49:13 INFO - [mozharness: 2016-08-10 13:49:13.294810Z] Finished populate-webroot step (success) 06:49:13 INFO - [mozharness: 2016-08-10 13:49:13.294932Z] Running create-virtualenv step. 06:49:13 INFO - Running pre-action listener: _resource_record_pre_action 06:49:13 INFO - Running main action method: create_virtualenv 06:49:13 INFO - Creating virtualenv /builds/slave/test/build/venv 06:49:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:49:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:49:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:13 INFO - Using real prefix '/tools/python27' 06:49:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:49:14 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:16 INFO - Installing pip.................done. 06:49:16 INFO - Return code: 0 06:49:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:49: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')]} 06:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:16 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 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:16 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 06:49:16 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 06:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:16 INFO - 'HOME': '/Users/cltbld', 06:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:16 INFO - 'LOGNAME': 'cltbld', 06:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:16 INFO - 'MOZ_NO_REMOTE': '1', 06:49:16 INFO - 'NO_EM_RESTART': '1', 06:49:16 INFO - 'PAGER': '/bin/cat', 06:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:16 INFO - 'PWD': '/builds/slave/test', 06:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:16 INFO - 'SHELL': '/bin/bash', 06:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:16 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:16 INFO - 'USER': 'cltbld', 06:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:16 INFO - 'XPC_FLAGS': '0x0', 06:49:16 INFO - 'XPC_SERVICE_NAME': '0', 06:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:49:17 INFO - Cleaning up... 06:49:17 INFO - Return code: 0 06:49:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:49:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:17 INFO - 'HOME': '/Users/cltbld', 06:49:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:17 INFO - 'LOGNAME': 'cltbld', 06:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:17 INFO - 'MOZ_NO_REMOTE': '1', 06:49:17 INFO - 'NO_EM_RESTART': '1', 06:49:17 INFO - 'PAGER': '/bin/cat', 06:49:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:17 INFO - 'PWD': '/builds/slave/test', 06:49:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:17 INFO - 'SHELL': '/bin/bash', 06:49:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:17 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:17 INFO - 'USER': 'cltbld', 06:49:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:17 INFO - 'XPC_FLAGS': '0x0', 06:49:17 INFO - 'XPC_SERVICE_NAME': '0', 06:49:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:17 INFO - Downloading/unpacking psutil>=3.1.1 06:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:49:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:20 INFO - Installing collected packages: psutil 06:49:20 INFO - Running setup.py install for psutil 06:49:20 INFO - building 'psutil._psutil_osx' extension 06:49:20 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 06:49:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:49:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:49:21 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 06:49:21 INFO - building 'psutil._psutil_posix' extension 06:49:21 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 06:49:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:49:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:49:21 INFO - ^ 06:49:21 INFO - 1 warning generated. 06:49:21 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 06:49:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:21 INFO - Successfully installed psutil 06:49:21 INFO - Cleaning up... 06:49:22 INFO - Return code: 0 06:49:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:49:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:22 INFO - 'HOME': '/Users/cltbld', 06:49:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:22 INFO - 'LOGNAME': 'cltbld', 06:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:22 INFO - 'MOZ_NO_REMOTE': '1', 06:49:22 INFO - 'NO_EM_RESTART': '1', 06:49:22 INFO - 'PAGER': '/bin/cat', 06:49:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:22 INFO - 'PWD': '/builds/slave/test', 06:49:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:22 INFO - 'SHELL': '/bin/bash', 06:49:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:22 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:22 INFO - 'USER': 'cltbld', 06:49:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:22 INFO - 'XPC_FLAGS': '0x0', 06:49:22 INFO - 'XPC_SERVICE_NAME': '0', 06:49:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:49:24 INFO - Installing collected packages: mozsystemmonitor 06:49:24 INFO - Running setup.py install for mozsystemmonitor 06:49:24 INFO - Successfully installed mozsystemmonitor 06:49:24 INFO - Cleaning up... 06:49:25 INFO - Return code: 0 06:49:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:25 INFO - 'HOME': '/Users/cltbld', 06:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:25 INFO - 'LOGNAME': 'cltbld', 06:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:25 INFO - 'MOZ_NO_REMOTE': '1', 06:49:25 INFO - 'NO_EM_RESTART': '1', 06:49:25 INFO - 'PAGER': '/bin/cat', 06:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:25 INFO - 'PWD': '/builds/slave/test', 06:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:25 INFO - 'SHELL': '/bin/bash', 06:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:25 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:25 INFO - 'USER': 'cltbld', 06:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:25 INFO - 'XPC_FLAGS': '0x0', 06:49:25 INFO - 'XPC_SERVICE_NAME': '0', 06:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:25 INFO - Downloading/unpacking jsonschema==2.5.1 06:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:49:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:49:27 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 06:49:27 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 06:49:27 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 06:49:27 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 06:49:27 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 06:49:27 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 06:49:28 INFO - Downloading functools32-3.2.3-2.tar.gz 06:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:49:28 INFO - warning: no files found matching '*.txt' 06:49:28 INFO - no previously-included directories found matching 'build' 06:49:28 INFO - no previously-included directories found matching 'dist' 06:49:28 INFO - no previously-included directories found matching '.git*' 06:49:28 INFO - Installing collected packages: jsonschema, functools32 06:49:28 INFO - Running setup.py install for functools32 06:49:28 INFO - warning: no files found matching '*.txt' 06:49:28 INFO - no previously-included directories found matching 'build' 06:49:28 INFO - no previously-included directories found matching 'dist' 06:49:28 INFO - no previously-included directories found matching '.git*' 06:49:28 INFO - Successfully installed jsonschema functools32 06:49:28 INFO - Cleaning up... 06:49:28 INFO - Return code: 0 06:49:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:49:28 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')]} 06:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:28 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')]} 06:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:28 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 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:28 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 06:49:28 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 06:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:28 INFO - 'HOME': '/Users/cltbld', 06:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:28 INFO - 'LOGNAME': 'cltbld', 06:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:28 INFO - 'MOZ_NO_REMOTE': '1', 06:49:28 INFO - 'NO_EM_RESTART': '1', 06:49:28 INFO - 'PAGER': '/bin/cat', 06:49:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:28 INFO - 'PWD': '/builds/slave/test', 06:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:28 INFO - 'SHELL': '/bin/bash', 06:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:28 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:28 INFO - 'USER': 'cltbld', 06:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:28 INFO - 'XPC_FLAGS': '0x0', 06:49:28 INFO - 'XPC_SERVICE_NAME': '0', 06:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:49:28 INFO - Cleaning up... 06:49:28 INFO - Return code: 0 06:49:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:49:28 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')]} 06:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:28 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')]} 06:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:28 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 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:28 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 06:49:28 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 06:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:28 INFO - 'HOME': '/Users/cltbld', 06:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:28 INFO - 'LOGNAME': 'cltbld', 06:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:28 INFO - 'MOZ_NO_REMOTE': '1', 06:49:28 INFO - 'NO_EM_RESTART': '1', 06:49:28 INFO - 'PAGER': '/bin/cat', 06:49:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:28 INFO - 'PWD': '/builds/slave/test', 06:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:28 INFO - 'SHELL': '/bin/bash', 06:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:28 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:28 INFO - 'USER': 'cltbld', 06:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:28 INFO - 'XPC_FLAGS': '0x0', 06:49:28 INFO - 'XPC_SERVICE_NAME': '0', 06:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:29 INFO - Downloading/unpacking blobuploader==1.2.4 06:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:31 INFO - Downloading blobuploader-1.2.4.tar.gz 06:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:49:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:49:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:32 INFO - Downloading docopt-0.6.1.tar.gz 06:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:49:32 INFO - Installing collected packages: blobuploader, requests, docopt 06:49:32 INFO - Running setup.py install for blobuploader 06:49:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:49:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:49:33 INFO - Running setup.py install for requests 06:49:33 INFO - Running setup.py install for docopt 06:49:33 INFO - Successfully installed blobuploader requests docopt 06:49:33 INFO - Cleaning up... 06:49:33 INFO - Return code: 0 06:49:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:33 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')]} 06:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:33 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')]} 06:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:33 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 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:33 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 06:49:33 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 06:49:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:33 INFO - 'HOME': '/Users/cltbld', 06:49:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:33 INFO - 'LOGNAME': 'cltbld', 06:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:33 INFO - 'MOZ_NO_REMOTE': '1', 06:49:33 INFO - 'NO_EM_RESTART': '1', 06:49:33 INFO - 'PAGER': '/bin/cat', 06:49:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:33 INFO - 'PWD': '/builds/slave/test', 06:49:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:33 INFO - 'SHELL': '/bin/bash', 06:49:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:33 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:33 INFO - 'USER': 'cltbld', 06:49:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:33 INFO - 'XPC_FLAGS': '0x0', 06:49:33 INFO - 'XPC_SERVICE_NAME': '0', 06:49:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-dVsHse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-DvztB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-4AgIoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-rANhYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-eUFuE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-trubTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-TznNkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-tH35u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-p3Au7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:49:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-OhxLSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:49:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-VeeRuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:49:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-nqbBJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:49:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-FaM3IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:49:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-AqLW7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-cQO_6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:49:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-ldSTUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:49:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-AfwOeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:49:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:49:35 INFO - Running setup.py install for manifestparser 06:49:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:49:35 INFO - Running setup.py install for mozcrash 06:49:36 INFO - Running setup.py install for mozdebug 06:49:36 INFO - Running setup.py install for mozdevice 06:49:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:49:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:49:36 INFO - Running setup.py install for mozfile 06:49:36 INFO - Running setup.py install for mozhttpd 06:49:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:49:36 INFO - Running setup.py install for mozinfo 06:49:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:49:36 INFO - Running setup.py install for mozInstall 06:49:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:49:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:49:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:49:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:49:36 INFO - Running setup.py install for mozleak 06:49:37 INFO - Running setup.py install for mozlog 06:49:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:49:37 INFO - Running setup.py install for moznetwork 06:49:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:49:37 INFO - Running setup.py install for mozprocess 06:49:37 INFO - Running setup.py install for mozprofile 06:49:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:49:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:49:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:49:37 INFO - Running setup.py install for mozrunner 06:49:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:49:37 INFO - Running setup.py install for mozscreenshot 06:49:38 INFO - Running setup.py install for moztest 06:49:38 INFO - Running setup.py install for mozversion 06:49:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:49:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:49:38 INFO - Cleaning up... 06:49:38 INFO - Return code: 0 06:49:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:38 INFO - 'HOME': '/Users/cltbld', 06:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:38 INFO - 'LOGNAME': 'cltbld', 06:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:38 INFO - 'MOZ_NO_REMOTE': '1', 06:49:38 INFO - 'NO_EM_RESTART': '1', 06:49:38 INFO - 'PAGER': '/bin/cat', 06:49:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:38 INFO - 'PWD': '/builds/slave/test', 06:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:38 INFO - 'SHELL': '/bin/bash', 06:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:38 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:38 INFO - 'USER': 'cltbld', 06:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:38 INFO - 'XPC_FLAGS': '0x0', 06:49:38 INFO - 'XPC_SERVICE_NAME': '0', 06:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:49:38 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-6iRcs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:49:38 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)) 06:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:49:38 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-tX1aMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:49:38 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)) 06:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:49:38 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-B0Onan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:49:38 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)) 06:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:49:38 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-CIo7Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:49:39 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-qinnfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:49:39 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-sQz3wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:49:39 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-eUl5cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:49:39 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-jgT0Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:49:39 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Xfkabm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:49:39 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-_OuOiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:49:39 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)) 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:49:39 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Ul0xpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:49:39 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)) 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:49:39 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-pucMxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:49:39 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)) 06:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:49:39 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-UmHuYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:49:40 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-jwSX7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:40 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-zfqgbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:49:40 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-RcHjdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:49:40 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-UHiAuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:49:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:42 INFO - Downloading blessings-1.6.tar.gz 06:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:49:42 INFO - Installing collected packages: blessings 06:49:42 INFO - Running setup.py install for blessings 06:49:43 INFO - Successfully installed blessings 06:49:43 INFO - Cleaning up... 06:49:43 INFO - Return code: 0 06:49:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:49:43 INFO - Reading from file tmpfile_stdout 06:49:43 INFO - Current package versions: 06:49:43 INFO - blessings == 1.6 06:49:43 INFO - blobuploader == 1.2.4 06:49:43 INFO - docopt == 0.6.1 06:49:43 INFO - functools32 == 3.2.3-2 06:49:43 INFO - jsonschema == 2.5.1 06:49:43 INFO - manifestparser == 1.1 06:49:43 INFO - mozInstall == 1.12 06:49:43 INFO - mozcrash == 0.17 06:49:43 INFO - mozdebug == 0.1 06:49:43 INFO - mozdevice == 0.48 06:49:43 INFO - mozfile == 1.2 06:49:43 INFO - mozhttpd == 0.7 06:49:43 INFO - mozinfo == 0.9 06:49:43 INFO - mozleak == 0.1 06:49:43 INFO - mozlog == 3.3 06:49:43 INFO - moznetwork == 0.27 06:49:43 INFO - mozprocess == 0.23 06:49:43 INFO - mozprofile == 0.28 06:49:43 INFO - mozrunner == 6.12 06:49:43 INFO - mozscreenshot == 0.1 06:49:43 INFO - mozsystemmonitor == 0.3 06:49:43 INFO - moztest == 0.7 06:49:43 INFO - mozversion == 1.4 06:49:43 INFO - psutil == 3.1.1 06:49:43 INFO - requests == 1.2.3 06:49:43 INFO - wsgiref == 0.1.2 06:49:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49: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')]} 06:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:43 INFO - 'HOME': '/Users/cltbld', 06:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:43 INFO - 'LOGNAME': 'cltbld', 06:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:43 INFO - 'MOZ_NO_REMOTE': '1', 06:49:43 INFO - 'NO_EM_RESTART': '1', 06:49:43 INFO - 'PAGER': '/bin/cat', 06:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:43 INFO - 'PWD': '/builds/slave/test', 06:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:43 INFO - 'SHELL': '/bin/bash', 06:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:43 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:43 INFO - 'USER': 'cltbld', 06:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:43 INFO - 'XPC_FLAGS': '0x0', 06:49:43 INFO - 'XPC_SERVICE_NAME': '0', 06:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:43 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)) 06:49:43 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)) 06:49:43 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)) 06:49:43 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)) 06:49:43 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)) 06:49:43 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)) 06:49:43 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)) 06:49:43 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)) 06:49:43 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)) 06:49:43 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)) 06:49:43 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)) 06:49:43 INFO - Cleaning up... 06:49:43 INFO - Return code: 0 06:49:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:49: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')]} 06:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 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 0x10abb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c2d98040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, '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.6YMB8W5u3O/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.E3sToBV0nA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 06:49:43 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 06:49:43 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 06:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:43 INFO - 'HOME': '/Users/cltbld', 06:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:43 INFO - 'LOGNAME': 'cltbld', 06:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:43 INFO - 'MOZ_NO_REMOTE': '1', 06:49:43 INFO - 'NO_EM_RESTART': '1', 06:49:43 INFO - 'PAGER': '/bin/cat', 06:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:43 INFO - 'PWD': '/builds/slave/test', 06:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:43 INFO - 'SHELL': '/bin/bash', 06:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:49:43 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:43 INFO - 'USER': 'cltbld', 06:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:43 INFO - 'XPC_FLAGS': '0x0', 06:49:43 INFO - 'XPC_SERVICE_NAME': '0', 06:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:49:44 INFO - Cleaning up... 06:49:44 INFO - Return code: 0 06:49:44 INFO - Running post-action listener: _resource_record_post_action 06:49:44 INFO - Running post-action listener: _start_resource_monitoring 06:49:44 INFO - Starting resource monitoring. 06:49:44 INFO - [mozharness: 2016-08-10 13:49:44.045857Z] Finished create-virtualenv step (success) 06:49:44 INFO - [mozharness: 2016-08-10 13:49:44.046657Z] Running install step. 06:49:44 INFO - Running pre-action listener: _resource_record_pre_action 06:49:44 INFO - Running main action method: install 06:49:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:49:44 INFO - Reading from file tmpfile_stdout 06:49:44 INFO - Detecting whether we're running mozinstall >=1.0... 06:49:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:49:44 INFO - Reading from file tmpfile_stdout 06:49:44 INFO - Output received: 06:49:44 INFO - Usage: mozinstall [options] installer 06:49:44 INFO - Options: 06:49:44 INFO - -h, --help show this help message and exit 06:49:44 INFO - -d DEST, --destination=DEST 06:49:44 INFO - Directory to install application into. [default: 06:49:44 INFO - "/builds/slave/test"] 06:49:44 INFO - --app=APP Application being installed. [default: firefox] 06:49:44 INFO - mkdir: /builds/slave/test/build/application 06:49:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:50:18 INFO - Reading from file tmpfile_stdout 06:50:18 INFO - Output received: 06:50:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:50:18 INFO - Running post-action listener: _resource_record_post_action 06:50:18 INFO - [mozharness: 2016-08-10 13:50:18.604261Z] Finished install step (success) 06:50:18 INFO - [mozharness: 2016-08-10 13:50:18.604397Z] Running run-tests step. 06:50:18 INFO - Running pre-action listener: _resource_record_pre_action 06:50:18 INFO - Running main action method: run_tests 06:50:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:50:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:50:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:50:18 INFO - 2016-08-10 06:50:18.619 screenresolution[1637:7474] starting screenresolution argv=screenresolution get 06:50:18 INFO - 2016-08-10 06:50:18.621 screenresolution[1637:7474] Display 0: 1600x1200x32@60 06:50:18 INFO - 2016-08-10 06:50:18.628 screenresolution[1638:7476] starting screenresolution argv=screenresolution list 06:50:18 INFO - Available Modes on Display 0 06:50:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:50:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:50:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:50:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:50:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:50:18 INFO - Intel Iris: 06:50:18 INFO - Chipset Model: Intel Iris 06:50:18 INFO - Type: GPU 06:50:18 INFO - Bus: Built-In 06:50:18 INFO - VRAM (Dynamic, Max): 1536 MB 06:50:18 INFO - Vendor: Intel (0x8086) 06:50:18 INFO - Device ID: 0x0a2e 06:50:18 INFO - Revision ID: 0x0009 06:50:18 INFO - Displays: 06:50:18 INFO - Display: 06:50:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:50:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:50:18 INFO - Display Serial Number: 1600x1200 60 06:50:18 INFO - Main Display: Yes 06:50:18 INFO - Mirror: Off 06:50:18 INFO - Online: Yes 06:50:18 INFO - Rotation: Supported 06:50:18 INFO - Return code: 0 06:50:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:50:18 INFO - Python 2.7.3 06:50:18 INFO - Return code: 0 06:50:18 INFO - grabbing minidump binary from tooltool 06:50:18 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')]} 06:50:18 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 0x10ab18d30>, '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 0x10a87ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab10b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:50:18 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 06:50:18 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 06:50:18 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 06:50:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:18 INFO - Return code: 0 06:50:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:50:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:50:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:50:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:50:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:50:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--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 06:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0268 --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 06:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YMB8W5u3O/Render', 06:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:18 INFO - 'HOME': '/Users/cltbld', 06:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:18 INFO - 'LOGNAME': 'cltbld', 06:50:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:50:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:18 INFO - 'MOZ_NO_REMOTE': '1', 06:50:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:50:18 INFO - 'NO_EM_RESTART': '1', 06:50:18 INFO - 'PAGER': '/bin/cat', 06:50:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:18 INFO - 'PWD': '/builds/slave/test', 06:50:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:18 INFO - 'SHELL': '/bin/bash', 06:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E3sToBV0nA/Listeners', 06:50:18 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 06:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:18 INFO - 'USER': 'cltbld', 06:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:18 INFO - 'XPC_FLAGS': '0x0', 06:50:18 INFO - 'XPC_SERVICE_NAME': '0', 06:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--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 06:50:19 INFO - mozversion application_buildid: 20160810055414 06:50:19 INFO - mozversion application_changeset: c2463be000652c901f160910b4075d081b6c664f 06:50:19 INFO - mozversion application_display_name: Nightly 06:50:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:19 INFO - mozversion application_name: Firefox 06:50:19 INFO - mozversion application_remotingname: firefox 06:50:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:50:19 INFO - mozversion application_vendor: Mozilla 06:50:19 INFO - mozversion application_version: 51.0a1 06:50:19 INFO - mozversion platform_buildid: 20160810055414 06:50:19 INFO - mozversion platform_changeset: c2463be000652c901f160910b4075d081b6c664f 06:50:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:50:19 INFO - mozversion platform_version: 51.0a1 06:50:19 INFO - using testdate: 1470837019 06:50:19 INFO - actual date: 1470837019 06:50:19 INFO - starting webserver on 'localhost:49272' 06:50:19 INFO - SUITE-START | Running 2 tests 06:50:19 INFO - TEST-START | dromaeo_css 06:50:19 INFO - operating with platform_type : mac_ 06:50:19 INFO - Initialising browser for dromaeo_css test... 06:50:19 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpfhJi1S/profile http://localhost:49272/getInfo.html) 06:50:21 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 06:50:21 INFO - PROCESS | 1648 | colorDepth:24 06:50:21 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 06:50:21 INFO - PROCESS | 1648 | __metrics 06:50:21 INFO - PROCESS | 1648 | 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" 06:50:21 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:22 INFO - TEST-INFO | 1648: exit 0 06:50:22 INFO - Browser initialized. 06:50:22 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:22 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpfhJi1S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:34 INFO - PROCESS | 1650 | RSS: Main: 243560448 06:50:34 INFO - PROCESS | 1650 | 06:51:26 INFO - PROCESS | 1650 | 1470837086472 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] 06:53:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 06:53:38 INFO - PROCESS | 1650 | RSS: Main: 345124864 06:53:38 INFO - PROCESS | 1650 | 06:56:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 06:56:41 INFO - PROCESS | 1650 | RSS: Main: 384413696 06:56:41 INFO - PROCESS | 1650 | 06:59:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 06:59:44 INFO - PROCESS | 1650 | RSS: Main: 355205120 06:59:44 INFO - PROCESS | 1650 | 07:02:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 07:02:47 INFO - PROCESS | 1650 | RSS: Main: 357847040 07:02:47 INFO - PROCESS | 1650 | 07:05:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 07:05:52 INFO - PROCESS | 1650 | RSS: Main: 346386432 07:05:52 INFO - PROCESS | 1650 | 07:08:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 07:08:55 INFO - PROCESS | 1650 | RSS: Main: 520249344 07:08:55 INFO - PROCESS | 1650 | 07:08:55 INFO - PROCESS | 1650 | __start_tp_report 07:08:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 07:08:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 07:08:55 INFO - PROCESS | 1650 | |i|pagename|runs| 07:08:55 INFO - PROCESS | 1650 | |0;dojo.html;2498.737632548581;3371.679690429409;3379.6620337966206;3395.422778127718;3437.415639341312;5536.363318218406;5669.971650141749;5702.515286200673;5737.082066869301;5751.4248575142465;5658.066419040863;5683.715814209283;5749.56878234132;5788.18965344851;5794.420557944203;5115.053715062725;5140.511651393112;5198.168293073109;5212.244224587433;5269.552088072499;4439.80125366151;5285.392179899303;5305.442928492511;5309.150535914255;5317.521423071923;4201.4538110045805;5128.461511541272;5179.19722443022;5206.869828254324;5221.321228240324;5179.067767801795;5201.55786758126;5222.843314700565;5300.310959575269;5320.989012087691;4291.97854010731;5234.816781412632;5251.10731175701;5279.709615971158;5288.1803320485005;4995.150824359831;5782.624129431616;5799.652020878761;5860.677662728548;5864.7067646617925;6083.513318934474;6153.384661533855;6200.782972595937;6252.906206406908;6258.937410625881;5222.268882356473;5730.34101078373;6318.905216421757;6366.236051673783;6382.968085159591;4333.58830911063;5821.185034095272;5826.533877289891;5874.089516125007;5884.9705751470965;5314.946850531523;6226.688665566703;6291.276503202099;6294.213223347082;6362.586431881913;5204.9219261711105;5479.123340265538;6196.132541444202;6203.906941395882;6222.81331560054;6245.75016999324;6318.778842740482;6335.334789847;6337.33457986914;6350.555461117678;6102.664353460514;6109.192117492145;6151.169592105009;6218;6241.500679945593;6214.440700336901;6298.937010629835;6315.494760419156;6315.684215789192;6316.8420789479715;5009.89980200394;5019.648624596243;5019.7239151847;5034.496550344937;5064.037832811754;4413.933790993137;4432.069265454291;4450.888727781831;4506.707064040893;4529.162105010583;5777.653340799566;5784.1902133701315;5802.47777700009;5812.79655212074;5839.883202335929;6233.417129203257;6324.588901721373;6337.144485494491;6348.968255158787;6361.2048493938255;5623.437656234344;5684.317881854204;5696.003199440164;5766.4233576642;5802.274715660543;5465.207544905967;5468.097763868917;5470.507654311131;5519.779208831682;5524.14375771756;6323.146375239284;6325.399087086904;6326.367363263636;6328.082428047999;6339.778107766206;6149.846253843511;6222.502199824094;6278;6333.556651034383;6365.809025729235;6276;6313.936860631335;6325.746970121144;6327.873442531031;6337.90493142594;6258.217722784652;6269.467095296951;6270.905936411049;6274.74901003973;6277.529185311028;6145.801568694062;6189.288231853215;6324.747010119728;6342.175517182736;6344.619322840645;4994.425641051181;6156.230471191101;6160.383961603804;6168.753249869955;6170.413810687977;5960.731767070405;6100.877982440237;6153.29237137717;6159.692015399301;6162.22972128484;5776.162456443876;5877.35349111606;5971.671558064349;5996.760129594767;6033.547483938634;6097.2988106366565;6177.135201071764;6177.980633195472;6183.721732521957;6198.256209254918;5971.3132989705;5995.940040599538;5998.25021872266;6003.519718422603;6004.159417681441 07:08:55 INFO - PROCESS | 1650 | |1;ext.html;480.34672844930867;503.9143345631242;507.3531247659234;521.8643152780277;523.2726510150889;40178.59821401785;42043.36934945978;42257.78871105644;44185;44215.33676994839;42965;43439.6968090957;43469.391836489835;43470.78264608672;43597.78201108998;8656.307495400353;9673.129418352364;9859.605615775396;9867.062629050264;9871;8698.826023479527;9940.900590994106;11635;11868.228565143281;12183.32991685457;11889.405529723523;11960.581379651714;11968.34174120423;11996;12053.337066461341;11862.406879655982;11914.642560723192;11923.284602923766;11934.403279836017;11939.94030029853;11870.169088163831;11939.223950443193;11959.641210763692;11960.1627886048;11980.221285616408;40869;41177.79411102955;41189.176216475804;41189.79405102985;41274.79362603168;3422.828858557062;3468;3473.774204676688;3509.5963964144194;3546.942042748263;31894.202644934063;32001.51997720036;32214;32837.6716232837;32844.1788955278;3213.1806389370563;3219.114743445548;3251.5935508061493;3350.2461946062185;3375.881844135468;500864;501146;502480.99999999633;503303;503706;33881;62019;62481.062784058275;62528;62528.68735656293;34409.96770096851;35577.46633800495;35841.28317433689;35896.74361397338;35958.8202058988;14761.557153285205;14918.4778532753;14919.179445130621;14924.104553726811;14975.176365299796;11451.54193832254;11632.243904146204;12496.875031249752;12553.748925021631;12628.558000470122;7677.270659287359;7799.883001754978;7864.4888082274465;7879.6848126075465;7896.802579935547;3199.82400967949;3240.9675903240664;3257.7719559631073;3260.6902344277255;3271.8854840080485;957.2389949989774;992.3847214726916;1049.6746008737164;1069.9866748871393;1113.8329250612474;29740.851295743814;30458.54312185319;30643.846780765954;30823;31100.84449577783;1047.779966207105;1068.631322193842;1178.5168081086713;1182.0661677274857;1185.2829038431796;14530.05554638945;15835.287412066486;15943.840561594468;15988.600284992735;16301.592460188353;188911.0554447219;190479;191246.04376978305;191361;191746;59130;59660.70169649124;59693.40306596965;59857.102143467884;59925;1255.3911352993791;1357.6809449779491;1385.2935003148466;1388.02838013389;1410.9435622574981;30752.846235768677;31184.68815311818;31646.626503012827;31648.367032659677;32598.674013259562;51243;51706.48293517017;51783;51833.44499664865;51868.22197666963;551915;555762;555952;556517;558549;27111.72888271092;27298.90804367803;27823.44353112967;28120.43759124847;28938.42123157567;45756.77121614504;48080.5191948076;48374.79063023312;48650.270245945634;49649.51051468462;39549;39759.2048159041;39969.60030399775;40159.59840401559;41204.96987575335;39718.404223936086;39757.60242397655;39915.60084399119;40980.59019409768;41212;38765.41851872281;39380.80309598434;39469;39591.80204098961;39681.40477892892;34387.82806085954;34937;35258.64741352656;35437.93686189419;35780.92657220287;23083.769162308163;24982.250532484053;25628.231153065437;25822.104848009494;25838.61242081408 07:08:55 INFO - PROCESS | 1650 | |2;jquery.html;351.47279081377934;368.7437231124369;373.5162963961671;377.6469001483612;397.9243943650706;13388.263645499494;15599.766003509942;20370.490737731565;21024.369268921917;21144.04851781668;17374.652506949886;19948.01299675081;20153.899230503863;20706.068226929787;21011.789882101173;5751.482366587006;5791.999999999989;6043.969780151093;6058.818235452944;6088.878222435571;6582.243042050178;6670.76652317169;6708.731650733965;6765.898511522331;6785.050092986986;6379.393957574046;6525.282218955911;6613.074169616258;6614.834629134286;6651.866962660744;6377.362263773632;6580.650966551845;6628.370304821035;6631.071649969008;6658.201015878077;5761.308642962871;5764.5676574257095;5768.509676677488;5768.711564421762;5775.740091695884;13359.53241636538;22912.281578881484;24165.637515437105;25231;26245.606315905276;2099.9475013124643;2108.483421561727;2111.883846388448;2238.597052530544;2874.6406699162603;9981.800363992752;10037.347572407843;10133.847992280122;10364.792704145875;10379.42913139777;1629.6659184867074;1859.7024476083761;1866.2534986005571;1922.644310802506;1956.0415396455776;107685.46157269164;112230;127797.36101319527;128040.99487563962;128696;11200.495977681025;11451.312921224753;11489.885101148882;11522.76954460906;11728.354940478355;14395.928020359832;14423.197100362455;14425;14428.134311941318;14443.566692999228;6608;8400.243978042006;8439.451435656663;8565.828683426296;8587.785305367415;8299.29455996247;8350.164983501601;8390.958045209734;8481.109483504266;8497.320214382835;4353.825846966086;4429.645628349725;4507.5943165115295;4593.402857628487;4612.192866248393;1595.4096984115952;1836.4949638849423;1901.9049047547567;1902.4292712186289;1904.4572296895594;803.4054799448367;851.8509260879322;937.6062053937362;944.2776276148752;952.228694757235;19936.10287537064;21048.579028419652;21072.262470813755;21082.683759743617;21631;910.8269428808637;930.6091441594547;932.7341707613298;940.6190492850407;1021.7598864266891;10195.28632995698;10896.237263391486;10977.859317433024;11013.339199648046;11021.559137634405;542052;583446;588869;594815;603675;92825.53587232021;112003.87996119935;119938.4003079979;129571;132346;996.446971930571;1005.5726316315537;1006.5369929832212;1052.952617132231;1055.1453322808395;17575.296988120845;18644.161012754186;19287.035648217814;19335.033248337808;19349.8065019348;42344.57655423407;55276.89446211134;55321.44678553163;55360.72319638376;58085.54786130381;81667.6916000458;83426.16573834184;84805;85042;86444;6574.868502630016;7815.804604884924;8067.112617611941;8132;8275.55177843887;10679.946600266949;12727.109102362745;12822.551210707581;12995.675108122372;13079;10287.691369258935;11075.556977721124;11194.104471642086;11253.268537545033;11313;10762.3542587445;10822.080123189617;10853.457327133454;11210.495527701436;11233.887661123284;11094.833577496505;11180.776384472427;11332.320060796379;11487.54049837997;11557.653270401901;7402.074740657418;7782.338501227459;8039.598020098854;8243.752687419386;8258.174182581934;9635.759106022126;10070.798584028133;10637.723473183267;11047.613333533609;11125.221234513507 07:08:55 INFO - PROCESS | 1650 | |3;mootools.html;1503.6391266096136;1517.7495713207322;1709.2479309103994;1844.5480857189991;1882.3317722208624;8310.958445207772;8818.98581663109;8837.337199710024;8860.424072435295;8903.020667726545;7780.26087521686;8020.39847011475;8357.498550086999;8578.270846978014;8658.26404755595;2342.074880422232;2363.610004349289;2366.3965688749345;2370.466645004877;2373.750756170603;2330.277613939684;2347.6595893595418;2375.904963801446;2376.7979721723586;2378.3935096550354;2322.4658328584437;2347.4248809041724;2352.5647755165264;2358.5636657218383;2361.6457531370347;1946.347973428903;2329.638905969569;2329.755375685554;2333;2348.7768661977084;2326.4881726020417;2326.674265602817;2326.6975293211945;2327.325075728037;2329.46422322865;8737;8778.429402088845;8841.16008979146;8841.690540831105;8859.468431894107;5161.406438259573;5309.62832601718;5316.255724198615;5318.202269659543;5327.520523152934;3441.4321636929876;3484.6515348465205;3628.147385364464;3632.8183590820618;3646.4712616670436;1027.1166796554958;1064.6220591689994;1066.978660426795;1079.320028382122;1081.9945900270527;9333.906660933371;11364.829527557093;11474.254173478697;11483.942580287045;11488.425578721031;4457.710248833815;4561.156186105581;4710.36410084641;4727.456342520585;4734.455537613149;9756.02439756033;9763.755906102404;9778.97320781322;9780.657676981271;9794.95102524497;5249.028929648028;5267.868303292448;5276.287701160371;5277.182036784305;5277.4986376294955;4074.780101216308;4356.629686476622;4494.640428765691;4519.81920723174;4857;2990.2524368907775;3630.655087766711;3728.7762734236035;3729.4778730977687;3964.682825373963;1255.811628255769;1262.741138066694;1271.7392934448417;1277.508159358635;1279.4306533592649;877.9780505487286;908.68650315641;916.3814425262921;939.4645052320112;946.532367226689;5804.506616937608;5971.701414929236;6056.6971651418135;6104.877902441926;6238.438540531283;889.7241855024963;899.9415038022507;904.1230006893435;943.528235882059;966.8598053282235;3488.5639295088113;3634.5638523376833;3747.4004159334377;3917.4515567820526;3952.940705889414;10411.895881041093;10603.469826508644;10703.464826758787;10706.304090234265;10706.732331691614;10644.680659580225;10657.946710266398;10661.893381066246;10678.359298442118;10771.730706732238;7695.538267703956;8032.357411407191;8067.3142782864115;8068.717594884269;8177.977752780902;5844.240248767633;5920.970395147997;5969.791057312973;6057.57596968208;6094.3600921904335;9886.4562449066;10141.797164056825;10148.289619726844;10148.441835699108;10188.490575471049;9234.26125909939;9894;10230.846537302095;10233.334833235816;10242.743931401774;6985.057017302803;7304.744333948286;7431.925680743123;7556.319931206218;7645.311921927053;8160.224778646019;8193.959030204811;8232.547209903512;8251.33989280844;8345.707900223462;7374.778756637309;7409.925900741139;7442.144153422426;7456.2170972049325;7510.399168066432;7252.238514955854;7404.92595074064;7415.369693575891;7462.888056679046;7466.738664146729;6798.830029249309;6824.863502730017;6991.287134652042;6991.44068474531;6997.300269973166;4886.828960986349;5077.365329333833;5121.334226550524;5157.252198431282;5331.680099194061;5090.745462726774;5125.692458452505;5212.765425555784;5220.504052115043;5356.839294821161 07:08:55 INFO - PROCESS | 1650 | |4;prototype.html;297.44378013115477;298.8356403977812;310.08988618404976;312.35342840320544;318.6049298869403;4112.81492332845;4820.46974832769;5333.919991200135;5338.6796792192445;5398.2982212312445;4808.543188397105;4896.730679812609;4979.900401991967;5141.82003629873;5218.6346955713025;3637.7813432500143;3784.413415920537;3960.7029472789586;3986.2625414298304;4007.73949693269;3623.275344931011;3974.403839424095;4032.5564187939303;4038.798060096998;4038.798060096998;2770.1301621405573;3722.7394082414244;3960.643542081212;3961.247363001035;3985.8804235872826;3590.910227244314;3803.4215800442785;3809.666616684166;3934.2721596504452;3959.8418861720143;2952.822830630169;3009.2627306310096;3484.3902317094407;3492.6507349265125;3498.807565583892;4471.39636149119;4629.8148074077;4888.315635810989;5037.5718063964605;5054.368203974504;4481.977590112028;4491.371208030879;4511.684182107254;4532.614727748145;4563.361129441881;5075.0611136939415;5445.673259604437;5464.63924686315;5509.944900551023;5531.363893152299;3255.7720959532603;3320.7509436792097;3794.4687743715904;3861.3049651062797;3871.399933010388;4643.605293550052;5074.188129899198;5261.947380526222;5706.9429305707245;5780.306363236438;3761.5298087739034;3785;3787.696984241254;3790.77255364679;3829.368154254517;3833.674137698327;3839.308924393636;3843.577206507282;3843.8462461501226;3855.094052897567;3994.121293315466;4179.91640167195;4471.977640111843;4486.484054333793;4491.944393067626;5087.09234037236;5467.9453205468235;5521.420250873681;5523.575383262403;5524.475174858382;1155.6879642496478;1269.8793614606598;1333.1001573937747;1333.5066025570407;1340.2762508245632;796.4345314826538;804.1757198871087;830.2320353672949;835.5070508400073;848.8132610825609;4051.534073581517;4192;4239.448871646666;5020.046191223656;5129;4759.904801903943;5600.85997850057;5670.914936275959;5673.375928647845;5739.942600574024;4609.446866376056;4942.950570494321;5038.546530812245;5139.563137133386;5200.843974680765;2591.740825917393;2619.698734645502;2931.4869897767803;2944.2492164497917;2968.85155742212;4775.913651960651;5682.516986056149;5749.332693518916;5764.365919748824;5805.854853628609;4404.867853964386;5377.489138531833;5491.395946445888;5575.804846830341;5800.303963524319;5162.7351298932;5266.868328291824;5753.913691294634;5776.566757493205;5878.441548052928;4302.462192225972;5266;5549.694766787866;5555.194496797861;5590.301212348457;4918.975405122951;5615.57449955535;5650.717464126859;5658.745356458887;5662.66024038559;5853.765849366148;5894.528437724886;5916.26046744157;5963.671998040149;5985.551083668829;3369.679880411357;3568.3755342814384;3793.1465420280215;3846.538415390171;3859.2088621831895;4657.4411070670385;5642.266505354278;5643.109558297852;5667.3482549507335;5733.856653583527;4856.732879691651;4967.03142887148;5427;5573.749181286933;5582.804601838916;5160.974195129001;5457.399686034612;5496.890062198813;5570.4151064139305;5590.916136258041;4884.9741554274;5163.251328557263;5489.807856724996;5496.835094947158;5508.108243172366;4589.9541004590865;5229.764660590206;5340.973295133499;5453.863653408696;5579.8884022320135;4561.863144105682;4614.377059096979;5058.519440653132;5140.665856719302;5479.424660410759 07:08:55 INFO - PROCESS | 1650 | |5;yui.html;647.4140902483255;708.3907839258237;766.4443278622999;781.3592853859838;817.1624085312554;15410.152441615706;16460.25928833201;16474.505764827045;16477.25852336646;16582.502524924243;14571.97996140268;14588.051776634538;14762.704745905075;14770.261486925665;14783.113013219188;654.116942128128;681.8465845184843;700.9088818453606;820.7250571058703;850.642730053376;825.7192554531458;829.7552222094497;833.6665333866441;835.3776436554775;840.3487297344576;895.8208358328328;895.9920089898864;897.1432282170512;898.5956319656149;899.3120262998812;891.2602539891874;891.7146513115806;892.0455113029061;893.0622846011662;893.7363477774072;438.5022998896244;516.3803435876926;650.5056157320423;667.5293917787948;670.936261055199;15115.244237788067;15125.924370378189;15144.924275378553;15170.469033583771;15254.08475491474;12902;13129.540466083641;13250.536231231861;13389.531366402129;13683.24742139182;12198.268103913793;12600.4329805159;12905.161164524276;13096.738065238642;13231.933840330834;4377.34339849022;4434.844780432702;4460.620847227957;4490.865274041784;4622.6070783983405;90877;114114;114914;115217;115885;10162.23783216247;10221.846672299922;10295.794084118275;10328.896711032794;10368.585256589651;19159.042047897827;19184.424467266006;19199.040047997543;19199.32802351911;19221.13504892283;7607.087149542091;7637.4653774236385;7660.846783064308;7859.567723775247;7868.960655196687;4393.846215382447;4406.427164468599;4432.978887963044;4521.66087543429;4545.136424079415;3346.849391777376;3466.2547552276383;3469.531613232232;3470.687638112582;3475.7740746851878;678.1455366238575;681.7409384433982;686.2382755141789;696.3489137656308;714.731975509184;594.7115648910275;667.5393978155057;693.8863124684909;695.6104581434413;700.6496751624188;9670.806583868423;9722.465264410524;9741.220702343795;9768;9810.313278070467;647.6567419267795;663.3631713554945;686.5983399711225;689.4759982413302;695.5027155583782;3870.628816112955;4415.4259946206785;4431.933520997188;4648.58162765346;4682.6253899687945;93716;105647;139197;146553.5344646561;150555;88774;139041;140941.99999999796;141146.29426853007;141398;97962;118958;120106;120122.3993880025;121219.39390303168;8948.418352807306;8949.686760963335;9011.954940225258;9065.184133428023;9113.04313047147;55719.72140139274;61168.082478761964;62240.066399003146;62477.37522624715;64136.67931660312;76919;93998.53000734953;98069.50965245128;98410.5079474598;104849;11830.82253766177;11884.168108232341;12085;12108.818367724667;12343.321117338633;13364.398602063126;13525.864741352854;13568.457261709422;13771.931140344233;14131.222782747047;12224.899838843954;12353.505859765508;12489.625311240678;12507.749845002867;12723.80914286268;12189.207701499374;12387.706387488428;12506.499740010298;12819.230846149261;12932;12070.74201464388;12341.50633974631;12348.876511235132;12359.50561977511;12716.618501444971;10374.533146008598;10487.318324308895;10494.842577361498;10666.520006599876;10835.133189344991;10130.189584833342;10263.076323130954;10269.640562580274;10285.53715082838;10317.845232321672 07:08:55 INFO - PROCESS | 1650 | __end_tp_report 07:08:55 INFO - PROCESS | 1650 | __start_cc_report 07:08:55 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1309 07:08:55 INFO - PROCESS | 1650 | __end_cc_report 07:08:55 INFO - PROCESS | 1650 | __startTimestamp1470838135591__endTimestamp 07:08:55 INFO - PROCESS | 1650 | 07:08:55 INFO - PROCESS | 1650 | ------- Summary: start ------- 07:08:55 INFO - PROCESS | 1650 | Number of tests: 6 07:08:55 INFO - PROCESS | 1650 | 07:08:55 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5721.10 Median:5884.97 stddev:697.46 (11.9%) stddev-sans-first:652.19 07:08:55 INFO - PROCESS | 1650 | Values: 2498.7 3371.7 3379.7 3395.4 3437.4 5536.4 5670.0 5702.5 5737.1 5751.4 5658.1 5683.7 5749.6 5788.2 5794.4 5115.1 5140.5 5198.2 5212.2 5269.6 4439.8 5285.4 5305.4 5309.2 5317.5 4201.5 5128.5 5179.2 5206.9 5221.3 5179.1 5201.6 5222.8 5300.3 5321.0 4292.0 5234.8 5251.1 5279.7 5288.2 4995.2 5782.6 5799.7 5860.7 5864.7 6083.5 6153.4 6200.8 6252.9 6258.9 5222.3 5730.3 6318.9 6366.2 6383.0 4333.6 5821.2 5826.5 5874.1 5885.0 5314.9 6226.7 6291.3 6294.2 6362.6 5204.9 5479.1 6196.1 6203.9 6222.8 6245.8 6318.8 6335.3 6337.3 6350.6 6102.7 6109.2 6151.2 6218.0 6241.5 6214.4 6298.9 6315.5 6315.7 6316.8 5009.9 5019.6 5019.7 5034.5 5064.0 4413.9 4432.1 4450.9 4506.7 4529.2 5777.7 5784.2 5802.5 5812.8 5839.9 6233.4 6324.6 6337.1 6349.0 6361.2 5623.4 5684.3 5696.0 5766.4 5802.3 5465.2 5468.1 5470.5 5519.8 5524.1 6323.1 6325.4 6326.4 6328.1 6339.8 6149.8 6222.5 6278.0 6333.6 6365.8 6276.0 6313.9 6325.7 6327.9 6337.9 6258.2 6269.5 6270.9 6274.7 6277.5 6145.8 6189.3 6324.7 6342.2 6344.6 4994.4 6156.2 6160.4 6168.8 6170.4 5960.7 6100.9 6153.3 6159.7 6162.2 5776.2 5877.4 5971.7 5996.8 6033.5 6097.3 6177.1 6178.0 6183.7 6198.3 5971.3 5995.9 5998.3 6003.5 6004.2 07:08:55 INFO - PROCESS | 1650 | 07:08:55 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:56968.76 Median:3470.89 stddev:119474.39 (3442.2%) stddev-sans-first:119734.27 07:08:55 INFO - PROCESS | 1650 | Values: 480.3 503.9 507.4 521.9 523.3 40178.6 42043.4 42257.8 44185.0 44215.3 42965.0 43439.7 43469.4 43470.8 43597.8 8656.3 9673.1 9859.6 9867.1 9871.0 8698.8 9940.9 11635.0 11868.2 12183.3 11889.4 11960.6 11968.3 11996.0 12053.3 11862.4 11914.6 11923.3 11934.4 11939.9 11870.2 11939.2 11959.6 11960.2 11980.2 40869.0 41177.8 41189.2 41189.8 41274.8 3422.8 3468.0 3473.8 3509.6 3546.9 31894.2 32001.5 32214.0 32837.7 32844.2 3213.2 3219.1 3251.6 3350.2 3375.9 500864.0 501146.0 502481.0 503303.0 503706.0 33881.0 62019.0 62481.1 62528.0 62528.7 34410.0 35577.5 35841.3 35896.7 35958.8 14761.6 14918.5 14919.2 14924.1 14975.2 11451.5 11632.2 12496.9 12553.7 12628.6 7677.3 7799.9 7864.5 7879.7 7896.8 3199.8 3241.0 3257.8 3260.7 3271.9 957.2 992.4 1049.7 1070.0 1113.8 29740.9 30458.5 30643.8 30823.0 31100.8 1047.8 1068.6 1178.5 1182.1 1185.3 14530.1 15835.3 15943.8 15988.6 16301.6 188911.1 190479.0 191246.0 191361.0 191746.0 59130.0 59660.7 59693.4 59857.1 59925.0 1255.4 1357.7 1385.3 1388.0 1410.9 30752.8 31184.7 31646.6 31648.4 32598.7 51243.0 51706.5 51783.0 51833.4 51868.2 551915.0 555762.0 555952.0 556517.0 558549.0 27111.7 27298.9 27823.4 28120.4 28938.4 45756.8 48080.5 48374.8 48650.3 49649.5 39549.0 39759.2 39969.6 40159.6 41205.0 39718.4 39757.6 39915.6 40980.6 41212.0 38765.4 39380.8 39469.0 39591.8 39681.4 34387.8 34937.0 35258.6 35437.9 35780.9 23083.8 24982.3 25628.2 25822.1 25838.6 07:08:55 INFO - PROCESS | 1650 | 07:08:55 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34426.83 Median:11934.80 stddev:97392.08 (816.0%) stddev-sans-first:97631.69 07:08:55 INFO - PROCESS | 1650 | Values: 351.5 368.7 373.5 377.6 397.9 13388.3 15599.8 20370.5 21024.4 21144.0 17374.7 19948.0 20153.9 20706.1 21011.8 5751.5 5792.0 6044.0 6058.8 6088.9 6582.2 6670.8 6708.7 6765.9 6785.1 6379.4 6525.3 6613.1 6614.8 6651.9 6377.4 6580.7 6628.4 6631.1 6658.2 5761.3 5764.6 5768.5 5768.7 5775.7 13359.5 22912.3 24165.6 25231.0 26245.6 2099.9 2108.5 2111.9 2238.6 2874.6 9981.8 10037.3 10133.8 10364.8 10379.4 1629.7 1859.7 1866.3 1922.6 1956.0 107685.5 112230.0 127797.4 128041.0 128696.0 11200.5 11451.3 11489.9 11522.8 11728.4 14395.9 14423.2 14425.0 14428.1 14443.6 6608.0 8400.2 8439.5 8565.8 8587.8 8299.3 8350.2 8391.0 8481.1 8497.3 4353.8 4429.6 4507.6 4593.4 4612.2 1595.4 1836.5 1901.9 1902.4 1904.5 803.4 851.9 937.6 944.3 952.2 19936.1 21048.6 21072.3 21082.7 21631.0 910.8 930.6 932.7 940.6 1021.8 10195.3 10896.2 10977.9 11013.3 11021.6 542052.0 583446.0 588869.0 594815.0 603675.0 92825.5 112003.9 119938.4 129571.0 132346.0 996.4 1005.6 1006.5 1053.0 1055.1 17575.3 18644.2 19287.0 19335.0 19349.8 42344.6 55276.9 55321.4 55360.7 58085.5 81667.7 83426.2 84805.0 85042.0 86444.0 6574.9 7815.8 8067.1 8132.0 8275.6 10679.9 12727.1 12822.6 12995.7 13079.0 10287.7 11075.6 11194.1 11253.3 11313.0 10762.4 10822.1 10853.5 11210.5 11233.9 11094.8 11180.8 11332.3 11487.5 11557.7 7402.1 7782.3 8039.6 8243.8 8258.2 9635.8 10070.8 10637.7 11047.6 11125.2 07:08:55 INFO - PROCESS | 1650 | 07:08:55 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5662.19 Median:5141.47 stddev:3157.53 (61.4%) stddev-sans-first:3150.92 07:08:55 INFO - PROCESS | 1650 | Values: 1503.6 1517.7 1709.2 1844.5 1882.3 8311.0 8819.0 8837.3 8860.4 8903.0 7780.3 8020.4 8357.5 8578.3 8658.3 2342.1 2363.6 2366.4 2370.5 2373.8 2330.3 2347.7 2375.9 2376.8 2378.4 2322.5 2347.4 2352.6 2358.6 2361.6 1946.3 2329.6 2329.8 2333.0 2348.8 2326.5 2326.7 2326.7 2327.3 2329.5 8737.0 8778.4 8841.2 8841.7 8859.5 5161.4 5309.6 5316.3 5318.2 5327.5 3441.4 3484.7 3628.1 3632.8 3646.5 1027.1 1064.6 1067.0 1079.3 1082.0 9333.9 11364.8 11474.3 11483.9 11488.4 4457.7 4561.2 4710.4 4727.5 4734.5 9756.0 9763.8 9779.0 9780.7 9795.0 5249.0 5267.9 5276.3 5277.2 5277.5 4074.8 4356.6 4494.6 4519.8 4857.0 2990.3 3630.7 3728.8 3729.5 3964.7 1255.8 1262.7 1271.7 1277.5 1279.4 878.0 908.7 916.4 939.5 946.5 5804.5 5971.7 6056.7 6104.9 6238.4 889.7 899.9 904.1 943.5 966.9 3488.6 3634.6 3747.4 3917.5 3952.9 10411.9 10603.5 10703.5 10706.3 10706.7 10644.7 10657.9 10661.9 10678.4 10771.7 7695.5 8032.4 8067.3 8068.7 8178.0 5844.2 5921.0 5969.8 6057.6 6094.4 9886.5 10141.8 10148.3 10148.4 10188.5 9234.3 9894.0 10230.8 10233.3 10242.7 6985.1 7304.7 7431.9 7556.3 7645.3 8160.2 8194.0 8232.5 8251.3 8345.7 7374.8 7409.9 7442.1 7456.2 7510.4 7252.2 7404.9 7415.4 7462.9 7466.7 6798.8 6824.9 6991.3 6991.4 6997.3 4886.8 5077.4 5121.3 5157.3 5331.7 5090.7 5125.7 5212.8 5220.5 5356.8 07:08:55 INFO - PROCESS | 1650 | 07:08:55 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4400.59 Median:4892.52 stddev:1368.26 (28.0%) stddev-sans-first:1336.99 07:08:55 INFO - PROCESS | 1650 | Values: 297.4 298.8 310.1 312.4 318.6 4112.8 4820.5 5333.9 5338.7 5398.3 4808.5 4896.7 4979.9 5141.8 5218.6 3637.8 3784.4 3960.7 3986.3 4007.7 3623.3 3974.4 4032.6 4038.8 4038.8 2770.1 3722.7 3960.6 3961.2 3985.9 3590.9 3803.4 3809.7 3934.3 3959.8 2952.8 3009.3 3484.4 3492.7 3498.8 4471.4 4629.8 4888.3 5037.6 5054.4 4482.0 4491.4 4511.7 4532.6 4563.4 5075.1 5445.7 5464.6 5509.9 5531.4 3255.8 3320.8 3794.5 3861.3 3871.4 4643.6 5074.2 5261.9 5706.9 5780.3 3761.5 3785.0 3787.7 3790.8 3829.4 3833.7 3839.3 3843.6 3843.8 3855.1 3994.1 4179.9 4472.0 4486.5 4491.9 5087.1 5467.9 5521.4 5523.6 5524.5 1155.7 1269.9 1333.1 1333.5 1340.3 796.4 804.2 830.2 835.5 848.8 4051.5 4192.0 4239.4 5020.0 5129.0 4759.9 5600.9 5670.9 5673.4 5739.9 4609.4 4943.0 5038.5 5139.6 5200.8 2591.7 2619.7 2931.5 2944.2 2968.9 4775.9 5682.5 5749.3 5764.4 5805.9 4404.9 5377.5 5491.4 5575.8 5800.3 5162.7 5266.9 5753.9 5776.6 5878.4 4302.5 5266.0 5549.7 5555.2 5590.3 4919.0 5615.6 5650.7 5658.7 5662.7 5853.8 5894.5 5916.3 5963.7 5985.6 3369.7 3568.4 3793.1 3846.5 3859.2 4657.4 5642.3 5643.1 5667.3 5733.9 4856.7 4967.0 5427.0 5573.7 5582.8 5161.0 5457.4 5496.9 5570.4 5590.9 4885.0 5163.3 5489.8 5496.8 5508.1 4590.0 5229.8 5341.0 5453.9 5579.9 4561.9 4614.4 5058.5 5140.7 5479.4 07:08:55 INFO - PROCESS | 1650 | 07:08:55 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:24291.89 Median:3473.23 stddev:38893.84 (1119.8%) stddev-sans-first:38962.43 07:08:55 INFO - PROCESS | 1650 | Values: 647.4 708.4 766.4 781.4 817.2 15410.2 16460.3 16474.5 16477.3 16582.5 14572.0 14588.1 14762.7 14770.3 14783.1 654.1 681.8 700.9 820.7 850.6 825.7 829.8 833.7 835.4 840.3 895.8 896.0 897.1 898.6 899.3 891.3 891.7 892.0 893.1 893.7 438.5 516.4 650.5 667.5 670.9 15115.2 15125.9 15144.9 15170.5 15254.1 12902.0 13129.5 13250.5 13389.5 13683.2 12198.3 12600.4 12905.2 13096.7 13231.9 4377.3 4434.8 4460.6 4490.9 4622.6 90877.0 114114.0 114914.0 115217.0 115885.0 10162.2 10221.8 10295.8 10328.9 10368.6 19159.0 19184.4 19199.0 19199.3 19221.1 7607.1 7637.5 7660.8 7859.6 7869.0 4393.8 4406.4 4433.0 4521.7 4545.1 3346.8 3466.3 3469.5 3470.7 3475.8 678.1 681.7 686.2 696.3 714.7 594.7 667.5 693.9 695.6 700.6 9670.8 9722.5 9741.2 9768.0 9810.3 647.7 663.4 686.6 689.5 695.5 3870.6 4415.4 4431.9 4648.6 4682.6 93716.0 105647.0 139197.0 146553.5 150555.0 88774.0 139041.0 140942.0 141146.3 141398.0 97962.0 118958.0 120106.0 120122.4 121219.4 8948.4 8949.7 9012.0 9065.2 9113.0 55719.7 61168.1 62240.1 62477.4 64136.7 76919.0 93998.5 98069.5 98410.5 104849.0 11830.8 11884.2 12085.0 12108.8 12343.3 13364.4 13525.9 13568.5 13771.9 14131.2 12224.9 12353.5 12489.6 12507.7 12723.8 12189.2 12387.7 12506.5 12819.2 12932.0 12070.7 12341.5 12348.9 12359.5 12716.6 10374.5 10487.3 10494.8 10666.5 10835.1 10130.2 10263.1 10269.6 10285.5 10317.8 07:08:55 INFO - PROCESS | 1650 | -------- Summary: end -------- 07:08:55 INFO - PROCESS | 1650 | 07:08:56 INFO - TEST-INFO | 1650: exit 0 07:08:56 INFO - TEST-OK | dromaeo_css | took 1117049ms 07:08:56 INFO - TEST-START | kraken 07:08:56 INFO - operating with platform_type : mac_ 07:08:56 INFO - Initialising browser for kraken test... 07:08:56 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmphpkYqO/profile http://localhost:49272/getInfo.html) 07:08:58 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 07:08:58 INFO - PROCESS | 1660 | colorDepth:24 07:08:58 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 07:08:58 INFO - PROCESS | 1660 | __metrics 07:08:58 INFO - PROCESS | 1660 | 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" 07:08:58 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:08:59 INFO - TEST-INFO | 1660: exit 0 07:08:59 INFO - Browser initialized. 07:08:59 INFO - Running cycle 1/1 for kraken test... 07:08:59 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmphpkYqO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:11 INFO - PROCESS | 1661 | RSS: Main: 243552256 07:09:11 INFO - PROCESS | 1661 | 07:09:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:15 INFO - PROCESS | 1661 | RSS: Main: 292646912 07:09:15 INFO - PROCESS | 1661 | 07:09:17 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 07:09:18 INFO - PROCESS | 1661 | RSS: Main: 303099904 07:09:18 INFO - PROCESS | 1661 | 07:09:21 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 07:09:22 INFO - PROCESS | 1661 | RSS: Main: 394174464 07:09:22 INFO - PROCESS | 1661 | 07:09:24 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 07:09:24 INFO - PROCESS | 1661 | RSS: Main: 296177664 07:09:24 INFO - PROCESS | 1661 | 07:09:26 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:27 INFO - PROCESS | 1661 | RSS: Main: 301400064 07:09:27 INFO - PROCESS | 1661 | 07:09:30 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:30 INFO - PROCESS | 1661 | RSS: Main: 335851520 07:09:30 INFO - PROCESS | 1661 | 07:09:33 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:34 INFO - PROCESS | 1661 | RSS: Main: 339222528 07:09:34 INFO - PROCESS | 1661 | 07:09:37 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 07:09:37 INFO - PROCESS | 1661 | RSS: Main: 340750336 07:09:37 INFO - PROCESS | 1661 | 07:09:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:40 INFO - PROCESS | 1661 | RSS: Main: 313864192 07:09:40 INFO - PROCESS | 1661 | 07:09:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:09:42 INFO - PROCESS | 1661 | RSS: Main: 319750144 07:09:42 INFO - PROCESS | 1661 | 07:09:44 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:09:45 INFO - PROCESS | 1661 | RSS: Main: 325578752 07:09:45 INFO - PROCESS | 1661 | 07:09:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:09:48 INFO - PROCESS | 1661 | RSS: Main: 330452992 07:09:48 INFO - PROCESS | 1661 | 07:09:51 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:09:52 INFO - PROCESS | 1661 | RSS: Main: 331866112 07:09:52 INFO - PROCESS | 1661 | 07:09:53 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 07:09:54 INFO - PROCESS | 1661 | RSS: Main: 375226368 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | __start_tp_report 07:09:54 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 07:09:54 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 07:09:54 INFO - PROCESS | 1661 | |i|pagename|runs| 07:09:54 INFO - PROCESS | 1661 | |0;ai-astar;99;110;110;110;111;109;111;111;110;109 07:09:54 INFO - PROCESS | 1661 | |1;audio-beat-detection;140;106;109;164;103;106;128;108;141;107 07:09:54 INFO - PROCESS | 1661 | |2;audio-dft;185;184;184;180;183;179;182;182;185;203 07:09:54 INFO - PROCESS | 1661 | |3;audio-fft;77;58;64;86;60;60;63;62;84;56 07:09:54 INFO - PROCESS | 1661 | |4;audio-oscillator;82;68;98;69;77;68;95;69;67;97 07:09:54 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;88;84;87;86;88;84;88;88;87;84 07:09:54 INFO - PROCESS | 1661 | |6;imaging-darkroom;93;93;92;93;94;93;93;93;93;92 07:09:54 INFO - PROCESS | 1661 | |7;imaging-desaturate;126;133;91;85;85;83;84;85;83;85 07:09:54 INFO - PROCESS | 1661 | |8;json-parse-financial;55;52;54;53;52;51;53;53;52;51 07:09:54 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;66;66;72;79;71;73;72;70;70;71 07:09:54 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;87;82;83;85;84;85;84;83;81;88 07:09:54 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;139;136;138;135;133;137;136;130;156;137 07:09:54 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;166;166;166;163;166;167;168;165;164;165 07:09:54 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;67;68;68;67;70;61;87;65;66;66 07:09:54 INFO - PROCESS | 1661 | __end_tp_report 07:09:54 INFO - PROCESS | 1661 | __start_cc_report 07:09:54 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,2042 07:09:54 INFO - PROCESS | 1661 | __end_cc_report 07:09:54 INFO - PROCESS | 1661 | __startTimestamp1470838194240__endTimestamp 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | ------- Summary: start ------- 07:09:54 INFO - PROCESS | 1661 | Number of tests: 14 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.59 (3.2%) stddev-sans-first:0.78 07:09:54 INFO - PROCESS | 1661 | Values: 99.0 110.0 110.0 110.0 111.0 109.0 111.0 111.0 110.0 109.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:118.50 stddev:20.93 (17.7%) stddev-sans-first:21.06 07:09:54 INFO - PROCESS | 1661 | Values: 140.0 106.0 109.0 164.0 103.0 106.0 128.0 108.0 141.0 107.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:184.70 Median:184.00 stddev:6.73 (3.7%) stddev-sans-first:7.14 07:09:54 INFO - PROCESS | 1661 | Values: 185.0 184.0 184.0 180.0 183.0 179.0 182.0 182.0 185.0 203.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:67.00 Median:63.50 stddev:11.06 (17.4%) stddev-sans-first:11.12 07:09:54 INFO - PROCESS | 1661 | Values: 77.0 58.0 64.0 86.0 60.0 60.0 63.0 62.0 84.0 56.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.50 stddev:13.08 (16.5%) stddev-sans-first:13.83 07:09:54 INFO - PROCESS | 1661 | Values: 82.0 68.0 98.0 69.0 77.0 68.0 95.0 69.0 67.0 97.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.50 stddev:1.78 (2.0%) stddev-sans-first:1.79 07:09:54 INFO - PROCESS | 1661 | Values: 88.0 84.0 87.0 86.0 88.0 84.0 88.0 88.0 87.0 84.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:09:54 INFO - PROCESS | 1661 | Values: 93.0 93.0 92.0 93.0 94.0 93.0 93.0 93.0 93.0 92.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:85.00 stddev:18.92 (22.3%) stddev-sans-first:16.13 07:09:54 INFO - PROCESS | 1661 | Values: 126.0 133.0 91.0 85.0 85.0 83.0 84.0 85.0 83.0 85.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.26 (2.4%) stddev-sans-first:1.00 07:09:54 INFO - PROCESS | 1661 | Values: 55.0 52.0 54.0 53.0 52.0 51.0 53.0 53.0 52.0 51.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:3.68 (5.1%) stddev-sans-first:3.43 07:09:54 INFO - PROCESS | 1661 | Values: 66.0 66.0 72.0 79.0 71.0 73.0 72.0 70.0 70.0 71.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:2.15 (2.5%) stddev-sans-first:2.03 07:09:54 INFO - PROCESS | 1661 | Values: 87.0 82.0 83.0 85.0 84.0 85.0 84.0 83.0 81.0 88.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:137.00 stddev:6.93 (5.1%) stddev-sans-first:7.33 07:09:54 INFO - PROCESS | 1661 | Values: 139.0 136.0 138.0 135.0 133.0 137.0 136.0 130.0 156.0 137.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:166.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 07:09:54 INFO - PROCESS | 1661 | Values: 166.0 166.0 166.0 163.0 166.0 167.0 168.0 165.0 164.0 165.0 07:09:54 INFO - PROCESS | 1661 | 07:09:54 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:67.50 stddev:6.92 (10.2%) stddev-sans-first:7.31 07:09:54 INFO - PROCESS | 1661 | Values: 67.0 68.0 68.0 67.0 70.0 61.0 87.0 65.0 66.0 66.0 07:09:54 INFO - PROCESS | 1661 | -------- Summary: end -------- 07:09:54 INFO - PROCESS | 1661 | 07:09:55 INFO - TEST-INFO | 1661: exit 0 07:09:55 INFO - TEST-OK | kraken | took 58887ms 07:09:55 INFO - SUITE-END | took 1175s 07:09:55 INFO - Completed test suite (00:19:36) 07:09:55 INFO - javascript benchmark 07:09:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2498.737632548581, 3371.679690429409, 3379.6620337966206, 3395.422778127718, 3437.415639341312, 5536.363318218406, 5669.971650141749, 5702.515286200673, 5737.082066869301, 5751.4248575142465, 5658.066419040863, 5683.715814209283, 5749.56878234132, 5788.18965344851, 5794.420557944203, 5115.053715062725, 5140.511651393112, 5198.168293073109, 5212.244224587433, 5269.552088072499, 4439.80125366151, 5285.392179899303, 5305.442928492511, 5309.150535914255, 5317.521423071923, 4201.4538110045805, 5128.461511541272, 5179.19722443022, 5206.869828254324, 5221.321228240324, 5179.067767801795, 5201.55786758126, 5222.843314700565, 5300.310959575269, 5320.989012087691, 4291.97854010731, 5234.816781412632, 5251.10731175701, 5279.709615971158, 5288.1803320485005, 4995.150824359831, 5782.624129431616, 5799.652020878761, 5860.677662728548, 5864.7067646617925, 6083.513318934474, 6153.384661533855, 6200.782972595937, 6252.906206406908, 6258.937410625881, 5222.268882356473, 5730.34101078373, 6318.905216421757, 6366.236051673783, 6382.968085159591, 4333.58830911063, 5821.185034095272, 5826.533877289891, 5874.089516125007, 5884.9705751470965, 5314.946850531523, 6226.688665566703, 6291.276503202099, 6294.213223347082, 6362.586431881913, 5204.9219261711105, 5479.123340265538, 6196.132541444202, 6203.906941395882, 6222.81331560054, 6245.75016999324, 6318.778842740482, 6335.334789847, 6337.33457986914, 6350.555461117678, 6102.664353460514, 6109.192117492145, 6151.169592105009, 6218.0, 6241.500679945593, 6214.440700336901, 6298.937010629835, 6315.494760419156, 6315.684215789192, 6316.8420789479715, 5009.89980200394, 5019.648624596243, 5019.7239151847, 5034.496550344937, 5064.037832811754, 4413.933790993137, 4432.069265454291, 4450.888727781831, 4506.707064040893, 4529.162105010583, 5777.653340799566, 5784.1902133701315, 5802.47777700009, 5812.79655212074, 5839.883202335929, 6233.417129203257, 6324.588901721373, 6337.144485494491, 6348.968255158787, 6361.2048493938255, 5623.437656234344, 5684.317881854204, 5696.003199440164, 5766.4233576642, 5802.274715660543, 5465.207544905967, 5468.097763868917, 5470.507654311131, 5519.779208831682, 5524.14375771756, 6323.146375239284, 6325.399087086904, 6326.367363263636, 6328.082428047999, 6339.778107766206, 6149.846253843511, 6222.502199824094, 6278.0, 6333.556651034383, 6365.809025729235, 6276.0, 6313.936860631335, 6325.746970121144, 6327.873442531031, 6337.90493142594, 6258.217722784652, 6269.467095296951, 6270.905936411049, 6274.74901003973, 6277.529185311028, 6145.801568694062, 6189.288231853215, 6324.747010119728, 6342.175517182736, 6344.619322840645, 4994.425641051181, 6156.230471191101, 6160.383961603804, 6168.753249869955, 6170.413810687977, 5960.731767070405, 6100.877982440237, 6153.29237137717, 6159.692015399301, 6162.22972128484, 5776.162456443876, 5877.35349111606, 5971.671558064349, 5996.760129594767, 6033.547483938634, 6097.2988106366565, 6177.135201071764, 6177.980633195472, 6183.721732521957, 6198.256209254918, 5971.3132989705, 5995.940040599538, 5998.25021872266, 6003.519718422603, 6004.159417681441], "value": 5676.01590482051, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.34672844930867, 503.9143345631242, 507.3531247659234, 521.8643152780277, 523.2726510150889, 40178.59821401785, 42043.36934945978, 42257.78871105644, 44185.0, 44215.33676994839, 42965.0, 43439.6968090957, 43469.391836489835, 43470.78264608672, 43597.78201108998, 8656.307495400353, 9673.129418352364, 9859.605615775396, 9867.062629050264, 9871.0, 8698.826023479527, 9940.900590994106, 11635.0, 11868.228565143281, 12183.32991685457, 11889.405529723523, 11960.581379651714, 11968.34174120423, 11996.0, 12053.337066461341, 11862.406879655982, 11914.642560723192, 11923.284602923766, 11934.403279836017, 11939.94030029853, 11870.169088163831, 11939.223950443193, 11959.641210763692, 11960.1627886048, 11980.221285616408, 40869.0, 41177.79411102955, 41189.176216475804, 41189.79405102985, 41274.79362603168, 3422.828858557062, 3468.0, 3473.774204676688, 3509.5963964144194, 3546.942042748263, 31894.202644934063, 32001.51997720036, 32214.0, 32837.6716232837, 32844.1788955278, 3213.1806389370563, 3219.114743445548, 3251.5935508061493, 3350.2461946062185, 3375.881844135468, 500864.0, 501146.0, 502480.99999999633, 503303.0, 503706.0, 33881.0, 62019.0, 62481.062784058275, 62528.0, 62528.68735656293, 34409.96770096851, 35577.46633800495, 35841.28317433689, 35896.74361397338, 35958.8202058988, 14761.557153285205, 14918.4778532753, 14919.179445130621, 14924.104553726811, 14975.176365299796, 11451.54193832254, 11632.243904146204, 12496.875031249752, 12553.748925021631, 12628.558000470122, 7677.270659287359, 7799.883001754978, 7864.4888082274465, 7879.6848126075465, 7896.802579935547, 3199.82400967949, 3240.9675903240664, 3257.7719559631073, 3260.6902344277255, 3271.8854840080485, 957.2389949989774, 992.3847214726916, 1049.6746008737164, 1069.9866748871393, 1113.8329250612474, 29740.851295743814, 30458.54312185319, 30643.846780765954, 30823.0, 31100.84449577783, 1047.779966207105, 1068.631322193842, 1178.5168081086713, 1182.0661677274857, 1185.2829038431796, 14530.05554638945, 15835.287412066486, 15943.840561594468, 15988.600284992735, 16301.592460188353, 188911.0554447219, 190479.0, 191246.04376978305, 191361.0, 191746.0, 59130.0, 59660.70169649124, 59693.40306596965, 59857.102143467884, 59925.0, 1255.3911352993791, 1357.6809449779491, 1385.2935003148466, 1388.02838013389, 1410.9435622574981, 30752.846235768677, 31184.68815311818, 31646.626503012827, 31648.367032659677, 32598.674013259562, 51243.0, 51706.48293517017, 51783.0, 51833.44499664865, 51868.22197666963, 551915.0, 555762.0, 555952.0, 556517.0, 558549.0, 27111.72888271092, 27298.90804367803, 27823.44353112967, 28120.43759124847, 28938.42123157567, 45756.77121614504, 48080.5191948076, 48374.79063023312, 48650.270245945634, 49649.51051468462, 39549.0, 39759.2048159041, 39969.60030399775, 40159.59840401559, 41204.96987575335, 39718.404223936086, 39757.60242397655, 39915.60084399119, 40980.59019409768, 41212.0, 38765.41851872281, 39380.80309598434, 39469.0, 39591.80204098961, 39681.40477892892, 34387.82806085954, 34937.0, 35258.64741352656, 35437.93686189419, 35780.92657220287, 23083.769162308163, 24982.250532484053, 25628.231153065437, 25822.104848009494, 25838.61242081408], "value": 18773.76774623752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.47279081377934, 368.7437231124369, 373.5162963961671, 377.6469001483612, 397.9243943650706, 13388.263645499494, 15599.766003509942, 20370.490737731565, 21024.369268921917, 21144.04851781668, 17374.652506949886, 19948.01299675081, 20153.899230503863, 20706.068226929787, 21011.789882101173, 5751.482366587006, 5791.999999999989, 6043.969780151093, 6058.818235452944, 6088.878222435571, 6582.243042050178, 6670.76652317169, 6708.731650733965, 6765.898511522331, 6785.050092986986, 6379.393957574046, 6525.282218955911, 6613.074169616258, 6614.834629134286, 6651.866962660744, 6377.362263773632, 6580.650966551845, 6628.370304821035, 6631.071649969008, 6658.201015878077, 5761.308642962871, 5764.5676574257095, 5768.509676677488, 5768.711564421762, 5775.740091695884, 13359.53241636538, 22912.281578881484, 24165.637515437105, 25231.0, 26245.606315905276, 2099.9475013124643, 2108.483421561727, 2111.883846388448, 2238.597052530544, 2874.6406699162603, 9981.800363992752, 10037.347572407843, 10133.847992280122, 10364.792704145875, 10379.42913139777, 1629.6659184867074, 1859.7024476083761, 1866.2534986005571, 1922.644310802506, 1956.0415396455776, 107685.46157269164, 112230.0, 127797.36101319527, 128040.99487563962, 128696.0, 11200.495977681025, 11451.312921224753, 11489.885101148882, 11522.76954460906, 11728.354940478355, 14395.928020359832, 14423.197100362455, 14425.0, 14428.134311941318, 14443.566692999228, 6608.0, 8400.243978042006, 8439.451435656663, 8565.828683426296, 8587.785305367415, 8299.29455996247, 8350.164983501601, 8390.958045209734, 8481.109483504266, 8497.320214382835, 4353.825846966086, 4429.645628349725, 4507.5943165115295, 4593.402857628487, 4612.192866248393, 1595.4096984115952, 1836.4949638849423, 1901.9049047547567, 1902.4292712186289, 1904.4572296895594, 803.4054799448367, 851.8509260879322, 937.6062053937362, 944.2776276148752, 952.228694757235, 19936.10287537064, 21048.579028419652, 21072.262470813755, 21082.683759743617, 21631.0, 910.8269428808637, 930.6091441594547, 932.7341707613298, 940.6190492850407, 1021.7598864266891, 10195.28632995698, 10896.237263391486, 10977.859317433024, 11013.339199648046, 11021.559137634405, 542052.0, 583446.0, 588869.0, 594815.0, 603675.0, 92825.53587232021, 112003.87996119935, 119938.4003079979, 129571.0, 132346.0, 996.446971930571, 1005.5726316315537, 1006.5369929832212, 1052.952617132231, 1055.1453322808395, 17575.296988120845, 18644.161012754186, 19287.035648217814, 19335.033248337808, 19349.8065019348, 42344.57655423407, 55276.89446211134, 55321.44678553163, 55360.72319638376, 58085.54786130381, 81667.6916000458, 83426.16573834184, 84805.0, 85042.0, 86444.0, 6574.868502630016, 7815.804604884924, 8067.112617611941, 8132.0, 8275.55177843887, 10679.946600266949, 12727.109102362745, 12822.551210707581, 12995.675108122372, 13079.0, 10287.691369258935, 11075.556977721124, 11194.104471642086, 11253.268537545033, 11313.0, 10762.3542587445, 10822.080123189617, 10853.457327133454, 11210.495527701436, 11233.887661123284, 11094.833577496505, 11180.776384472427, 11332.320060796379, 11487.54049837997, 11557.653270401901, 7402.074740657418, 7782.338501227459, 8039.598020098854, 8243.752687419386, 8258.174182581934, 9635.759106022126, 10070.798584028133, 10637.723473183267, 11047.613333533609, 11125.221234513507], "value": 9542.266648931574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.6391266096136, 1517.7495713207322, 1709.2479309103994, 1844.5480857189991, 1882.3317722208624, 8310.958445207772, 8818.98581663109, 8837.337199710024, 8860.424072435295, 8903.020667726545, 7780.26087521686, 8020.39847011475, 8357.498550086999, 8578.270846978014, 8658.26404755595, 2342.074880422232, 2363.610004349289, 2366.3965688749345, 2370.466645004877, 2373.750756170603, 2330.277613939684, 2347.6595893595418, 2375.904963801446, 2376.7979721723586, 2378.3935096550354, 2322.4658328584437, 2347.4248809041724, 2352.5647755165264, 2358.5636657218383, 2361.6457531370347, 1946.347973428903, 2329.638905969569, 2329.755375685554, 2333.0, 2348.7768661977084, 2326.4881726020417, 2326.674265602817, 2326.6975293211945, 2327.325075728037, 2329.46422322865, 8737.0, 8778.429402088845, 8841.16008979146, 8841.690540831105, 8859.468431894107, 5161.406438259573, 5309.62832601718, 5316.255724198615, 5318.202269659543, 5327.520523152934, 3441.4321636929876, 3484.6515348465205, 3628.147385364464, 3632.8183590820618, 3646.4712616670436, 1027.1166796554958, 1064.6220591689994, 1066.978660426795, 1079.320028382122, 1081.9945900270527, 9333.906660933371, 11364.829527557093, 11474.254173478697, 11483.942580287045, 11488.425578721031, 4457.710248833815, 4561.156186105581, 4710.36410084641, 4727.456342520585, 4734.455537613149, 9756.02439756033, 9763.755906102404, 9778.97320781322, 9780.657676981271, 9794.95102524497, 5249.028929648028, 5267.868303292448, 5276.287701160371, 5277.182036784305, 5277.4986376294955, 4074.780101216308, 4356.629686476622, 4494.640428765691, 4519.81920723174, 4857.0, 2990.2524368907775, 3630.655087766711, 3728.7762734236035, 3729.4778730977687, 3964.682825373963, 1255.811628255769, 1262.741138066694, 1271.7392934448417, 1277.508159358635, 1279.4306533592649, 877.9780505487286, 908.68650315641, 916.3814425262921, 939.4645052320112, 946.532367226689, 5804.506616937608, 5971.701414929236, 6056.6971651418135, 6104.877902441926, 6238.438540531283, 889.7241855024963, 899.9415038022507, 904.1230006893435, 943.528235882059, 966.8598053282235, 3488.5639295088113, 3634.5638523376833, 3747.4004159334377, 3917.4515567820526, 3952.940705889414, 10411.895881041093, 10603.469826508644, 10703.464826758787, 10706.304090234265, 10706.732331691614, 10644.680659580225, 10657.946710266398, 10661.893381066246, 10678.359298442118, 10771.730706732238, 7695.538267703956, 8032.357411407191, 8067.3142782864115, 8068.717594884269, 8177.977752780902, 5844.240248767633, 5920.970395147997, 5969.791057312973, 6057.57596968208, 6094.3600921904335, 9886.4562449066, 10141.797164056825, 10148.289619726844, 10148.441835699108, 10188.490575471049, 9234.26125909939, 9894.0, 10230.846537302095, 10233.334833235816, 10242.743931401774, 6985.057017302803, 7304.744333948286, 7431.925680743123, 7556.319931206218, 7645.311921927053, 8160.224778646019, 8193.959030204811, 8232.547209903512, 8251.33989280844, 8345.707900223462, 7374.778756637309, 7409.925900741139, 7442.144153422426, 7456.2170972049325, 7510.399168066432, 7252.238514955854, 7404.92595074064, 7415.369693575891, 7462.888056679046, 7466.738664146729, 6798.830029249309, 6824.863502730017, 6991.287134652042, 6991.44068474531, 6997.300269973166, 4886.828960986349, 5077.365329333833, 5121.334226550524, 5157.252198431282, 5331.680099194061, 5090.745462726774, 5125.692458452505, 5212.765425555784, 5220.504052115043, 5356.839294821161], "value": 4557.873137852595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.44378013115477, 298.8356403977812, 310.08988618404976, 312.35342840320544, 318.6049298869403, 4112.81492332845, 4820.46974832769, 5333.919991200135, 5338.6796792192445, 5398.2982212312445, 4808.543188397105, 4896.730679812609, 4979.900401991967, 5141.82003629873, 5218.6346955713025, 3637.7813432500143, 3784.413415920537, 3960.7029472789586, 3986.2625414298304, 4007.73949693269, 3623.275344931011, 3974.403839424095, 4032.5564187939303, 4038.798060096998, 4038.798060096998, 2770.1301621405573, 3722.7394082414244, 3960.643542081212, 3961.247363001035, 3985.8804235872826, 3590.910227244314, 3803.4215800442785, 3809.666616684166, 3934.2721596504452, 3959.8418861720143, 2952.822830630169, 3009.2627306310096, 3484.3902317094407, 3492.6507349265125, 3498.807565583892, 4471.39636149119, 4629.8148074077, 4888.315635810989, 5037.5718063964605, 5054.368203974504, 4481.977590112028, 4491.371208030879, 4511.684182107254, 4532.614727748145, 4563.361129441881, 5075.0611136939415, 5445.673259604437, 5464.63924686315, 5509.944900551023, 5531.363893152299, 3255.7720959532603, 3320.7509436792097, 3794.4687743715904, 3861.3049651062797, 3871.399933010388, 4643.605293550052, 5074.188129899198, 5261.947380526222, 5706.9429305707245, 5780.306363236438, 3761.5298087739034, 3785.0, 3787.696984241254, 3790.77255364679, 3829.368154254517, 3833.674137698327, 3839.308924393636, 3843.577206507282, 3843.8462461501226, 3855.094052897567, 3994.121293315466, 4179.91640167195, 4471.977640111843, 4486.484054333793, 4491.944393067626, 5087.09234037236, 5467.9453205468235, 5521.420250873681, 5523.575383262403, 5524.475174858382, 1155.6879642496478, 1269.8793614606598, 1333.1001573937747, 1333.5066025570407, 1340.2762508245632, 796.4345314826538, 804.1757198871087, 830.2320353672949, 835.5070508400073, 848.8132610825609, 4051.534073581517, 4192.0, 4239.448871646666, 5020.046191223656, 5129.0, 4759.904801903943, 5600.85997850057, 5670.914936275959, 5673.375928647845, 5739.942600574024, 4609.446866376056, 4942.950570494321, 5038.546530812245, 5139.563137133386, 5200.843974680765, 2591.740825917393, 2619.698734645502, 2931.4869897767803, 2944.2492164497917, 2968.85155742212, 4775.913651960651, 5682.516986056149, 5749.332693518916, 5764.365919748824, 5805.854853628609, 4404.867853964386, 5377.489138531833, 5491.395946445888, 5575.804846830341, 5800.303963524319, 5162.7351298932, 5266.868328291824, 5753.913691294634, 5776.566757493205, 5878.441548052928, 4302.462192225972, 5266.0, 5549.694766787866, 5555.194496797861, 5590.301212348457, 4918.975405122951, 5615.57449955535, 5650.717464126859, 5658.745356458887, 5662.66024038559, 5853.765849366148, 5894.528437724886, 5916.26046744157, 5963.671998040149, 5985.551083668829, 3369.679880411357, 3568.3755342814384, 3793.1465420280215, 3846.538415390171, 3859.2088621831895, 4657.4411070670385, 5642.266505354278, 5643.109558297852, 5667.3482549507335, 5733.856653583527, 4856.732879691651, 4967.03142887148, 5427.0, 5573.749181286933, 5582.804601838916, 5160.974195129001, 5457.399686034612, 5496.890062198813, 5570.4151064139305, 5590.916136258041, 4884.9741554274, 5163.251328557263, 5489.807856724996, 5496.835094947158, 5508.108243172366, 4589.9541004590865, 5229.764660590206, 5340.973295133499, 5453.863653408696, 5579.8884022320135, 4561.863144105682, 4614.377059096979, 5058.519440653132, 5140.665856719302, 5479.424660410759], "value": 3967.227943412806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.4140902483255, 708.3907839258237, 766.4443278622999, 781.3592853859838, 817.1624085312554, 15410.152441615706, 16460.25928833201, 16474.505764827045, 16477.25852336646, 16582.502524924243, 14571.97996140268, 14588.051776634538, 14762.704745905075, 14770.261486925665, 14783.113013219188, 654.116942128128, 681.8465845184843, 700.9088818453606, 820.7250571058703, 850.642730053376, 825.7192554531458, 829.7552222094497, 833.6665333866441, 835.3776436554775, 840.3487297344576, 895.8208358328328, 895.9920089898864, 897.1432282170512, 898.5956319656149, 899.3120262998812, 891.2602539891874, 891.7146513115806, 892.0455113029061, 893.0622846011662, 893.7363477774072, 438.5022998896244, 516.3803435876926, 650.5056157320423, 667.5293917787948, 670.936261055199, 15115.244237788067, 15125.924370378189, 15144.924275378553, 15170.469033583771, 15254.08475491474, 12902.0, 13129.540466083641, 13250.536231231861, 13389.531366402129, 13683.24742139182, 12198.268103913793, 12600.4329805159, 12905.161164524276, 13096.738065238642, 13231.933840330834, 4377.34339849022, 4434.844780432702, 4460.620847227957, 4490.865274041784, 4622.6070783983405, 90877.0, 114114.0, 114914.0, 115217.0, 115885.0, 10162.23783216247, 10221.846672299922, 10295.794084118275, 10328.896711032794, 10368.585256589651, 19159.042047897827, 19184.424467266006, 19199.040047997543, 19199.32802351911, 19221.13504892283, 7607.087149542091, 7637.4653774236385, 7660.846783064308, 7859.567723775247, 7868.960655196687, 4393.846215382447, 4406.427164468599, 4432.978887963044, 4521.66087543429, 4545.136424079415, 3346.849391777376, 3466.2547552276383, 3469.531613232232, 3470.687638112582, 3475.7740746851878, 678.1455366238575, 681.7409384433982, 686.2382755141789, 696.3489137656308, 714.731975509184, 594.7115648910275, 667.5393978155057, 693.8863124684909, 695.6104581434413, 700.6496751624188, 9670.806583868423, 9722.465264410524, 9741.220702343795, 9768.0, 9810.313278070467, 647.6567419267795, 663.3631713554945, 686.5983399711225, 689.4759982413302, 695.5027155583782, 3870.628816112955, 4415.4259946206785, 4431.933520997188, 4648.58162765346, 4682.6253899687945, 93716.0, 105647.0, 139197.0, 146553.5344646561, 150555.0, 88774.0, 139041.0, 140941.99999999796, 141146.29426853007, 141398.0, 97962.0, 118958.0, 120106.0, 120122.3993880025, 121219.39390303168, 8948.418352807306, 8949.686760963335, 9011.954940225258, 9065.184133428023, 9113.04313047147, 55719.72140139274, 61168.082478761964, 62240.066399003146, 62477.37522624715, 64136.67931660312, 76919.0, 93998.53000734953, 98069.50965245128, 98410.5079474598, 104849.0, 11830.82253766177, 11884.168108232341, 12085.0, 12108.818367724667, 12343.321117338633, 13364.398602063126, 13525.864741352854, 13568.457261709422, 13771.931140344233, 14131.222782747047, 12224.899838843954, 12353.505859765508, 12489.625311240678, 12507.749845002867, 12723.80914286268, 12189.207701499374, 12387.706387488428, 12506.499740010298, 12819.230846149261, 12932.0, 12070.74201464388, 12341.50633974631, 12348.876511235132, 12359.50561977511, 12716.618501444971, 10374.533146008598, 10487.318324308895, 10494.842577361498, 10666.520006599876, 10835.133189344991, 10130.189584833342, 10263.076323130954, 10269.640562580274, 10285.53715082838, 10317.845232321672], "value": 7673.802888399228, "unit": "score"}], "name": "dromaeo_css", "value": 7215.370932934079, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 110.0, 110.0, 111.0, 109.0, 111.0, 111.0, 110.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 106.0, 109.0, 164.0, 103.0, 106.0, 128.0, 108.0, 141.0, 107.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 180.0, 183.0, 179.0, 182.0, 182.0, 185.0, 203.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 64.0, 86.0, 60.0, 60.0, 63.0, 62.0, 84.0, 56.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 68.0, 98.0, 69.0, 77.0, 68.0, 95.0, 69.0, 67.0, 97.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 86.0, 88.0, 84.0, 88.0, 88.0, 87.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 91.0, 85.0, 85.0, 83.0, 84.0, 85.0, 83.0, 85.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 53.0, 52.0, 51.0, 53.0, 53.0, 52.0, 51.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 72.0, 79.0, 71.0, 73.0, 72.0, 70.0, 70.0, 71.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 83.0, 85.0, 84.0, 85.0, 84.0, 83.0, 81.0, 88.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 138.0, 135.0, 133.0, 137.0, 136.0, 130.0, 156.0, 137.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 166.0, 163.0, 166.0, 167.0, 168.0, 165.0, 164.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 70.0, 61.0, 87.0, 65.0, 66.0, 66.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1413.8, "alertThreshold": 2.0}]} 07:09:55 INFO - Return code: 0 07:09:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:09:55 INFO - # TBPL SUCCESS # 07:09:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:09:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:09:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:09:55 INFO - 2016-08-10 07:09:55.539 screenresolution[1665:9733] starting screenresolution argv=screenresolution get 07:09:55 INFO - 2016-08-10 07:09:55.542 screenresolution[1665:9733] Display 0: 1600x1200x32@60 07:09:55 INFO - 2016-08-10 07:09:55.548 screenresolution[1666:9736] starting screenresolution argv=screenresolution list 07:09:55 INFO - Available Modes on Display 0 07:09:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:09:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:09:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:09:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:09:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:09:55 INFO - Intel Iris: 07:09:55 INFO - Chipset Model: Intel Iris 07:09:55 INFO - Type: GPU 07:09:55 INFO - Bus: Built-In 07:09:55 INFO - VRAM (Dynamic, Max): 1536 MB 07:09:55 INFO - Vendor: Intel (0x8086) 07:09:55 INFO - Device ID: 0x0a2e 07:09:55 INFO - Revision ID: 0x0009 07:09:55 INFO - Displays: 07:09:55 INFO - Display: 07:09:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:09:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:09:55 INFO - Display Serial Number: 1600x1200 60 07:09:55 INFO - Main Display: Yes 07:09:55 INFO - Mirror: Off 07:09:55 INFO - Online: Yes 07:09:55 INFO - Rotation: Supported 07:09:55 INFO - Return code: 0 07:09:55 INFO - Running post-action listener: _resource_record_post_action 07:09:55 INFO - [mozharness: 2016-08-10 14:09:55.782755Z] Finished run-tests step (success) 07:09:55 INFO - Running post-run listener: _resource_record_post_run 07:09:55 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 37082112; Write bytes: 700308480; Read time: 242; Write time: 1970 07:09:55 INFO - TinderboxPrint: CPU usage
53.4% 07:09:55 INFO - TinderboxPrint: I/O read bytes / time
37,082,112 / 242 07:09:55 INFO - TinderboxPrint: I/O write bytes / time
700,308,480 / 1,970 07:09:55 INFO - TinderboxPrint: CPU idle
2,258.9 (46.6%) 07:09:55 INFO - TinderboxPrint: CPU system
967.1 (20.0%) 07:09:55 INFO - TinderboxPrint: CPU user
1,619.6 (33.4%) 07:09:55 INFO - TinderboxPrint: Swap in / out
440,483,840 / 0 07:09:55 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392798720; Write bytes: 386098688; Read time: 29774; Write time: 804 07:09:55 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35177472; Write bytes: 294282752; Read time: 223; Write time: 1114 07:09:56 INFO - Running post-run listener: _upload_blobber_files 07:09:56 INFO - Blob upload gear active. 07:09:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:09:56 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 07:09:56 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:09:56 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:09:56 INFO - (blobuploader) - INFO - Open directory for files ... 07:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:09:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:09:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:09:57 INFO - (blobuploader) - INFO - Done attempting. 07:09:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:09:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:09:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:09:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:09:58 INFO - (blobuploader) - INFO - Done attempting. 07:09:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:09:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:10:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:01 INFO - (blobuploader) - INFO - Done attempting. 07:10:01 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:01 INFO - Return code: 0 07:10:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:10:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f3bcb8fb4e12e01920d78c6cbeca80bd0408c583c5d95bfdc38b2a098dfdfc3124eb51a6bed0e02b1f2688be9564606c609f8f11dcc78d02043d86517929386", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/38d2483ae3ae6b7935449b3c7ab6a706f131b67c77e4d0f90ba2bb47a3c38e8e3f7d80726df591f9f3e741ed88e08e618db9f6fd61720de4445bcd867dd572d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/957e3e64493411ac5d02a9deda8e2ca632e012b0a32a8e055a8de03649f478aa7bf41de701562d059ee130d3cda318241b5cec53e07894bf570aaf1317dfe990"} 07:10:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:10:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:10:01 INFO - Contents: 07:10:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f3bcb8fb4e12e01920d78c6cbeca80bd0408c583c5d95bfdc38b2a098dfdfc3124eb51a6bed0e02b1f2688be9564606c609f8f11dcc78d02043d86517929386", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/38d2483ae3ae6b7935449b3c7ab6a706f131b67c77e4d0f90ba2bb47a3c38e8e3f7d80726df591f9f3e741ed88e08e618db9f6fd61720de4445bcd867dd572d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/957e3e64493411ac5d02a9deda8e2ca632e012b0a32a8e055a8de03649f478aa7bf41de701562d059ee130d3cda318241b5cec53e07894bf570aaf1317dfe990"} 07:10:01 INFO - Running post-run listener: copy_logs_to_upload_dir 07:10:01 INFO - Copying logs to upload dir... 07:10:01 INFO - mkdir: /builds/slave/test/build/upload/logs 07:10:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.170746 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-10 07:10:01.430100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 07:10:01.433316) ========= 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.6YMB8W5u3O/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.E3sToBV0nA/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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/Autoland/sha512/0f3bcb8fb4e12e01920d78c6cbeca80bd0408c583c5d95bfdc38b2a098dfdfc3124eb51a6bed0e02b1f2688be9564606c609f8f11dcc78d02043d86517929386", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/38d2483ae3ae6b7935449b3c7ab6a706f131b67c77e4d0f90ba2bb47a3c38e8e3f7d80726df591f9f3e741ed88e08e618db9f6fd61720de4445bcd867dd572d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/957e3e64493411ac5d02a9deda8e2ca632e012b0a32a8e055a8de03649f478aa7bf41de701562d059ee130d3cda318241b5cec53e07894bf570aaf1317dfe990"} build_url:https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011008 build_url: 'https://queue.taskcluster.net/v1/task/CjHT4os_Teij4BkfU8ow9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f3bcb8fb4e12e01920d78c6cbeca80bd0408c583c5d95bfdc38b2a098dfdfc3124eb51a6bed0e02b1f2688be9564606c609f8f11dcc78d02043d86517929386", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/38d2483ae3ae6b7935449b3c7ab6a706f131b67c77e4d0f90ba2bb47a3c38e8e3f7d80726df591f9f3e741ed88e08e618db9f6fd61720de4445bcd867dd572d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/957e3e64493411ac5d02a9deda8e2ca632e012b0a32a8e055a8de03649f478aa7bf41de701562d059ee130d3cda318241b5cec53e07894bf570aaf1317dfe990"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 07:10:01.468092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 07:10:01.468522) ========= 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.6YMB8W5u3O/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.E3sToBV0nA/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.005074 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 07:10:01.518000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 07:10:01.518316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 07:10:01.518923) ========= ========= Total master_lag: 0.19 =========