builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0309 starttime: 1470703063.86 results: success (0) buildid: 20160808152620 builduid: 98d28b3402b347d2bcfb23e2da750f1f revision: 2a61cb431fae12a02397638eff64d87b492d5e83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:43.865699) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:43.866076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:43.866380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:43.955149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:43.955484) ========= 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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-08 17:37:43-- 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% 145M=0s 2016-08-08 17:37:44 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149745 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:44.165261) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:44.165801) ========= 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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.020660 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:44.359891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 17:37:44.360199) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2a61cb431fae12a02397638eff64d87b492d5e83 --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 2a61cb431fae12a02397638eff64d87b492d5e83 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OAx9nt42Vt/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.NHIhLQOG8m/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-08 17:37:44,448 truncating revision to first 12 chars 2016-08-08 17:37:44,448 Setting DEBUG logging. 2016-08-08 17:37:44,448 attempt 1/10 2016-08-08 17:37:44,448 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2a61cb431fae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 17:37:45,770 unpacking tar archive at: autoland-2a61cb431fae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581832 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 17:37:45.972727) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:45.973074) ========= script_repo_revision: 2a61cb431fae12a02397638eff64d87b492d5e83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:45.973524) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:45.973835) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 17:37:45.992473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-08 17:37:45.992793) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:37:46 INFO - MultiFileLogger online at 20160808 17:37:46 in /builds/slave/test 17:37:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 17:37:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:37:46 INFO - {'append_to_log': False, 17:37:46 INFO - 'base_work_dir': '/builds/slave/test', 17:37:46 INFO - 'blob_upload_branch': 'Autoland', 17:37:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:37:46 INFO - 'branch': 'Autoland', 17:37:46 INFO - 'buildbot_json_path': 'buildprops.json', 17:37:46 INFO - 'config_files': ('talos/mac_config.py',), 17:37:46 INFO - 'default_actions': ('clobber', 17:37:46 INFO - 'read-buildbot-config', 17:37:46 INFO - 'download-and-extract', 17:37:46 INFO - 'populate-webroot', 17:37:46 INFO - 'create-virtualenv', 17:37:46 INFO - 'install', 17:37:46 INFO - 'run-tests'), 17:37:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:37:46 INFO - 'download_minidump_stackwalk': True, 17:37:46 INFO - 'download_symbols': 'ondemand', 17:37:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:37:46 INFO - 'tooltool.py': '/tools/tooltool.py', 17:37:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:37:46 INFO - '/tools/misc-python/virtualenv.py')}, 17:37:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:37:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:37:46 INFO - 'installer_path': 'installer.exe', 17:37:46 INFO - 'log_level': 'info', 17:37:46 INFO - 'log_name': 'talos', 17:37:46 INFO - 'log_to_console': True, 17:37:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:37:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:37:46 INFO - 'opt_config_files': (), 17:37:46 INFO - 'pip_index': False, 17:37:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:46 INFO - 'cmd': ('bash', 17:37:46 INFO - '-c', 17:37:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:46 INFO - 'enabled': True, 17:37:46 INFO - 'halt_on_failure': False, 17:37:46 INFO - 'name': 'check_screen_resolution'},), 17:37:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:46 INFO - 'cmd': ('bash', 17:37:46 INFO - '-c', 17:37:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:46 INFO - 'enabled': True, 17:37:46 INFO - 'halt_on_failure': False, 17:37:46 INFO - 'name': 'check_screen_resolution'},), 17:37:46 INFO - 'run_cmd_checks_enabled': True, 17:37:46 INFO - 'sps_profile': False, 17:37:46 INFO - 'sps_profile_interval': 0, 17:37:46 INFO - 'suite': 'dromaeojs-e10s', 17:37:46 INFO - 'system_bits': '32', 17:37:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:37:46 INFO - 'title': 't-yosemite-r7-0309', 17:37:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:37:46 INFO - 'use_talos_json': True, 17:37:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:37:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:37:46 INFO - 'work_dir': 'build'} 17:37:46 INFO - [mozharness: 2016-08-09 00:37:46.186146Z] Running clobber step. 17:37:46 INFO - Running pre-action listener: _resource_record_pre_action 17:37:46 INFO - Running main action method: clobber 17:37:46 INFO - rmtree: /builds/slave/test/build 17:37:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:37:47 INFO - Running post-action listener: _resource_record_post_action 17:37:47 INFO - [mozharness: 2016-08-09 00:37:47.692688Z] Finished clobber step (success) 17:37:47 INFO - [mozharness: 2016-08-09 00:37:47.692845Z] Running read-buildbot-config step. 17:37:47 INFO - Running pre-action listener: _resource_record_pre_action 17:37:47 INFO - Running main action method: read_buildbot_config 17:37:47 INFO - Using buildbot properties: 17:37:47 INFO - { 17:37:47 INFO - "project": "", 17:37:47 INFO - "product": "firefox", 17:37:47 INFO - "script_repo_revision": "production", 17:37:47 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 17:37:47 INFO - "repository": "", 17:37:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 17:37:47 INFO - "buildid": "20160808152620", 17:37:47 INFO - "pgo_build": "False", 17:37:47 INFO - "basedir": "/builds/slave/test", 17:37:47 INFO - "buildnumber": 120, 17:37:47 INFO - "slavename": "t-yosemite-r7-0309", 17:37:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:37:47 INFO - "platform": "yosemite_r7", 17:37:47 INFO - "scheduler": "tests-autoland-macosx64-talos", 17:37:47 INFO - "branch": "autoland", 17:37:47 INFO - "repo_path": "integration/autoland", 17:37:47 INFO - "revision": "2a61cb431fae12a02397638eff64d87b492d5e83", 17:37:47 INFO - "stage_platform": "macosx64", 17:37:47 INFO - "builduid": "98d28b3402b347d2bcfb23e2da750f1f", 17:37:47 INFO - "slavebuilddir": "test" 17:37:47 INFO - } 17:37:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:37:47 INFO - Running post-action listener: _resource_record_post_action 17:37:47 INFO - [mozharness: 2016-08-09 00:37:47.696149Z] Finished read-buildbot-config step (success) 17:37:47 INFO - [mozharness: 2016-08-09 00:37:47.696262Z] Running download-and-extract step. 17:37:47 INFO - Running pre-action listener: _resource_record_pre_action 17:37:47 INFO - Running main action method: download_and_extract 17:37:47 INFO - mkdir: /builds/slave/test/build/tests 17:37:47 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')]} 17:37:47 INFO - trying https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:37:47 INFO - Downloading https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/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 17:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/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 17:37:48 INFO - Downloaded 1199 bytes. 17:37:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:37:48 INFO - Using the following test package requirements: 17:37:48 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:37:48 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:37:48 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:37:48 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:37:48 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:37:48 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:37:48 INFO - u'jsshell-mac.zip'], 17:37:48 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:37:48 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:37:48 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:37:48 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:37:48 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:37:48 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:37:48 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:37:48 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:37:48 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:37:48 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:37:48 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:37:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:37:48 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')]} 17:37:48 INFO - trying https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:37:48 INFO - Downloading https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/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 17:37:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/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 17:37:49 INFO - Downloaded 16324570 bytes. 17:37:49 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'] 17:37:49 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 17:37:52 INFO - Return code: 0 17:37:52 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 17:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:52 INFO - trying https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:37:52 INFO - Downloading https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/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 17:37:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/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 17:37:53 INFO - Downloaded 16324570 bytes. 17:37:53 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'] 17:37:53 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 17:37:57 INFO - Return code: 0 17:37:57 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')]} 17:37:57 INFO - trying https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:37:57 INFO - Downloading https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/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 17:37:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/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 17:37:58 INFO - Downloaded 14413723 bytes. 17:37:58 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'] 17:37:58 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 17:37:58 INFO - Return code: 0 17:37: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')]} 17:37:58 INFO - trying https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:37:58 INFO - Downloading https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:37:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/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 17:38:02 INFO - Downloaded 111982259 bytes. 17:38:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:38:02 INFO - mkdir: /builds/slave/test/properties 17:38:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:38:02 INFO - Writing to file /builds/slave/test/properties/build_url 17:38:02 INFO - Contents: 17:38:02 INFO - build_url:https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:38:04 INFO - Running post-action listener: _resource_record_post_action 17:38:04 INFO - Running post-action listener: set_extra_try_arguments 17:38:04 INFO - [mozharness: 2016-08-09 00:38:04.034740Z] Finished download-and-extract step (success) 17:38:04 INFO - [mozharness: 2016-08-09 00:38:04.034866Z] Running populate-webroot step. 17:38:04 INFO - Running pre-action listener: _resource_record_pre_action 17:38:04 INFO - Running main action method: populate_webroot 17:38:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:38:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:38:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:38:04 INFO - '--tppagecycles', 17:38:04 INFO - '7'], 17:38:04 INFO - 'tests': ['tsvgm']}}, 17:38:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:38:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:38:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:38:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:38:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:04 INFO - 'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:04 INFO - 'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['damp', 'tps']}, 17:38:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:04 INFO - 'tests': ['damp', 'tps']}, 17:38:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['dromaeo_dom']}, 17:38:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:38:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['basic_compositor_video']}, 17:38:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:38:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['a11yr', 17:38:04 INFO - 'ts_paint', 17:38:04 INFO - 'tpaint', 17:38:04 INFO - 'sessionrestore', 17:38:04 INFO - 'sessionrestore_no_auto_restore', 17:38:04 INFO - 'tabpaint']}, 17:38:04 INFO - 'other-e10s': {'tests': ['a11yr', 17:38:04 INFO - 'ts_paint', 17:38:04 INFO - 'tpaint', 17:38:04 INFO - 'sessionrestore', 17:38:04 INFO - 'sessionrestore_no_auto_restore', 17:38:04 INFO - 'tabpaint']}, 17:38:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:38:04 INFO - 'ts_paint', 17:38:04 INFO - 'tpaint', 17:38:04 INFO - 'sessionrestore', 17:38:04 INFO - 'sessionrestore_no_auto_restore', 17:38:04 INFO - 'tabpaint']}, 17:38:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:38:04 INFO - 'ts_paint', 17:38:04 INFO - 'tpaint', 17:38:04 INFO - 'sessionrestore', 17:38:04 INFO - 'sessionrestore_no_auto_restore', 17:38:04 INFO - 'tabpaint']}, 17:38:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['a11yr', 17:38:04 INFO - 'ts_paint', 17:38:04 INFO - 'tpaint', 17:38:04 INFO - 'sessionrestore', 17:38:04 INFO - 'sessionrestore_no_auto_restore', 17:38:04 INFO - 'tabpaint']}, 17:38:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['a11yr', 17:38:04 INFO - 'ts_paint', 17:38:04 INFO - 'tpaint', 17:38:04 INFO - 'sessionrestore', 17:38:04 INFO - 'sessionrestore_no_auto_restore', 17:38:04 INFO - 'tabpaint']}, 17:38:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['tsvgx', 17:38:04 INFO - 'tsvgr_opacity', 17:38:04 INFO - 'tart', 17:38:04 INFO - 'tscrollx', 17:38:04 INFO - 'cart']}, 17:38:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:38:04 INFO - 'tsvgr_opacity', 17:38:04 INFO - 'tart', 17:38:04 INFO - 'tscrollx', 17:38:04 INFO - 'cart']}, 17:38:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:04 INFO - 'talos_options': ['--disable-e10s'], 17:38:04 INFO - 'tests': ['tp5o']}, 17:38:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:04 INFO - 'tests': ['tp5o']}, 17:38:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:04 INFO - 'talos_options': ['--disable-e10s', 17:38:04 INFO - '--xperf_path', 17:38:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:04 INFO - 'tests': ['tp5n']}, 17:38:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:04 INFO - 'talos_options': ['--xperf_path', 17:38:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:04 INFO - 'tests': ['tp5n']}}, 17:38:04 INFO - 'talos.zip': {'path': '', 17:38:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:38:04 INFO - Running post-action listener: _resource_record_post_action 17:38:04 INFO - [mozharness: 2016-08-09 00:38:04.054006Z] Finished populate-webroot step (success) 17:38:04 INFO - [mozharness: 2016-08-09 00:38:04.054125Z] Running create-virtualenv step. 17:38:04 INFO - Running pre-action listener: _resource_record_pre_action 17:38:04 INFO - Running main action method: create_virtualenv 17:38:04 INFO - Creating virtualenv /builds/slave/test/build/venv 17:38:04 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 17:38:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:38:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:38:04 INFO - Using real prefix '/tools/python27' 17:38:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:38:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:38:07 INFO - Installing pip.................done. 17:38:07 INFO - Return code: 0 17:38:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:07 INFO - 'HOME': '/Users/cltbld', 17:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:07 INFO - 'LOGNAME': 'cltbld', 17:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:07 INFO - 'MOZ_NO_REMOTE': '1', 17:38:07 INFO - 'NO_EM_RESTART': '1', 17:38:07 INFO - 'PAGER': '/bin/cat', 17:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:07 INFO - 'PWD': '/builds/slave/test', 17:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:07 INFO - 'SHELL': '/bin/bash', 17:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:07 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:07 INFO - 'USER': 'cltbld', 17:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:07 INFO - 'XPC_FLAGS': '0x0', 17:38:07 INFO - 'XPC_SERVICE_NAME': '0', 17:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:08 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 17:38:08 INFO - Cleaning up... 17:38:08 INFO - Return code: 0 17:38:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:38: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')]} 17:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38: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')]} 17:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:08 INFO - 'HOME': '/Users/cltbld', 17:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:08 INFO - 'LOGNAME': 'cltbld', 17:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:08 INFO - 'MOZ_NO_REMOTE': '1', 17:38:08 INFO - 'NO_EM_RESTART': '1', 17:38:08 INFO - 'PAGER': '/bin/cat', 17:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:08 INFO - 'PWD': '/builds/slave/test', 17:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:08 INFO - 'SHELL': '/bin/bash', 17:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:08 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:08 INFO - 'USER': 'cltbld', 17:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:08 INFO - 'XPC_FLAGS': '0x0', 17:38:08 INFO - 'XPC_SERVICE_NAME': '0', 17:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:08 INFO - Downloading/unpacking psutil>=3.1.1 17:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:38:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:11 INFO - Installing collected packages: psutil 17:38:11 INFO - Running setup.py install for psutil 17:38:12 INFO - building 'psutil._psutil_osx' extension 17:38:12 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 17:38:12 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 17:38:12 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 17:38:12 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 17:38:12 INFO - building 'psutil._psutil_posix' extension 17:38:12 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 17:38:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:38:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:38:12 INFO - ^ 17:38:12 INFO - 1 warning generated. 17:38:12 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 17:38:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:12 INFO - Successfully installed psutil 17:38:12 INFO - Cleaning up... 17:38:12 INFO - Return code: 0 17:38:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:12 INFO - 'HOME': '/Users/cltbld', 17:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:12 INFO - 'LOGNAME': 'cltbld', 17:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:12 INFO - 'MOZ_NO_REMOTE': '1', 17:38:12 INFO - 'NO_EM_RESTART': '1', 17:38:12 INFO - 'PAGER': '/bin/cat', 17:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:12 INFO - 'PWD': '/builds/slave/test', 17:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:12 INFO - 'SHELL': '/bin/bash', 17:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:12 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:12 INFO - 'USER': 'cltbld', 17:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:12 INFO - 'XPC_FLAGS': '0x0', 17:38:12 INFO - 'XPC_SERVICE_NAME': '0', 17:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:38:13 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 17:38:13 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 17:38:13 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 17:38:13 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 17:38:13 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 17:38:13 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 17:38:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:38:15 INFO - Installing collected packages: mozsystemmonitor 17:38:15 INFO - Running setup.py install for mozsystemmonitor 17:38:15 INFO - Successfully installed mozsystemmonitor 17:38:15 INFO - Cleaning up... 17:38:15 INFO - Return code: 0 17:38:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:38:15 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')]} 17:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:15 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')]} 17:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:15 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 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:15 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 17:38:15 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 17:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:15 INFO - 'HOME': '/Users/cltbld', 17:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:15 INFO - 'LOGNAME': 'cltbld', 17:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:15 INFO - 'MOZ_NO_REMOTE': '1', 17:38:15 INFO - 'NO_EM_RESTART': '1', 17:38:15 INFO - 'PAGER': '/bin/cat', 17:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:15 INFO - 'PWD': '/builds/slave/test', 17:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:15 INFO - 'SHELL': '/bin/bash', 17:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:15 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:15 INFO - 'USER': 'cltbld', 17:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:15 INFO - 'XPC_FLAGS': '0x0', 17:38:15 INFO - 'XPC_SERVICE_NAME': '0', 17:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:16 INFO - Downloading/unpacking jsonschema==2.5.1 17:38:16 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 17:38:16 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 17:38:16 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 17:38:16 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 17:38:16 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 17:38:16 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 17:38:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:38:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:38:18 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 17:38:18 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 17:38:18 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 17:38:18 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 17:38:18 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 17:38:18 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 17:38:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:38:19 INFO - warning: no files found matching '*.txt' 17:38:19 INFO - no previously-included directories found matching 'build' 17:38:19 INFO - no previously-included directories found matching 'dist' 17:38:19 INFO - no previously-included directories found matching '.git*' 17:38:19 INFO - Installing collected packages: jsonschema, functools32 17:38:19 INFO - Running setup.py install for functools32 17:38:19 INFO - warning: no files found matching '*.txt' 17:38:19 INFO - no previously-included directories found matching 'build' 17:38:19 INFO - no previously-included directories found matching 'dist' 17:38:19 INFO - no previously-included directories found matching '.git*' 17:38:19 INFO - Successfully installed jsonschema functools32 17:38:19 INFO - Cleaning up... 17:38:19 INFO - Return code: 0 17:38:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:19 INFO - 'HOME': '/Users/cltbld', 17:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:19 INFO - 'LOGNAME': 'cltbld', 17:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:19 INFO - 'MOZ_NO_REMOTE': '1', 17:38:19 INFO - 'NO_EM_RESTART': '1', 17:38:19 INFO - 'PAGER': '/bin/cat', 17:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:19 INFO - 'PWD': '/builds/slave/test', 17:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:19 INFO - 'SHELL': '/bin/bash', 17:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:19 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:19 INFO - 'USER': 'cltbld', 17:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:19 INFO - 'XPC_FLAGS': '0x0', 17:38:19 INFO - 'XPC_SERVICE_NAME': '0', 17:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:38:19 INFO - Cleaning up... 17:38:19 INFO - Return code: 0 17:38:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:19 INFO - 'HOME': '/Users/cltbld', 17:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:19 INFO - 'LOGNAME': 'cltbld', 17:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:19 INFO - 'MOZ_NO_REMOTE': '1', 17:38:19 INFO - 'NO_EM_RESTART': '1', 17:38:19 INFO - 'PAGER': '/bin/cat', 17:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:19 INFO - 'PWD': '/builds/slave/test', 17:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:19 INFO - 'SHELL': '/bin/bash', 17:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:19 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:19 INFO - 'USER': 'cltbld', 17:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:19 INFO - 'XPC_FLAGS': '0x0', 17:38:19 INFO - 'XPC_SERVICE_NAME': '0', 17:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:38:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:38: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 17:38: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 17:38: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 17:38: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 17:38: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 17:38: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 17:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:38:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:23 INFO - Downloading docopt-0.6.1.tar.gz 17:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:38:23 INFO - Installing collected packages: blobuploader, requests, docopt 17:38:23 INFO - Running setup.py install for blobuploader 17:38:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:38:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:38:23 INFO - Running setup.py install for requests 17:38:24 INFO - Running setup.py install for docopt 17:38:24 INFO - Successfully installed blobuploader requests docopt 17:38:24 INFO - Cleaning up... 17:38:24 INFO - Return code: 0 17:38:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:24 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')]} 17:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:24 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')]} 17:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:24 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 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:24 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 17:38:24 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 17:38:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:24 INFO - 'HOME': '/Users/cltbld', 17:38:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:24 INFO - 'LOGNAME': 'cltbld', 17:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:24 INFO - 'MOZ_NO_REMOTE': '1', 17:38:24 INFO - 'NO_EM_RESTART': '1', 17:38:24 INFO - 'PAGER': '/bin/cat', 17:38:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:24 INFO - 'PWD': '/builds/slave/test', 17:38:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:24 INFO - 'SHELL': '/bin/bash', 17:38:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:24 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:24 INFO - 'USER': 'cltbld', 17:38:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:24 INFO - 'XPC_FLAGS': '0x0', 17:38:24 INFO - 'XPC_SERVICE_NAME': '0', 17:38:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:24 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-UHNLS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:24 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-lbWs1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:24 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-qhYylf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-SwEuwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-C0VilU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-CLdHXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Prkmsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-or3LW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-6CnO4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-E4MLRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-wa0wMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-E9Aczi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-JnM0eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-birJB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-klX3VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-UDfPcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-szC5Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:38:26 INFO - Running setup.py install for manifestparser 17:38:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:38:26 INFO - Running setup.py install for mozcrash 17:38:26 INFO - Running setup.py install for mozdebug 17:38:26 INFO - Running setup.py install for mozdevice 17:38:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:38:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:38:27 INFO - Running setup.py install for mozfile 17:38:27 INFO - Running setup.py install for mozhttpd 17:38:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:38:27 INFO - Running setup.py install for mozinfo 17:38:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:38:27 INFO - Running setup.py install for mozInstall 17:38:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:38:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:38:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:38:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:38:27 INFO - Running setup.py install for mozleak 17:38:27 INFO - Running setup.py install for mozlog 17:38:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:38:28 INFO - Running setup.py install for moznetwork 17:38:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:38:28 INFO - Running setup.py install for mozprocess 17:38:28 INFO - Running setup.py install for mozprofile 17:38:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:38:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:38:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:38:28 INFO - Running setup.py install for mozrunner 17:38:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:38:28 INFO - Running setup.py install for mozscreenshot 17:38:28 INFO - Running setup.py install for moztest 17:38:28 INFO - Running setup.py install for mozversion 17:38:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:38:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:38:29 INFO - Cleaning up... 17:38:29 INFO - Return code: 0 17:38:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:29 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 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:29 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 17:38:29 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 17:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:29 INFO - 'HOME': '/Users/cltbld', 17:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:29 INFO - 'LOGNAME': 'cltbld', 17:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:29 INFO - 'MOZ_NO_REMOTE': '1', 17:38:29 INFO - 'NO_EM_RESTART': '1', 17:38:29 INFO - 'PAGER': '/bin/cat', 17:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:29 INFO - 'PWD': '/builds/slave/test', 17:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:29 INFO - 'SHELL': '/bin/bash', 17:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:29 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:29 INFO - 'USER': 'cltbld', 17:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:29 INFO - 'XPC_FLAGS': '0x0', 17:38:29 INFO - 'XPC_SERVICE_NAME': '0', 17:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:29 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-d_SqxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:29 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)) 17:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:29 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-LGUM6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:29 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)) 17:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:29 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-wD7vZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:29 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)) 17:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:29 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-aR3A35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:29 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)) 17:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:29 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-sLpBhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:29 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)) 17:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:29 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-FqvHIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Mb7SVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-4TjPqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-KijiVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-nGkIuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-yl98Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-_La3qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-x014as-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-E4H4GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-b_8cTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:30 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)) 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:30 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-fDEC5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:31 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)) 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:31 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-3PallO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:31 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)) 17:38:31 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)) 17:38:31 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)) 17:38:31 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)) 17:38:31 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)) 17:38:31 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)) 17:38:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:38: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 17:38: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 17:38: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 17:38: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 17:38: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 17:38: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 17:38:33 INFO - Downloading blessings-1.6.tar.gz 17:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:38:33 INFO - Installing collected packages: blessings 17:38:33 INFO - Running setup.py install for blessings 17:38:33 INFO - Successfully installed blessings 17:38:33 INFO - Cleaning up... 17:38:33 INFO - Return code: 0 17:38:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:38:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:34 INFO - Reading from file tmpfile_stdout 17:38:34 INFO - Current package versions: 17:38:34 INFO - blessings == 1.6 17:38:34 INFO - blobuploader == 1.2.4 17:38:34 INFO - docopt == 0.6.1 17:38:34 INFO - functools32 == 3.2.3-2 17:38:34 INFO - jsonschema == 2.5.1 17:38:34 INFO - manifestparser == 1.1 17:38:34 INFO - mozInstall == 1.12 17:38:34 INFO - mozcrash == 0.17 17:38:34 INFO - mozdebug == 0.1 17:38:34 INFO - mozdevice == 0.48 17:38:34 INFO - mozfile == 1.2 17:38:34 INFO - mozhttpd == 0.7 17:38:34 INFO - mozinfo == 0.9 17:38:34 INFO - mozleak == 0.1 17:38:34 INFO - mozlog == 3.3 17:38:34 INFO - moznetwork == 0.27 17:38:34 INFO - mozprocess == 0.23 17:38:34 INFO - mozprofile == 0.28 17:38:34 INFO - mozrunner == 6.12 17:38:34 INFO - mozscreenshot == 0.1 17:38:34 INFO - mozsystemmonitor == 0.3 17:38:34 INFO - moztest == 0.7 17:38:34 INFO - mozversion == 1.4 17:38:34 INFO - psutil == 3.1.1 17:38:34 INFO - requests == 1.2.3 17:38:34 INFO - wsgiref == 0.1.2 17:38:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:34 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 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:34 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 17:38:34 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 17:38:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:34 INFO - 'HOME': '/Users/cltbld', 17:38:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:34 INFO - 'LOGNAME': 'cltbld', 17:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:34 INFO - 'MOZ_NO_REMOTE': '1', 17:38:34 INFO - 'NO_EM_RESTART': '1', 17:38:34 INFO - 'PAGER': '/bin/cat', 17:38:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:34 INFO - 'PWD': '/builds/slave/test', 17:38:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:34 INFO - 'SHELL': '/bin/bash', 17:38:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:34 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:34 INFO - 'USER': 'cltbld', 17:38:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:34 INFO - 'XPC_FLAGS': '0x0', 17:38:34 INFO - 'XPC_SERVICE_NAME': '0', 17:38:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:34 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)) 17:38:34 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)) 17:38:34 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)) 17:38:34 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)) 17:38:34 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)) 17:38:34 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)) 17:38:34 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)) 17:38:34 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)) 17:38:34 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)) 17:38:34 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)) 17:38:34 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)) 17:38:34 INFO - Cleaning up... 17:38:34 INFO - Return code: 0 17:38:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:34 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 0x108504a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108599618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcde1462de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, '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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 17:38:34 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 17:38:34 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 17:38:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:38:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:34 INFO - 'HOME': '/Users/cltbld', 17:38:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:34 INFO - 'LOGNAME': 'cltbld', 17:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:34 INFO - 'MOZ_NO_REMOTE': '1', 17:38:34 INFO - 'NO_EM_RESTART': '1', 17:38:34 INFO - 'PAGER': '/bin/cat', 17:38:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:34 INFO - 'PWD': '/builds/slave/test', 17:38:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:34 INFO - 'SHELL': '/bin/bash', 17:38:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:38:34 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:38:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:34 INFO - 'USER': 'cltbld', 17:38:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:34 INFO - 'XPC_FLAGS': '0x0', 17:38:34 INFO - 'XPC_SERVICE_NAME': '0', 17:38:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:38:34 INFO - Cleaning up... 17:38:34 INFO - Return code: 0 17:38:34 INFO - Running post-action listener: _resource_record_post_action 17:38:34 INFO - Running post-action listener: _start_resource_monitoring 17:38:34 INFO - Starting resource monitoring. 17:38:34 INFO - [mozharness: 2016-08-09 00:38:34.788637Z] Finished create-virtualenv step (success) 17:38:34 INFO - [mozharness: 2016-08-09 00:38:34.789683Z] Running install step. 17:38:34 INFO - Running pre-action listener: _resource_record_pre_action 17:38:34 INFO - Running main action method: install 17:38:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:35 INFO - Reading from file tmpfile_stdout 17:38:35 INFO - Detecting whether we're running mozinstall >=1.0... 17:38:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:38:35 INFO - Reading from file tmpfile_stdout 17:38:35 INFO - Output received: 17:38:35 INFO - Usage: mozinstall [options] installer 17:38:35 INFO - Options: 17:38:35 INFO - -h, --help show this help message and exit 17:38:35 INFO - -d DEST, --destination=DEST 17:38:35 INFO - Directory to install application into. [default: 17:38:35 INFO - "/builds/slave/test"] 17:38:35 INFO - --app=APP Application being installed. [default: firefox] 17:38:35 INFO - mkdir: /builds/slave/test/build/application 17:38:35 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'] 17:38:35 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 17:39:09 INFO - Reading from file tmpfile_stdout 17:39:09 INFO - Output received: 17:39:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:39:09 INFO - Running post-action listener: _resource_record_post_action 17:39:09 INFO - [mozharness: 2016-08-09 00:39:09.825845Z] Finished install step (success) 17:39:09 INFO - [mozharness: 2016-08-09 00:39:09.825965Z] Running run-tests step. 17:39:09 INFO - Running pre-action listener: _resource_record_pre_action 17:39:09 INFO - Running main action method: run_tests 17:39:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:39:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:39:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:39:09 INFO - 2016-08-08 17:39:09.840 screenresolution[2205:23918] starting screenresolution argv=screenresolution get 17:39:09 INFO - 2016-08-08 17:39:09.842 screenresolution[2205:23918] Display 0: 1600x1200x32@60 17:39:09 INFO - 2016-08-08 17:39:09.848 screenresolution[2206:23920] starting screenresolution argv=screenresolution list 17:39:09 INFO - Available Modes on Display 0 17:39:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:39:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:39:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:39:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:39:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:39:10 INFO - Intel Iris: 17:39:10 INFO - Chipset Model: Intel Iris 17:39:10 INFO - Type: GPU 17:39:10 INFO - Bus: Built-In 17:39:10 INFO - VRAM (Dynamic, Max): 1536 MB 17:39:10 INFO - Vendor: Intel (0x8086) 17:39:10 INFO - Device ID: 0x0a2e 17:39:10 INFO - Revision ID: 0x0009 17:39:10 INFO - Displays: 17:39:10 INFO - Display: 17:39:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:39:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:39:10 INFO - Display Serial Number: 1600x1200 60 17:39:10 INFO - Main Display: Yes 17:39:10 INFO - Mirror: Off 17:39:10 INFO - Online: Yes 17:39:10 INFO - Rotation: Supported 17:39:10 INFO - Return code: 0 17:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:39:10 INFO - Python 2.7.3 17:39:10 INFO - Return code: 0 17:39:10 INFO - grabbing minidump binary from tooltool 17:39:10 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')]} 17:39:10 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 0x108468d30>, '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 0x1081cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108460b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:39:10 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 17:39:10 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 17:39:10 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 17:39:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:39:10 INFO - Return code: 0 17:39:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:39:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:39:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:39:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:39:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0309 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OAx9nt42Vt/Render', 17:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:10 INFO - 'HOME': '/Users/cltbld', 17:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:10 INFO - 'LOGNAME': 'cltbld', 17:39:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:10 INFO - 'MOZ_NO_REMOTE': '1', 17:39:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:10 INFO - 'NO_EM_RESTART': '1', 17:39:10 INFO - 'PAGER': '/bin/cat', 17:39:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:10 INFO - 'PWD': '/builds/slave/test', 17:39:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:10 INFO - 'SHELL': '/bin/bash', 17:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NHIhLQOG8m/Listeners', 17:39:10 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 17:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:10 INFO - 'USER': 'cltbld', 17:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:10 INFO - 'XPC_FLAGS': '0x0', 17:39:10 INFO - 'XPC_SERVICE_NAME': '0', 17:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:39:10 INFO - mozversion application_buildid: 20160808152620 17:39:10 INFO - mozversion application_changeset: 2a61cb431fae12a02397638eff64d87b492d5e83 17:39:10 INFO - mozversion application_display_name: Nightly 17:39:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:39:10 INFO - mozversion application_name: Firefox 17:39:10 INFO - mozversion application_remotingname: firefox 17:39:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:39:10 INFO - mozversion application_vendor: Mozilla 17:39:10 INFO - mozversion application_version: 51.0a1 17:39:10 INFO - mozversion platform_buildid: 20160808152620 17:39:10 INFO - mozversion platform_changeset: 2a61cb431fae12a02397638eff64d87b492d5e83 17:39:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:39:10 INFO - mozversion platform_version: 51.0a1 17:39:10 INFO - using testdate: 1470703150 17:39:10 INFO - actual date: 1470703150 17:39:10 INFO - starting webserver on 'localhost:56322' 17:39:10 INFO - SUITE-START | Running 2 tests 17:39:10 INFO - TEST-START | dromaeo_css 17:39:10 INFO - operating with platform_type : mac_ 17:39:10 INFO - Initialising browser for dromaeo_css test... 17:39:10 INFO - TEST-INFO | started process 2216 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpt2fr5S/profile http://localhost:56322/getInfo.html) 17:39:13 INFO - PROCESS | 2216 | __metrics Screen width/height:1600/1200 17:39:13 INFO - PROCESS | 2216 | colorDepth:24 17:39:13 INFO - PROCESS | 2216 | Browser inner width/height: 1024/689 17:39:13 INFO - PROCESS | 2216 | __metrics 17:39:13 ERROR - PROCESS | 2216 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:39:13 INFO - TEST-INFO | 2216: exit 0 17:39:13 INFO - Browser initialized. 17:39:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:39:13 INFO - TEST-INFO | started process 2219 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpt2fr5S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:25 INFO - PROCESS | 2219 | RSS: Main: 254693376 17:39:25 INFO - PROCESS | 2219 | 17:40:15 INFO - PROCESS | 2219 | 1470703215443 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] 17:42:28 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:56322/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56322/tests/dromaeo/cssquery-ext.html) 17:42:29 INFO - PROCESS | 2219 | RSS: Main: 271425536 17:42:29 INFO - PROCESS | 2219 | 17:45:31 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:56322/tests/dromaeo/cssquery-ext.html (next: http://localhost:56322/tests/dromaeo/cssquery-jquery.html) 17:45:32 INFO - PROCESS | 2219 | RSS: Main: 281366528 17:45:32 INFO - PROCESS | 2219 | 17:48:34 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:56322/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56322/tests/dromaeo/cssquery-mootools.html) 17:48:34 INFO - PROCESS | 2219 | RSS: Main: 288116736 17:48:34 INFO - PROCESS | 2219 | 17:51:36 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:56322/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56322/tests/dromaeo/cssquery-prototype.html) 17:51:37 INFO - PROCESS | 2219 | RSS: Main: 287318016 17:51:37 INFO - PROCESS | 2219 | 17:54:40 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:56322/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56322/tests/dromaeo/cssquery-yui.html) 17:54:40 INFO - PROCESS | 2219 | RSS: Main: 291020800 17:54:40 INFO - PROCESS | 2219 | 17:57:43 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:56322/tests/dromaeo/cssquery-yui.html (next: http://localhost:56322/tests/dromaeo/cssquery-dojo.html) 17:57:43 INFO - PROCESS | 2219 | RSS: Main: 292081664 17:57:43 INFO - PROCESS | 2219 | 17:57:43 INFO - PROCESS | 2219 | __start_tp_report 17:57:43 INFO - PROCESS | 2219 | _x_x_mozilla_page_load 17:57:43 INFO - PROCESS | 2219 | _x_x_mozilla_page_load_details 17:57:43 INFO - PROCESS | 2219 | |i|pagename|runs| 17:57:43 INFO - PROCESS | 2219 | |0;dojo.html;3378.780379275347;3402.8808991685287;3431.176517635768;3437.45000799872;3444.3627928833166;5721.084626459768;5735.541156707463;5755.482006619403;5816.621919575236;5823.272090988627;5612.07400778871;5721.885562288751;5779.2775903012125;5805.906835680846;5888.676122813244;5162.586993040566;5209.7134657593815;5256.947430525704;5279.9208011879855;5326.174442961347;5212.035773381917;5357.062514060043;5385.21914322423;5395.271638328834;5411.404745477994;5130.589552835764;5170.327857378555;5264.078786212436;5280.894382112337;5339.06566350889;5236.214567814858;5244.370675518962;5278.155495120763;5281.841544753625;5304.575633949275;5155.690658560461;5186.196139598331;5208.088584497736;5210.713410762407;5216.191490319006;5521.806736764194;5591.608587398884;5626.54987600995;5675.2054712340305;5743.368229494752;4742.976285118587;4916.434610019822;6208.534359923024;6238.906416403757;6289.748410063592;5223.843284701465;6182.84542886427;6190.628562286277;6200.596961197508;6229.719662615194;5554.9722251388885;5695.829125126253;5756.481916627524;5781.364049954502;5832.970835145839;5529.529989950899;6141.240538582634;6192.256929168529;6251.812445626639;6268.592541484789;6158.907616385758;6171;6177.69111544421;6211.378862113753;6231.189945307081;6137.5302083125;6142.938570614237;6148.292946311142;6193.040078787795;6218.533609979269;6128.908066379008;6136.12084543884;6163.260408750889;6173.9073913891325;6181.443670069715;5157.200633901752;6193.535484838655;6232.189815323979;6236.688165591702;6238.033104868752;4935.802567897315;5012.147934851084;5026.145555255543;5030.698158110525;5037.622178336639;3721.9069523262133;4420.115976804652;4425.468943726773;4446.510883802779;4469.41897553316;5677.3471050829685;5737.65574065549;5750.654960702372;5750.913736293959;5764.990962718719;6113.354685976905;6217.875642487125;6227.221597300338;6241.282252541016;6250.656213908279;5350.545203657655;5425.538829199562;5754.74103665336;5786.421357864264;5795.33353664334;5441.183822426588;5451.918221226685;5466.972665136649;5470.863228419242;5479.75341109651;5263.868403289872;6164.660943648142;6334.334894835976;6349.523785715997;6357.237131544151;6174.9691251545255;6187.690615469299;6207.037909124093;6215;6217.316095229431;6302.212223472066;6378.744850206125;6399.072134540373;6409.35906409374;6411.262704789009;6095.878082438415;6111.480524155319;6118;6123.2652081750475;6128.63228206309;6037.667928263988;6110.953680641605;6144.846378840386;6178.474829639351;6213.875722485615;6087.515510307694;6108.053251745987;6108.694565271808;6109.040306147876;6123.6596393800855;5985.880282394415;6081.361457046946;6127.387261274015;6130.141780150871;6133.294671112701;5826;5880.294364676266;5960.254968128984;5994.6403215807195;6045.909311360245;4988.9251661225835;6022.1870047543025;6058.182145410313;6084.087386891824;6088.908666369919;4950.504949505021;5833.387494313036;5851.473367396955;5889.175515427929;5933.703314834327 17:57:43 INFO - PROCESS | 2219 | |1;ext.html;473.1884817537922;485.6843052016191;498.4591717985985;521.2207749414625;526.9934425247776;38046.429303560435;40796.18407631846;40853;40860.97847553809;40917.38623920636;40802.79598602003;41205;41861.74414767554;41894;41922.16155676885;9454.810903781938;9555.187809036206;9600.471974041426;9655.46894920779;9668.661596844111;9571.042895710443;9621.759456013586;9647;9657.32398732089;9658.806823863519;9587.760305992337;9633.614655413776;9661.178799802025;9682.70951871445;9683.322167448281;9645.421274723503;9669.903300966971;9685.661001864972;9688.46713430761;9707.077827606367;9521.952390238004;9570.425774453555;9589.664361747306;9607.4715890626;9648.469334186617;39026.60973390258;39071.80464097661;39365.60634393648;39429.21141577181;39498.81503554898;3109.3781243751114;3358.9160270993175;3406.8807591734417;3414.9413681758733;3431.5367425397503;29590;30143.397132057456;30256.09231723052;31417.37165256705;31445.056648300586;3241.092494101655;3253.511973204015;3270.8201048942296;3280.16355829262;3371.679690429405;500274;503709;506040.46979765233;506622;508274;60716.69641651763;61086.0837087444;61137.08294375588;61191.38808611857;61346.77306453846;34421.96734097981;34728.78449254264;35092.12269693227;35724.82137589347;60456.69771651114;15363;15740.055596664237;15785.842141578667;15922.044677319398;15953.441629543142;11977.041836653047;12063.155579109378;12129.02967762577;12137.635870923887;12151.027917766558;19194.904025479784;19199.52001199981;19332.71000934987;19398.4180474586;19437.319693810932;6765.289644587346;7879.606019698992;8029.156938521488;8072.434929554992;8124.918750812416;895.3285036222833;907.2923119966437;974.4786539201493;1019.50553981319;1092.208149091918;30036.399272014438;30454;30531.38937221243;30542.06758219412;30839;1038.9896101039044;1061.1404762142536;1073.6725298783947;1081.869446428484;1083.149727463937;15401.691966160613;15634.06195628266;15640.687186256439;15923;16041.358345666276;653236;657122;657154;657336;659069;57835.71082144647;58029.419705803244;58575.70712146412;58656.41343586509;58678.413215868146;1340.2427628389928;1356.2066191278213;1369.3153423288356;1378.6484446466086;1382.6819831438825;29187.41625167442;29697.406051879272;29885.402291954473;30096;30171.849140755035;50025;50334.49665503445;50665.240021400445;50885.47343579699;50924;524008;525222;526402;527595;528382;26576.202713918614;26737.064202752812;26926.461470770082;27067.187984360502;27084.916603336434;38949.61050389573;47390.52609473999;48037.5196248033;48322.79193020062;48972;29315;39175;39462.605373945895;39819;40479.79760101181;39059.60940390673;39312;39420.60579394169;40000.799995999834;40534;38443.42334864923;38610.227795444494;38667;39038.02404939899;39325.80337098296;32454;34344.313113738084;35117;35150.82424587963;35165.47251791276;22175.778242218017;23599;25922.574258415214;26015.73984260133;26097 17:57:43 INFO - PROCESS | 2219 | |2;jquery.html;297.32655535212746;373.1212993400542;379.3342683590299;391.371848183665;399.7801209334865;19799.010049497523;20160;20735.274265400712;20832.791672083276;21116.472088197803;19554.804451955475;19713.11290991905;20393.388198354074;20550.58898822023;20858.58282834346;5427.240186373911;5577.247071645326;5830.533557315426;5942.405759424067;6023.608465449754;5803.419658034205;5904.468597826216;5940.732667029973;5942.197803296564;5954.434328738785;5707.600467967244;5748.5975981681295;5762.711864406784;5822.970885145568;5833.591648584601;5660.801871934483;5698.17376480408;5766.221560089376;5837.416258374171;5848.795292164775;4954.405471343462;5228.477152284741;5245.160774276097;5287.180487024518;5342.252084708144;12699.873001270054;12852.485900563966;12916;13077.476900923952;13223.867761322359;2102.9158833646634;2138.1447421031557;2151.752548456916;2162.556675881456;2179.6294629912954;9741.025897410273;9775.169110625606;9934.801303973953;10006.649767258185;10031.74920626983;1772.5568607848038;1784.6519928613925;1800.5138612574663;1822.9908850455795;1848.663162990801;88600;123679;127962;129916;130963;10905.781884362268;11268.15488838324;11397.658070257905;11746;11913.761724765629;13797.448102076005;14041.297935103205;14242.786358204636;14297.78553321701;14317.284135793168;6661.40047395727;7918.762437126896;8191.631376588068;8303.667853285922;8325.5004699717;7222.349988500955;8020.11778704342;8058.758237252891;8164.877526837102;8204.343652507905;3274.7216486598904;3752.718546108998;3921.8235179416993;4379.861236078579;4491.842785502492;1647.2916645842163;1916.8370688491354;1930.1700268884515;1945.1830231302886;1947.8831270123555;715.3990647855826;934.9158575728081;944.1644144931647;964.4309857184155;986.6645340584236;14858.702825943421;15876.364945402285;20489.590208195754;20579.382618521468;20660.58678826415;863.5897948474425;922.3359181389388;972.8151651186251;993.180625983552;993.2947607198826;10408.427536485415;10803.297785643908;10806.675799726021;10833.945830270955;10853.837192442119;545051;564315;600500;604608;622643;77202.6139869297;117148;128084.35957820152;130037;133465.33267333795;415.4619767401223;447.311140843098;449.42024788023735;449.78185579993675;451.7425067711439;10869.29349592274;11240.156988225752;18359.724604130683;18922.243110275434;19079.71380429267;53320.73339633277;54303.45696542984;55963.720181398836;56115.71942140427;56223.43776562182;61260;71165.5092071775;71184.28815711777;72493.91259131012;75278;5282.630215884851;5417.83746487606;8203.30271926893;8446.450980686235;8540.231379175904;10665.46672666348;10716.142708583451;12871.22772633645;13423.798643020558;13629.318534073058;11485.02377297939;11680.123990700562;11692.369216926123;11744.29534227949;11822.527098915947;11315.660530184108;11347.602833900773;11662.591809286634;11669;11775.352355620524;11551.826722599335;11575.88424115748;11820.527178912747;11842.644720658394;11961;8303.1281715419;8360.372972027;8389.706360277361;8408.2432581068;8444.704435344733;8670.523121228392;9847.409155450696;11704.005159561533;11720.648380548597;11728.94135529317 17:57:43 INFO - PROCESS | 2219 | |3;mootools.html;1503.2483758120943;1539.7844301797747;1619.4089157457531;1733.575274057856;1861.851051915847;7740.342070923978;7940.602969851513;8289;8864.157904999023;8872.822543549133;7011.89482157768;8673.392862499628;8679.86980195296;8691.43505672131;8693;2294.8737819419966;2307.204014614955;2337.906483740648;2344.120954642009;2349.177787774274;2014.6474366985792;2270.0692715986447;2314.271004633535;2319.6288593824906;2320.454693147109;2327.2320134355705;2332.067173130753;2344.4373350395867;2350.4828937633692;2350.8589484630893;2307.411610039429;2320.3619004773736;2321.7097862767155;2329.9883500582473;2340.0756701103055;2294.0021090825544;2323.93028209154;2324.2910912171783;2326.6161083421216;2333.0784340185533;8556.358273129541;8561.972563292446;8675.132486751338;8676.566171691453;8679.652813887436;4415.227335216357;5120.206368012964;5216.321878155815;5266.447023062561;5268.130758424855;3417.9145521361916;3477.687008169277;3561.821908904544;3583.8924832255075;3632.128289210597;987.521052289639;1031.5564307347838;1036.5387402605843;1045.3309881675734;1045.9633912813015;10903.83644245337;11264.887351126548;11304.37825919574;11457.770844583061;11467.311961282267;4508.458984921765;4607.433472619326;4706.717596944126;4710.36410084641;4736.8105275788585;9248.768780780534;9735.659251926148;9832.459214743114;9846.704598862045;9847.261455390875;5196.272521846944;5258.106121959276;5274.26160337553;5278.049951008856;5279.208118782137;3868.864589739346;4324.891877703082;4774.761261936958;4803.927941080887;4821.421429428491;3892.1826416452295;3911.6675082618294;3980.144268982183;4038.51537815464;4048.67610591152;1278.5972418688084;1290.7160424706549;1295.1775622479793;1301.7266374061364;1306.1640550047978;813.6297984417076;834.2700137379793;918.7565295196778;921.9946616109934;923.6997975657938;5743.339515955635;5776.335721392094;5915.260592425947;5916.171735956969;5972.611780234358;431.0538368281592;439.8944253379166;442.05400443051894;442.2503855964174;442.7078128435217;3402.608699999532;3979.7612143270917;4037.7577345358786;4054.1688953764997;4060.9796951015646;10190.388576685422;10644.414557199429;10666.78666426667;10682.786344273227;10736.463176841127;8877.467351958903;10537.578496860193;10627.36235825853;10662.893371066346;10672.092872105803;7633.160352361236;7876.527408355402;8110.513369197867;8181.795455113551;8201.876971845428;5074.746262686777;5779.624324418899;5839.182514447895;5845.561582881386;5855.38518455556;9749.56126974302;9796.020397960147;9846.704598862045;9896.851547226941;9937.006299370005;9863.358881672668;9933.3543319684;9969.750756230862;10110.797784044425;10143.7464063399;6837.213720422215;7222.277772222946;7302.707891684273;7437.70249190048;7540.1328847181085;8332;8340.916590834015;8356.87464688018;8434.451760635538;8443.831123377375;6279.96860015697;7350.264973502607;7504.587247701211;7541.283578060075;7581.241875812595;7295;7349.118105827335;7380.815479613053;7389.334959853639;7444.255574442513;6848.3494068063455;6891.241963384124;6930.27232140618;6931.272216417204;6936.965315173392;4928.236123400879;4934.5312195341385;4984.352034235526;5008.449070602303;5054.09026375256;4872.297451918738;4911.656184067224;5018.347614810052;5105.489451054865;5141.357330333708 17:57:43 INFO - PROCESS | 2219 | |4;prototype.html;286.188655162614;299.9475091858925;308.8116249088056;310.1393632669341;313.49214272877924;4576.5423457654215;4730.597899178565;5265.368155821302;5639.887202255957;5707.229524014257;4291.605228300807;5500.314789091319;5557.194206840016;5584.274044374226;5611.148321054053;3658.213484100918;3769.962300377002;4273.829046838123;4325.545817689144;4391.516933137353;3547.8935631930954;3710.5361829771277;3927.463779334873;4018.839246430139;4174.874753757377;3495.7727747696445;3512.6838584527386;4197.223513649969;4215.220184265905;4225.323948168294;3398.745094117951;3675.4563083504727;4224.746515209097;4233.51314598822;4236.597523235288;2792.7765778737653;3028.4700177468853;3613.1328481164596;3689.5756987946193;3798.7966979152025;5431.728413579305;5462.617616766828;5490.862728431781;5501.312335958005;5545.863098064887;4077;4260.38224457455;4450.888727781831;4843.975780121077;4882.218844984785;4979;5172.172452407597;5228.816991405282;5351.608581768729;5950.8809823803285;3548.8048157351336;3915.471411359487;3986.80065996699;4015.9196816063513;4030.6775457963586;5235.607329450307;6300.621962682254;6304.716287767015;6349.333320001426;6388.329225431356;3745.831437585315;3898.7855667938534;4012.277789997828;4028.703638925843;4070.531888832763;4076.979615101965;4080.6327430531396;4089;4091.734037287567;4093.7134400592267;4204.87385378433;4778.163821331323;4779.832705855279;4809.44691360498;4838.2016967200725;5571.470710282517;5721.455207094062;5930.7924222652;6039;6041.6375017499095;1106.8727096383857;1319.3139567425078;1345.502164199233;1351;1374.6906945937285;868.7654333329965;902.3457992955055;907.0793144957873;938.483833891357;939.2626787971546;5478.506934375925;5548.389677135512;5550.944490555043;5569.721513924287;5587.413321601254;6114.3708205471185;6136.417040381157;6149.66176860268;6149.831532008904;6172.814815555541;4634.536546345406;5511.917321240185;5515.806946756844;5567.937634301118;5583.956743574761;2728.639726636445;3191.744660427207;3224.9841299990426;3244.626867910173;3245.6592057833586;5620.803271885465;5989.850253743692;6373.330800265998;6384.648844313514;6391.648459334781;5317.7872885084935;5993.670348130808;6310.716017779211;6401.391867772554;6459.838504037342;5176.611754118456;6352.6823658816875;6441.710123044568;6492.577982431127;6548;4733.479317275166;5158.38099428071;5380.596455265792;5764.394738552392;6115.755369785159;5639.915401269066;6133.068083553666;6134.815955521163;6163.84590385244;6225.252969643671;5480.534154596904;5558.828522072547;6029.969850150721;6115.3578874217565;6473.676316184266;4143.440635514167;4181.243877571366;4199.685023623301;4203.894902627459;4211.473565804275;4811.893264549103;5358.35699716021;5934.546036221153;6145.35473775265;6163.938360616516;5202.583793296603;5771.095538472378;5936.910946335895;5950.880982380415;5967.433093856077;4612.930806037845;5447.12845944647;5517.751701173537;5580.832575022756;6034.366391529002;4832.637552183671;5117.974410127926;5492.313460817398;5813;5871.001929671881;5859;5926.436988486087;6038.671492271869;6042.972694641833;6092.360302168386;5581.832545023656;5877.676727780014;5918.23063001807;5922.822315330547;5938.376470470711 17:57:43 INFO - PROCESS | 2219 | |5;yui.html;714.7998560403088;744.6202436757252;770.9344705700015;827.7516744976506;863.335231871459;15174.848251517482;15826.762598561016;15842.049477031385;15851.524454266391;16081.195940202986;11288.209825312231;14066.156030638169;14074.507392241274;14097.942654300918;14099.365528551214;835.6072645856437;838.3586556284447;867.8915135608049;876.8772371867943;894.7941973346134;854.0775961961098;890.8262888736699;892.7411050795262;894.2041582991111;894.6153154143716;915.4827522449795;919.2278486071698;931.1759093202497;935.1303287942211;937.779621788879;926.420986883198;927.1238679447924;928.9814203715922;929.2705226397279;929.8977112517617;669.3941982505792;683.2313647146959;691.636890632422;695.4679670052413;698.3156506623537;15157.924210378987;15419.151946643042;15610.76583851243;15636;15680.372785088583;13913.30433478322;14240.572782816533;14334.354954027094;14401.351939162763;14513.854861451357;10144.644937427229;11766.58816941403;12005.473317576812;12219.327936963464;12466.439010244561;3590.8025058621765;3807;3809.7523660962224;3878.972072400788;3883.0292426893275;117873.41063294714;119178;119800.20299695512;120742;123308;9717.271204659679;10950.342508221793;11026.283291586022;11047.502862371213;11403.828942565702;22295.219667311565;22862.42843928915;22896.88551557265;22922.96846641872;23011;7892.0924093729955;7970.402219833536;8166.265036146657;8219.383546234056;8276;4035.394690796404;4456.9108617828115;4497.415336006364;4545.954540454619;4574.81700731967;3559.4126969049817;3621.7102631789394;3677.2277821657217;3682.4844521766972;3682.5949145593963;635.7520566978882;647.7668039505775;650.5576208178484;652.350910843704;668.238208442376;602.0728078758663;627.4729227448964;627.7269387816223;674.8043067510367;675.9425448836805;8335.708250211213;8993.370464067453;9399.812003760024;9460.52697365129;9786.27502910791;496.70197881271673;532.4622131647064;635.4471609699499;636.926753423353;659.6042374575217;4310.43964284641;4652.651051171176;4708.599769019604;4717.198076327033;4741.715497070187;121841.39079304723;154702;155500;161549.38450615344;162472;118750.21874671886;133034;136901;139459;140935;82758;82902;96686.0331396677;103485.48257258817;108896.91103089026;7761.573113478587;9013.954930225307;9101.40840845343;9145.63417463294;9182.17360437564;50183;65188.67405662941;66566.33433665601;67673.3232667667;68760;97482;102878.48560757148;104912.47543762233;105177.47411262894;107666;10878;11316.321020738782;11562.710932226426;12169.939150304546;12401.13192076582;13151.21092734439;13257.270850103338;13492.055556110978;13944.79082813779;14163;12199.085068620067;12285.815712764137;12388;12494.562690306158;12651.810222846849;11776.941115294369;12043.397830108284;12067.698307542381;12471;12471.438785254504;11947.522099115939;11970.922616964515;12093.939530302292;12109.212901161396;12530.122891397516;8793.516356600448;10548.472576370998;10584.364938103738;10698.572057117939;11047.226694131334;7544.509606875536;8383.161683831568;8564.314854811724;9428.858567121362;10339.741506462398 17:57:43 INFO - PROCESS | 2219 | __end_tp_report 17:57:43 INFO - PROCESS | 2219 | __start_cc_report 17:57:43 INFO - PROCESS | 2219 | _x_x_mozilla_cycle_collect,423 17:57:43 INFO - PROCESS | 2219 | __end_cc_report 17:57:43 INFO - PROCESS | 2219 | __startTimestamp1470704263358__endTimestamp 17:57:43 INFO - PROCESS | 2219 | 17:57:43 INFO - PROCESS | 2219 | ------- Summary: start ------- 17:57:43 INFO - PROCESS | 2219 | Number of tests: 6 17:57:43 INFO - PROCESS | 2219 | 17:57:43 INFO - PROCESS | 2219 | [#0] dojo.html Cycles:165 Average:5692.10 Median:5832.97 stddev:633.95 (10.9%) stddev-sans-first:609.36 17:57:43 INFO - PROCESS | 2219 | Values: 3378.8 3402.9 3431.2 3437.5 3444.4 5721.1 5735.5 5755.5 5816.6 5823.3 5612.1 5721.9 5779.3 5805.9 5888.7 5162.6 5209.7 5256.9 5279.9 5326.2 5212.0 5357.1 5385.2 5395.3 5411.4 5130.6 5170.3 5264.1 5280.9 5339.1 5236.2 5244.4 5278.2 5281.8 5304.6 5155.7 5186.2 5208.1 5210.7 5216.2 5521.8 5591.6 5626.5 5675.2 5743.4 4743.0 4916.4 6208.5 6238.9 6289.7 5223.8 6182.8 6190.6 6200.6 6229.7 5555.0 5695.8 5756.5 5781.4 5833.0 5529.5 6141.2 6192.3 6251.8 6268.6 6158.9 6171.0 6177.7 6211.4 6231.2 6137.5 6142.9 6148.3 6193.0 6218.5 6128.9 6136.1 6163.3 6173.9 6181.4 5157.2 6193.5 6232.2 6236.7 6238.0 4935.8 5012.1 5026.1 5030.7 5037.6 3721.9 4420.1 4425.5 4446.5 4469.4 5677.3 5737.7 5750.7 5750.9 5765.0 6113.4 6217.9 6227.2 6241.3 6250.7 5350.5 5425.5 5754.7 5786.4 5795.3 5441.2 5451.9 5467.0 5470.9 5479.8 5263.9 6164.7 6334.3 6349.5 6357.2 6175.0 6187.7 6207.0 6215.0 6217.3 6302.2 6378.7 6399.1 6409.4 6411.3 6095.9 6111.5 6118.0 6123.3 6128.6 6037.7 6111.0 6144.8 6178.5 6213.9 6087.5 6108.1 6108.7 6109.0 6123.7 5985.9 6081.4 6127.4 6130.1 6133.3 5826.0 5880.3 5960.3 5994.6 6045.9 4988.9 6022.2 6058.2 6084.1 6088.9 4950.5 5833.4 5851.5 5889.2 5933.7 17:57:43 INFO - PROCESS | 2219 | 17:57:43 INFO - PROCESS | 2219 | [#1] ext.html Cycles:180 Average:69112.45 Median:39424.91 stddev:151460.86 (384.2%) stddev-sans-first:151798.07 17:57:43 INFO - PROCESS | 2219 | Values: 473.2 485.7 498.5 521.2 527.0 38046.4 40796.2 40853.0 40861.0 40917.4 40802.8 41205.0 41861.7 41894.0 41922.2 9454.8 9555.2 9600.5 9655.5 9668.7 9571.0 9621.8 9647.0 9657.3 9658.8 9587.8 9633.6 9661.2 9682.7 9683.3 9645.4 9669.9 9685.7 9688.5 9707.1 9522.0 9570.4 9589.7 9607.5 9648.5 39026.6 39071.8 39365.6 39429.2 39498.8 3109.4 3358.9 3406.9 3414.9 3431.5 29590.0 30143.4 30256.1 31417.4 31445.1 3241.1 3253.5 3270.8 3280.2 3371.7 500274.0 503709.0 506040.5 506622.0 508274.0 60716.7 61086.1 61137.1 61191.4 61346.8 34422.0 34728.8 35092.1 35724.8 60456.7 15363.0 15740.1 15785.8 15922.0 15953.4 11977.0 12063.2 12129.0 12137.6 12151.0 19194.9 19199.5 19332.7 19398.4 19437.3 6765.3 7879.6 8029.2 8072.4 8124.9 895.3 907.3 974.5 1019.5 1092.2 30036.4 30454.0 30531.4 30542.1 30839.0 1039.0 1061.1 1073.7 1081.9 1083.1 15401.7 15634.1 15640.7 15923.0 16041.4 653236.0 657122.0 657154.0 657336.0 659069.0 57835.7 58029.4 58575.7 58656.4 58678.4 1340.2 1356.2 1369.3 1378.6 1382.7 29187.4 29697.4 29885.4 30096.0 30171.8 50025.0 50334.5 50665.2 50885.5 50924.0 524008.0 525222.0 526402.0 527595.0 528382.0 26576.2 26737.1 26926.5 27067.2 27084.9 38949.6 47390.5 48037.5 48322.8 48972.0 29315.0 39175.0 39462.6 39819.0 40479.8 39059.6 39312.0 39420.6 40000.8 40534.0 38443.4 38610.2 38667.0 39038.0 39325.8 32454.0 34344.3 35117.0 35150.8 35165.5 22175.8 23599.0 25922.6 26015.7 26097.0 17:57:43 INFO - PROCESS | 2219 | 17:57:43 INFO - PROCESS | 2219 | [#2] jquery.html Cycles:180 Average:33740.15 Median:2062.92 stddev:98173.52 (4759.0%) stddev-sans-first:98416.81 17:57:43 INFO - PROCESS | 2219 | Values: 297.3 373.1 379.3 391.4 399.8 19799.0 20160.0 20735.3 20832.8 21116.5 19554.8 19713.1 20393.4 20550.6 20858.6 5427.2 5577.2 5830.5 5942.4 6023.6 5803.4 5904.5 5940.7 5942.2 5954.4 5707.6 5748.6 5762.7 5823.0 5833.6 5660.8 5698.2 5766.2 5837.4 5848.8 4954.4 5228.5 5245.2 5287.2 5342.3 12699.9 12852.5 12916.0 13077.5 13223.9 2102.9 2138.1 2151.8 2162.6 2179.6 9741.0 9775.2 9934.8 10006.6 10031.7 1772.6 1784.7 1800.5 1823.0 1848.7 88600.0 123679.0 127962.0 129916.0 130963.0 10905.8 11268.2 11397.7 11746.0 11913.8 13797.4 14041.3 14242.8 14297.8 14317.3 6661.4 7918.8 8191.6 8303.7 8325.5 7222.3 8020.1 8058.8 8164.9 8204.3 3274.7 3752.7 3921.8 4379.9 4491.8 1647.3 1916.8 1930.2 1945.2 1947.9 715.4 934.9 944.2 964.4 986.7 14858.7 15876.4 20489.6 20579.4 20660.6 863.6 922.3 972.8 993.2 993.3 10408.4 10803.3 10806.7 10833.9 10853.8 545051.0 564315.0 600500.0 604608.0 622643.0 77202.6 117148.0 128084.4 130037.0 133465.3 415.5 447.3 449.4 449.8 451.7 10869.3 11240.2 18359.7 18922.2 19079.7 53320.7 54303.5 55963.7 56115.7 56223.4 61260.0 71165.5 71184.3 72493.9 75278.0 5282.6 5417.8 8203.3 8446.5 8540.2 10665.5 10716.1 12871.2 13423.8 13629.3 11485.0 11680.1 11692.4 11744.3 11822.5 11315.7 11347.6 11662.6 11669.0 11775.4 11551.8 11575.9 11820.5 11842.6 11961.0 8303.1 8360.4 8389.7 8408.2 8444.7 8670.5 9847.4 11704.0 11720.6 11728.9 17:57:43 INFO - PROCESS | 2219 | 17:57:43 INFO - PROCESS | 2219 | [#3] mootools.html Cycles:180 Average:5596.92 Median:4996.40 stddev:3146.71 (63.0%) stddev-sans-first:3140.50 17:57:43 INFO - PROCESS | 2219 | Values: 1503.2 1539.8 1619.4 1733.6 1861.9 7740.3 7940.6 8289.0 8864.2 8872.8 7011.9 8673.4 8679.9 8691.4 8693.0 2294.9 2307.2 2337.9 2344.1 2349.2 2014.6 2270.1 2314.3 2319.6 2320.5 2327.2 2332.1 2344.4 2350.5 2350.9 2307.4 2320.4 2321.7 2330.0 2340.1 2294.0 2323.9 2324.3 2326.6 2333.1 8556.4 8562.0 8675.1 8676.6 8679.7 4415.2 5120.2 5216.3 5266.4 5268.1 3417.9 3477.7 3561.8 3583.9 3632.1 987.5 1031.6 1036.5 1045.3 1046.0 10903.8 11264.9 11304.4 11457.8 11467.3 4508.5 4607.4 4706.7 4710.4 4736.8 9248.8 9735.7 9832.5 9846.7 9847.3 5196.3 5258.1 5274.3 5278.0 5279.2 3868.9 4324.9 4774.8 4803.9 4821.4 3892.2 3911.7 3980.1 4038.5 4048.7 1278.6 1290.7 1295.2 1301.7 1306.2 813.6 834.3 918.8 922.0 923.7 5743.3 5776.3 5915.3 5916.2 5972.6 431.1 439.9 442.1 442.3 442.7 3402.6 3979.8 4037.8 4054.2 4061.0 10190.4 10644.4 10666.8 10682.8 10736.5 8877.5 10537.6 10627.4 10662.9 10672.1 7633.2 7876.5 8110.5 8181.8 8201.9 5074.7 5779.6 5839.2 5845.6 5855.4 9749.6 9796.0 9846.7 9896.9 9937.0 9863.4 9933.4 9969.8 10110.8 10143.7 6837.2 7222.3 7302.7 7437.7 7540.1 8332.0 8340.9 8356.9 8434.5 8443.8 6280.0 7350.3 7504.6 7541.3 7581.2 7295.0 7349.1 7380.8 7389.3 7444.3 6848.3 6891.2 6930.3 6931.3 6937.0 4928.2 4934.5 4984.4 5008.4 5054.1 4872.3 4911.7 5018.3 5105.5 5141.4 17:57:43 INFO - PROCESS | 2219 | 17:57:43 INFO - PROCESS | 2219 | [#4] prototype.html Cycles:180 Average:4737.52 Median:5406.16 stddev:1509.20 (27.9%) stddev-sans-first:1475.99 17:57:43 INFO - PROCESS | 2219 | Values: 286.2 299.9 308.8 310.1 313.5 4576.5 4730.6 5265.4 5639.9 5707.2 4291.6 5500.3 5557.2 5584.3 5611.1 3658.2 3770.0 4273.8 4325.5 4391.5 3547.9 3710.5 3927.5 4018.8 4174.9 3495.8 3512.7 4197.2 4215.2 4225.3 3398.7 3675.5 4224.7 4233.5 4236.6 2792.8 3028.5 3613.1 3689.6 3798.8 5431.7 5462.6 5490.9 5501.3 5545.9 4077.0 4260.4 4450.9 4844.0 4882.2 4979.0 5172.2 5228.8 5351.6 5950.9 3548.8 3915.5 3986.8 4015.9 4030.7 5235.6 6300.6 6304.7 6349.3 6388.3 3745.8 3898.8 4012.3 4028.7 4070.5 4077.0 4080.6 4089.0 4091.7 4093.7 4204.9 4778.2 4779.8 4809.4 4838.2 5571.5 5721.5 5930.8 6039.0 6041.6 1106.9 1319.3 1345.5 1351.0 1374.7 868.8 902.3 907.1 938.5 939.3 5478.5 5548.4 5550.9 5569.7 5587.4 6114.4 6136.4 6149.7 6149.8 6172.8 4634.5 5511.9 5515.8 5567.9 5584.0 2728.6 3191.7 3225.0 3244.6 3245.7 5620.8 5989.9 6373.3 6384.6 6391.6 5317.8 5993.7 6310.7 6401.4 6459.8 5176.6 6352.7 6441.7 6492.6 6548.0 4733.5 5158.4 5380.6 5764.4 6115.8 5639.9 6133.1 6134.8 6163.8 6225.3 5480.5 5558.8 6030.0 6115.4 6473.7 4143.4 4181.2 4199.7 4203.9 4211.5 4811.9 5358.4 5934.5 6145.4 6163.9 5202.6 5771.1 5936.9 5950.9 5967.4 4612.9 5447.1 5517.8 5580.8 6034.4 4832.6 5118.0 5492.3 5813.0 5871.0 5859.0 5926.4 6038.7 6043.0 6092.4 5581.8 5877.7 5918.2 5922.8 5938.4 17:57:43 INFO - PROCESS | 2219 | 17:57:43 INFO - PROCESS | 2219 | [#5] yui.html Cycles:180 Average:25072.34 Median:3744.80 stddev:40859.75 (1091.1%) stddev-sans-first:40933.44 17:57:43 INFO - PROCESS | 2219 | Values: 714.8 744.6 770.9 827.8 863.3 15174.8 15826.8 15842.0 15851.5 16081.2 11288.2 14066.2 14074.5 14097.9 14099.4 835.6 838.4 867.9 876.9 894.8 854.1 890.8 892.7 894.2 894.6 915.5 919.2 931.2 935.1 937.8 926.4 927.1 929.0 929.3 929.9 669.4 683.2 691.6 695.5 698.3 15157.9 15419.2 15610.8 15636.0 15680.4 13913.3 14240.6 14334.4 14401.4 14513.9 10144.6 11766.6 12005.5 12219.3 12466.4 3590.8 3807.0 3809.8 3879.0 3883.0 117873.4 119178.0 119800.2 120742.0 123308.0 9717.3 10950.3 11026.3 11047.5 11403.8 22295.2 22862.4 22896.9 22923.0 23011.0 7892.1 7970.4 8166.3 8219.4 8276.0 4035.4 4456.9 4497.4 4546.0 4574.8 3559.4 3621.7 3677.2 3682.5 3682.6 635.8 647.8 650.6 652.4 668.2 602.1 627.5 627.7 674.8 675.9 8335.7 8993.4 9399.8 9460.5 9786.3 496.7 532.5 635.4 636.9 659.6 4310.4 4652.7 4708.6 4717.2 4741.7 121841.4 154702.0 155500.0 161549.4 162472.0 118750.2 133034.0 136901.0 139459.0 140935.0 82758.0 82902.0 96686.0 103485.5 108896.9 7761.6 9014.0 9101.4 9145.6 9182.2 50183.0 65188.7 66566.3 67673.3 68760.0 97482.0 102878.5 104912.5 105177.5 107666.0 10878.0 11316.3 11562.7 12169.9 12401.1 13151.2 13257.3 13492.1 13944.8 14163.0 12199.1 12285.8 12388.0 12494.6 12651.8 11776.9 12043.4 12067.7 12471.0 12471.4 11947.5 11970.9 12093.9 12109.2 12530.1 8793.5 10548.5 10584.4 10698.6 11047.2 7544.5 8383.2 8564.3 9428.9 10339.7 17:57:43 INFO - PROCESS | 2219 | -------- Summary: end -------- 17:57:43 INFO - PROCESS | 2219 | 17:57:44 INFO - TEST-INFO | 2219: exit 0 17:57:44 INFO - TEST-OK | dromaeo_css | took 1113625ms 17:57:44 INFO - TEST-START | kraken 17:57:44 INFO - operating with platform_type : mac_ 17:57:44 INFO - Initialising browser for kraken test... 17:57:44 INFO - TEST-INFO | started process 2228 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpHm6det/profile http://localhost:56322/getInfo.html) 17:57:46 INFO - PROCESS | 2228 | __metrics Screen width/height:1600/1200 17:57:46 INFO - PROCESS | 2228 | colorDepth:24 17:57:46 INFO - PROCESS | 2228 | Browser inner width/height: 1024/689 17:57:46 INFO - PROCESS | 2228 | __metrics 17:57:47 ERROR - PROCESS | 2228 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:57:47 INFO - TEST-INFO | 2228: exit 0 17:57:47 INFO - Browser initialized. 17:57:47 INFO - Running cycle 1/1 for kraken test... 17:57:47 INFO - TEST-INFO | started process 2230 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpHm6det/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:59 INFO - PROCESS | 2230 | RSS: Main: 254570496 17:57:59 INFO - PROCESS | 2230 | 17:58:02 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56322/tests/kraken/driver.html?testName=audio-beat-detection) 17:58:03 INFO - PROCESS | 2230 | RSS: Main: 267517952 17:58:03 INFO - PROCESS | 2230 | 17:58:06 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56322/tests/kraken/driver.html?testName=audio-dft) 17:58:07 INFO - PROCESS | 2230 | RSS: Main: 276361216 17:58:07 INFO - PROCESS | 2230 | 17:58:10 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56322/tests/kraken/driver.html?testName=audio-fft) 17:58:11 INFO - PROCESS | 2230 | RSS: Main: 279191552 17:58:11 INFO - PROCESS | 2230 | 17:58:13 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56322/tests/kraken/driver.html?testName=audio-oscillator) 17:58:13 INFO - PROCESS | 2230 | RSS: Main: 280526848 17:58:13 INFO - PROCESS | 2230 | 17:58:15 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56322/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:58:16 INFO - PROCESS | 2230 | RSS: Main: 280989696 17:58:16 INFO - PROCESS | 2230 | 17:58:19 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56322/tests/kraken/driver.html?testName=imaging-darkroom) 17:58:20 INFO - PROCESS | 2230 | RSS: Main: 282271744 17:58:20 INFO - PROCESS | 2230 | 17:58:23 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56322/tests/kraken/driver.html?testName=imaging-desaturate) 17:58:23 INFO - PROCESS | 2230 | RSS: Main: 282730496 17:58:23 INFO - PROCESS | 2230 | 17:58:26 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56322/tests/kraken/driver.html?testName=json-parse-financial) 17:58:27 INFO - PROCESS | 2230 | RSS: Main: 282636288 17:58:27 INFO - PROCESS | 2230 | 17:58:29 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56322/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:58:29 INFO - PROCESS | 2230 | RSS: Main: 282558464 17:58:29 INFO - PROCESS | 2230 | 17:58:31 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56322/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:58:32 INFO - PROCESS | 2230 | RSS: Main: 282615808 17:58:32 INFO - PROCESS | 2230 | 17:58:34 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56322/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:58:35 INFO - PROCESS | 2230 | RSS: Main: 282923008 17:58:35 INFO - PROCESS | 2230 | 17:58:38 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:58:38 INFO - PROCESS | 2230 | RSS: Main: 283799552 17:58:38 INFO - PROCESS | 2230 | 17:58:41 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:58:42 INFO - PROCESS | 2230 | RSS: Main: 283103232 17:58:42 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:56322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56322/tests/kraken/driver.html?testName=ai-astar) 17:58:44 INFO - PROCESS | 2230 | RSS: Main: 284082176 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | __start_tp_report 17:58:44 INFO - PROCESS | 2230 | _x_x_mozilla_page_load 17:58:44 INFO - PROCESS | 2230 | _x_x_mozilla_page_load_details 17:58:44 INFO - PROCESS | 2230 | |i|pagename|runs| 17:58:44 INFO - PROCESS | 2230 | |0;ai-astar;117;170;119;118;120;159;163;129;117;117 17:58:44 INFO - PROCESS | 2230 | |1;audio-beat-detection;143;108;130;183;137;161;129;111;164;136 17:58:44 INFO - PROCESS | 2230 | |2;audio-dft;265;201;194;233;273;251;195;190;195;200 17:58:44 INFO - PROCESS | 2230 | |3;audio-fft;71;82;77;147;51;58;64;89;157;82 17:58:44 INFO - PROCESS | 2230 | |4;audio-oscillator;72;100;149;80;71;95;115;72;72;114 17:58:44 INFO - PROCESS | 2230 | |5;imaging-gaussian-blur;136;114;93;91;91;89;94;89;92;89 17:58:44 INFO - PROCESS | 2230 | |6;imaging-darkroom;99;155;152;98;97;97;97;103;104;141 17:58:44 INFO - PROCESS | 2230 | |7;imaging-desaturate;91;95;122;110;92;92;89;90;79;144 17:58:44 INFO - PROCESS | 2230 | |8;json-parse-financial;59;58;56;56;58;58;56;57;57;57 17:58:44 INFO - PROCESS | 2230 | |9;json-stringify-tinderbox;67;74;71;72;79;80;78;73;71;73 17:58:44 INFO - PROCESS | 2230 | |10;stanford-crypto-aes;86;83;83;85;73;96;102;107;86;89 17:58:44 INFO - PROCESS | 2230 | |11;stanford-crypto-ccm;173;151;152;139;138;150;151;160;162;166 17:58:44 INFO - PROCESS | 2230 | |12;stanford-crypto-pbkdf2;168;170;167;183;227;223;172;168;169;240 17:58:44 INFO - PROCESS | 2230 | |13;stanford-crypto-sha256-iterative;66;69;67;68;69;66;66;70;67;66 17:58:44 INFO - PROCESS | 2230 | __end_tp_report 17:58:44 INFO - PROCESS | 2230 | __start_cc_report 17:58:44 INFO - PROCESS | 2230 | _x_x_mozilla_cycle_collect,1040 17:58:44 INFO - PROCESS | 2230 | __end_cc_report 17:58:44 INFO - PROCESS | 2230 | __startTimestamp1470704324413__endTimestamp 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | ------- Summary: start ------- 17:58:44 INFO - PROCESS | 2230 | Number of tests: 14 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#0] ai-astar Cycles:10 Average:132.90 Median:124.50 stddev:21.91 (17.6%) stddev-sans-first:22.47 17:58:44 INFO - PROCESS | 2230 | Values: 117.0 170.0 119.0 118.0 120.0 159.0 163.0 129.0 117.0 117.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:140.00 stddev:23.54 (16.8%) stddev-sans-first:24.94 17:58:44 INFO - PROCESS | 2230 | Values: 143.0 108.0 130.0 183.0 137.0 161.0 129.0 111.0 164.0 136.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#2] audio-dft Cycles:10 Average:219.70 Median:217.00 stddev:32.57 (15.0%) stddev-sans-first:30.15 17:58:44 INFO - PROCESS | 2230 | Values: 265.0 201.0 194.0 233.0 273.0 251.0 195.0 190.0 195.0 200.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#3] audio-fft Cycles:10 Average:87.80 Median:74.00 stddev:35.85 (48.5%) stddev-sans-first:37.51 17:58:44 INFO - PROCESS | 2230 | Values: 71.0 82.0 77.0 147.0 51.0 58.0 64.0 89.0 157.0 82.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:72.00 stddev:25.99 (36.1%) stddev-sans-first:26.32 17:58:44 INFO - PROCESS | 2230 | Values: 72.0 100.0 149.0 80.0 71.0 95.0 115.0 72.0 72.0 114.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:91.00 stddev:15.34 (16.9%) stddev-sans-first:7.88 17:58:44 INFO - PROCESS | 2230 | Values: 136.0 114.0 93.0 91.0 91.0 89.0 94.0 89.0 92.0 89.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#6] imaging-darkroom Cycles:10 Average:114.30 Median:97.00 stddev:24.54 (25.3%) stddev-sans-first:25.40 17:58:44 INFO - PROCESS | 2230 | Values: 99.0 155.0 152.0 98.0 97.0 97.0 97.0 103.0 104.0 141.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#7] imaging-desaturate Cycles:10 Average:100.40 Median:90.50 stddev:19.48 (21.5%) stddev-sans-first:20.36 17:58:44 INFO - PROCESS | 2230 | Values: 91.0 95.0 122.0 110.0 92.0 92.0 89.0 90.0 79.0 144.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:1.03 (1.8%) stddev-sans-first:0.87 17:58:44 INFO - PROCESS | 2230 | Values: 59.0 58.0 56.0 56.0 58.0 58.0 56.0 57.0 57.0 57.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:73.50 stddev:4.08 (5.5%) stddev-sans-first:3.50 17:58:44 INFO - PROCESS | 2230 | Values: 67.0 74.0 71.0 72.0 79.0 80.0 78.0 73.0 71.0 73.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:85.50 stddev:10.02 (11.7%) stddev-sans-first:10.57 17:58:44 INFO - PROCESS | 2230 | Values: 86.0 83.0 83.0 85.0 73.0 96.0 102.0 107.0 86.0 89.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#11] stanford-crypto-ccm Cycles:10 Average:154.20 Median:156.00 stddev:11.17 (7.2%) stddev-sans-first:9.56 17:58:44 INFO - PROCESS | 2230 | Values: 173.0 151.0 152.0 139.0 138.0 150.0 151.0 160.0 162.0 166.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.70 Median:177.50 stddev:29.16 (16.4%) stddev-sans-first:29.95 17:58:44 INFO - PROCESS | 2230 | Values: 168.0 170.0 167.0 183.0 227.0 223.0 172.0 168.0 169.0 240.0 17:58:44 INFO - PROCESS | 2230 | 17:58:44 INFO - PROCESS | 2230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.51 (2.2%) stddev-sans-first:1.51 17:58:44 INFO - PROCESS | 2230 | Values: 66.0 69.0 67.0 68.0 69.0 66.0 66.0 70.0 67.0 66.0 17:58:44 INFO - PROCESS | 2230 | -------- Summary: end -------- 17:58:44 INFO - PROCESS | 2230 | 17:58:45 INFO - TEST-INFO | 2230: exit 0 17:58:45 INFO - TEST-OK | kraken | took 61210ms 17:58:45 INFO - SUITE-END | took 1174s 17:58:45 INFO - Completed test suite (00:19:35) 17:58:45 INFO - javascript benchmark 17:58:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7245.263726636351, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3378.780379275347, 3402.8808991685287, 3431.176517635768, 3437.45000799872, 3444.3627928833166, 5721.084626459768, 5735.541156707463, 5755.482006619403, 5816.621919575236, 5823.272090988627, 5612.07400778871, 5721.885562288751, 5779.2775903012125, 5805.906835680846, 5888.676122813244, 5162.586993040566, 5209.7134657593815, 5256.947430525704, 5279.9208011879855, 5326.174442961347, 5212.035773381917, 5357.062514060043, 5385.21914322423, 5395.271638328834, 5411.404745477994, 5130.589552835764, 5170.327857378555, 5264.078786212436, 5280.894382112337, 5339.06566350889, 5236.214567814858, 5244.370675518962, 5278.155495120763, 5281.841544753625, 5304.575633949275, 5155.690658560461, 5186.196139598331, 5208.088584497736, 5210.713410762407, 5216.191490319006, 5521.806736764194, 5591.608587398884, 5626.54987600995, 5675.2054712340305, 5743.368229494752, 4742.976285118587, 4916.434610019822, 6208.534359923024, 6238.906416403757, 6289.748410063592, 5223.843284701465, 6182.84542886427, 6190.628562286277, 6200.596961197508, 6229.719662615194, 5554.9722251388885, 5695.829125126253, 5756.481916627524, 5781.364049954502, 5832.970835145839, 5529.529989950899, 6141.240538582634, 6192.256929168529, 6251.812445626639, 6268.592541484789, 6158.907616385758, 6171.0, 6177.69111544421, 6211.378862113753, 6231.189945307081, 6137.5302083125, 6142.938570614237, 6148.292946311142, 6193.040078787795, 6218.533609979269, 6128.908066379008, 6136.12084543884, 6163.260408750889, 6173.9073913891325, 6181.443670069715, 5157.200633901752, 6193.535484838655, 6232.189815323979, 6236.688165591702, 6238.033104868752, 4935.802567897315, 5012.147934851084, 5026.145555255543, 5030.698158110525, 5037.622178336639, 3721.9069523262133, 4420.115976804652, 4425.468943726773, 4446.510883802779, 4469.41897553316, 5677.3471050829685, 5737.65574065549, 5750.654960702372, 5750.913736293959, 5764.990962718719, 6113.354685976905, 6217.875642487125, 6227.221597300338, 6241.282252541016, 6250.656213908279, 5350.545203657655, 5425.538829199562, 5754.74103665336, 5786.421357864264, 5795.33353664334, 5441.183822426588, 5451.918221226685, 5466.972665136649, 5470.863228419242, 5479.75341109651, 5263.868403289872, 6164.660943648142, 6334.334894835976, 6349.523785715997, 6357.237131544151, 6174.9691251545255, 6187.690615469299, 6207.037909124093, 6215.0, 6217.316095229431, 6302.212223472066, 6378.744850206125, 6399.072134540373, 6409.35906409374, 6411.262704789009, 6095.878082438415, 6111.480524155319, 6118.0, 6123.2652081750475, 6128.63228206309, 6037.667928263988, 6110.953680641605, 6144.846378840386, 6178.474829639351, 6213.875722485615, 6087.515510307694, 6108.053251745987, 6108.694565271808, 6109.040306147876, 6123.6596393800855, 5985.880282394415, 6081.361457046946, 6127.387261274015, 6130.141780150871, 6133.294671112701, 5826.0, 5880.294364676266, 5960.254968128984, 5994.6403215807195, 6045.909311360245, 4988.9251661225835, 6022.1870047543025, 6058.182145410313, 6084.087386891824, 6088.908666369919, 4950.504949505021, 5833.387494313036, 5851.473367396955, 5889.175515427929, 5933.703314834327], "value": 5655.188812127881, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.1884817537922, 485.6843052016191, 498.4591717985985, 521.2207749414625, 526.9934425247776, 38046.429303560435, 40796.18407631846, 40853.0, 40860.97847553809, 40917.38623920636, 40802.79598602003, 41205.0, 41861.74414767554, 41894.0, 41922.16155676885, 9454.810903781938, 9555.187809036206, 9600.471974041426, 9655.46894920779, 9668.661596844111, 9571.042895710443, 9621.759456013586, 9647.0, 9657.32398732089, 9658.806823863519, 9587.760305992337, 9633.614655413776, 9661.178799802025, 9682.70951871445, 9683.322167448281, 9645.421274723503, 9669.903300966971, 9685.661001864972, 9688.46713430761, 9707.077827606367, 9521.952390238004, 9570.425774453555, 9589.664361747306, 9607.4715890626, 9648.469334186617, 39026.60973390258, 39071.80464097661, 39365.60634393648, 39429.21141577181, 39498.81503554898, 3109.3781243751114, 3358.9160270993175, 3406.8807591734417, 3414.9413681758733, 3431.5367425397503, 29590.0, 30143.397132057456, 30256.09231723052, 31417.37165256705, 31445.056648300586, 3241.092494101655, 3253.511973204015, 3270.8201048942296, 3280.16355829262, 3371.679690429405, 500274.0, 503709.0, 506040.46979765233, 506622.0, 508274.0, 60716.69641651763, 61086.0837087444, 61137.08294375588, 61191.38808611857, 61346.77306453846, 34421.96734097981, 34728.78449254264, 35092.12269693227, 35724.82137589347, 60456.69771651114, 15363.0, 15740.055596664237, 15785.842141578667, 15922.044677319398, 15953.441629543142, 11977.041836653047, 12063.155579109378, 12129.02967762577, 12137.635870923887, 12151.027917766558, 19194.904025479784, 19199.52001199981, 19332.71000934987, 19398.4180474586, 19437.319693810932, 6765.289644587346, 7879.606019698992, 8029.156938521488, 8072.434929554992, 8124.918750812416, 895.3285036222833, 907.2923119966437, 974.4786539201493, 1019.50553981319, 1092.208149091918, 30036.399272014438, 30454.0, 30531.38937221243, 30542.06758219412, 30839.0, 1038.9896101039044, 1061.1404762142536, 1073.6725298783947, 1081.869446428484, 1083.149727463937, 15401.691966160613, 15634.06195628266, 15640.687186256439, 15923.0, 16041.358345666276, 653236.0, 657122.0, 657154.0, 657336.0, 659069.0, 57835.71082144647, 58029.419705803244, 58575.70712146412, 58656.41343586509, 58678.413215868146, 1340.2427628389928, 1356.2066191278213, 1369.3153423288356, 1378.6484446466086, 1382.6819831438825, 29187.41625167442, 29697.406051879272, 29885.402291954473, 30096.0, 30171.849140755035, 50025.0, 50334.49665503445, 50665.240021400445, 50885.47343579699, 50924.0, 524008.0, 525222.0, 526402.0, 527595.0, 528382.0, 26576.202713918614, 26737.064202752812, 26926.461470770082, 27067.187984360502, 27084.916603336434, 38949.61050389573, 47390.52609473999, 48037.5196248033, 48322.79193020062, 48972.0, 29315.0, 39175.0, 39462.605373945895, 39819.0, 40479.79760101181, 39059.60940390673, 39312.0, 39420.60579394169, 40000.799995999834, 40534.0, 38443.42334864923, 38610.227795444494, 38667.0, 39038.02404939899, 39325.80337098296, 32454.0, 34344.313113738084, 35117.0, 35150.82424587963, 35165.47251791276, 22175.778242218017, 23599.0, 25922.574258415214, 26015.73984260133, 26097.0], "value": 19722.85200527237, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.32655535212746, 373.1212993400542, 379.3342683590299, 391.371848183665, 399.7801209334865, 19799.010049497523, 20160.0, 20735.274265400712, 20832.791672083276, 21116.472088197803, 19554.804451955475, 19713.11290991905, 20393.388198354074, 20550.58898822023, 20858.58282834346, 5427.240186373911, 5577.247071645326, 5830.533557315426, 5942.405759424067, 6023.608465449754, 5803.419658034205, 5904.468597826216, 5940.732667029973, 5942.197803296564, 5954.434328738785, 5707.600467967244, 5748.5975981681295, 5762.711864406784, 5822.970885145568, 5833.591648584601, 5660.801871934483, 5698.17376480408, 5766.221560089376, 5837.416258374171, 5848.795292164775, 4954.405471343462, 5228.477152284741, 5245.160774276097, 5287.180487024518, 5342.252084708144, 12699.873001270054, 12852.485900563966, 12916.0, 13077.476900923952, 13223.867761322359, 2102.9158833646634, 2138.1447421031557, 2151.752548456916, 2162.556675881456, 2179.6294629912954, 9741.025897410273, 9775.169110625606, 9934.801303973953, 10006.649767258185, 10031.74920626983, 1772.5568607848038, 1784.6519928613925, 1800.5138612574663, 1822.9908850455795, 1848.663162990801, 88600.0, 123679.0, 127962.0, 129916.0, 130963.0, 10905.781884362268, 11268.15488838324, 11397.658070257905, 11746.0, 11913.761724765629, 13797.448102076005, 14041.297935103205, 14242.786358204636, 14297.78553321701, 14317.284135793168, 6661.40047395727, 7918.762437126896, 8191.631376588068, 8303.667853285922, 8325.5004699717, 7222.349988500955, 8020.11778704342, 8058.758237252891, 8164.877526837102, 8204.343652507905, 3274.7216486598904, 3752.718546108998, 3921.8235179416993, 4379.861236078579, 4491.842785502492, 1647.2916645842163, 1916.8370688491354, 1930.1700268884515, 1945.1830231302886, 1947.8831270123555, 715.3990647855826, 934.9158575728081, 944.1644144931647, 964.4309857184155, 986.6645340584236, 14858.702825943421, 15876.364945402285, 20489.590208195754, 20579.382618521468, 20660.58678826415, 863.5897948474425, 922.3359181389388, 972.8151651186251, 993.180625983552, 993.2947607198826, 10408.427536485415, 10803.297785643908, 10806.675799726021, 10833.945830270955, 10853.837192442119, 545051.0, 564315.0, 600500.0, 604608.0, 622643.0, 77202.6139869297, 117148.0, 128084.35957820152, 130037.0, 133465.33267333795, 415.4619767401223, 447.311140843098, 449.42024788023735, 449.78185579993675, 451.7425067711439, 10869.29349592274, 11240.156988225752, 18359.724604130683, 18922.243110275434, 19079.71380429267, 53320.73339633277, 54303.45696542984, 55963.720181398836, 56115.71942140427, 56223.43776562182, 61260.0, 71165.5092071775, 71184.28815711777, 72493.91259131012, 75278.0, 5282.630215884851, 5417.83746487606, 8203.30271926893, 8446.450980686235, 8540.231379175904, 10665.46672666348, 10716.142708583451, 12871.22772633645, 13423.798643020558, 13629.318534073058, 11485.02377297939, 11680.123990700562, 11692.369216926123, 11744.29534227949, 11822.527098915947, 11315.660530184108, 11347.602833900773, 11662.591809286634, 11669.0, 11775.352355620524, 11551.826722599335, 11575.88424115748, 11820.527178912747, 11842.644720658394, 11961.0, 8303.1281715419, 8360.372972027, 8389.706360277361, 8408.2432581068, 8444.704435344733, 8670.523121228392, 9847.409155450696, 11704.005159561533, 11720.648380548597, 11728.94135529317], "value": 8919.94582831091, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.2483758120943, 1539.7844301797747, 1619.4089157457531, 1733.575274057856, 1861.851051915847, 7740.342070923978, 7940.602969851513, 8289.0, 8864.157904999023, 8872.822543549133, 7011.89482157768, 8673.392862499628, 8679.86980195296, 8691.43505672131, 8693.0, 2294.8737819419966, 2307.204014614955, 2337.906483740648, 2344.120954642009, 2349.177787774274, 2014.6474366985792, 2270.0692715986447, 2314.271004633535, 2319.6288593824906, 2320.454693147109, 2327.2320134355705, 2332.067173130753, 2344.4373350395867, 2350.4828937633692, 2350.8589484630893, 2307.411610039429, 2320.3619004773736, 2321.7097862767155, 2329.9883500582473, 2340.0756701103055, 2294.0021090825544, 2323.93028209154, 2324.2910912171783, 2326.6161083421216, 2333.0784340185533, 8556.358273129541, 8561.972563292446, 8675.132486751338, 8676.566171691453, 8679.652813887436, 4415.227335216357, 5120.206368012964, 5216.321878155815, 5266.447023062561, 5268.130758424855, 3417.9145521361916, 3477.687008169277, 3561.821908904544, 3583.8924832255075, 3632.128289210597, 987.521052289639, 1031.5564307347838, 1036.5387402605843, 1045.3309881675734, 1045.9633912813015, 10903.83644245337, 11264.887351126548, 11304.37825919574, 11457.770844583061, 11467.311961282267, 4508.458984921765, 4607.433472619326, 4706.717596944126, 4710.36410084641, 4736.8105275788585, 9248.768780780534, 9735.659251926148, 9832.459214743114, 9846.704598862045, 9847.261455390875, 5196.272521846944, 5258.106121959276, 5274.26160337553, 5278.049951008856, 5279.208118782137, 3868.864589739346, 4324.891877703082, 4774.761261936958, 4803.927941080887, 4821.421429428491, 3892.1826416452295, 3911.6675082618294, 3980.144268982183, 4038.51537815464, 4048.67610591152, 1278.5972418688084, 1290.7160424706549, 1295.1775622479793, 1301.7266374061364, 1306.1640550047978, 813.6297984417076, 834.2700137379793, 918.7565295196778, 921.9946616109934, 923.6997975657938, 5743.339515955635, 5776.335721392094, 5915.260592425947, 5916.171735956969, 5972.611780234358, 431.0538368281592, 439.8944253379166, 442.05400443051894, 442.2503855964174, 442.7078128435217, 3402.608699999532, 3979.7612143270917, 4037.7577345358786, 4054.1688953764997, 4060.9796951015646, 10190.388576685422, 10644.414557199429, 10666.78666426667, 10682.786344273227, 10736.463176841127, 8877.467351958903, 10537.578496860193, 10627.36235825853, 10662.893371066346, 10672.092872105803, 7633.160352361236, 7876.527408355402, 8110.513369197867, 8181.795455113551, 8201.876971845428, 5074.746262686777, 5779.624324418899, 5839.182514447895, 5845.561582881386, 5855.38518455556, 9749.56126974302, 9796.020397960147, 9846.704598862045, 9896.851547226941, 9937.006299370005, 9863.358881672668, 9933.3543319684, 9969.750756230862, 10110.797784044425, 10143.7464063399, 6837.213720422215, 7222.277772222946, 7302.707891684273, 7437.70249190048, 7540.1328847181085, 8332.0, 8340.916590834015, 8356.87464688018, 8434.451760635538, 8443.831123377375, 6279.96860015697, 7350.264973502607, 7504.587247701211, 7541.283578060075, 7581.241875812595, 7295.0, 7349.118105827335, 7380.815479613053, 7389.334959853639, 7444.255574442513, 6848.3494068063455, 6891.241963384124, 6930.27232140618, 6931.272216417204, 6936.965315173392, 4928.236123400879, 4934.5312195341385, 4984.352034235526, 5008.449070602303, 5054.09026375256, 4872.297451918738, 4911.656184067224, 5018.347614810052, 5105.489451054865, 5141.357330333708], "value": 4427.735445374284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.188655162614, 299.9475091858925, 308.8116249088056, 310.1393632669341, 313.49214272877924, 4576.5423457654215, 4730.597899178565, 5265.368155821302, 5639.887202255957, 5707.229524014257, 4291.605228300807, 5500.314789091319, 5557.194206840016, 5584.274044374226, 5611.148321054053, 3658.213484100918, 3769.962300377002, 4273.829046838123, 4325.545817689144, 4391.516933137353, 3547.8935631930954, 3710.5361829771277, 3927.463779334873, 4018.839246430139, 4174.874753757377, 3495.7727747696445, 3512.6838584527386, 4197.223513649969, 4215.220184265905, 4225.323948168294, 3398.745094117951, 3675.4563083504727, 4224.746515209097, 4233.51314598822, 4236.597523235288, 2792.7765778737653, 3028.4700177468853, 3613.1328481164596, 3689.5756987946193, 3798.7966979152025, 5431.728413579305, 5462.617616766828, 5490.862728431781, 5501.312335958005, 5545.863098064887, 4077.0, 4260.38224457455, 4450.888727781831, 4843.975780121077, 4882.218844984785, 4979.0, 5172.172452407597, 5228.816991405282, 5351.608581768729, 5950.8809823803285, 3548.8048157351336, 3915.471411359487, 3986.80065996699, 4015.9196816063513, 4030.6775457963586, 5235.607329450307, 6300.621962682254, 6304.716287767015, 6349.333320001426, 6388.329225431356, 3745.831437585315, 3898.7855667938534, 4012.277789997828, 4028.703638925843, 4070.531888832763, 4076.979615101965, 4080.6327430531396, 4089.0, 4091.734037287567, 4093.7134400592267, 4204.87385378433, 4778.163821331323, 4779.832705855279, 4809.44691360498, 4838.2016967200725, 5571.470710282517, 5721.455207094062, 5930.7924222652, 6039.0, 6041.6375017499095, 1106.8727096383857, 1319.3139567425078, 1345.502164199233, 1351.0, 1374.6906945937285, 868.7654333329965, 902.3457992955055, 907.0793144957873, 938.483833891357, 939.2626787971546, 5478.506934375925, 5548.389677135512, 5550.944490555043, 5569.721513924287, 5587.413321601254, 6114.3708205471185, 6136.417040381157, 6149.66176860268, 6149.831532008904, 6172.814815555541, 4634.536546345406, 5511.917321240185, 5515.806946756844, 5567.937634301118, 5583.956743574761, 2728.639726636445, 3191.744660427207, 3224.9841299990426, 3244.626867910173, 3245.6592057833586, 5620.803271885465, 5989.850253743692, 6373.330800265998, 6384.648844313514, 6391.648459334781, 5317.7872885084935, 5993.670348130808, 6310.716017779211, 6401.391867772554, 6459.838504037342, 5176.611754118456, 6352.6823658816875, 6441.710123044568, 6492.577982431127, 6548.0, 4733.479317275166, 5158.38099428071, 5380.596455265792, 5764.394738552392, 6115.755369785159, 5639.915401269066, 6133.068083553666, 6134.815955521163, 6163.84590385244, 6225.252969643671, 5480.534154596904, 5558.828522072547, 6029.969850150721, 6115.3578874217565, 6473.676316184266, 4143.440635514167, 4181.243877571366, 4199.685023623301, 4203.894902627459, 4211.473565804275, 4811.893264549103, 5358.35699716021, 5934.546036221153, 6145.35473775265, 6163.938360616516, 5202.583793296603, 5771.095538472378, 5936.910946335895, 5950.880982380415, 5967.433093856077, 4612.930806037845, 5447.12845944647, 5517.751701173537, 5580.832575022756, 6034.366391529002, 4832.637552183671, 5117.974410127926, 5492.313460817398, 5813.0, 5871.001929671881, 5859.0, 5926.436988486087, 6038.671492271869, 6042.972694641833, 6092.360302168386, 5581.832545023656, 5877.676727780014, 5918.23063001807, 5922.822315330547, 5938.376470470711], "value": 4251.451583147362, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.7998560403088, 744.6202436757252, 770.9344705700015, 827.7516744976506, 863.335231871459, 15174.848251517482, 15826.762598561016, 15842.049477031385, 15851.524454266391, 16081.195940202986, 11288.209825312231, 14066.156030638169, 14074.507392241274, 14097.942654300918, 14099.365528551214, 835.6072645856437, 838.3586556284447, 867.8915135608049, 876.8772371867943, 894.7941973346134, 854.0775961961098, 890.8262888736699, 892.7411050795262, 894.2041582991111, 894.6153154143716, 915.4827522449795, 919.2278486071698, 931.1759093202497, 935.1303287942211, 937.779621788879, 926.420986883198, 927.1238679447924, 928.9814203715922, 929.2705226397279, 929.8977112517617, 669.3941982505792, 683.2313647146959, 691.636890632422, 695.4679670052413, 698.3156506623537, 15157.924210378987, 15419.151946643042, 15610.76583851243, 15636.0, 15680.372785088583, 13913.30433478322, 14240.572782816533, 14334.354954027094, 14401.351939162763, 14513.854861451357, 10144.644937427229, 11766.58816941403, 12005.473317576812, 12219.327936963464, 12466.439010244561, 3590.8025058621765, 3807.0, 3809.7523660962224, 3878.972072400788, 3883.0292426893275, 117873.41063294714, 119178.0, 119800.20299695512, 120742.0, 123308.0, 9717.271204659679, 10950.342508221793, 11026.283291586022, 11047.502862371213, 11403.828942565702, 22295.219667311565, 22862.42843928915, 22896.88551557265, 22922.96846641872, 23011.0, 7892.0924093729955, 7970.402219833536, 8166.265036146657, 8219.383546234056, 8276.0, 4035.394690796404, 4456.9108617828115, 4497.415336006364, 4545.954540454619, 4574.81700731967, 3559.4126969049817, 3621.7102631789394, 3677.2277821657217, 3682.4844521766972, 3682.5949145593963, 635.7520566978882, 647.7668039505775, 650.5576208178484, 652.350910843704, 668.238208442376, 602.0728078758663, 627.4729227448964, 627.7269387816223, 674.8043067510367, 675.9425448836805, 8335.708250211213, 8993.370464067453, 9399.812003760024, 9460.52697365129, 9786.27502910791, 496.70197881271673, 532.4622131647064, 635.4471609699499, 636.926753423353, 659.6042374575217, 4310.43964284641, 4652.651051171176, 4708.599769019604, 4717.198076327033, 4741.715497070187, 121841.39079304723, 154702.0, 155500.0, 161549.38450615344, 162472.0, 118750.21874671886, 133034.0, 136901.0, 139459.0, 140935.0, 82758.0, 82902.0, 96686.0331396677, 103485.48257258817, 108896.91103089026, 7761.573113478587, 9013.954930225307, 9101.40840845343, 9145.63417463294, 9182.17360437564, 50183.0, 65188.67405662941, 66566.33433665601, 67673.3232667667, 68760.0, 97482.0, 102878.48560757148, 104912.47543762233, 105177.47411262894, 107666.0, 10878.0, 11316.321020738782, 11562.710932226426, 12169.939150304546, 12401.13192076582, 13151.21092734439, 13257.270850103338, 13492.055556110978, 13944.79082813779, 14163.0, 12199.085068620067, 12285.815712764137, 12388.0, 12494.562690306158, 12651.810222846849, 11776.941115294369, 12043.397830108284, 12067.698307542381, 12471.0, 12471.438785254504, 11947.522099115939, 11970.922616964515, 12093.939530302292, 12109.212901161396, 12530.122891397516, 8793.516356600448, 10548.472576370998, 10584.364938103738, 10698.572057117939, 11047.226694131334, 7544.509606875536, 8383.161683831568, 8564.314854811724, 9428.858567121362, 10339.741506462398], "value": 7722.944862751669, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1617.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 170.0, 119.0, 118.0, 120.0, 159.0, 163.0, 129.0, 117.0, 117.0], "value": 132.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 130.0, 183.0, 137.0, 161.0, 129.0, 111.0, 164.0, 136.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [265.0, 201.0, 194.0, 233.0, 273.0, 251.0, 195.0, 190.0, 195.0, 200.0], "value": 219.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 82.0, 77.0, 147.0, 51.0, 58.0, 64.0, 89.0, 157.0, 82.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 100.0, 149.0, 80.0, 71.0, 95.0, 115.0, 72.0, 72.0, 114.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 114.0, 93.0, 91.0, 91.0, 89.0, 94.0, 89.0, 92.0, 89.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 155.0, 152.0, 98.0, 97.0, 97.0, 97.0, 103.0, 104.0, 141.0], "value": 114.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 122.0, 110.0, 92.0, 92.0, 89.0, 90.0, 79.0, 144.0], "value": 100.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 56.0, 56.0, 58.0, 58.0, 56.0, 57.0, 57.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 71.0, 72.0, 79.0, 80.0, 78.0, 73.0, 71.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 83.0, 85.0, 73.0, 96.0, 102.0, 107.0, 86.0, 89.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 151.0, 152.0, 139.0, 138.0, 150.0, 151.0, 160.0, 162.0, 166.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 167.0, 183.0, 227.0, 223.0, 172.0, 168.0, 169.0, 240.0], "value": 188.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 68.0, 69.0, 66.0, 66.0, 70.0, 67.0, 66.0], "value": 67.4, "unit": "score"}]}]} 17:58:45 INFO - Return code: 0 17:58:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:58:45 ERROR - # TBPL SUCCESS # 17:58:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:58:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:58:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:58:45 INFO - 2016-08-08 17:58:45.728 screenresolution[2235:26765] starting screenresolution argv=screenresolution get 17:58:45 INFO - 2016-08-08 17:58:45.731 screenresolution[2235:26765] Display 0: 1600x1200x32@60 17:58:45 INFO - 2016-08-08 17:58:45.737 screenresolution[2236:26768] starting screenresolution argv=screenresolution list 17:58:45 INFO - Available Modes on Display 0 17:58:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:58:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:58:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:58:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:58:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:58:45 INFO - Intel Iris: 17:58:45 INFO - Chipset Model: Intel Iris 17:58:45 INFO - Type: GPU 17:58:45 INFO - Bus: Built-In 17:58:45 INFO - VRAM (Dynamic, Max): 1536 MB 17:58:45 INFO - Vendor: Intel (0x8086) 17:58:45 INFO - Device ID: 0x0a2e 17:58:45 INFO - Revision ID: 0x0009 17:58:45 INFO - Displays: 17:58:45 INFO - Display: 17:58:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:58:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:58:45 INFO - Display Serial Number: 1600x1200 60 17:58:45 INFO - Main Display: Yes 17:58:45 INFO - Mirror: Off 17:58:45 INFO - Online: Yes 17:58:45 INFO - Rotation: Supported 17:58:45 INFO - Return code: 0 17:58:45 INFO - Running post-action listener: _resource_record_post_action 17:58:45 INFO - [mozharness: 2016-08-09 00:58:45.977246Z] Finished run-tests step (success) 17:58:45 INFO - Running post-run listener: _resource_record_post_run 17:58:46 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1183744; Write bytes: 710380544; Read time: 12; Write time: 1996 17:58:46 INFO - TinderboxPrint: CPU usage
54.3% 17:58:46 INFO - TinderboxPrint: I/O read bytes / time
1,183,744 / 12 17:58:46 INFO - TinderboxPrint: I/O write bytes / time
710,380,544 / 1,996 17:58:46 INFO - TinderboxPrint: CPU idle
2,214.4 (45.7%) 17:58:46 INFO - TinderboxPrint: CPU system
977.5 (20.2%) 17:58:46 INFO - TinderboxPrint: CPU user
1,649.7 (34.1%) 17:58:46 INFO - TinderboxPrint: Swap in / out
407,736,320 / 0 17:58:46 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407792128; Write bytes: 410846720; Read time: 30736; Write time: 847 17:58:46 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1146880; Write bytes: 298046976; Read time: 12; Write time: 1140 17:58:46 INFO - Running post-run listener: _upload_blobber_files 17:58:46 INFO - Blob upload gear active. 17:58:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:58:46 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 17:58:46 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'] 17:58:46 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 17:58:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:47 INFO - (blobuploader) - INFO - Done attempting. 17:58:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:58:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:58:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:48 INFO - (blobuploader) - INFO - Done attempting. 17:58:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:58:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:58:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:51 INFO - (blobuploader) - INFO - Done attempting. 17:58:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:58:51 INFO - Return code: 0 17:58:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:58:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:58:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b2e3c2aef6563df286c78b4bb59a5c47d8cf60a4fdc868e4cab20ae6433450e5b67db24619039e9799a7d10c716548862fc2277c403c700755eeadac32f28d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37729502c017ad7f070b35331c695a752c3763575fd46bd0fba7b0663a16a8cda22cabffefbe159db23da9a64502edb692e52c719c843c6267df190ca2a08447", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/15ce5220b8db6f0d6c1a2582969e088db165985851450643a97b2420230c8516d263380c4398f4779488f317ec4081fbce8858ba0c99470204ed97e7a670436f"} 17:58:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:58:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:58:51 INFO - Contents: 17:58:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b2e3c2aef6563df286c78b4bb59a5c47d8cf60a4fdc868e4cab20ae6433450e5b67db24619039e9799a7d10c716548862fc2277c403c700755eeadac32f28d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37729502c017ad7f070b35331c695a752c3763575fd46bd0fba7b0663a16a8cda22cabffefbe159db23da9a64502edb692e52c719c843c6267df190ca2a08447", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/15ce5220b8db6f0d6c1a2582969e088db165985851450643a97b2420230c8516d263380c4398f4779488f317ec4081fbce8858ba0c99470204ed97e7a670436f"} 17:58:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:58:51 INFO - Copying logs to upload dir... 17:58:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:58:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.546428 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-08 17:58:51.587121) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 17:58:51.591047) ========= 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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b2e3c2aef6563df286c78b4bb59a5c47d8cf60a4fdc868e4cab20ae6433450e5b67db24619039e9799a7d10c716548862fc2277c403c700755eeadac32f28d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37729502c017ad7f070b35331c695a752c3763575fd46bd0fba7b0663a16a8cda22cabffefbe159db23da9a64502edb692e52c719c843c6267df190ca2a08447", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/15ce5220b8db6f0d6c1a2582969e088db165985851450643a97b2420230c8516d263380c4398f4779488f317ec4081fbce8858ba0c99470204ed97e7a670436f"} build_url:https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011599 build_url: 'https://queue.taskcluster.net/v1/task/VXcOzpm1R3OZ_c3E7qvshQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b2e3c2aef6563df286c78b4bb59a5c47d8cf60a4fdc868e4cab20ae6433450e5b67db24619039e9799a7d10c716548862fc2277c403c700755eeadac32f28d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37729502c017ad7f070b35331c695a752c3763575fd46bd0fba7b0663a16a8cda22cabffefbe159db23da9a64502edb692e52c719c843c6267df190ca2a08447", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/15ce5220b8db6f0d6c1a2582969e088db165985851450643a97b2420230c8516d263380c4398f4779488f317ec4081fbce8858ba0c99470204ed97e7a670436f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 17:58:51.630050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:58:51.630617) ========= 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.OAx9nt42Vt/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.NHIhLQOG8m/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.005335 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:58:51.680185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 17:58:51.680506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 17:58:51.680848) ========= ========= Total master_lag: 0.38 =========