builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0097 starttime: 1470832312.69 results: success (0) buildid: 20160810030202 builduid: 1104e10009e6475594166a23e45c1d7b revision: 6cf0089510fad8deb866136f5b92bbced9498447 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:52.690034) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:52.690990) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:52.691673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:52.748939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:52.749241) ========= 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.f2fqRhBJzE/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.O8gxsztS3F/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-10 05:31:52-- 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% 163M=0s 2016-08-10 05:31:52 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208783 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:52.988110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:52.988424) ========= 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.f2fqRhBJzE/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.O8gxsztS3F/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.038540 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:53.055946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 05:31:53.056317) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6cf0089510fad8deb866136f5b92bbced9498447 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6cf0089510fad8deb866136f5b92bbced9498447 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f2fqRhBJzE/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.O8gxsztS3F/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-10 05:31:53,136 truncating revision to first 12 chars 2016-08-10 05:31:53,136 Setting DEBUG logging. 2016-08-10 05:31:53,137 attempt 1/10 2016-08-10 05:31:53,137 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6cf0089510fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 05:31:54,321 unpacking tar archive at: mozilla-central-6cf0089510fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.506173 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 05:31:54.595794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:54.596407) ========= script_repo_revision: 6cf0089510fad8deb866136f5b92bbced9498447 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:54.597255) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:54.597937) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 05:31:54.659981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-10 05:31:54.660630) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f2fqRhBJzE/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.O8gxsztS3F/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:31:54 INFO - MultiFileLogger online at 20160810 05:31:54 in /builds/slave/test 05:31:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:31:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:54 INFO - {'append_to_log': False, 05:31:54 INFO - 'base_work_dir': '/builds/slave/test', 05:31:54 INFO - 'blob_upload_branch': 'Firefox', 05:31:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:54 INFO - 'branch': 'Firefox', 05:31:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:54 INFO - 'config_files': ('talos/mac_config.py',), 05:31:54 INFO - 'default_actions': ('clobber', 05:31:54 INFO - 'read-buildbot-config', 05:31:54 INFO - 'download-and-extract', 05:31:54 INFO - 'populate-webroot', 05:31:54 INFO - 'create-virtualenv', 05:31:54 INFO - 'install', 05:31:54 INFO - 'run-tests'), 05:31:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:54 INFO - 'download_minidump_stackwalk': True, 05:31:54 INFO - 'download_symbols': 'ondemand', 05:31:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:54 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:54 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:54 INFO - 'installer_path': 'installer.exe', 05:31:54 INFO - 'log_level': 'info', 05:31:54 INFO - 'log_name': 'talos', 05:31:54 INFO - 'log_to_console': True, 05:31:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:54 INFO - 'opt_config_files': (), 05:31:54 INFO - 'pip_index': False, 05:31:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:54 INFO - 'cmd': ('bash', 05:31:54 INFO - '-c', 05:31:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:54 INFO - 'enabled': True, 05:31:54 INFO - 'halt_on_failure': False, 05:31:54 INFO - 'name': 'check_screen_resolution'},), 05:31:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:54 INFO - 'cmd': ('bash', 05:31:54 INFO - '-c', 05:31:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:54 INFO - 'enabled': True, 05:31:54 INFO - 'halt_on_failure': False, 05:31:54 INFO - 'name': 'check_screen_resolution'},), 05:31:54 INFO - 'run_cmd_checks_enabled': True, 05:31:54 INFO - 'sps_profile': False, 05:31:54 INFO - 'sps_profile_interval': 0, 05:31:54 INFO - 'suite': 'dromaeojs-e10s', 05:31:54 INFO - 'system_bits': '32', 05:31:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:54 INFO - 'title': 't-yosemite-r7-0097', 05:31:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:54 INFO - 'use_talos_json': True, 05:31:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:54 INFO - 'work_dir': 'build'} 05:31:54 INFO - [mozharness: 2016-08-10 12:31:54.873238Z] Running clobber step. 05:31:54 INFO - Running pre-action listener: _resource_record_pre_action 05:31:54 INFO - Running main action method: clobber 05:31:54 INFO - rmtree: /builds/slave/test/build 05:31:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:56 INFO - Running post-action listener: _resource_record_post_action 05:31:56 INFO - [mozharness: 2016-08-10 12:31:56.972155Z] Finished clobber step (success) 05:31:56 INFO - [mozharness: 2016-08-10 12:31:56.972287Z] Running read-buildbot-config step. 05:31:56 INFO - Running pre-action listener: _resource_record_pre_action 05:31:56 INFO - Running main action method: read_buildbot_config 05:31:56 INFO - Using buildbot properties: 05:31:56 INFO - { 05:31:56 INFO - "project": "", 05:31:56 INFO - "product": "firefox", 05:31:56 INFO - "script_repo_revision": "production", 05:31:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:31:56 INFO - "repository": "", 05:31:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:31:56 INFO - "buildid": "20160810030202", 05:31:56 INFO - "stage_platform": "macosx64", 05:31:56 INFO - "basedir": "/builds/slave/test", 05:31:56 INFO - "nightly_build": "True", 05:31:56 INFO - "buildnumber": 278, 05:31:56 INFO - "slavename": "t-yosemite-r7-0097", 05:31:56 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:31:56 INFO - "platform": "yosemite_r7", 05:31:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:56 INFO - "branch": "mozilla-central", 05:31:56 INFO - "repo_path": "mozilla-central", 05:31:56 INFO - "revision": "6cf0089510fad8deb866136f5b92bbced9498447", 05:31:56 INFO - "pgo_build": "False", 05:31:56 INFO - "builduid": "1104e10009e6475594166a23e45c1d7b", 05:31:56 INFO - "slavebuilddir": "test" 05:31:56 INFO - } 05:31:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:31:56 INFO - Running post-action listener: _resource_record_post_action 05:31:56 INFO - [mozharness: 2016-08-10 12:31:56.975645Z] Finished read-buildbot-config step (success) 05:31:56 INFO - [mozharness: 2016-08-10 12:31:56.975781Z] Running download-and-extract step. 05:31:56 INFO - Running pre-action listener: _resource_record_pre_action 05:31:56 INFO - Running main action method: download_and_extract 05:31:56 INFO - mkdir: /builds/slave/test/build/tests 05:31:56 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')]} 05:31:56 INFO - trying https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:31:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/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 05:31:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/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 05:31:58 INFO - Downloaded 1199 bytes. 05:31:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:31:58 INFO - Using the following test package requirements: 05:31:58 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:31:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:31:58 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:31:58 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:31:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:31:58 INFO - u'jsshell-mac.zip'], 05:31:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:31:58 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:31:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:31:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:31:58 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:31:58 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:31:58 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:31:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:31:58 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:31:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:31:58 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31: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')]} 05:31:58 INFO - trying https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:31:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/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 05:31:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/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 05:31:59 INFO - Downloaded 16326158 bytes. 05:31:59 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'] 05:31:59 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 05:32:02 INFO - Return code: 0 05:32:02 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 05:32:02 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')]} 05:32:02 INFO - trying https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:32:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/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 05:32:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/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 05:32:03 INFO - Downloaded 16326158 bytes. 05:32:03 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'] 05:32:03 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 05:32:07 INFO - Return code: 0 05:32: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')]} 05:32:07 INFO - trying https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:32:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/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 05:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/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 05:32:08 INFO - Downloaded 14413723 bytes. 05:32:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:32:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:32:08 INFO - Return code: 0 05:32: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')]} 05:32:08 INFO - trying https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:32:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/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 05:32:11 INFO - Downloaded 111030119 bytes. 05:32:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:32:11 INFO - mkdir: /builds/slave/test/properties 05:32:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:11 INFO - Contents: 05:32:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:32:12 INFO - Running post-action listener: _resource_record_post_action 05:32:12 INFO - Running post-action listener: set_extra_try_arguments 05:32:12 INFO - [mozharness: 2016-08-10 12:32:12.280251Z] Finished download-and-extract step (success) 05:32:12 INFO - [mozharness: 2016-08-10 12:32:12.280412Z] Running populate-webroot step. 05:32:12 INFO - Running pre-action listener: _resource_record_pre_action 05:32:12 INFO - Running main action method: populate_webroot 05:32:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:12 INFO - '--tppagecycles', 05:32:12 INFO - '7'], 05:32:12 INFO - 'tests': ['tsvgm']}}, 05:32:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:12 INFO - 'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:12 INFO - 'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['damp', 'tps']}, 05:32:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:12 INFO - 'tests': ['damp', 'tps']}, 05:32:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['dromaeo_dom']}, 05:32:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['basic_compositor_video']}, 05:32:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:32:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['a11yr', 05:32:12 INFO - 'ts_paint', 05:32:12 INFO - 'tpaint', 05:32:12 INFO - 'sessionrestore', 05:32:12 INFO - 'sessionrestore_no_auto_restore', 05:32:12 INFO - 'tabpaint']}, 05:32:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:12 INFO - 'ts_paint', 05:32:12 INFO - 'tpaint', 05:32:12 INFO - 'sessionrestore', 05:32:12 INFO - 'sessionrestore_no_auto_restore', 05:32:12 INFO - 'tabpaint']}, 05:32:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:12 INFO - 'ts_paint', 05:32:12 INFO - 'tpaint', 05:32:12 INFO - 'sessionrestore', 05:32:12 INFO - 'sessionrestore_no_auto_restore', 05:32:12 INFO - 'tabpaint']}, 05:32:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:12 INFO - 'ts_paint', 05:32:12 INFO - 'tpaint', 05:32:12 INFO - 'sessionrestore', 05:32:12 INFO - 'sessionrestore_no_auto_restore', 05:32:12 INFO - 'tabpaint']}, 05:32:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['a11yr', 05:32:12 INFO - 'ts_paint', 05:32:12 INFO - 'tpaint', 05:32:12 INFO - 'sessionrestore', 05:32:12 INFO - 'sessionrestore_no_auto_restore', 05:32:12 INFO - 'tabpaint']}, 05:32:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['a11yr', 05:32:12 INFO - 'ts_paint', 05:32:12 INFO - 'tpaint', 05:32:12 INFO - 'sessionrestore', 05:32:12 INFO - 'sessionrestore_no_auto_restore', 05:32:12 INFO - 'tabpaint']}, 05:32:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['tsvgx', 05:32:12 INFO - 'tsvgr_opacity', 05:32:12 INFO - 'tart', 05:32:12 INFO - 'tscrollx', 05:32:12 INFO - 'cart']}, 05:32:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:12 INFO - 'tsvgr_opacity', 05:32:12 INFO - 'tart', 05:32:12 INFO - 'tscrollx', 05:32:12 INFO - 'cart']}, 05:32:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:12 INFO - 'talos_options': ['--disable-e10s'], 05:32:12 INFO - 'tests': ['tp5o']}, 05:32:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:12 INFO - 'tests': ['tp5o']}, 05:32:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:12 INFO - 'talos_options': ['--disable-e10s', 05:32:12 INFO - '--xperf_path', 05:32:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:12 INFO - 'tests': ['tp5n']}, 05:32:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:12 INFO - 'talos_options': ['--xperf_path', 05:32:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:12 INFO - 'tests': ['tp5n']}}, 05:32:12 INFO - 'talos.zip': {'path': '', 05:32:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:12 INFO - Running post-action listener: _resource_record_post_action 05:32:12 INFO - [mozharness: 2016-08-10 12:32:12.299492Z] Finished populate-webroot step (success) 05:32:12 INFO - [mozharness: 2016-08-10 12:32:12.299605Z] Running create-virtualenv step. 05:32:12 INFO - Running pre-action listener: _resource_record_pre_action 05:32:12 INFO - Running main action method: create_virtualenv 05:32:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:12 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 05:32:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:12 INFO - Using real prefix '/tools/python27' 05:32:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:16 INFO - Installing pip.................done. 05:32:16 INFO - Return code: 0 05:32:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:16 INFO - 'HOME': '/Users/cltbld', 05:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:16 INFO - 'LOGNAME': 'cltbld', 05:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:16 INFO - 'MOZ_NO_REMOTE': '1', 05:32:16 INFO - 'NO_EM_RESTART': '1', 05:32:16 INFO - 'PAGER': '/bin/cat', 05:32:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:16 INFO - 'PWD': '/builds/slave/test', 05:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:16 INFO - 'SHELL': '/bin/bash', 05:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:16 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:16 INFO - 'USER': 'cltbld', 05:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:16 INFO - 'XPC_FLAGS': '0x0', 05:32:16 INFO - 'XPC_SERVICE_NAME': '0', 05:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:16 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 05:32:16 INFO - Cleaning up... 05:32:16 INFO - Return code: 0 05:32:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:16 INFO - 'HOME': '/Users/cltbld', 05:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:16 INFO - 'LOGNAME': 'cltbld', 05:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:16 INFO - 'MOZ_NO_REMOTE': '1', 05:32:16 INFO - 'NO_EM_RESTART': '1', 05:32:16 INFO - 'PAGER': '/bin/cat', 05:32:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:16 INFO - 'PWD': '/builds/slave/test', 05:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:16 INFO - 'SHELL': '/bin/bash', 05:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:16 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:16 INFO - 'USER': 'cltbld', 05:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:16 INFO - 'XPC_FLAGS': '0x0', 05:32:16 INFO - 'XPC_SERVICE_NAME': '0', 05:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:16 INFO - Downloading/unpacking psutil>=3.1.1 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:20 INFO - Installing collected packages: psutil 05:32:20 INFO - Running setup.py install for psutil 05:32:20 INFO - building 'psutil._psutil_osx' extension 05:32:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:32:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:32:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:32:20 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 05:32:21 INFO - building 'psutil._psutil_posix' extension 05:32:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:32:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:21 INFO - ^ 05:32:21 INFO - 1 warning generated. 05:32:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:32:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:21 INFO - Successfully installed psutil 05:32:21 INFO - Cleaning up... 05:32:21 INFO - Return code: 0 05:32:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:21 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 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:21 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 05:32:21 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 05:32:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:21 INFO - 'HOME': '/Users/cltbld', 05:32:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:21 INFO - 'LOGNAME': 'cltbld', 05:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:21 INFO - 'MOZ_NO_REMOTE': '1', 05:32:21 INFO - 'NO_EM_RESTART': '1', 05:32:21 INFO - 'PAGER': '/bin/cat', 05:32:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:21 INFO - 'PWD': '/builds/slave/test', 05:32:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:21 INFO - 'SHELL': '/bin/bash', 05:32:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:21 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:21 INFO - 'USER': 'cltbld', 05:32:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:21 INFO - 'XPC_FLAGS': '0x0', 05:32:21 INFO - 'XPC_SERVICE_NAME': '0', 05:32:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:21 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 05:32:21 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 05:32:21 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 05:32:21 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 05:32:21 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 05:32:21 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 05:32:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:24 INFO - Installing collected packages: mozsystemmonitor 05:32:24 INFO - Running setup.py install for mozsystemmonitor 05:32:24 INFO - Successfully installed mozsystemmonitor 05:32:24 INFO - Cleaning up... 05:32:24 INFO - Return code: 0 05:32:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:24 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 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:24 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 05:32:24 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 05:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:24 INFO - 'HOME': '/Users/cltbld', 05:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:24 INFO - 'LOGNAME': 'cltbld', 05:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:24 INFO - 'MOZ_NO_REMOTE': '1', 05:32:24 INFO - 'NO_EM_RESTART': '1', 05:32:24 INFO - 'PAGER': '/bin/cat', 05:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:24 INFO - 'PWD': '/builds/slave/test', 05:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:24 INFO - 'SHELL': '/bin/bash', 05:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:24 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:24 INFO - 'USER': 'cltbld', 05:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:24 INFO - 'XPC_FLAGS': '0x0', 05:32:24 INFO - 'XPC_SERVICE_NAME': '0', 05:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:24 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:27 INFO - warning: no files found matching '*.txt' 05:32:27 INFO - no previously-included directories found matching 'build' 05:32:27 INFO - no previously-included directories found matching 'dist' 05:32:27 INFO - no previously-included directories found matching '.git*' 05:32:27 INFO - Installing collected packages: jsonschema, functools32 05:32:27 INFO - Running setup.py install for functools32 05:32:27 INFO - warning: no files found matching '*.txt' 05:32:27 INFO - no previously-included directories found matching 'build' 05:32:27 INFO - no previously-included directories found matching 'dist' 05:32:27 INFO - no previously-included directories found matching '.git*' 05:32:27 INFO - Successfully installed jsonschema functools32 05:32:27 INFO - Cleaning up... 05:32:27 INFO - Return code: 0 05:32:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32:27 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')]} 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 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')]} 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 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 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:27 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 05:32:27 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 05:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:27 INFO - 'HOME': '/Users/cltbld', 05:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:27 INFO - 'LOGNAME': 'cltbld', 05:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:27 INFO - 'MOZ_NO_REMOTE': '1', 05:32:27 INFO - 'NO_EM_RESTART': '1', 05:32:27 INFO - 'PAGER': '/bin/cat', 05:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:27 INFO - 'PWD': '/builds/slave/test', 05:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:27 INFO - 'SHELL': '/bin/bash', 05:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:27 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:27 INFO - 'USER': 'cltbld', 05:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:27 INFO - 'XPC_FLAGS': '0x0', 05:32:27 INFO - 'XPC_SERVICE_NAME': '0', 05:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:28 INFO - Cleaning up... 05:32:28 INFO - Return code: 0 05:32:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:28 INFO - 'HOME': '/Users/cltbld', 05:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:28 INFO - 'LOGNAME': 'cltbld', 05:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:28 INFO - 'MOZ_NO_REMOTE': '1', 05:32:28 INFO - 'NO_EM_RESTART': '1', 05:32:28 INFO - 'PAGER': '/bin/cat', 05:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:28 INFO - 'PWD': '/builds/slave/test', 05:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:28 INFO - 'SHELL': '/bin/bash', 05:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:28 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:28 INFO - 'USER': 'cltbld', 05:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:28 INFO - 'XPC_FLAGS': '0x0', 05:32:28 INFO - 'XPC_SERVICE_NAME': '0', 05:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:30 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 05:32:30 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 05:32:30 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 05:32:30 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 05:32:30 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 05:32:30 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 05:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:31 INFO - Downloading docopt-0.6.1.tar.gz 05:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:32 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:32 INFO - Running setup.py install for blobuploader 05:32:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:32 INFO - Running setup.py install for requests 05:32:32 INFO - Running setup.py install for docopt 05:32:32 INFO - Successfully installed blobuploader requests docopt 05:32:32 INFO - Cleaning up... 05:32:32 INFO - Return code: 0 05:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:32 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 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:32 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 05:32:32 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 05:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:32 INFO - 'HOME': '/Users/cltbld', 05:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:32 INFO - 'LOGNAME': 'cltbld', 05:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:32 INFO - 'MOZ_NO_REMOTE': '1', 05:32:32 INFO - 'NO_EM_RESTART': '1', 05:32:32 INFO - 'PAGER': '/bin/cat', 05:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:32 INFO - 'PWD': '/builds/slave/test', 05:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:32 INFO - 'SHELL': '/bin/bash', 05:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:32 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:32 INFO - 'USER': 'cltbld', 05:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:32 INFO - 'XPC_FLAGS': '0x0', 05:32:32 INFO - 'XPC_SERVICE_NAME': '0', 05:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:33 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-A6BYvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:33 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Tzd1Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:33 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-V11BBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:33 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-H2MUp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:33 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-gDZh4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:33 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-6CtOC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:33 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-G8qwGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:33 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-mAGZFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-FBI_Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-07zn15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-VTXLTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-EKtu4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-QoOlnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-HYIFfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-EtyUYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-YJCaqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-DTqueq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:34 INFO - Running setup.py install for manifestparser 05:32:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for mozcrash 05:32:35 INFO - Running setup.py install for mozdebug 05:32:35 INFO - Running setup.py install for mozdevice 05:32:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for mozfile 05:32:35 INFO - Running setup.py install for mozhttpd 05:32:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for mozinfo 05:32:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for mozInstall 05:32:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Running setup.py install for mozleak 05:32:36 INFO - Running setup.py install for mozlog 05:32:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Running setup.py install for moznetwork 05:32:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Running setup.py install for mozprocess 05:32:36 INFO - Running setup.py install for mozprofile 05:32:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:36 INFO - Running setup.py install for mozrunner 05:32:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:37 INFO - Running setup.py install for mozscreenshot 05:32:37 INFO - Running setup.py install for moztest 05:32:37 INFO - Running setup.py install for mozversion 05:32:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:37 INFO - Cleaning up... 05:32:37 INFO - Return code: 0 05:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:37 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')]} 05:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:37 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')]} 05:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:37 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 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:37 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 05:32:37 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 05:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:37 INFO - 'HOME': '/Users/cltbld', 05:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:37 INFO - 'LOGNAME': 'cltbld', 05:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:37 INFO - 'MOZ_NO_REMOTE': '1', 05:32:37 INFO - 'NO_EM_RESTART': '1', 05:32:37 INFO - 'PAGER': '/bin/cat', 05:32:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:37 INFO - 'PWD': '/builds/slave/test', 05:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:37 INFO - 'SHELL': '/bin/bash', 05:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:37 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:37 INFO - 'USER': 'cltbld', 05:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:37 INFO - 'XPC_FLAGS': '0x0', 05:32:37 INFO - 'XPC_SERVICE_NAME': '0', 05:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-CEL5C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:37 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)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-tVVD4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-yEdUbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-1dADq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:38 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-HEH730-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:38 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-sDHFV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:38 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-pHt7Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:38 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-04YZFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:38 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-AnDN9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:38 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-1SnpwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:38 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:38 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-eE41DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-hK0opH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-o_BJSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:39 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)) 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-7u4mqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:39 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)) 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-xD_k4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:39 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)) 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-AEyx_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:39 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)) 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:39 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-sUPdFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:39 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)) 05:32:39 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)) 05:32:39 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)) 05:32:39 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)) 05:32:39 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)) 05:32:39 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)) 05:32:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:39 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 05:32:39 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 05:32:39 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 05:32:39 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 05:32:39 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 05:32:39 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 05:32:42 INFO - Downloading blessings-1.6.tar.gz 05:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:42 INFO - Installing collected packages: blessings 05:32:42 INFO - Running setup.py install for blessings 05:32:42 INFO - Successfully installed blessings 05:32:42 INFO - Cleaning up... 05:32:42 INFO - Return code: 0 05:32:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:42 INFO - Reading from file tmpfile_stdout 05:32:42 INFO - Current package versions: 05:32:42 INFO - blessings == 1.6 05:32:42 INFO - blobuploader == 1.2.4 05:32:42 INFO - docopt == 0.6.1 05:32:42 INFO - functools32 == 3.2.3-2 05:32:42 INFO - jsonschema == 2.5.1 05:32:42 INFO - manifestparser == 1.1 05:32:42 INFO - mozInstall == 1.12 05:32:42 INFO - mozcrash == 0.17 05:32:42 INFO - mozdebug == 0.1 05:32:42 INFO - mozdevice == 0.48 05:32:42 INFO - mozfile == 1.2 05:32:42 INFO - mozhttpd == 0.7 05:32:42 INFO - mozinfo == 0.9 05:32:42 INFO - mozleak == 0.1 05:32:42 INFO - mozlog == 3.3 05:32:42 INFO - moznetwork == 0.27 05:32:42 INFO - mozprocess == 0.23 05:32:42 INFO - mozprofile == 0.28 05:32:42 INFO - mozrunner == 6.12 05:32:42 INFO - mozscreenshot == 0.1 05:32:42 INFO - mozsystemmonitor == 0.3 05:32:42 INFO - moztest == 0.7 05:32:42 INFO - mozversion == 1.4 05:32:42 INFO - psutil == 3.1.1 05:32:42 INFO - requests == 1.2.3 05:32:42 INFO - wsgiref == 0.1.2 05:32:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:42 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')]} 05:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:42 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')]} 05:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:42 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 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:42 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 05:32:42 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 05:32:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:42 INFO - 'HOME': '/Users/cltbld', 05:32:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:42 INFO - 'LOGNAME': 'cltbld', 05:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:42 INFO - 'MOZ_NO_REMOTE': '1', 05:32:42 INFO - 'NO_EM_RESTART': '1', 05:32:42 INFO - 'PAGER': '/bin/cat', 05:32:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:42 INFO - 'PWD': '/builds/slave/test', 05:32:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:42 INFO - 'SHELL': '/bin/bash', 05:32:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:42 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:42 INFO - 'USER': 'cltbld', 05:32:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:42 INFO - 'XPC_FLAGS': '0x0', 05:32:42 INFO - 'XPC_SERVICE_NAME': '0', 05:32:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:43 INFO - Cleaning up... 05:32:43 INFO - Return code: 0 05:32:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10126ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101303618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1525a7a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, '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.f2fqRhBJzE/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.O8gxsztS3F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 05:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:43 INFO - 'HOME': '/Users/cltbld', 05:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:43 INFO - 'LOGNAME': 'cltbld', 05:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:43 INFO - 'MOZ_NO_REMOTE': '1', 05:32:43 INFO - 'NO_EM_RESTART': '1', 05:32:43 INFO - 'PAGER': '/bin/cat', 05:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:43 INFO - 'PWD': '/builds/slave/test', 05:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:43 INFO - 'SHELL': '/bin/bash', 05:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:32:43 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:43 INFO - 'USER': 'cltbld', 05:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:43 INFO - 'XPC_FLAGS': '0x0', 05:32:43 INFO - 'XPC_SERVICE_NAME': '0', 05:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:43 INFO - Cleaning up... 05:32:43 INFO - Return code: 0 05:32:43 INFO - Running post-action listener: _resource_record_post_action 05:32:43 INFO - Running post-action listener: _start_resource_monitoring 05:32:43 INFO - Starting resource monitoring. 05:32:43 INFO - [mozharness: 2016-08-10 12:32:43.392732Z] Finished create-virtualenv step (success) 05:32:43 INFO - [mozharness: 2016-08-10 12:32:43.393730Z] Running install step. 05:32:43 INFO - Running pre-action listener: _resource_record_pre_action 05:32:43 INFO - Running main action method: install 05:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:43 INFO - Reading from file tmpfile_stdout 05:32:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:43 INFO - Reading from file tmpfile_stdout 05:32:43 INFO - Output received: 05:32:43 INFO - Usage: mozinstall [options] installer 05:32:43 INFO - Options: 05:32:43 INFO - -h, --help show this help message and exit 05:32:43 INFO - -d DEST, --destination=DEST 05:32:43 INFO - Directory to install application into. [default: 05:32:43 INFO - "/builds/slave/test"] 05:32:43 INFO - --app=APP Application being installed. [default: firefox] 05:32:43 INFO - mkdir: /builds/slave/test/build/application 05:32:43 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'] 05:32:43 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 05:33:17 INFO - Reading from file tmpfile_stdout 05:33:17 INFO - Output received: 05:33:17 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:33:17 INFO - Running post-action listener: _resource_record_post_action 05:33:17 INFO - [mozharness: 2016-08-10 12:33:17.630992Z] Finished install step (success) 05:33:17 INFO - [mozharness: 2016-08-10 12:33:17.631159Z] Running run-tests step. 05:33:17 INFO - Running pre-action listener: _resource_record_pre_action 05:33:17 INFO - Running main action method: run_tests 05:33:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:17 INFO - 2016-08-10 05:33:17.645 screenresolution[1642:8197] starting screenresolution argv=screenresolution get 05:33:17 INFO - 2016-08-10 05:33:17.648 screenresolution[1642:8197] Display 0: 1600x1200x32@60 05:33:17 INFO - 2016-08-10 05:33:17.654 screenresolution[1643:8199] starting screenresolution argv=screenresolution list 05:33:17 INFO - Available Modes on Display 0 05:33:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:17 INFO - Intel Iris: 05:33:17 INFO - Chipset Model: Intel Iris 05:33:17 INFO - Type: GPU 05:33:17 INFO - Bus: Built-In 05:33:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:17 INFO - Vendor: Intel (0x8086) 05:33:17 INFO - Device ID: 0x0a2e 05:33:17 INFO - Revision ID: 0x0009 05:33:17 INFO - Displays: 05:33:17 INFO - Display: 05:33:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:17 INFO - Display Serial Number: 1600x1200 60 05:33:17 INFO - Main Display: Yes 05:33:17 INFO - Mirror: Off 05:33:17 INFO - Online: Yes 05:33:17 INFO - Rotation: Supported 05:33:17 INFO - Return code: 0 05:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:17 INFO - Python 2.7.3 05:33:17 INFO - Return code: 0 05:33:17 INFO - grabbing minidump binary from tooltool 05:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:17 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 0x1011d2d30>, '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 0x100f37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011cab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:18 INFO - Return code: 0 05:33:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 05:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0097 --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 05:33:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f2fqRhBJzE/Render', 05:33:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:18 INFO - 'HOME': '/Users/cltbld', 05:33:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:18 INFO - 'LOGNAME': 'cltbld', 05:33:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:18 INFO - 'MOZ_NO_REMOTE': '1', 05:33:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:18 INFO - 'NO_EM_RESTART': '1', 05:33:18 INFO - 'PAGER': '/bin/cat', 05:33:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:18 INFO - 'PWD': '/builds/slave/test', 05:33:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:18 INFO - 'SHELL': '/bin/bash', 05:33:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O8gxsztS3F/Listeners', 05:33:18 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 05:33:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:18 INFO - 'USER': 'cltbld', 05:33:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:18 INFO - 'XPC_FLAGS': '0x0', 05:33:18 INFO - 'XPC_SERVICE_NAME': '0', 05:33:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 05:33:18 INFO - mozversion application_buildid: 20160810030202 05:33:18 INFO - mozversion application_changeset: 6cf0089510fad8deb866136f5b92bbced9498447 05:33:18 INFO - mozversion application_display_name: Nightly 05:33:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:18 INFO - mozversion application_name: Firefox 05:33:18 INFO - mozversion application_remotingname: firefox 05:33:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:18 INFO - mozversion application_vendor: Mozilla 05:33:18 INFO - mozversion application_version: 51.0a1 05:33:18 INFO - mozversion platform_buildid: 20160810030202 05:33:18 INFO - mozversion platform_changeset: 6cf0089510fad8deb866136f5b92bbced9498447 05:33:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:18 INFO - mozversion platform_version: 51.0a1 05:33:18 INFO - using testdate: 1470832398 05:33:18 INFO - actual date: 1470832398 05:33:18 INFO - starting webserver on 'localhost:49270' 05:33:18 INFO - SUITE-START | Running 2 tests 05:33:18 INFO - TEST-START | dromaeo_css 05:33:18 INFO - operating with platform_type : mac_ 05:33:18 INFO - Initialising browser for dromaeo_css test... 05:33:18 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpm4Kbf2/profile http://localhost:49270/getInfo.html) 05:33:21 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 05:33:21 INFO - PROCESS | 1653 | colorDepth:24 05:33:21 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 05:33:21 INFO - PROCESS | 1653 | __metrics 05:33:21 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:33:22 INFO - TEST-INFO | 1653: exit 0 05:33:22 INFO - Browser initialized. 05:33:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:22 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpm4Kbf2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:34 INFO - PROCESS | 1658 | RSS: Main: 254742528 05:33:34 INFO - PROCESS | 1658 | 05:34:23 INFO - PROCESS | 1658 | 1470832463736 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] 05:36:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 05:36:37 INFO - PROCESS | 1658 | RSS: Main: 267661312 05:36:37 INFO - PROCESS | 1658 | 05:39:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 05:39:40 INFO - PROCESS | 1658 | RSS: Main: 280002560 05:39:40 INFO - PROCESS | 1658 | 05:42:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 05:42:42 INFO - PROCESS | 1658 | RSS: Main: 287789056 05:42:42 INFO - PROCESS | 1658 | 05:45:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 05:45:45 INFO - PROCESS | 1658 | RSS: Main: 286744576 05:45:45 INFO - PROCESS | 1658 | 05:48:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:48:48 INFO - PROCESS | 1658 | RSS: Main: 291749888 05:48:48 INFO - PROCESS | 1658 | 05:51:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:51:51 INFO - PROCESS | 1658 | RSS: Main: 291815424 05:51:51 INFO - PROCESS | 1658 | 05:51:51 INFO - PROCESS | 1658 | __start_tp_report 05:51:51 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 05:51:51 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 05:51:51 INFO - PROCESS | 1658 | |i|pagename|runs| 05:51:51 INFO - PROCESS | 1658 | |0;dojo.html;3399.47308167234;3400.9149771255716;3435.896923092308;3446.1040129566304;3454.2400671852192;5726.226959360485;5819.243498345215;5854.326752423467;5923.703814809264;5990.940090599103;5793.304803423584;5830.154627579009;5839.737211825467;5846.269216347957;5984.700764961756;5171.120909445394;5281.735913204344;5326.973365133169;5337.439568845273;5348.197770334442;5162.638615296931;5234.293370395005;5304.257403963429;5355.544778693816;5361.758720857571;4480.305552639346;5281.471852814707;5310.522053015208;5353.116735738598;5359.035373632744;5268.262443257947;5283.339582552181;5297.152455607084;5332.040232758102;5367.731613419313;5150.768215430277;5245.711485868275;5288.0745869472685;5296.417394086648;5359.705216213107;4569.657275704336;5659.490645841894;5846.473817356458;5915.556333274979;6000.969995149996;5219.164933610604;6180.072989051633;6186.938130618726;6187.443130118266;6202.503799696014;6133.080037994292;6210.223722034746;6262.342454042351;6313.621182729005;6335.651539165344;5914.2311499504785;5935.91096133554;5950.077737950538;5999.220101386792;6023.126646636213;5336.332958380202;5353.304070470892;6322.336154703782;6331.651759153198;6335.334789847;5742.28221472316;6100.054491553817;6170.81487555365;6212.192414986023;6217.626942383471;6160.7535698571555;6163.753449861955;6186.752529898754;6279.497640188774;6286.497080233662;6155.4767844732805;6186.443220110122;6189.35011823761;6197.721102550396;6200.100985357189;6013.819585412444;6160.507159427235;6209.689515524296;6217.564770466024;6223.159873417031;5035.244713293036;5065.468125846806;5068.239764035424;5097.974510127426;5147.794088236504;4433.800478978454;4440.555944405533;4490.955090449119;4519.525449827786;4552.271636538138;5508.614396992172;5935.52515798735;6031.577789554689;6048.909266361008;6050.092486127028;6149.446549810538;6152.538559608047;6166.105914642351;6213.316535181127;6234.501239900887;5978.432048955342;6039.456448919618;6045.274567051894;6050.6974651267265;6110.450059494667;5555.611107222537;5585.441455854382;5598.1602759586385;5606.887862242732;5613.101903695389;6183.659898705524;6265.592736472115;6349.7142628580905;6400.327965563549;6472.611643301323;5372.677639341652;6235.719392627252;6254.28075771274;6270.529710271657;6275.184226050585;6420.6147631142285;6446.194225721785;6462.870742585028;6472.8705425890275;6481.060246264359;6122.418370254819;6129.542179248553;6143.573288551087;6145.617236122016;6170.50635949132;4733.692309999839;5929.377415371324;6168.938310616836;6193.597416167935;6210.596311239755;6129;6134.294556125924;6164.8767024658355;6183.288921774054;6191.473724733448;4841.927371089366;5949.315828679757;6122.051082082285;6133.601315914451;6144.446999770043;4911.238757992517;4987.376577927759;5792.536597072309;6069.9089513656445;6082.665453400105;5262.789558401512;6125.816225513242;6131.662758548323;6137.119594896349;6241.375862413904;5978.252718410199;6057;6087.66517841523;6105.45050945417;6131.662758548323 05:51:51 INFO - PROCESS | 1658 | |1;ext.html;520.307990372804;537.9193121031842;543.4239705911734;565.1720229863249;571.8027280588199;36640.26719465609;39202.80398598006;39347.01632459187;39379.40930886039;39399.60600393995;40050;40123.99690007751;40569;40662.186756264855;40726.7963660182;9615.42307461551;9727.319087663866;9760.609575617002;9820.803583928317;9854.162396196332;9623.1820295275;9696.418214907093;9698.175655069328;9714;9720.368176068569;9677.080677335642;9691.127798498133;9709.174720148796;9756.317057805956;9765.169960553361;9651.710448686586;9685.806283874319;9689.982551832098;9724.513774311255;9735.221182305399;9642.758931026781;9714.659986900424;9735.56189971446;9740.318177727562;9758.951205243928;37686.43470347947;38011;38132.23735525274;38180.42729359062;38433.23133537341;3107.3163903941095;3369.696727294531;3413.76103672743;3462.982685086584;3551.3074950384685;28345.724442399936;29242.122736317946;29389;29468.410631787458;30391;2922.991567909089;3107.844607769625;3120.0951724000015;3155.857986390618;3230.8869189578254;380408;446113.8471538205;448092;451120;452365.9999999967;32578.022659320257;32742.362881855814;32827;32850.17874553155;32923.17692057718;33500;33813.661863381545;33832.661673383445;34793.652063479545;34977.30045399078;16464.259108340153;16603.501894943172;16663.50009499717;16664.333426662797;16670.58323541921;11741.823872641917;12243.449044793006;12621.558245461365;12748.426320815586;12886.29125398112;18665.06674666261;18859.811401885807;18897.960612166462;18900.905495472434;18940.526486837938;8056.677732890736;8130.634121464548;8162.632836477355;8204.630791614392;8208.384371172186;921.3044151665583;998.4009594243541;1022.99488502557;1052.7736536644504;1070.550368845087;29927.40145197084;29957;30158.396832063238;30233;30397.936072237364;1030.5362586835954;1056.4717641179411;1080.2330345454816;1080.3733834376044;1134.1040577943331;15092.320845561977;15525.84474155244;15561.455349062728;15615;15735.213239337987;681179;688166.1183388102;688528.1147188564;692489;693256;55555.44444555583;55724.44275557274;55877.72061139668;56292.718536407054;56931.71534142303;1324.72843067171;1360.156702844243;1380.82049333588;1385.7505648983079;1387.9653008674863;26313.81587828514;29079.836806527503;29524.852375737984;29738.10785676433;30252.54621180728;41405.171896562504;48482;48668.026639467724;48986.02027959492;49047.07623390191;517896;520173;521756;522461;525375;25016;25285.367865803502;25937;26247.21258362252;26326.473470530098;46100.74682376659;46295;46364;46514;47688.761556193385;34194.65805342014;34732.47901281533;38325.808370957966;39040.21919561536;39671.80164099161;38259.42610860895;38270.617293826705;39367;39597;39650.00874978149;33832.98501044972;36705.816470918544;37136.25727485489;38042.80978595089;38275.61724382832;31868.7252509897;32054.519182212753;33571;34131.65868341384;34713.30573388468;22889;23352.18267360634;24256.1510347137;24973.375665608506;25816.8709156453 05:51:51 INFO - PROCESS | 1658 | |2;jquery.html;367.23431645020133;375.64126259422255;377.13259503142774;387.22554890219567;395.7585872617701;19391.321303754372;21154;21449.14203431863;21510.784892151114;21606.567868642618;20093.29673461429;20169.899150504265;20845.27041553546;21179;21211.363659090213;5867.55993300502;5899.705014749266;5912.142739302799;5944.643321400708;6075.483583895374;4122.855700050499;5940.851478713023;5999;6318.241810982689;6601.306862779411;6541.672916354187;6572.507061970371;6625.701843417058;6647.800565983004;6649.601023938555;6521.152250207443;6540.247871494791;6603.108580341641;6660.333966603325;6691.866162676719;4963;5245.344331958505;5795.768169273224;5801.7099145042575;5803.390643982406;13071.673208169777;13170.473181072746;13210.33948302581;13301.334933253396;13371.398287077105;2127.3298910843037;2141.8714877107423;2170.1644866726265;2172.5546263016045;2956.645202575683;10071.395716257048;10081.697549073466;10914.836277455845;11106.555737770479;15877.126758028304;1797.1373740604583;1889.6882014467733;1908.5991941692262;1916.568772026297;1967.803219678035;123804.9999999991;124636;124683.37658311741;126658;129607.7039229605;9636.951815241018;10886.61896833607;11166.994970452699;11466.140039497071;11676.893533625294;13099.672508187372;14108.788368174486;14233.78649320261;14438.77270432025;14477.276136193148;8316.750497485085;8566.52884091381;8599.14008599135;8758.605862736065;8787.69243076502;8628.525431101225;8628.78428039304;8666.436681615674;8740.650373984969;8773.649054037767;4258.02065524931;4436.711613745097;4446.355278484666;4558.247889098328;4607.101615185074;1596.3454983456727;1693.7628731977534;1701.3789966662328;1826.4338055202663;2003.228756928593;876.816297997698;929.5956259027345;932.5756780664781;977.953589659058;1013.0123129948389;20869.478263043544;21831.890840546013;22087.66868496974;22089.895505224675;22178.223762168247;935.7426707655313;943.6036864516919;958.5590628311055;980.9798899122642;1006.3257617396216;11098.668159820872;11356.659300221007;11442;11446.771064578661;11461.484233209525;579214;590854;598220;600347;602298;122913;127518;130698;130707.34646326897;133979.66020339672;880.3485420788699;962.2686758063921;969.5346233807812;991.0436428846198;1013.3565186106875;15887.761683574987;18920.810791891905;19192.328268510537;19390;19450.513737156685;53845;55348.44651553433;55839;56851.43148568627;57093;79354.80967785373;79362.6031869837;80378.59810701144;81421.77867331877;81816;6374.74501019954;7320.377767889789;7447.441441891771;7541.43439242048;7601.619919003917;10017.799644006933;10925.781484370427;11312.20814542974;12991.987298751901;13360.465581376637;10103.292769506064;10883.619073332395;11245.381504017358;11684.948354648122;11695.415229238673;9124.908750912671;9400.435973841591;9581.802274715661;11419.543218271509;11479.598214062467;11508.021818145551;11509.769804604028;11608.477618507019;11764.647060588197;11890.881091188978;7119.394851437686;7444.143923448873;7468.290512401313;7556.546607203585;7714.652840622073;10388;11123.888761112285;11363.375014373958;11468;11493.82759258595 05:51:51 INFO - PROCESS | 1658 | |3;mootools.html;1387.7363300972816;1536.1627912787533;1669.5408762590293;1736.4964160393486;1869.8410635096016;7836.412269079813;8214.137515560862;8294.170582941719;8745.081766414522;8779.912200877989;8416.66333346667;8567.614457349418;8588.871166932486;8605.56972151393;8654.826903461942;2316.4672125411166;2351.730065764485;2352.6000579901456;2359.327591636384;2360.398098484884;2316.5830150572892;2345.659879317498;2348.3894187511287;2350.21267875262;2360.5042940982416;2143.378420258131;2329.6389059695775;2339.6373562097815;2340.8946597403155;2346.155384061736;2294.9541009179725;2308.2613563659634;2310.2838120182796;2311.9884400577976;2316.953660926772;2324.7675232476618;2325.1396983116356;2325.5000174962297;2326.220716060122;2326.3951372643232;7636.389088872932;8568.100349463279;8659.653613855502;8665;8704.390692651517;5094.949050509485;5246.527812496894;5255.1329030709885;5257.684538927677;5262.92105618416;3366.5118557808983;3452.1197094740683;3545.290941811648;3545.964540354589;3546.9113272168142;919.9218066464292;1043.9634612788516;1081.4971038467072;1099.923005389623;1104.36499013067;11300.434978251054;11310.434478276136;11421.42892855354;11426.71433214168;11440.542378304857;4446.021875187518;4552.954470455319;4669.906601868011;4743.454502732161;4748.810047598126;7724.575148366781;8562.229399354088;9721.46531940736;9758.219342452729;9884.851727224097;5171.3277273954145;5192.3769147702515;5194.558462530652;5195.740212989335;5209.4009188943;4172.144710334374;4668.346431499593;4787.8563643090765;4790.8323208688225;4832.492588278251;3871.1676989447406;3918.2759585782164;3939;4021.738586991836;4033.2941735196223;1262.5770366927;1273.6879464531248;1283.2108253424265;1287.4721364240804;1290.7999260114698;834.1283358889974;895.5208963204655;898.734873212404;913.5386629752065;913.6665117232162;4741.83403580873;5808.941910580925;5948.881022379528;6036.547258955596;6054.212952316258;419.5594625643063;422.3812115251172;427.2608387489598;430.86427775250695;432.19611522568;3923.588023257574;3939.3893946438347;4036.7577945323374;4089.8568550100604;4091.4067460218102;7890.763277101696;10246.53890574926;10436.53035613384;10442.530086146142;10449.68650940473;10165.593376265015;10378.37729736203;10398.168146548258;10405.21960852924;10417.906119857458;7949.165337639581;8170.264676179172;8208.261256486945;8239.464434811718;8273.131321211185;5659.915101273402;5744.310682718101;5814.273215848019;5834.649921004753;5842.269716285465;9777.902220977983;9803.656872009446;9820.165285950488;9825.213982881496;9836.557354918903;9754.707358779247;9953.651622193478;10007;10007.54966026516;10134.239932005277;6847.931520684929;7406.222346653523;7416.221296763762;7850.175731548105;8226.917730822855;7322.5972571506945;8228.547429891414;8255.174482551696;8411.873821892554;8420.157984201776;6829.214640316427;7291.8177045572165;7315.817104572216;7356.411487081128;7425.591592462466;7025.508214424941;7045.718171273296;7192.8921066183;7234.312740289664;7255.238199988925;6769.830754231184;6806.489513286622;6890.414314783299;6897.241303456716;6911.3779759821855;4912.238603016538;4973.875653108556;4992.900141997213;5050.696958182521;5061.924071138862;4392.714473559208;4940.2342636891335;4941.629377796751;5001.549860512571;5033.169527028 05:51:51 INFO - PROCESS | 1658 | |4;prototype.html;296.87234489169646;301.47844229482996;312.66700963473886;314.53291861585546;315.10195941566536;4836.709797412158;5541.473560011803;5542.667439953606;5781.733320673817;5861.59321762777;4779.296045564689;5707.315122185333;5708.372079071299;5725.4847063764255;5726.713664316789;4339.2406328892475;4368.694191406603;4374.7156434831795;4382.846600368987;4386.649068074562;4097.323941549641;4334.5448727883595;4358.934615980763;4387.978060109695;4403.383526306304;3286.6384697683234;3807.2385522895393;4028.858989935353;4336.588024137702;4341.785689298465;4012.8996775080855;4027.4361589377218;4328.679752675433;4341.3705012773125;4385.47374315081;3448.2758620689683;3609.693176080036;3751.6998640108727;3765.9475585805526;3790.5261842269715;4891.682040667345;5593.440655934414;5598.916016259759;5623.831285061455;5641.097424412074;5025.296458495814;5046.949530504685;5050.712068422566;5051.6716413433005;5064.848054558369;4982.800687972477;5832.445917637818;6014.609050411709;6058.758259444034;6082.178905847698;4171.457710497646;4180.728252663597;4187.371894215861;4191.7484950902735;4191.8532851350055;5603.299587551556;6287.685615719196;6380.521460890405;6402.711877965503;6430.678466076677;3624.3657359961903;4050.7518327328025;4051.2100140472326;4054.594540545922;4079.938800917989;3470.687638112582;4126.731762435432;4128.979355103265;4131.9173616527505;4162.8334866605;4873.661541843849;4887.511248875084;4897.971426000579;4901.730404827768;4903.632227582945;4949.925751113737;5719.770249396316;6016.833939781675;6060.969575192272;6080.939190608037;1295.151675652449;1390.6592884743302;1399.5591388712523;1402.102654301248;1474.4913005013252;821.7411515372638;870.5473153959905;873.4148120759106;887.8845750052452;908.4957848394205;4503.842365517191;4623.214053610895;4674.345591617176;4699.365585645963;4752.120857641347;4372.0051764541395;4498.053774777526;4830.396200474941;5027.134533315975;5214.556762675215;3690.2655751796615;4301.870943871689;4701.576858082721;4726.125666751662;4738.976305118453;2548.5030419068476;2556.7187609362954;2582.5480540905264;2595.974040259573;2760.6135141079862;4786.994731106437;4824.276358546176;5123.718195499208;5221.164613661796;5412.729363531807;5009.774560144802;5312.246958503762;5334.41280978725;5350.806169470498;5379.4351593082165;4755.405574303212;4846.75766211688;4848.569671946784;4894.608431325485;5398.811041613525;4564.1556312082375;4671.804252001554;5175.637705360588;5218.556422704112;5236.460316746451;4595.621313605971;4789;5113.64204505681;5176.767045483038;5498;6149.477294429845;6485.108934639179;6507;6518.934810651833;6522.967385163044;4011.478507793968;4032.0646089876436;4039.333509970822;4052.8378864845076;4054.959450405458;5665.518430933417;5999.4600485954725;6032.698365081641;6128.089157650259;6334.398232167937;5301.522862942354;5948;6159.476444502267;6161.753529858755;6165.84585385369;5795.681237531976;5809.419058094157;6087.512998959984;6106.664133472702;6129.417705317987;4620.468646105741;4939.333190019302;5962;5973.880522389441;6005.354966331634;5214.582833373245;6113.2184855891355;6123.418275263843;6126;6147.66187859672;5286.8942621148135;5846.883062338644;5893.675847828411;6033.5173186145885;6043.54673399488 05:51:51 INFO - PROCESS | 1658 | |5;yui.html;699.185448951971;712.8289210589458;756.1682149635405;769.057904067517;833.3666413525723;13490.865091349096;15480.458183963563;15480.535583932486;15905.363785448582;16012.359505619761;14472;14514.491992780255;14616.707665846703;14664.266786660677;14681.486147984822;865.9004214515332;886.902440731519;889.0931250124901;890.6214858685065;892.6563273139856;698.3679769808306;860.9655613775473;887.1527691055027;889.799795046116;903.7966457547033;911.0252030327553;918.6325469812061;932.3380399916068;934.5327336331834;934.8737920380729;924.9768755781092;928.6703220356744;929.1591110045385;937.7327461673391;938.3572253006678;679.3376457953506;693.750249910032;699.6117154978984;702.0487239790062;702.5924963521196;14551;14652.560423187322;14671.926640366837;14677.926610366987;14732.70534589313;14884.255787210705;14960.40158393663;14989.550313490612;15139.091654500655;15207.695846083127;10448.895511044944;10460.843087353696;10626.203034772345;10915.890841091647;11027.669169924835;3917.4907262056036;3928.096537796323;3944.960550394488;3966.107625784204;3987.302222111119;125890;126495;126774;127021;127861.72138278591;11633.767324653629;11693.941530292464;11703.88296117045;11720.296782193096;11985.52057917691;23219.651705224434;24237.63643545348;24263.272101836974;24276.393090172885;24309.39226519351;8213.630386632616;8383.161683831568;8455.492670439793;8514.148585141436;8529.402941794138;4260.914781704349;4462.263726485158;4664;4698.694584851974;4839.443464001614;3605.8557657693923;3715.6098609646137;3750.7937063461773;3757.5866654667966;3764.378877485184;568.0031544639132;634.7207228819304;648.0959062108427;663.7112855907695;672.7544446277074;590.4538302070567;611.6452457574596;655.5607742812327;668.3350066683681;673.7675501951819;9494.34158435639;9526.618935242652;9575.281853860988;9623;9659.32384733062;575.7639367859158;599.2060519811267;601.6059481039925;693.9410150137194;694.4270976444352;4654.604358629486;4786.856394308176;4802.711837289774;4857.191043561915;4858;108677;150230;156253;158965.2051739757;159979;119812;143193;143201.27194912086;145326.64020079415;147160;119175;121286.39356803159;122021;124651.3767431157;125150.12274815886;8814.955925220333;9000.36997410175;9256.676016339396;9289.953550232205;9482.857757133786;46375;61342;64469.355306446334;64974.67512662406;65534.68930621456;88485.11514884769;88497.55751221202;89040;91803.54098229467;94392;11468.82796758066;12493.125481216228;12496.187747796364;12578.937105314415;12679.366031698193;11045.668629941114;13515.797263040866;13532.391042402918;13663.795043074164;13671;11961.222520536137;12133.272003679807;12499.93750031244;12648.43082061291;12958.157719748186;11977.520899164285;12170.817437738264;12625.558105466265;12705.872941270469;12735.108542401942;12074.215176013531;12373.443195056065;12526.561570344995;12656.303903285409;12699.809502857279;10098.747531311776;10173.338732982333;10246.333988290737;10347.43089130105;10657.786844263226;7996.400269979658;8448.66205351779;9306.626810163365;10615.759982835947;11034.172437067413 05:51:51 INFO - PROCESS | 1658 | __end_tp_report 05:51:51 INFO - PROCESS | 1658 | __start_cc_report 05:51:51 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,403 05:51:51 INFO - PROCESS | 1658 | __end_cc_report 05:51:51 INFO - PROCESS | 1658 | __startTimestamp1470833511358__endTimestamp 05:51:51 INFO - PROCESS | 1658 | 05:51:51 INFO - PROCESS | 1658 | ------- Summary: start ------- 05:51:51 INFO - PROCESS | 1658 | Number of tests: 6 05:51:51 INFO - PROCESS | 1658 | 05:51:51 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5746.89 Median:6023.13 stddev:643.73 (10.7%) stddev-sans-first:618.80 05:51:51 INFO - PROCESS | 1658 | Values: 3399.5 3400.9 3435.9 3446.1 3454.2 5726.2 5819.2 5854.3 5923.7 5990.9 5793.3 5830.2 5839.7 5846.3 5984.7 5171.1 5281.7 5327.0 5337.4 5348.2 5162.6 5234.3 5304.3 5355.5 5361.8 4480.3 5281.5 5310.5 5353.1 5359.0 5268.3 5283.3 5297.2 5332.0 5367.7 5150.8 5245.7 5288.1 5296.4 5359.7 4569.7 5659.5 5846.5 5915.6 6001.0 5219.2 6180.1 6186.9 6187.4 6202.5 6133.1 6210.2 6262.3 6313.6 6335.7 5914.2 5935.9 5950.1 5999.2 6023.1 5336.3 5353.3 6322.3 6331.7 6335.3 5742.3 6100.1 6170.8 6212.2 6217.6 6160.8 6163.8 6186.8 6279.5 6286.5 6155.5 6186.4 6189.4 6197.7 6200.1 6013.8 6160.5 6209.7 6217.6 6223.2 5035.2 5065.5 5068.2 5098.0 5147.8 4433.8 4440.6 4491.0 4519.5 4552.3 5508.6 5935.5 6031.6 6048.9 6050.1 6149.4 6152.5 6166.1 6213.3 6234.5 5978.4 6039.5 6045.3 6050.7 6110.5 5555.6 5585.4 5598.2 5606.9 5613.1 6183.7 6265.6 6349.7 6400.3 6472.6 5372.7 6235.7 6254.3 6270.5 6275.2 6420.6 6446.2 6462.9 6472.9 6481.1 6122.4 6129.5 6143.6 6145.6 6170.5 4733.7 5929.4 6168.9 6193.6 6210.6 6129.0 6134.3 6164.9 6183.3 6191.5 4841.9 5949.3 6122.1 6133.6 6144.4 4911.2 4987.4 5792.5 6069.9 6082.7 5262.8 6125.8 6131.7 6137.1 6241.4 5978.3 6057.0 6087.7 6105.5 6131.7 05:51:51 INFO - PROCESS | 1658 | 05:51:51 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:66543.87 Median:209209.50 stddev:149740.39 (71.6%) stddev-sans-first:150078.40 05:51:51 INFO - PROCESS | 1658 | Values: 520.3 537.9 543.4 565.2 571.8 36640.3 39202.8 39347.0 39379.4 39399.6 40050.0 40124.0 40569.0 40662.2 40726.8 9615.4 9727.3 9760.6 9820.8 9854.2 9623.2 9696.4 9698.2 9714.0 9720.4 9677.1 9691.1 9709.2 9756.3 9765.2 9651.7 9685.8 9690.0 9724.5 9735.2 9642.8 9714.7 9735.6 9740.3 9759.0 37686.4 38011.0 38132.2 38180.4 38433.2 3107.3 3369.7 3413.8 3463.0 3551.3 28345.7 29242.1 29389.0 29468.4 30391.0 2923.0 3107.8 3120.1 3155.9 3230.9 380408.0 446113.8 448092.0 451120.0 452366.0 32578.0 32742.4 32827.0 32850.2 32923.2 33500.0 33813.7 33832.7 34793.7 34977.3 16464.3 16603.5 16663.5 16664.3 16670.6 11741.8 12243.4 12621.6 12748.4 12886.3 18665.1 18859.8 18898.0 18900.9 18940.5 8056.7 8130.6 8162.6 8204.6 8208.4 921.3 998.4 1023.0 1052.8 1070.6 29927.4 29957.0 30158.4 30233.0 30397.9 1030.5 1056.5 1080.2 1080.4 1134.1 15092.3 15525.8 15561.5 15615.0 15735.2 681179.0 688166.1 688528.1 692489.0 693256.0 55555.4 55724.4 55877.7 56292.7 56931.7 1324.7 1360.2 1380.8 1385.8 1388.0 26313.8 29079.8 29524.9 29738.1 30252.5 41405.2 48482.0 48668.0 48986.0 49047.1 517896.0 520173.0 521756.0 522461.0 525375.0 25016.0 25285.4 25937.0 26247.2 26326.5 46100.7 46295.0 46364.0 46514.0 47688.8 34194.7 34732.5 38325.8 39040.2 39671.8 38259.4 38270.6 39367.0 39597.0 39650.0 33833.0 36705.8 37136.3 38042.8 38275.6 31868.7 32054.5 33571.0 34131.7 34713.3 22889.0 23352.2 24256.2 24973.4 25816.9 05:51:51 INFO - PROCESS | 1658 | 05:51:51 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35024.06 Median:22088.78 stddev:99534.03 (450.6%) stddev-sans-first:99779.23 05:51:51 INFO - PROCESS | 1658 | Values: 367.2 375.6 377.1 387.2 395.8 19391.3 21154.0 21449.1 21510.8 21606.6 20093.3 20169.9 20845.3 21179.0 21211.4 5867.6 5899.7 5912.1 5944.6 6075.5 4122.9 5940.9 5999.0 6318.2 6601.3 6541.7 6572.5 6625.7 6647.8 6649.6 6521.2 6540.2 6603.1 6660.3 6691.9 4963.0 5245.3 5795.8 5801.7 5803.4 13071.7 13170.5 13210.3 13301.3 13371.4 2127.3 2141.9 2170.2 2172.6 2956.6 10071.4 10081.7 10914.8 11106.6 15877.1 1797.1 1889.7 1908.6 1916.6 1967.8 123805.0 124636.0 124683.4 126658.0 129607.7 9637.0 10886.6 11167.0 11466.1 11676.9 13099.7 14108.8 14233.8 14438.8 14477.3 8316.8 8566.5 8599.1 8758.6 8787.7 8628.5 8628.8 8666.4 8740.7 8773.6 4258.0 4436.7 4446.4 4558.2 4607.1 1596.3 1693.8 1701.4 1826.4 2003.2 876.8 929.6 932.6 978.0 1013.0 20869.5 21831.9 22087.7 22089.9 22178.2 935.7 943.6 958.6 981.0 1006.3 11098.7 11356.7 11442.0 11446.8 11461.5 579214.0 590854.0 598220.0 600347.0 602298.0 122913.0 127518.0 130698.0 130707.3 133979.7 880.3 962.3 969.5 991.0 1013.4 15887.8 18920.8 19192.3 19390.0 19450.5 53845.0 55348.4 55839.0 56851.4 57093.0 79354.8 79362.6 80378.6 81421.8 81816.0 6374.7 7320.4 7447.4 7541.4 7601.6 10017.8 10925.8 11312.2 12992.0 13360.5 10103.3 10883.6 11245.4 11684.9 11695.4 9124.9 9400.4 9581.8 11419.5 11479.6 11508.0 11509.8 11608.5 11764.6 11890.9 7119.4 7444.1 7468.3 7556.5 7714.7 10388.0 11123.9 11363.4 11468.0 11493.8 05:51:51 INFO - PROCESS | 1658 | 05:51:51 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5568.23 Median:4957.75 stddev:3104.77 (62.6%) stddev-sans-first:3097.59 05:51:51 INFO - PROCESS | 1658 | Values: 1387.7 1536.2 1669.5 1736.5 1869.8 7836.4 8214.1 8294.2 8745.1 8779.9 8416.7 8567.6 8588.9 8605.6 8654.8 2316.5 2351.7 2352.6 2359.3 2360.4 2316.6 2345.7 2348.4 2350.2 2360.5 2143.4 2329.6 2339.6 2340.9 2346.2 2295.0 2308.3 2310.3 2312.0 2317.0 2324.8 2325.1 2325.5 2326.2 2326.4 7636.4 8568.1 8659.7 8665.0 8704.4 5094.9 5246.5 5255.1 5257.7 5262.9 3366.5 3452.1 3545.3 3546.0 3546.9 919.9 1044.0 1081.5 1099.9 1104.4 11300.4 11310.4 11421.4 11426.7 11440.5 4446.0 4553.0 4669.9 4743.5 4748.8 7724.6 8562.2 9721.5 9758.2 9884.9 5171.3 5192.4 5194.6 5195.7 5209.4 4172.1 4668.3 4787.9 4790.8 4832.5 3871.2 3918.3 3939.0 4021.7 4033.3 1262.6 1273.7 1283.2 1287.5 1290.8 834.1 895.5 898.7 913.5 913.7 4741.8 5808.9 5948.9 6036.5 6054.2 419.6 422.4 427.3 430.9 432.2 3923.6 3939.4 4036.8 4089.9 4091.4 7890.8 10246.5 10436.5 10442.5 10449.7 10165.6 10378.4 10398.2 10405.2 10417.9 7949.2 8170.3 8208.3 8239.5 8273.1 5659.9 5744.3 5814.3 5834.6 5842.3 9777.9 9803.7 9820.2 9825.2 9836.6 9754.7 9953.7 10007.0 10007.5 10134.2 6847.9 7406.2 7416.2 7850.2 8226.9 7322.6 8228.5 8255.2 8411.9 8420.2 6829.2 7291.8 7315.8 7356.4 7425.6 7025.5 7045.7 7192.9 7234.3 7255.2 6769.8 6806.5 6890.4 6897.2 6911.4 4912.2 4973.9 4992.9 5050.7 5061.9 4392.7 4940.2 4941.6 5001.5 5033.2 05:51:51 INFO - PROCESS | 1658 | 05:51:51 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4638.91 Median:4902.68 stddev:1441.62 (29.4%) stddev-sans-first:1408.35 05:51:51 INFO - PROCESS | 1658 | Values: 296.9 301.5 312.7 314.5 315.1 4836.7 5541.5 5542.7 5781.7 5861.6 4779.3 5707.3 5708.4 5725.5 5726.7 4339.2 4368.7 4374.7 4382.8 4386.6 4097.3 4334.5 4358.9 4388.0 4403.4 3286.6 3807.2 4028.9 4336.6 4341.8 4012.9 4027.4 4328.7 4341.4 4385.5 3448.3 3609.7 3751.7 3765.9 3790.5 4891.7 5593.4 5598.9 5623.8 5641.1 5025.3 5046.9 5050.7 5051.7 5064.8 4982.8 5832.4 6014.6 6058.8 6082.2 4171.5 4180.7 4187.4 4191.7 4191.9 5603.3 6287.7 6380.5 6402.7 6430.7 3624.4 4050.8 4051.2 4054.6 4079.9 3470.7 4126.7 4129.0 4131.9 4162.8 4873.7 4887.5 4898.0 4901.7 4903.6 4949.9 5719.8 6016.8 6061.0 6080.9 1295.2 1390.7 1399.6 1402.1 1474.5 821.7 870.5 873.4 887.9 908.5 4503.8 4623.2 4674.3 4699.4 4752.1 4372.0 4498.1 4830.4 5027.1 5214.6 3690.3 4301.9 4701.6 4726.1 4739.0 2548.5 2556.7 2582.5 2596.0 2760.6 4787.0 4824.3 5123.7 5221.2 5412.7 5009.8 5312.2 5334.4 5350.8 5379.4 4755.4 4846.8 4848.6 4894.6 5398.8 4564.2 4671.8 5175.6 5218.6 5236.5 4595.6 4789.0 5113.6 5176.8 5498.0 6149.5 6485.1 6507.0 6518.9 6523.0 4011.5 4032.1 4039.3 4052.8 4055.0 5665.5 5999.5 6032.7 6128.1 6334.4 5301.5 5948.0 6159.5 6161.8 6165.8 5795.7 5809.4 6087.5 6106.7 6129.4 4620.5 4939.3 5962.0 5973.9 6005.4 5214.6 6113.2 6123.4 6126.0 6147.7 5286.9 5846.9 5893.7 6033.5 6043.5 05:51:51 INFO - PROCESS | 1658 | 05:51:51 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:25738.67 Median:3760.98 stddev:42191.22 (1121.8%) stddev-sans-first:42267.69 05:51:51 INFO - PROCESS | 1658 | Values: 699.2 712.8 756.2 769.1 833.4 13490.9 15480.5 15480.5 15905.4 16012.4 14472.0 14514.5 14616.7 14664.3 14681.5 865.9 886.9 889.1 890.6 892.7 698.4 861.0 887.2 889.8 903.8 911.0 918.6 932.3 934.5 934.9 925.0 928.7 929.2 937.7 938.4 679.3 693.8 699.6 702.0 702.6 14551.0 14652.6 14671.9 14677.9 14732.7 14884.3 14960.4 14989.6 15139.1 15207.7 10448.9 10460.8 10626.2 10915.9 11027.7 3917.5 3928.1 3945.0 3966.1 3987.3 125890.0 126495.0 126774.0 127021.0 127861.7 11633.8 11693.9 11703.9 11720.3 11985.5 23219.7 24237.6 24263.3 24276.4 24309.4 8213.6 8383.2 8455.5 8514.1 8529.4 4260.9 4462.3 4664.0 4698.7 4839.4 3605.9 3715.6 3750.8 3757.6 3764.4 568.0 634.7 648.1 663.7 672.8 590.5 611.6 655.6 668.3 673.8 9494.3 9526.6 9575.3 9623.0 9659.3 575.8 599.2 601.6 693.9 694.4 4654.6 4786.9 4802.7 4857.2 4858.0 108677.0 150230.0 156253.0 158965.2 159979.0 119812.0 143193.0 143201.3 145326.6 147160.0 119175.0 121286.4 122021.0 124651.4 125150.1 8815.0 9000.4 9256.7 9290.0 9482.9 46375.0 61342.0 64469.4 64974.7 65534.7 88485.1 88497.6 89040.0 91803.5 94392.0 11468.8 12493.1 12496.2 12578.9 12679.4 11045.7 13515.8 13532.4 13663.8 13671.0 11961.2 12133.3 12499.9 12648.4 12958.2 11977.5 12170.8 12625.6 12705.9 12735.1 12074.2 12373.4 12526.6 12656.3 12699.8 10098.7 10173.3 10246.3 10347.4 10657.8 7996.4 8448.7 9306.6 10615.8 11034.2 05:51:51 INFO - PROCESS | 1658 | -------- Summary: end -------- 05:51:51 INFO - PROCESS | 1658 | 05:51:51 INFO - TEST-INFO | 1658: exit 0 05:51:51 INFO - TEST-OK | dromaeo_css | took 1113737ms 05:51:51 INFO - TEST-START | kraken 05:51:51 INFO - operating with platform_type : mac_ 05:51:51 INFO - Initialising browser for kraken test... 05:51:51 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpX5Yg7O/profile http://localhost:49270/getInfo.html) 05:51:54 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 05:51:54 INFO - PROCESS | 1666 | colorDepth:24 05:51:54 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 05:51:54 INFO - PROCESS | 1666 | __metrics 05:51:54 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:51:55 INFO - TEST-INFO | 1666: exit 0 05:51:55 INFO - Browser initialized. 05:51:55 INFO - Running cycle 1/1 for kraken test... 05:51:55 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpX5Yg7O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:07 INFO - PROCESS | 1669 | RSS: Main: 254500864 05:52:07 INFO - PROCESS | 1669 | 05:52:10 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:11 INFO - PROCESS | 1669 | RSS: Main: 267292672 05:52:11 INFO - PROCESS | 1669 | 05:52:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 05:52:14 INFO - PROCESS | 1669 | RSS: Main: 276041728 05:52:14 INFO - PROCESS | 1669 | 05:52:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 05:52:18 INFO - PROCESS | 1669 | RSS: Main: 279003136 05:52:18 INFO - PROCESS | 1669 | 05:52:20 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 05:52:21 INFO - PROCESS | 1669 | RSS: Main: 280465408 05:52:21 INFO - PROCESS | 1669 | 05:52:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:24 INFO - PROCESS | 1669 | RSS: Main: 282132480 05:52:24 INFO - PROCESS | 1669 | 05:52:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:27 INFO - PROCESS | 1669 | RSS: Main: 282075136 05:52:27 INFO - PROCESS | 1669 | 05:52:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:31 INFO - PROCESS | 1669 | RSS: Main: 282435584 05:52:31 INFO - PROCESS | 1669 | 05:52:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 05:52:34 INFO - PROCESS | 1669 | RSS: Main: 282529792 05:52:34 INFO - PROCESS | 1669 | 05:52:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:37 INFO - PROCESS | 1669 | RSS: Main: 282456064 05:52:37 INFO - PROCESS | 1669 | 05:52:38 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:39 INFO - PROCESS | 1669 | RSS: Main: 282771456 05:52:39 INFO - PROCESS | 1669 | 05:52:41 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:42 INFO - PROCESS | 1669 | RSS: Main: 282951680 05:52:42 INFO - PROCESS | 1669 | 05:52:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:46 INFO - PROCESS | 1669 | RSS: Main: 283324416 05:52:46 INFO - PROCESS | 1669 | 05:52:49 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:49 INFO - PROCESS | 1669 | RSS: Main: 282861568 05:52:49 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 05:52:51 INFO - PROCESS | 1669 | RSS: Main: 283824128 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | __start_tp_report 05:52:51 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 05:52:51 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 05:52:51 INFO - PROCESS | 1669 | |i|pagename|runs| 05:52:51 INFO - PROCESS | 1669 | |0;ai-astar;103;117;107;118;117;117;112;115;118;115 05:52:51 INFO - PROCESS | 1669 | |1;audio-beat-detection;135;139;166;180;107;124;125;118;185;118 05:52:51 INFO - PROCESS | 1669 | |2;audio-dft;196;212;270;259;211;206;270;199;261;270 05:52:51 INFO - PROCESS | 1669 | |3;audio-fft;70;81;76;144;60;79;64;60;143;71 05:52:51 INFO - PROCESS | 1669 | |4;audio-oscillator;70;72;121;70;72;74;112;69;73;132 05:52:51 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;88;90;121;87;91;85;89;89;89;84 05:52:51 INFO - PROCESS | 1669 | |6;imaging-darkroom;114;117;95;96;96;95;114;144;146;93 05:52:51 INFO - PROCESS | 1669 | |7;imaging-desaturate;101;131;90;93;92;90;90;91;86;97 05:52:51 INFO - PROCESS | 1669 | |8;json-parse-financial;55;57;56;55;56;55;55;57;55;56 05:52:51 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;62;68;75;70;67;69;91;97;59;67 05:52:51 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;86;92;97;96;102;71;96;97;102;98 05:52:51 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;144;184;160;135;147;150;152;156;161;141 05:52:51 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;168;171;172;174;169;164;226;215;173;187 05:52:51 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;70;68;69;84;85;86;83;86;68;68 05:52:51 INFO - PROCESS | 1669 | __end_tp_report 05:52:51 INFO - PROCESS | 1669 | __start_cc_report 05:52:51 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1038 05:52:51 INFO - PROCESS | 1669 | __end_cc_report 05:52:51 INFO - PROCESS | 1669 | __startTimestamp1470833571926__endTimestamp 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | ------- Summary: start ------- 05:52:51 INFO - PROCESS | 1669 | Number of tests: 14 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:113.90 Median:117.00 stddev:5.11 (4.4%) stddev-sans-first:3.59 05:52:51 INFO - PROCESS | 1669 | Values: 103.0 117.0 107.0 118.0 117.0 117.0 112.0 115.0 118.0 115.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:137.00 stddev:27.62 (20.2%) stddev-sans-first:29.24 05:52:51 INFO - PROCESS | 1669 | Values: 135.0 139.0 166.0 180.0 107.0 124.0 125.0 118.0 185.0 118.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:235.40 Median:260.00 stddev:32.81 (12.6%) stddev-sans-first:31.55 05:52:51 INFO - PROCESS | 1669 | Values: 196.0 212.0 270.0 259.0 211.0 206.0 270.0 199.0 261.0 270.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:84.80 Median:70.50 stddev:31.78 (45.1%) stddev-sans-first:33.25 05:52:51 INFO - PROCESS | 1669 | Values: 70.0 81.0 76.0 144.0 60.0 79.0 64.0 60.0 143.0 71.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:71.00 stddev:24.77 (34.9%) stddev-sans-first:25.54 05:52:51 INFO - PROCESS | 1669 | Values: 70.0 72.0 121.0 70.0 72.0 74.0 112.0 69.0 73.0 132.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:89.00 stddev:10.66 (12.0%) stddev-sans-first:11.24 05:52:51 INFO - PROCESS | 1669 | Values: 88.0 90.0 121.0 87.0 91.0 85.0 89.0 89.0 89.0 84.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:111.00 Median:94.00 stddev:20.15 (21.4%) stddev-sans-first:21.34 05:52:51 INFO - PROCESS | 1669 | Values: 114.0 117.0 95.0 96.0 96.0 95.0 114.0 144.0 146.0 93.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:90.50 stddev:12.95 (14.3%) stddev-sans-first:13.61 05:52:51 INFO - PROCESS | 1669 | Values: 101.0 131.0 90.0 93.0 92.0 90.0 90.0 91.0 86.0 97.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 05:52:51 INFO - PROCESS | 1669 | Values: 55.0 57.0 56.0 55.0 56.0 55.0 55.0 57.0 55.0 56.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:69.50 stddev:12.20 (17.6%) stddev-sans-first:12.34 05:52:51 INFO - PROCESS | 1669 | Values: 62.0 68.0 75.0 70.0 67.0 69.0 91.0 97.0 59.0 67.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:93.70 Median:96.00 stddev:9.23 (9.6%) stddev-sans-first:9.36 05:52:51 INFO - PROCESS | 1669 | Values: 86.0 92.0 97.0 96.0 102.0 71.0 96.0 97.0 102.0 98.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:153.00 Median:154.00 stddev:13.65 (8.9%) stddev-sans-first:14.09 05:52:51 INFO - PROCESS | 1669 | Values: 144.0 184.0 160.0 135.0 147.0 150.0 152.0 156.0 161.0 141.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:173.50 stddev:21.36 (12.3%) stddev-sans-first:22.05 05:52:51 INFO - PROCESS | 1669 | Values: 168.0 171.0 172.0 174.0 169.0 164.0 226.0 215.0 173.0 187.0 05:52:51 INFO - PROCESS | 1669 | 05:52:51 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:83.50 stddev:8.60 (10.3%) stddev-sans-first:8.78 05:52:51 INFO - PROCESS | 1669 | Values: 70.0 68.0 69.0 84.0 85.0 86.0 83.0 86.0 68.0 68.0 05:52:51 INFO - PROCESS | 1669 | -------- Summary: end -------- 05:52:51 INFO - PROCESS | 1669 | 05:52:52 INFO - TEST-INFO | 1669: exit 0 05:52:52 INFO - TEST-OK | kraken | took 60790ms 05:52:52 INFO - SUITE-END | took 1174s 05:52:53 INFO - Completed test suite (00:19:34) 05:52:53 INFO - javascript benchmark 05:52:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7287.247109872694, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.47308167234, 3400.9149771255716, 3435.896923092308, 3446.1040129566304, 3454.2400671852192, 5726.226959360485, 5819.243498345215, 5854.326752423467, 5923.703814809264, 5990.940090599103, 5793.304803423584, 5830.154627579009, 5839.737211825467, 5846.269216347957, 5984.700764961756, 5171.120909445394, 5281.735913204344, 5326.973365133169, 5337.439568845273, 5348.197770334442, 5162.638615296931, 5234.293370395005, 5304.257403963429, 5355.544778693816, 5361.758720857571, 4480.305552639346, 5281.471852814707, 5310.522053015208, 5353.116735738598, 5359.035373632744, 5268.262443257947, 5283.339582552181, 5297.152455607084, 5332.040232758102, 5367.731613419313, 5150.768215430277, 5245.711485868275, 5288.0745869472685, 5296.417394086648, 5359.705216213107, 4569.657275704336, 5659.490645841894, 5846.473817356458, 5915.556333274979, 6000.969995149996, 5219.164933610604, 6180.072989051633, 6186.938130618726, 6187.443130118266, 6202.503799696014, 6133.080037994292, 6210.223722034746, 6262.342454042351, 6313.621182729005, 6335.651539165344, 5914.2311499504785, 5935.91096133554, 5950.077737950538, 5999.220101386792, 6023.126646636213, 5336.332958380202, 5353.304070470892, 6322.336154703782, 6331.651759153198, 6335.334789847, 5742.28221472316, 6100.054491553817, 6170.81487555365, 6212.192414986023, 6217.626942383471, 6160.7535698571555, 6163.753449861955, 6186.752529898754, 6279.497640188774, 6286.497080233662, 6155.4767844732805, 6186.443220110122, 6189.35011823761, 6197.721102550396, 6200.100985357189, 6013.819585412444, 6160.507159427235, 6209.689515524296, 6217.564770466024, 6223.159873417031, 5035.244713293036, 5065.468125846806, 5068.239764035424, 5097.974510127426, 5147.794088236504, 4433.800478978454, 4440.555944405533, 4490.955090449119, 4519.525449827786, 4552.271636538138, 5508.614396992172, 5935.52515798735, 6031.577789554689, 6048.909266361008, 6050.092486127028, 6149.446549810538, 6152.538559608047, 6166.105914642351, 6213.316535181127, 6234.501239900887, 5978.432048955342, 6039.456448919618, 6045.274567051894, 6050.6974651267265, 6110.450059494667, 5555.611107222537, 5585.441455854382, 5598.1602759586385, 5606.887862242732, 5613.101903695389, 6183.659898705524, 6265.592736472115, 6349.7142628580905, 6400.327965563549, 6472.611643301323, 5372.677639341652, 6235.719392627252, 6254.28075771274, 6270.529710271657, 6275.184226050585, 6420.6147631142285, 6446.194225721785, 6462.870742585028, 6472.8705425890275, 6481.060246264359, 6122.418370254819, 6129.542179248553, 6143.573288551087, 6145.617236122016, 6170.50635949132, 4733.692309999839, 5929.377415371324, 6168.938310616836, 6193.597416167935, 6210.596311239755, 6129.0, 6134.294556125924, 6164.8767024658355, 6183.288921774054, 6191.473724733448, 4841.927371089366, 5949.315828679757, 6122.051082082285, 6133.601315914451, 6144.446999770043, 4911.238757992517, 4987.376577927759, 5792.536597072309, 6069.9089513656445, 6082.665453400105, 5262.789558401512, 6125.816225513242, 6131.662758548323, 6137.119594896349, 6241.375862413904, 5978.252718410199, 6057.0, 6087.66517841523, 6105.45050945417, 6131.662758548323], "value": 5710.310014451436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.307990372804, 537.9193121031842, 543.4239705911734, 565.1720229863249, 571.8027280588199, 36640.26719465609, 39202.80398598006, 39347.01632459187, 39379.40930886039, 39399.60600393995, 40050.0, 40123.99690007751, 40569.0, 40662.186756264855, 40726.7963660182, 9615.42307461551, 9727.319087663866, 9760.609575617002, 9820.803583928317, 9854.162396196332, 9623.1820295275, 9696.418214907093, 9698.175655069328, 9714.0, 9720.368176068569, 9677.080677335642, 9691.127798498133, 9709.174720148796, 9756.317057805956, 9765.169960553361, 9651.710448686586, 9685.806283874319, 9689.982551832098, 9724.513774311255, 9735.221182305399, 9642.758931026781, 9714.659986900424, 9735.56189971446, 9740.318177727562, 9758.951205243928, 37686.43470347947, 38011.0, 38132.23735525274, 38180.42729359062, 38433.23133537341, 3107.3163903941095, 3369.696727294531, 3413.76103672743, 3462.982685086584, 3551.3074950384685, 28345.724442399936, 29242.122736317946, 29389.0, 29468.410631787458, 30391.0, 2922.991567909089, 3107.844607769625, 3120.0951724000015, 3155.857986390618, 3230.8869189578254, 380408.0, 446113.8471538205, 448092.0, 451120.0, 452365.9999999967, 32578.022659320257, 32742.362881855814, 32827.0, 32850.17874553155, 32923.17692057718, 33500.0, 33813.661863381545, 33832.661673383445, 34793.652063479545, 34977.30045399078, 16464.259108340153, 16603.501894943172, 16663.50009499717, 16664.333426662797, 16670.58323541921, 11741.823872641917, 12243.449044793006, 12621.558245461365, 12748.426320815586, 12886.29125398112, 18665.06674666261, 18859.811401885807, 18897.960612166462, 18900.905495472434, 18940.526486837938, 8056.677732890736, 8130.634121464548, 8162.632836477355, 8204.630791614392, 8208.384371172186, 921.3044151665583, 998.4009594243541, 1022.99488502557, 1052.7736536644504, 1070.550368845087, 29927.40145197084, 29957.0, 30158.396832063238, 30233.0, 30397.936072237364, 1030.5362586835954, 1056.4717641179411, 1080.2330345454816, 1080.3733834376044, 1134.1040577943331, 15092.320845561977, 15525.84474155244, 15561.455349062728, 15615.0, 15735.213239337987, 681179.0, 688166.1183388102, 688528.1147188564, 692489.0, 693256.0, 55555.44444555583, 55724.44275557274, 55877.72061139668, 56292.718536407054, 56931.71534142303, 1324.72843067171, 1360.156702844243, 1380.82049333588, 1385.7505648983079, 1387.9653008674863, 26313.81587828514, 29079.836806527503, 29524.852375737984, 29738.10785676433, 30252.54621180728, 41405.171896562504, 48482.0, 48668.026639467724, 48986.02027959492, 49047.07623390191, 517896.0, 520173.0, 521756.0, 522461.0, 525375.0, 25016.0, 25285.367865803502, 25937.0, 26247.21258362252, 26326.473470530098, 46100.74682376659, 46295.0, 46364.0, 46514.0, 47688.761556193385, 34194.65805342014, 34732.47901281533, 38325.808370957966, 39040.21919561536, 39671.80164099161, 38259.42610860895, 38270.617293826705, 39367.0, 39597.0, 39650.00874978149, 33832.98501044972, 36705.816470918544, 37136.25727485489, 38042.80978595089, 38275.61724382832, 31868.7252509897, 32054.519182212753, 33571.0, 34131.65868341384, 34713.30573388468, 22889.0, 23352.18267360634, 24256.1510347137, 24973.375665608506, 25816.8709156453], "value": 19119.08362992129, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.23431645020133, 375.64126259422255, 377.13259503142774, 387.22554890219567, 395.7585872617701, 19391.321303754372, 21154.0, 21449.14203431863, 21510.784892151114, 21606.567868642618, 20093.29673461429, 20169.899150504265, 20845.27041553546, 21179.0, 21211.363659090213, 5867.55993300502, 5899.705014749266, 5912.142739302799, 5944.643321400708, 6075.483583895374, 4122.855700050499, 5940.851478713023, 5999.0, 6318.241810982689, 6601.306862779411, 6541.672916354187, 6572.507061970371, 6625.701843417058, 6647.800565983004, 6649.601023938555, 6521.152250207443, 6540.247871494791, 6603.108580341641, 6660.333966603325, 6691.866162676719, 4963.0, 5245.344331958505, 5795.768169273224, 5801.7099145042575, 5803.390643982406, 13071.673208169777, 13170.473181072746, 13210.33948302581, 13301.334933253396, 13371.398287077105, 2127.3298910843037, 2141.8714877107423, 2170.1644866726265, 2172.5546263016045, 2956.645202575683, 10071.395716257048, 10081.697549073466, 10914.836277455845, 11106.555737770479, 15877.126758028304, 1797.1373740604583, 1889.6882014467733, 1908.5991941692262, 1916.568772026297, 1967.803219678035, 123804.9999999991, 124636.0, 124683.37658311741, 126658.0, 129607.7039229605, 9636.951815241018, 10886.61896833607, 11166.994970452699, 11466.140039497071, 11676.893533625294, 13099.672508187372, 14108.788368174486, 14233.78649320261, 14438.77270432025, 14477.276136193148, 8316.750497485085, 8566.52884091381, 8599.14008599135, 8758.605862736065, 8787.69243076502, 8628.525431101225, 8628.78428039304, 8666.436681615674, 8740.650373984969, 8773.649054037767, 4258.02065524931, 4436.711613745097, 4446.355278484666, 4558.247889098328, 4607.101615185074, 1596.3454983456727, 1693.7628731977534, 1701.3789966662328, 1826.4338055202663, 2003.228756928593, 876.816297997698, 929.5956259027345, 932.5756780664781, 977.953589659058, 1013.0123129948389, 20869.478263043544, 21831.890840546013, 22087.66868496974, 22089.895505224675, 22178.223762168247, 935.7426707655313, 943.6036864516919, 958.5590628311055, 980.9798899122642, 1006.3257617396216, 11098.668159820872, 11356.659300221007, 11442.0, 11446.771064578661, 11461.484233209525, 579214.0, 590854.0, 598220.0, 600347.0, 602298.0, 122913.0, 127518.0, 130698.0, 130707.34646326897, 133979.66020339672, 880.3485420788699, 962.2686758063921, 969.5346233807812, 991.0436428846198, 1013.3565186106875, 15887.761683574987, 18920.810791891905, 19192.328268510537, 19390.0, 19450.513737156685, 53845.0, 55348.44651553433, 55839.0, 56851.43148568627, 57093.0, 79354.80967785373, 79362.6031869837, 80378.59810701144, 81421.77867331877, 81816.0, 6374.74501019954, 7320.377767889789, 7447.441441891771, 7541.43439242048, 7601.619919003917, 10017.799644006933, 10925.781484370427, 11312.20814542974, 12991.987298751901, 13360.465581376637, 10103.292769506064, 10883.619073332395, 11245.381504017358, 11684.948354648122, 11695.415229238673, 9124.908750912671, 9400.435973841591, 9581.802274715661, 11419.543218271509, 11479.598214062467, 11508.021818145551, 11509.769804604028, 11608.477618507019, 11764.647060588197, 11890.881091188978, 7119.394851437686, 7444.143923448873, 7468.290512401313, 7556.546607203585, 7714.652840622073, 10388.0, 11123.888761112285, 11363.375014373958, 11468.0, 11493.82759258595], "value": 9466.797140764624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.7363300972816, 1536.1627912787533, 1669.5408762590293, 1736.4964160393486, 1869.8410635096016, 7836.412269079813, 8214.137515560862, 8294.170582941719, 8745.081766414522, 8779.912200877989, 8416.66333346667, 8567.614457349418, 8588.871166932486, 8605.56972151393, 8654.826903461942, 2316.4672125411166, 2351.730065764485, 2352.6000579901456, 2359.327591636384, 2360.398098484884, 2316.5830150572892, 2345.659879317498, 2348.3894187511287, 2350.21267875262, 2360.5042940982416, 2143.378420258131, 2329.6389059695775, 2339.6373562097815, 2340.8946597403155, 2346.155384061736, 2294.9541009179725, 2308.2613563659634, 2310.2838120182796, 2311.9884400577976, 2316.953660926772, 2324.7675232476618, 2325.1396983116356, 2325.5000174962297, 2326.220716060122, 2326.3951372643232, 7636.389088872932, 8568.100349463279, 8659.653613855502, 8665.0, 8704.390692651517, 5094.949050509485, 5246.527812496894, 5255.1329030709885, 5257.684538927677, 5262.92105618416, 3366.5118557808983, 3452.1197094740683, 3545.290941811648, 3545.964540354589, 3546.9113272168142, 919.9218066464292, 1043.9634612788516, 1081.4971038467072, 1099.923005389623, 1104.36499013067, 11300.434978251054, 11310.434478276136, 11421.42892855354, 11426.71433214168, 11440.542378304857, 4446.021875187518, 4552.954470455319, 4669.906601868011, 4743.454502732161, 4748.810047598126, 7724.575148366781, 8562.229399354088, 9721.46531940736, 9758.219342452729, 9884.851727224097, 5171.3277273954145, 5192.3769147702515, 5194.558462530652, 5195.740212989335, 5209.4009188943, 4172.144710334374, 4668.346431499593, 4787.8563643090765, 4790.8323208688225, 4832.492588278251, 3871.1676989447406, 3918.2759585782164, 3939.0, 4021.738586991836, 4033.2941735196223, 1262.5770366927, 1273.6879464531248, 1283.2108253424265, 1287.4721364240804, 1290.7999260114698, 834.1283358889974, 895.5208963204655, 898.734873212404, 913.5386629752065, 913.6665117232162, 4741.83403580873, 5808.941910580925, 5948.881022379528, 6036.547258955596, 6054.212952316258, 419.5594625643063, 422.3812115251172, 427.2608387489598, 430.86427775250695, 432.19611522568, 3923.588023257574, 3939.3893946438347, 4036.7577945323374, 4089.8568550100604, 4091.4067460218102, 7890.763277101696, 10246.53890574926, 10436.53035613384, 10442.530086146142, 10449.68650940473, 10165.593376265015, 10378.37729736203, 10398.168146548258, 10405.21960852924, 10417.906119857458, 7949.165337639581, 8170.264676179172, 8208.261256486945, 8239.464434811718, 8273.131321211185, 5659.915101273402, 5744.310682718101, 5814.273215848019, 5834.649921004753, 5842.269716285465, 9777.902220977983, 9803.656872009446, 9820.165285950488, 9825.213982881496, 9836.557354918903, 9754.707358779247, 9953.651622193478, 10007.0, 10007.54966026516, 10134.239932005277, 6847.931520684929, 7406.222346653523, 7416.221296763762, 7850.175731548105, 8226.917730822855, 7322.5972571506945, 8228.547429891414, 8255.174482551696, 8411.873821892554, 8420.157984201776, 6829.214640316427, 7291.8177045572165, 7315.817104572216, 7356.411487081128, 7425.591592462466, 7025.508214424941, 7045.718171273296, 7192.8921066183, 7234.312740289664, 7255.238199988925, 6769.830754231184, 6806.489513286622, 6890.414314783299, 6897.241303456716, 6911.3779759821855, 4912.238603016538, 4973.875653108556, 4992.900141997213, 5050.696958182521, 5061.924071138862, 4392.714473559208, 4940.2342636891335, 4941.629377796751, 5001.549860512571, 5033.169527028], "value": 4416.46710869498, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.87234489169646, 301.47844229482996, 312.66700963473886, 314.53291861585546, 315.10195941566536, 4836.709797412158, 5541.473560011803, 5542.667439953606, 5781.733320673817, 5861.59321762777, 4779.296045564689, 5707.315122185333, 5708.372079071299, 5725.4847063764255, 5726.713664316789, 4339.2406328892475, 4368.694191406603, 4374.7156434831795, 4382.846600368987, 4386.649068074562, 4097.323941549641, 4334.5448727883595, 4358.934615980763, 4387.978060109695, 4403.383526306304, 3286.6384697683234, 3807.2385522895393, 4028.858989935353, 4336.588024137702, 4341.785689298465, 4012.8996775080855, 4027.4361589377218, 4328.679752675433, 4341.3705012773125, 4385.47374315081, 3448.2758620689683, 3609.693176080036, 3751.6998640108727, 3765.9475585805526, 3790.5261842269715, 4891.682040667345, 5593.440655934414, 5598.916016259759, 5623.831285061455, 5641.097424412074, 5025.296458495814, 5046.949530504685, 5050.712068422566, 5051.6716413433005, 5064.848054558369, 4982.800687972477, 5832.445917637818, 6014.609050411709, 6058.758259444034, 6082.178905847698, 4171.457710497646, 4180.728252663597, 4187.371894215861, 4191.7484950902735, 4191.8532851350055, 5603.299587551556, 6287.685615719196, 6380.521460890405, 6402.711877965503, 6430.678466076677, 3624.3657359961903, 4050.7518327328025, 4051.2100140472326, 4054.594540545922, 4079.938800917989, 3470.687638112582, 4126.731762435432, 4128.979355103265, 4131.9173616527505, 4162.8334866605, 4873.661541843849, 4887.511248875084, 4897.971426000579, 4901.730404827768, 4903.632227582945, 4949.925751113737, 5719.770249396316, 6016.833939781675, 6060.969575192272, 6080.939190608037, 1295.151675652449, 1390.6592884743302, 1399.5591388712523, 1402.102654301248, 1474.4913005013252, 821.7411515372638, 870.5473153959905, 873.4148120759106, 887.8845750052452, 908.4957848394205, 4503.842365517191, 4623.214053610895, 4674.345591617176, 4699.365585645963, 4752.120857641347, 4372.0051764541395, 4498.053774777526, 4830.396200474941, 5027.134533315975, 5214.556762675215, 3690.2655751796615, 4301.870943871689, 4701.576858082721, 4726.125666751662, 4738.976305118453, 2548.5030419068476, 2556.7187609362954, 2582.5480540905264, 2595.974040259573, 2760.6135141079862, 4786.994731106437, 4824.276358546176, 5123.718195499208, 5221.164613661796, 5412.729363531807, 5009.774560144802, 5312.246958503762, 5334.41280978725, 5350.806169470498, 5379.4351593082165, 4755.405574303212, 4846.75766211688, 4848.569671946784, 4894.608431325485, 5398.811041613525, 4564.1556312082375, 4671.804252001554, 5175.637705360588, 5218.556422704112, 5236.460316746451, 4595.621313605971, 4789.0, 5113.64204505681, 5176.767045483038, 5498.0, 6149.477294429845, 6485.108934639179, 6507.0, 6518.934810651833, 6522.967385163044, 4011.478507793968, 4032.0646089876436, 4039.333509970822, 4052.8378864845076, 4054.959450405458, 5665.518430933417, 5999.4600485954725, 6032.698365081641, 6128.089157650259, 6334.398232167937, 5301.522862942354, 5948.0, 6159.476444502267, 6161.753529858755, 6165.84585385369, 5795.681237531976, 5809.419058094157, 6087.512998959984, 6106.664133472702, 6129.417705317987, 4620.468646105741, 4939.333190019302, 5962.0, 5973.880522389441, 6005.354966331634, 5214.582833373245, 6113.2184855891355, 6123.418275263843, 6126.0, 6147.66187859672, 5286.8942621148135, 5846.883062338644, 5893.675847828411, 6033.5173186145885, 6043.54673399488], "value": 4177.176969572134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.185448951971, 712.8289210589458, 756.1682149635405, 769.057904067517, 833.3666413525723, 13490.865091349096, 15480.458183963563, 15480.535583932486, 15905.363785448582, 16012.359505619761, 14472.0, 14514.491992780255, 14616.707665846703, 14664.266786660677, 14681.486147984822, 865.9004214515332, 886.902440731519, 889.0931250124901, 890.6214858685065, 892.6563273139856, 698.3679769808306, 860.9655613775473, 887.1527691055027, 889.799795046116, 903.7966457547033, 911.0252030327553, 918.6325469812061, 932.3380399916068, 934.5327336331834, 934.8737920380729, 924.9768755781092, 928.6703220356744, 929.1591110045385, 937.7327461673391, 938.3572253006678, 679.3376457953506, 693.750249910032, 699.6117154978984, 702.0487239790062, 702.5924963521196, 14551.0, 14652.560423187322, 14671.926640366837, 14677.926610366987, 14732.70534589313, 14884.255787210705, 14960.40158393663, 14989.550313490612, 15139.091654500655, 15207.695846083127, 10448.895511044944, 10460.843087353696, 10626.203034772345, 10915.890841091647, 11027.669169924835, 3917.4907262056036, 3928.096537796323, 3944.960550394488, 3966.107625784204, 3987.302222111119, 125890.0, 126495.0, 126774.0, 127021.0, 127861.72138278591, 11633.767324653629, 11693.941530292464, 11703.88296117045, 11720.296782193096, 11985.52057917691, 23219.651705224434, 24237.63643545348, 24263.272101836974, 24276.393090172885, 24309.39226519351, 8213.630386632616, 8383.161683831568, 8455.492670439793, 8514.148585141436, 8529.402941794138, 4260.914781704349, 4462.263726485158, 4664.0, 4698.694584851974, 4839.443464001614, 3605.8557657693923, 3715.6098609646137, 3750.7937063461773, 3757.5866654667966, 3764.378877485184, 568.0031544639132, 634.7207228819304, 648.0959062108427, 663.7112855907695, 672.7544446277074, 590.4538302070567, 611.6452457574596, 655.5607742812327, 668.3350066683681, 673.7675501951819, 9494.34158435639, 9526.618935242652, 9575.281853860988, 9623.0, 9659.32384733062, 575.7639367859158, 599.2060519811267, 601.6059481039925, 693.9410150137194, 694.4270976444352, 4654.604358629486, 4786.856394308176, 4802.711837289774, 4857.191043561915, 4858.0, 108677.0, 150230.0, 156253.0, 158965.2051739757, 159979.0, 119812.0, 143193.0, 143201.27194912086, 145326.64020079415, 147160.0, 119175.0, 121286.39356803159, 122021.0, 124651.3767431157, 125150.12274815886, 8814.955925220333, 9000.36997410175, 9256.676016339396, 9289.953550232205, 9482.857757133786, 46375.0, 61342.0, 64469.355306446334, 64974.67512662406, 65534.68930621456, 88485.11514884769, 88497.55751221202, 89040.0, 91803.54098229467, 94392.0, 11468.82796758066, 12493.125481216228, 12496.187747796364, 12578.937105314415, 12679.366031698193, 11045.668629941114, 13515.797263040866, 13532.391042402918, 13663.795043074164, 13671.0, 11961.222520536137, 12133.272003679807, 12499.93750031244, 12648.43082061291, 12958.157719748186, 11977.520899164285, 12170.817437738264, 12625.558105466265, 12705.872941270469, 12735.108542401942, 12074.215176013531, 12373.443195056065, 12526.561570344995, 12656.303903285409, 12699.809502857279, 10098.747531311776, 10173.338732982333, 10246.333988290737, 10347.43089130105, 10657.786844263226, 7996.400269979658, 8448.66205351779, 9306.626810163365, 10615.759982835947, 11034.172437067413], "value": 7853.2353893194195, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 107.0, 118.0, 117.0, 117.0, 112.0, 115.0, 118.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 166.0, 180.0, 107.0, 124.0, 125.0, 118.0, 185.0, 118.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 212.0, 270.0, 259.0, 211.0, 206.0, 270.0, 199.0, 261.0, 270.0], "value": 235.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 81.0, 76.0, 144.0, 60.0, 79.0, 64.0, 60.0, 143.0, 71.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 121.0, 70.0, 72.0, 74.0, 112.0, 69.0, 73.0, 132.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 121.0, 87.0, 91.0, 85.0, 89.0, 89.0, 89.0, 84.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 95.0, 96.0, 96.0, 95.0, 114.0, 144.0, 146.0, 93.0], "value": 111.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 131.0, 90.0, 93.0, 92.0, 90.0, 90.0, 91.0, 86.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 55.0, 56.0, 55.0, 55.0, 57.0, 55.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 68.0, 75.0, 70.0, 67.0, 69.0, 91.0, 97.0, 59.0, 67.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 92.0, 97.0, 96.0, 102.0, 71.0, 96.0, 97.0, 102.0, 98.0], "value": 93.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 184.0, 160.0, 135.0, 147.0, 150.0, 152.0, 156.0, 161.0, 141.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 172.0, 174.0, 169.0, 164.0, 226.0, 215.0, 173.0, 187.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 84.0, 85.0, 86.0, 83.0, 86.0, 68.0, 68.0], "value": 76.7, "unit": "score"}]}]} 05:52:53 INFO - Return code: 0 05:52:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:53 ERROR - # TBPL SUCCESS # 05:52:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:53 INFO - 2016-08-10 05:52:53.237 screenresolution[1674:11112] starting screenresolution argv=screenresolution get 05:52:53 INFO - 2016-08-10 05:52:53.240 screenresolution[1674:11112] Display 0: 1600x1200x32@60 05:52:53 INFO - 2016-08-10 05:52:53.246 screenresolution[1675:11115] starting screenresolution argv=screenresolution list 05:52:53 INFO - Available Modes on Display 0 05:52:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:53 INFO - Intel Iris: 05:52:53 INFO - Chipset Model: Intel Iris 05:52:53 INFO - Type: GPU 05:52:53 INFO - Bus: Built-In 05:52:53 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:53 INFO - Vendor: Intel (0x8086) 05:52:53 INFO - Device ID: 0x0a2e 05:52:53 INFO - Revision ID: 0x0009 05:52:53 INFO - Displays: 05:52:53 INFO - Display: 05:52:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:53 INFO - Display Serial Number: 1600x1200 60 05:52:53 INFO - Main Display: Yes 05:52:53 INFO - Mirror: Off 05:52:53 INFO - Online: Yes 05:52:53 INFO - Rotation: Supported 05:52:53 INFO - Return code: 0 05:52:53 INFO - Running post-action listener: _resource_record_post_action 05:52:53 INFO - [mozharness: 2016-08-10 12:52:53.480388Z] Finished run-tests step (success) 05:52:53 INFO - Running post-run listener: _resource_record_post_run 05:52:53 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 33684480; Write bytes: 706178048; Read time: 357; Write time: 2041 05:52:53 INFO - TinderboxPrint: CPU usage
54.5% 05:52:53 INFO - TinderboxPrint: I/O read bytes / time
33,684,480 / 357 05:52:53 INFO - TinderboxPrint: I/O write bytes / time
706,178,048 / 2,041 05:52:53 INFO - TinderboxPrint: CPU idle
2,199.0 (45.5%) 05:52:53 INFO - TinderboxPrint: CPU system
978.6 (20.2%) 05:52:53 INFO - TinderboxPrint: CPU user
1,660.1 (34.3%) 05:52:53 INFO - TinderboxPrint: Swap in / out
433,000,448 / 0 05:52:53 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401125888; Write bytes: 394462720; Read time: 29689; Write time: 725 05:52:53 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 31591424; Write bytes: 299828736; Read time: 333; Write time: 1282 05:52:53 INFO - Running post-run listener: _upload_blobber_files 05:52:53 INFO - Blob upload gear active. 05:52:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:53 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 05:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:52:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:52:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:54 INFO - (blobuploader) - INFO - Done attempting. 05:52:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:52:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:52:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:55 INFO - (blobuploader) - INFO - Done attempting. 05:52:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:52:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:52:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:58 INFO - (blobuploader) - INFO - Done attempting. 05:52:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:58 INFO - Return code: 0 05:52:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a163871ba26cf91c3d85cbb6ef45ce79448909a0f7cf7a7a8409a3cb85fbd9aacb15df5ffd45156156fc9a979f095669949ce814074490f22ed0459c74e5f20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6388d4cae2b10105c71fa00fdb43f83a0978474d04e7de28b8d67556619a1ecef9a15e6759be2118d1fa96e2fc80fc1a861fdac15b53a87c97cd397ac7d7a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea55ecad8a74cc34b666215f4a3a0c52e23675ee7b8a68d6444d44bfbe8d1383b84b3b1211a036131ff5a19d42f321d38be77b9c137ede512ec59f65b09359ee"} 05:52:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:58 INFO - Contents: 05:52:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a163871ba26cf91c3d85cbb6ef45ce79448909a0f7cf7a7a8409a3cb85fbd9aacb15df5ffd45156156fc9a979f095669949ce814074490f22ed0459c74e5f20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6388d4cae2b10105c71fa00fdb43f83a0978474d04e7de28b8d67556619a1ecef9a15e6759be2118d1fa96e2fc80fc1a861fdac15b53a87c97cd397ac7d7a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea55ecad8a74cc34b666215f4a3a0c52e23675ee7b8a68d6444d44bfbe8d1383b84b3b1211a036131ff5a19d42f321d38be77b9c137ede512ec59f65b09359ee"} 05:52:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:58 INFO - Copying logs to upload dir... 05:52:58 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.426426 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-10 05:52:58.136420) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 05:52:58.140412) ========= 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.f2fqRhBJzE/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.O8gxsztS3F/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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/Firefox/sha512/8a163871ba26cf91c3d85cbb6ef45ce79448909a0f7cf7a7a8409a3cb85fbd9aacb15df5ffd45156156fc9a979f095669949ce814074490f22ed0459c74e5f20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6388d4cae2b10105c71fa00fdb43f83a0978474d04e7de28b8d67556619a1ecef9a15e6759be2118d1fa96e2fc80fc1a861fdac15b53a87c97cd397ac7d7a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea55ecad8a74cc34b666215f4a3a0c52e23675ee7b8a68d6444d44bfbe8d1383b84b3b1211a036131ff5a19d42f321d38be77b9c137ede512ec59f65b09359ee"} build_url:https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/Y6iEyBF4R2iih1g4GUgWLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a163871ba26cf91c3d85cbb6ef45ce79448909a0f7cf7a7a8409a3cb85fbd9aacb15df5ffd45156156fc9a979f095669949ce814074490f22ed0459c74e5f20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f6388d4cae2b10105c71fa00fdb43f83a0978474d04e7de28b8d67556619a1ecef9a15e6759be2118d1fa96e2fc80fc1a861fdac15b53a87c97cd397ac7d7a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea55ecad8a74cc34b666215f4a3a0c52e23675ee7b8a68d6444d44bfbe8d1383b84b3b1211a036131ff5a19d42f321d38be77b9c137ede512ec59f65b09359ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 05:52:58.173722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 05:52:58.174132) ========= 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.f2fqRhBJzE/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.O8gxsztS3F/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.005022 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 05:52:58.223665) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 05:52:58.224129) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 05:52:58.224520) ========= ========= Total master_lag: 0.21 =========