builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0338 starttime: 1470757850.61 results: success (0) buildid: 20160809064620 builduid: df3f0aad8c01402a91b882437a2037c2 revision: 6cf0089510fad8deb866136f5b92bbced9498447 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:50.609284) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:50.609774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:50.610050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:50.636148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:50.636561) ========= 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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-09 08:50:50-- 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% 25.1M=0s 2016-08-09 08:50:50 (25.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149565 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:50.810568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:50.810927) ========= 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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.026344 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:50.859589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 08:50:50.859951) ========= 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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-09 08:50:50,945 truncating revision to first 12 chars 2016-08-09 08:50:50,945 Setting DEBUG logging. 2016-08-09 08:50:50,945 attempt 1/10 2016-08-09 08:50:50,945 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-09 08:50:52,038 unpacking tar archive at: mozilla-central-6cf0089510fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.364399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 08:50:52.245928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:52.246241) ========= script_repo_revision: 6cf0089510fad8deb866136f5b92bbced9498447 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:52.246630) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:52.246926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 08:50:52.265133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-09 08:50:52.265540) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:50:52 INFO - MultiFileLogger online at 20160809 08:50:52 in /builds/slave/test 08:50:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:50:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:52 INFO - {'append_to_log': False, 08:50:52 INFO - 'base_work_dir': '/builds/slave/test', 08:50:52 INFO - 'blob_upload_branch': 'Firefox', 08:50:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:52 INFO - 'branch': 'Firefox', 08:50:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:52 INFO - 'config_files': ('talos/mac_config.py',), 08:50:52 INFO - 'default_actions': ('clobber', 08:50:52 INFO - 'read-buildbot-config', 08:50:52 INFO - 'download-and-extract', 08:50:52 INFO - 'populate-webroot', 08:50:52 INFO - 'create-virtualenv', 08:50:52 INFO - 'install', 08:50:52 INFO - 'run-tests'), 08:50:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:52 INFO - 'download_minidump_stackwalk': True, 08:50:52 INFO - 'download_symbols': 'ondemand', 08:50:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:52 INFO - 'installer_path': 'installer.exe', 08:50:52 INFO - 'log_level': 'info', 08:50:52 INFO - 'log_name': 'talos', 08:50:52 INFO - 'log_to_console': True, 08:50:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:50:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:50:52 INFO - 'opt_config_files': (), 08:50:52 INFO - 'pip_index': False, 08:50:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:52 INFO - 'cmd': ('bash', 08:50:52 INFO - '-c', 08:50:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:52 INFO - 'enabled': True, 08:50:52 INFO - 'halt_on_failure': False, 08:50:52 INFO - 'name': 'check_screen_resolution'},), 08:50:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:52 INFO - 'cmd': ('bash', 08:50:52 INFO - '-c', 08:50:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:52 INFO - 'enabled': True, 08:50:52 INFO - 'halt_on_failure': False, 08:50:52 INFO - 'name': 'check_screen_resolution'},), 08:50:52 INFO - 'run_cmd_checks_enabled': True, 08:50:52 INFO - 'sps_profile': False, 08:50:52 INFO - 'sps_profile_interval': 0, 08:50:52 INFO - 'suite': 'dromaeojs', 08:50:52 INFO - 'system_bits': '32', 08:50:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:52 INFO - 'title': 't-yosemite-r7-0338', 08:50:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:52 INFO - 'use_talos_json': True, 08:50:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:52 INFO - 'work_dir': 'build'} 08:50:52 INFO - [mozharness: 2016-08-09 15:50:52.460467Z] Running clobber step. 08:50:52 INFO - Running pre-action listener: _resource_record_pre_action 08:50:52 INFO - Running main action method: clobber 08:50:52 INFO - rmtree: /builds/slave/test/build 08:50:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:54 INFO - Running post-action listener: _resource_record_post_action 08:50:54 INFO - [mozharness: 2016-08-09 15:50:54.724500Z] Finished clobber step (success) 08:50:54 INFO - [mozharness: 2016-08-09 15:50:54.724686Z] Running read-buildbot-config step. 08:50:54 INFO - Running pre-action listener: _resource_record_pre_action 08:50:54 INFO - Running main action method: read_buildbot_config 08:50:54 INFO - Using buildbot properties: 08:50:54 INFO - { 08:50:54 INFO - "project": "", 08:50:54 INFO - "product": "firefox", 08:50:54 INFO - "script_repo_revision": "production", 08:50:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:50:54 INFO - "repository": "", 08:50:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:50:54 INFO - "buildid": "20160809064620", 08:50:54 INFO - "pgo_build": "False", 08:50:54 INFO - "basedir": "/builds/slave/test", 08:50:54 INFO - "buildnumber": 31, 08:50:54 INFO - "slavename": "t-yosemite-r7-0338", 08:50:54 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:50:54 INFO - "platform": "yosemite_r7", 08:50:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:50:54 INFO - "branch": "mozilla-central", 08:50:54 INFO - "repo_path": "mozilla-central", 08:50:54 INFO - "revision": "6cf0089510fad8deb866136f5b92bbced9498447", 08:50:54 INFO - "stage_platform": "macosx64", 08:50:54 INFO - "builduid": "df3f0aad8c01402a91b882437a2037c2", 08:50:54 INFO - "slavebuilddir": "test" 08:50:54 INFO - } 08:50:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:50:54 INFO - Running post-action listener: _resource_record_post_action 08:50:54 INFO - [mozharness: 2016-08-09 15:50:54.727842Z] Finished read-buildbot-config step (success) 08:50:54 INFO - [mozharness: 2016-08-09 15:50:54.727957Z] Running download-and-extract step. 08:50:54 INFO - Running pre-action listener: _resource_record_pre_action 08:50:54 INFO - Running main action method: download_and_extract 08:50:54 INFO - mkdir: /builds/slave/test/build/tests 08:50:54 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')]} 08:50:54 INFO - trying https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:50:54 INFO - Downloading https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/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 08:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/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 08:50:55 INFO - Downloaded 1199 bytes. 08:50:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:50:55 INFO - Using the following test package requirements: 08:50:55 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:50:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:55 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:50:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:55 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:50:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:55 INFO - u'jsshell-mac.zip'], 08:50:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:55 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:50:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:50:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:55 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:50:55 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:55 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:50:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:55 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:50:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:55 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:50:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:50:55 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')]} 08:50:55 INFO - trying https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:50:55 INFO - Downloading https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/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 08:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/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 08:50:56 INFO - Downloaded 16325921 bytes. 08:50:56 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'] 08:50:56 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 08:50:59 INFO - Return code: 0 08:50:59 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 08:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:59 INFO - trying https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:50:59 INFO - Downloading https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/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 08:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/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 08:51:00 INFO - Downloaded 16325921 bytes. 08:51:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:51:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:51:04 INFO - Return code: 0 08:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:04 INFO - trying https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:51:04 INFO - Downloading https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/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 08:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/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 08:51:04 INFO - Downloaded 14413723 bytes. 08:51:04 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'] 08:51:04 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 08:51:05 INFO - Return code: 0 08:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:05 INFO - trying https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:51:05 INFO - Downloading https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/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 08:51:08 INFO - Downloaded 110888271 bytes. 08:51:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:51:08 INFO - mkdir: /builds/slave/test/properties 08:51:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:08 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:08 INFO - Contents: 08:51:08 INFO - build_url:https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:51:09 INFO - Running post-action listener: _resource_record_post_action 08:51:09 INFO - Running post-action listener: set_extra_try_arguments 08:51:09 INFO - [mozharness: 2016-08-09 15:51:09.362954Z] Finished download-and-extract step (success) 08:51:09 INFO - [mozharness: 2016-08-09 15:51:09.363067Z] Running populate-webroot step. 08:51:09 INFO - Running pre-action listener: _resource_record_pre_action 08:51:09 INFO - Running main action method: populate_webroot 08:51:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:09 INFO - '--tppagecycles', 08:51:09 INFO - '7'], 08:51:09 INFO - 'tests': ['tsvgm']}}, 08:51:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:09 INFO - 'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:09 INFO - 'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['damp', 'tps']}, 08:51:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:09 INFO - 'tests': ['damp', 'tps']}, 08:51:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['dromaeo_dom']}, 08:51:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['basic_compositor_video']}, 08:51:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:51:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['a11yr', 08:51:09 INFO - 'ts_paint', 08:51:09 INFO - 'tpaint', 08:51:09 INFO - 'sessionrestore', 08:51:09 INFO - 'sessionrestore_no_auto_restore', 08:51:09 INFO - 'tabpaint']}, 08:51:09 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:09 INFO - 'ts_paint', 08:51:09 INFO - 'tpaint', 08:51:09 INFO - 'sessionrestore', 08:51:09 INFO - 'sessionrestore_no_auto_restore', 08:51:09 INFO - 'tabpaint']}, 08:51:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:09 INFO - 'ts_paint', 08:51:09 INFO - 'tpaint', 08:51:09 INFO - 'sessionrestore', 08:51:09 INFO - 'sessionrestore_no_auto_restore', 08:51:09 INFO - 'tabpaint']}, 08:51:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:09 INFO - 'ts_paint', 08:51:09 INFO - 'tpaint', 08:51:09 INFO - 'sessionrestore', 08:51:09 INFO - 'sessionrestore_no_auto_restore', 08:51:09 INFO - 'tabpaint']}, 08:51:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['a11yr', 08:51:09 INFO - 'ts_paint', 08:51:09 INFO - 'tpaint', 08:51:09 INFO - 'sessionrestore', 08:51:09 INFO - 'sessionrestore_no_auto_restore', 08:51:09 INFO - 'tabpaint']}, 08:51:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['a11yr', 08:51:09 INFO - 'ts_paint', 08:51:09 INFO - 'tpaint', 08:51:09 INFO - 'sessionrestore', 08:51:09 INFO - 'sessionrestore_no_auto_restore', 08:51:09 INFO - 'tabpaint']}, 08:51:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['tsvgx', 08:51:09 INFO - 'tsvgr_opacity', 08:51:09 INFO - 'tart', 08:51:09 INFO - 'tscrollx', 08:51:09 INFO - 'cart']}, 08:51:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:09 INFO - 'tsvgr_opacity', 08:51:09 INFO - 'tart', 08:51:09 INFO - 'tscrollx', 08:51:09 INFO - 'cart']}, 08:51:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:09 INFO - 'talos_options': ['--disable-e10s'], 08:51:09 INFO - 'tests': ['tp5o']}, 08:51:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:09 INFO - 'tests': ['tp5o']}, 08:51:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:09 INFO - 'talos_options': ['--disable-e10s', 08:51:09 INFO - '--xperf_path', 08:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:09 INFO - 'tests': ['tp5n']}, 08:51:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:09 INFO - 'talos_options': ['--xperf_path', 08:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:09 INFO - 'tests': ['tp5n']}}, 08:51:09 INFO - 'talos.zip': {'path': '', 08:51:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:09 INFO - Running post-action listener: _resource_record_post_action 08:51:09 INFO - [mozharness: 2016-08-09 15:51:09.381922Z] Finished populate-webroot step (success) 08:51:09 INFO - [mozharness: 2016-08-09 15:51:09.382033Z] Running create-virtualenv step. 08:51:09 INFO - Running pre-action listener: _resource_record_pre_action 08:51:09 INFO - Running main action method: create_virtualenv 08:51:09 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:09 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 08:51:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:09 INFO - Using real prefix '/tools/python27' 08:51:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:10 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:13 INFO - Installing pip.................done. 08:51:13 INFO - Return code: 0 08:51:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:13 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')]} 08:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:13 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')]} 08:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:13 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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51:13 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 08:51:13 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 08:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:13 INFO - 'HOME': '/Users/cltbld', 08:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:13 INFO - 'LOGNAME': 'cltbld', 08:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:13 INFO - 'MOZ_NO_REMOTE': '1', 08:51:13 INFO - 'NO_EM_RESTART': '1', 08:51:13 INFO - 'PAGER': '/bin/cat', 08:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:13 INFO - 'PWD': '/builds/slave/test', 08:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:13 INFO - 'SHELL': '/bin/bash', 08:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:13 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:13 INFO - 'USER': 'cltbld', 08:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:13 INFO - 'XPC_FLAGS': '0x0', 08:51:13 INFO - 'XPC_SERVICE_NAME': '0', 08:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:13 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 08:51:13 INFO - Cleaning up... 08:51:13 INFO - Return code: 0 08:51:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51:13 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')]} 08:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:13 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')]} 08:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:13 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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51:13 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 08:51:13 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 08:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:13 INFO - 'HOME': '/Users/cltbld', 08:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:13 INFO - 'LOGNAME': 'cltbld', 08:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:13 INFO - 'MOZ_NO_REMOTE': '1', 08:51:13 INFO - 'NO_EM_RESTART': '1', 08:51:13 INFO - 'PAGER': '/bin/cat', 08:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:13 INFO - 'PWD': '/builds/slave/test', 08:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:13 INFO - 'SHELL': '/bin/bash', 08:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:13 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:13 INFO - 'USER': 'cltbld', 08:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:13 INFO - 'XPC_FLAGS': '0x0', 08:51:13 INFO - 'XPC_SERVICE_NAME': '0', 08:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:13 INFO - Downloading/unpacking psutil>=3.1.1 08:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:16 INFO - Installing collected packages: psutil 08:51:16 INFO - Running setup.py install for psutil 08:51:17 INFO - building 'psutil._psutil_osx' extension 08:51:17 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 08:51:17 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 08:51:17 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 08:51:17 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 08:51:17 INFO - building 'psutil._psutil_posix' extension 08:51:17 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 08:51:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:51:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:51:17 INFO - ^ 08:51:17 INFO - 1 warning generated. 08:51:17 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 08:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:18 INFO - Successfully installed psutil 08:51:18 INFO - Cleaning up... 08:51:18 INFO - Return code: 0 08:51:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:18 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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51:18 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 08:51:18 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 08:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:18 INFO - 'HOME': '/Users/cltbld', 08:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:18 INFO - 'LOGNAME': 'cltbld', 08:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:18 INFO - 'MOZ_NO_REMOTE': '1', 08:51:18 INFO - 'NO_EM_RESTART': '1', 08:51:18 INFO - 'PAGER': '/bin/cat', 08:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:18 INFO - 'PWD': '/builds/slave/test', 08:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:18 INFO - 'SHELL': '/bin/bash', 08:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:18 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:18 INFO - 'USER': 'cltbld', 08:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:18 INFO - 'XPC_FLAGS': '0x0', 08:51:18 INFO - 'XPC_SERVICE_NAME': '0', 08:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:51:20 INFO - Installing collected packages: mozsystemmonitor 08:51:20 INFO - Running setup.py install for mozsystemmonitor 08:51:21 INFO - Successfully installed mozsystemmonitor 08:51:21 INFO - Cleaning up... 08:51:21 INFO - Return code: 0 08:51:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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', '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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:51: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 jsonschema==2.5.1 08:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:21 INFO - 'HOME': '/Users/cltbld', 08:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:21 INFO - 'LOGNAME': 'cltbld', 08:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:21 INFO - 'MOZ_NO_REMOTE': '1', 08:51:21 INFO - 'NO_EM_RESTART': '1', 08:51:21 INFO - 'PAGER': '/bin/cat', 08:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:21 INFO - 'PWD': '/builds/slave/test', 08:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:21 INFO - 'SHELL': '/bin/bash', 08:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:21 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:21 INFO - 'USER': 'cltbld', 08:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:21 INFO - 'XPC_FLAGS': '0x0', 08:51:21 INFO - 'XPC_SERVICE_NAME': '0', 08:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:21 INFO - Downloading/unpacking jsonschema==2.5.1 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:51:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:51:24 INFO - warning: no files found matching '*.txt' 08:51:24 INFO - no previously-included directories found matching 'build' 08:51:24 INFO - no previously-included directories found matching 'dist' 08:51:24 INFO - no previously-included directories found matching '.git*' 08:51:24 INFO - Installing collected packages: jsonschema, functools32 08:51:24 INFO - Running setup.py install for functools32 08:51:24 INFO - warning: no files found matching '*.txt' 08:51:24 INFO - no previously-included directories found matching 'build' 08:51:24 INFO - no previously-included directories found matching 'dist' 08:51:24 INFO - no previously-included directories found matching '.git*' 08:51:24 INFO - Successfully installed jsonschema functools32 08:51:24 INFO - Cleaning up... 08:51:24 INFO - Return code: 0 08:51:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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', '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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:51: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 functools32==3.2.3-2 08:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:24 INFO - 'HOME': '/Users/cltbld', 08:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:24 INFO - 'LOGNAME': 'cltbld', 08:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:24 INFO - 'MOZ_NO_REMOTE': '1', 08:51:24 INFO - 'NO_EM_RESTART': '1', 08:51:24 INFO - 'PAGER': '/bin/cat', 08:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:24 INFO - 'PWD': '/builds/slave/test', 08:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:24 INFO - 'SHELL': '/bin/bash', 08:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:24 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:24 INFO - 'USER': 'cltbld', 08:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:24 INFO - 'XPC_FLAGS': '0x0', 08:51:24 INFO - 'XPC_SERVICE_NAME': '0', 08:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:51:24 INFO - Cleaning up... 08:51:24 INFO - Return code: 0 08:51:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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', '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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:51: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 blobuploader==1.2.4 08:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:24 INFO - 'HOME': '/Users/cltbld', 08:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:24 INFO - 'LOGNAME': 'cltbld', 08:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:24 INFO - 'MOZ_NO_REMOTE': '1', 08:51:24 INFO - 'NO_EM_RESTART': '1', 08:51:24 INFO - 'PAGER': '/bin/cat', 08:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:24 INFO - 'PWD': '/builds/slave/test', 08:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:24 INFO - 'SHELL': '/bin/bash', 08:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:24 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:24 INFO - 'USER': 'cltbld', 08:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:24 INFO - 'XPC_FLAGS': '0x0', 08:51:24 INFO - 'XPC_SERVICE_NAME': '0', 08:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:25 INFO - Downloading/unpacking blobuploader==1.2.4 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51:28 INFO - Downloading docopt-0.6.1.tar.gz 08:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:28 INFO - Running setup.py install for blobuploader 08:51:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:28 INFO - Running setup.py install for requests 08:51:29 INFO - Running setup.py install for docopt 08:51:29 INFO - Successfully installed blobuploader requests docopt 08:51:29 INFO - Cleaning up... 08:51:29 INFO - Return code: 0 08:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:29 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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51:29 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 08:51:29 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 08:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:29 INFO - 'HOME': '/Users/cltbld', 08:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:29 INFO - 'LOGNAME': 'cltbld', 08:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:29 INFO - 'MOZ_NO_REMOTE': '1', 08:51:29 INFO - 'NO_EM_RESTART': '1', 08:51:29 INFO - 'PAGER': '/bin/cat', 08:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:29 INFO - 'PWD': '/builds/slave/test', 08:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:29 INFO - 'SHELL': '/bin/bash', 08:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:29 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:29 INFO - 'USER': 'cltbld', 08:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:29 INFO - 'XPC_FLAGS': '0x0', 08:51:29 INFO - 'XPC_SERVICE_NAME': '0', 08:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:29 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-blRvD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:29 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Il0z1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-HMkSqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-cI1YCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-t4IxR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-DUJ2vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-RCSD2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-8e605L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-pyiU09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-7i1yQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-x6q0B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:31 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-MEICxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:31 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-rGX78W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:31 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Zatp8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:31 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-9MJ0Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:31 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-PHOSv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:31 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-CsH2ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:31 INFO - Running setup.py install for manifestparser 08:51:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:31 INFO - Running setup.py install for mozcrash 08:51:31 INFO - Running setup.py install for mozdebug 08:51:32 INFO - Running setup.py install for mozdevice 08:51:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozfile 08:51:32 INFO - Running setup.py install for mozhttpd 08:51:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozinfo 08:51:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozInstall 08:51:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozleak 08:51:32 INFO - Running setup.py install for mozlog 08:51:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for moznetwork 08:51:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for mozprocess 08:51:33 INFO - Running setup.py install for mozprofile 08:51:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for mozrunner 08:51:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for mozscreenshot 08:51:33 INFO - Running setup.py install for moztest 08:51:34 INFO - Running setup.py install for mozversion 08:51:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:34 INFO - Cleaning up... 08:51:34 INFO - Return code: 0 08:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:34 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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51:34 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 08:51:34 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 08:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:34 INFO - 'HOME': '/Users/cltbld', 08:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:34 INFO - 'LOGNAME': 'cltbld', 08:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:34 INFO - 'MOZ_NO_REMOTE': '1', 08:51:34 INFO - 'NO_EM_RESTART': '1', 08:51:34 INFO - 'PAGER': '/bin/cat', 08:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:34 INFO - 'PWD': '/builds/slave/test', 08:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:34 INFO - 'SHELL': '/bin/bash', 08:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:34 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:34 INFO - 'USER': 'cltbld', 08:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:34 INFO - 'XPC_FLAGS': '0x0', 08:51:34 INFO - 'XPC_SERVICE_NAME': '0', 08:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-u_1QO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:34 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)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-EGHQ04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:34 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)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-aM49DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:34 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)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-cTBxxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:34 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)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:34 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-BXVLqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-U5RZQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-qYS7WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-u3Bm1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-o7dYzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-_rhvNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-CA6_zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-qW8GiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-IZVw2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ztS3sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:35 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-meMbmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:36 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-wDAvRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:36 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-LfZLom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:36 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)) 08:51:36 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)) 08:51:36 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)) 08:51:36 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)) 08:51:36 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)) 08:51:36 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)) 08:51:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:36 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 08:51:36 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 08:51:36 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 08:51:36 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 08:51:36 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 08:51:36 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 08:51:38 INFO - Downloading blessings-1.6.tar.gz 08:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:38 INFO - Installing collected packages: blessings 08:51:38 INFO - Running setup.py install for blessings 08:51:39 INFO - Successfully installed blessings 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:39 INFO - Reading from file tmpfile_stdout 08:51:39 INFO - Current package versions: 08:51:39 INFO - blessings == 1.6 08:51:39 INFO - blobuploader == 1.2.4 08:51:39 INFO - docopt == 0.6.1 08:51:39 INFO - functools32 == 3.2.3-2 08:51:39 INFO - jsonschema == 2.5.1 08:51:39 INFO - manifestparser == 1.1 08:51:39 INFO - mozInstall == 1.12 08:51:39 INFO - mozcrash == 0.17 08:51:39 INFO - mozdebug == 0.1 08:51:39 INFO - mozdevice == 0.48 08:51:39 INFO - mozfile == 1.2 08:51:39 INFO - mozhttpd == 0.7 08:51:39 INFO - mozinfo == 0.9 08:51:39 INFO - mozleak == 0.1 08:51:39 INFO - mozlog == 3.3 08:51:39 INFO - moznetwork == 0.27 08:51:39 INFO - mozprocess == 0.23 08:51:39 INFO - mozprofile == 0.28 08:51:39 INFO - mozrunner == 6.12 08:51:39 INFO - mozscreenshot == 0.1 08:51:39 INFO - mozsystemmonitor == 0.3 08:51:39 INFO - moztest == 0.7 08:51:39 INFO - mozversion == 1.4 08:51:39 INFO - psutil == 3.1.1 08:51:39 INFO - requests == 1.2.3 08:51:39 INFO - wsgiref == 0.1.2 08:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:39 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')]} 08:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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')]} 08:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51:39 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 08:51:39 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 08:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:39 INFO - 'HOME': '/Users/cltbld', 08:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:39 INFO - 'LOGNAME': 'cltbld', 08:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:39 INFO - 'MOZ_NO_REMOTE': '1', 08:51:39 INFO - 'NO_EM_RESTART': '1', 08:51:39 INFO - 'PAGER': '/bin/cat', 08:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:39 INFO - 'PWD': '/builds/slave/test', 08:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:39 INFO - 'SHELL': '/bin/bash', 08:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:39 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:39 INFO - 'USER': 'cltbld', 08:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:39 INFO - 'XPC_FLAGS': '0x0', 08:51:39 INFO - 'XPC_SERVICE_NAME': '0', 08:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:51:39 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')]} 08:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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')]} 08:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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 0x101459a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ee618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda134d8120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, '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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 08:51:39 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 08:51:39 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 08:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:39 INFO - 'HOME': '/Users/cltbld', 08:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:39 INFO - 'LOGNAME': 'cltbld', 08:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:39 INFO - 'MOZ_NO_REMOTE': '1', 08:51:39 INFO - 'NO_EM_RESTART': '1', 08:51:39 INFO - 'PAGER': '/bin/cat', 08:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:39 INFO - 'PWD': '/builds/slave/test', 08:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:39 INFO - 'SHELL': '/bin/bash', 08:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:51:39 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:39 INFO - 'USER': 'cltbld', 08:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:39 INFO - 'XPC_FLAGS': '0x0', 08:51:39 INFO - 'XPC_SERVICE_NAME': '0', 08:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Running post-action listener: _resource_record_post_action 08:51:39 INFO - Running post-action listener: _start_resource_monitoring 08:51:39 INFO - Starting resource monitoring. 08:51:39 INFO - [mozharness: 2016-08-09 15:51:39.975762Z] Finished create-virtualenv step (success) 08:51:39 INFO - [mozharness: 2016-08-09 15:51:39.976693Z] Running install step. 08:51:39 INFO - Running pre-action listener: _resource_record_pre_action 08:51:39 INFO - Running main action method: install 08:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:40 INFO - Reading from file tmpfile_stdout 08:51:40 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:40 INFO - Reading from file tmpfile_stdout 08:51:40 INFO - Output received: 08:51:40 INFO - Usage: mozinstall [options] installer 08:51:40 INFO - Options: 08:51:40 INFO - -h, --help show this help message and exit 08:51:40 INFO - -d DEST, --destination=DEST 08:51:40 INFO - Directory to install application into. [default: 08:51:40 INFO - "/builds/slave/test"] 08:51:40 INFO - --app=APP Application being installed. [default: firefox] 08:51:40 INFO - mkdir: /builds/slave/test/build/application 08:51:40 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'] 08:51:40 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 08:52:14 INFO - Reading from file tmpfile_stdout 08:52:14 INFO - Output received: 08:52:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:52:14 INFO - Running post-action listener: _resource_record_post_action 08:52:14 INFO - [mozharness: 2016-08-09 15:52:14.147478Z] Finished install step (success) 08:52:14 INFO - [mozharness: 2016-08-09 15:52:14.147601Z] Running run-tests step. 08:52:14 INFO - Running pre-action listener: _resource_record_pre_action 08:52:14 INFO - Running main action method: run_tests 08:52:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:52:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:52:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:52:14 INFO - 2016-08-09 08:52:14.161 screenresolution[1644:7418] starting screenresolution argv=screenresolution get 08:52:14 INFO - 2016-08-09 08:52:14.164 screenresolution[1644:7418] Display 0: 1600x1200x32@60 08:52:14 INFO - 2016-08-09 08:52:14.170 screenresolution[1645:7421] starting screenresolution argv=screenresolution list 08:52:14 INFO - Available Modes on Display 0 08:52:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:52:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:52:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:52:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:52:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:52:14 INFO - Intel Iris: 08:52:14 INFO - Chipset Model: Intel Iris 08:52:14 INFO - Type: GPU 08:52:14 INFO - Bus: Built-In 08:52:14 INFO - VRAM (Dynamic, Max): 1536 MB 08:52:14 INFO - Vendor: Intel (0x8086) 08:52:14 INFO - Device ID: 0x0a2e 08:52:14 INFO - Revision ID: 0x0009 08:52:14 INFO - Displays: 08:52:14 INFO - Display: 08:52:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:52:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:52:14 INFO - Display Serial Number: 1600x1200 60 08:52:14 INFO - Main Display: Yes 08:52:14 INFO - Mirror: Off 08:52:14 INFO - Online: Yes 08:52:14 INFO - Rotation: Supported 08:52:14 INFO - Return code: 0 08:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:14 INFO - Python 2.7.3 08:52:14 INFO - Return code: 0 08:52:14 INFO - grabbing minidump binary from tooltool 08:52:14 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')]} 08:52:14 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 0x1013bdd30>, '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 0x101122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013b5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:14 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 08:52:14 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 08:52:14 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 08:52:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:14 INFO - Return code: 0 08:52:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:52:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:52:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:52:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fmu2VB7gJG/Render', 08:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:14 INFO - 'HOME': '/Users/cltbld', 08:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:14 INFO - 'LOGNAME': 'cltbld', 08:52:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:14 INFO - 'MOZ_NO_REMOTE': '1', 08:52:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:14 INFO - 'NO_EM_RESTART': '1', 08:52:14 INFO - 'PAGER': '/bin/cat', 08:52:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:14 INFO - 'PWD': '/builds/slave/test', 08:52:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:14 INFO - 'SHELL': '/bin/bash', 08:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3UUiWqGwD/Listeners', 08:52:14 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 08:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:14 INFO - 'USER': 'cltbld', 08:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:14 INFO - 'XPC_FLAGS': '0x0', 08:52:14 INFO - 'XPC_SERVICE_NAME': '0', 08:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:52:14 INFO - mozversion application_buildid: 20160809064620 08:52:14 INFO - mozversion application_changeset: 6cf0089510fad8deb866136f5b92bbced9498447 08:52:14 INFO - mozversion application_display_name: Nightly 08:52:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:14 INFO - mozversion application_name: Firefox 08:52:14 INFO - mozversion application_remotingname: firefox 08:52:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:52:14 INFO - mozversion application_vendor: Mozilla 08:52:14 INFO - mozversion application_version: 51.0a1 08:52:14 INFO - mozversion platform_buildid: 20160809064620 08:52:14 INFO - mozversion platform_changeset: 6cf0089510fad8deb866136f5b92bbced9498447 08:52:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:52:14 INFO - mozversion platform_version: 51.0a1 08:52:14 INFO - using testdate: 1470757934 08:52:14 INFO - actual date: 1470757934 08:52:14 INFO - starting webserver on 'localhost:49279' 08:52:14 INFO - SUITE-START | Running 2 tests 08:52:14 INFO - TEST-START | dromaeo_css 08:52:14 INFO - operating with platform_type : mac_ 08:52:14 INFO - Initialising browser for dromaeo_css test... 08:52:14 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpYVa8xM/profile http://localhost:49279/getInfo.html) 08:52:17 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 08:52:17 INFO - PROCESS | 1655 | colorDepth:24 08:52:17 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 08:52:17 INFO - PROCESS | 1655 | __metrics 08:52:17 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:52:17 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:17 INFO - TEST-INFO | 1655: exit 0 08:52:17 INFO - Browser initialized. 08:52:17 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:17 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpYVa8xM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:29 INFO - PROCESS | 1657 | RSS: Main: 243535872 08:52:29 INFO - PROCESS | 1657 | 08:53:21 INFO - PROCESS | 1657 | 1470758001231 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] 08:55:33 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 08:55:35 INFO - PROCESS | 1657 | RSS: Main: 375078912 08:55:35 INFO - PROCESS | 1657 | 08:58:38 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 08:58:38 INFO - PROCESS | 1657 | RSS: Main: 391020544 08:58:38 INFO - PROCESS | 1657 | 09:01:41 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 09:01:41 INFO - PROCESS | 1657 | RSS: Main: 360341504 09:01:41 INFO - PROCESS | 1657 | 09:04:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 09:04:44 INFO - PROCESS | 1657 | RSS: Main: 358170624 09:04:44 INFO - PROCESS | 1657 | 09:07:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 09:07:48 INFO - PROCESS | 1657 | RSS: Main: 348000256 09:07:48 INFO - PROCESS | 1657 | 09:10:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 09:10:52 INFO - PROCESS | 1657 | RSS: Main: 390533120 09:10:52 INFO - PROCESS | 1657 | 09:10:52 INFO - PROCESS | 1657 | __start_tp_report 09:10:52 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 09:10:52 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 09:10:52 INFO - PROCESS | 1657 | |i|pagename|runs| 09:10:52 INFO - PROCESS | 1657 | |0;dojo.html;2853.32946757512;3367.730581553476;3373.460246360583;3397.558317418735;3431.7597768156224;5629.746661400237;5679.971600141998;5742.79900203493;5752.5110365618975;5756.338021127572;5768.971155144229;5861.618994765337;5895.557833162519;5913.9112913306335;5947.9107813382725;5168.689878607295;5238.738063096849;5268.31511903452;5315.0698627740185;5391.838244852661;5375.946240537603;5379.9731001345135;5381.650192737479;5387.380451248117;5405.567554595643;5205.609579281569;5242.18746094356;5308.734563271821;5332.760025798849;5351.785928562853;5265.815696450644;5293.841184764463;5296.92054619181;5310.389305229909;5310.389305229909;5218.5380557649;5259.921101183485;5268.341457317835;5290.127129023706;5296;5790.36306006339;5791.131330300446;5794;5808.1578171165365;5812.912806307909;5000.399952005746;6212.471939885115;6241.313455519935;6279.152314437538;6301.8109456716375;6229.595076320024;6339.904901426482;6341.207349081365;6358.841028974266;6366;5269.104252277122;5933.525317974551;6005.309389420273;6008.038713805814;6010.308814486302;5282.392524859613;6226.25284965807;6236.282827474808;6255.56211065221;6288.056791481223;6222.657753823583;6255.56211065221;6268.216472940882;6269.435750782452;6275.592086514362;6339.587926784744;6339.809805705836;6368.044793281045;6370.8088757337355;6372;5218.6868787872845;6096.878062438726;6184.6598437086395;6255.843603909939;6324.588901721373;6309.463695585835;6324.367563243731;6324.620522768557;6331.145295385156;6347.936520634735;5045.873853153627;5047.974760126176;5054.646174767731;5061.089003979319;5102.515261050195;3750.5499340079364;4431.7340959542535;4497.325401189848;4498.190325741398;4531.093781243764;5783.421657834267;5829.213056237439;5832.941670583325;5848.210491583667;5867.237259156368;6306.306306306303;6315;6327.588706734047;6330.208723909512;6339.11252424661;5654.886902262014;5718.485336319668;5725.1698503716725;5778.104393818965;5832.096025116114;5443.591730620219;5503.257060296889;5507.917381239285;5509.090999985037;5515.834524964177;6264.59280146789;6309.33751956038;6309.33751956038;6312.210973628296;6325.620462772248;6262.718177681924;6305.369463053658;6317.052442133717;6339.175907132228;6345.1434056401795;6378.585391949508;6388.520860935356;6395.264544577247;6402.199725034371;6405.615663060231;6143.56995010345;6183.474404675473;6199.070139478934;6246.1255424239735;6248.812535623939;6118;6263.561550691408;6274;6278.591891527036;6293.874122517615;6222.62664240147;6239.376062393724;6246.1255424239735;6249.78125765596;6271.31015588294;5956.434138756811;5989.221401217814;6073.969630151998;6143.846403839761;6241.251049874044;5246.029484545371;5984.042553191469;6038.486728628116;6051.062085376773;6052.788152414644;6141.416565426277;6146.477549408351;6155.599886007395;6162.137300777984;6164.445199932027;5859.5019423349495;5879.441453061952;5963.761449541969;5988.8802223956145;6002.009668404664 09:10:52 INFO - PROCESS | 1657 | |1;ext.html;475.20166120916866;476.44970059581186;519.3793416866845;533.9519443250107;546.6200990311735;31339.686603133963;41850.95372615686;42894.78552607232;43010.35484467728;45165.64503064905;44124.77937610308;44517;44550.108997820025;44577;44593.77703111488;9727.173190278834;9869.851952220723;9879.110880020797;9882.654107106217;9900.158486528653;9605.327627066108;9707.369021013612;9717.90282097177;9719.659811906584;9728.270379721549;9685.305071612474;9721.659741909034;9748.512574371289;9771.755706107333;9779.21766258701;9694.369865958726;9716.75708107296;9751;9752.609895604168;9754.561044753003;8341.791455213668;9646.75883102921;9723.173530249936;9729.659461918869;9735.075167859042;41770;42097.78951105256;42117.789411053054;42153;42210.78894605507;3508.6666766657127;3518.437050071976;3522.6125126236093;3594.892153235407;3677.724170687209;32128.875489357994;32421.351572968644;33342.6665733342;33619;33726.494102588236;3246.6593898433566;3285.671432856719;3309.4539400998806;3313.7349012078976;3429.639887811769;498969;504145;505548;505616.47191763803;507588.9241107579;34320;61492;61948;61955;62002.37997619966;34368.82815585956;35910.28179436397;35911.4613280801;35974;36039.4594081089;14685.632859178606;14794.038387504994;14837.480688175861;14851.2574371281;14854.405823767145;12694.873051269555;12772.489100435878;12819.35903204836;12823;12833.294168820805;7879.724209652634;7892.842143157105;7908.485948413335;7985.441019128722;7996.280334769898;3247.8376081195847;3260.494623333387;3265.4122257993313;3267.575215222006;3305.504174373815;974.2985050763439;989.4261328429494;996.0885789502669;1032.4940779018227;1063.441693111123;25273.74726252714;27897.860510697315;31635.525467118012;32146.517802232986;33076.842310519016;1005.3967619428284;1117.6758739965483;1122.7024838417826;1173.8767429419959;1195.2768575011992;14226.715465690835;16027.090284348342;16045.876788624684;16136.354545818036;16453.341866325212;687797;696536;696915;698787.5060624664;700247.9975200285;59802;60668;60690.696546517865;60784.696076519336;60945.39054609397;1232.2914324263584;1345.6904911870324;1353.810466534686;1377.5522955039453;1398.1121987537986;31150.75396984186;31884.202894927814;31985.68014319827;32799;33014.66985330116;52114;52683.73658131685;52849.88600455939;52901.735491322295;53067;564519;567979;569138;569838;569945;26511.867440662674;27584.586231206147;27663.723362766115;27667.169984900484;27701.8919243228;49425.505744943526;49849.750751246014;49866;51012.489875102256;52854.47145528649;25063.498730024934;39959.2008159841;41442;41485.377719334836;43771.12457750891;40729.592704073766;40905.38641920314;41365.75902722923;41955.58044419639;42391.57608423876;39611.405828912015;40177.79911100426;40303.59696402998;40318.79840600778;42071.73784786461;31063.378732425677;34938.65061349354;34962.211614956046;35074.473882892285;35365.939021829385;25769.355766105997;25920.611190831776;25954.35114122162;26009.6098558518;26226.40852253734 09:10:52 INFO - PROCESS | 1657 | |2;jquery.html;352.81653540159135;371.5133175540043;374.6085340818844;379.8461623042668;398.53172522286326;15458.92270538647;16036.67926641468;19946.501337466572;20762.85804280764;20859.478513037164;19774.011299435042;20370.796292037074;20371.98140092993;20381.898090509563;21152;5203.739813009353;5868.911966320508;6013.669248191348;6109.327973922865;6124.877502449948;6020.698965051752;6105.694715264219;6114;6117.632942023471;6127.234095738033;5679.772809087653;5976.910346344808;5981.401859814027;6062.757489700407;6069.3323734389405;5999.950008748451;6065.4844338231305;6080.209572755558;6085.78699745509;6091.604045737035;5641.548676105902;5830.679312637803;5838.766449342063;5838.795642152504;5846.298444186682;12425.813612795815;12654.620361389174;12657.556985505555;13027.934860325733;13266.469341226339;2050.98974505128;2138.272987184365;2233.932982010542;2245.9213927512624;2894.6526416829906;9849.409035457824;10155.492225388702;10308.53611587473;12395.822396872283;14792.926035369863;1446.349142885695;1859.395696398676;1877.676238252029;1909.5035290824346;1913.435536516717;113086;119342;121694;122746.38626806809;126189;11050.613228536962;11329.830052549218;11555.075593952464;11572.94213528927;11730.413479326;14568.198749068903;14586.051906626035;14592.927035364755;14626.63433414152;14640.341184646717;6731.663416829139;8318.70884519039;8377.287930525852;8439.66241350339;8550.273226775793;8217.8356432871;8258.710945117013;8276.751697449086;8412.990441147102;8446.366522510836;4419.359192917073;4515.0518391137575;4548.408706868086;4575.267957126844;4622.791974361162;1732.5841797968649;1819.6178802451368;1881.2286962345372;1918.4915997260457;1950.2101648832245;651.794684674326;724.5399171526119;763.3778470546487;950.1923365139714;959.3284700709531;20247.696284555743;21774.061808515216;21804.541124166553;21864.344069677936;21865.234716785155;910.7859652981545;938.9530523473799;957.4255446731905;994.5077186792583;1011.4841430870309;10459.424731639681;11125.833112503318;11241.381724005258;11427.771444571228;11437.370944598128;592661;596081;597101;600713;603404;117194;119410;121341.39329303474;128427;128472.71527284608;975.2636759246865;1020.1481762728205;1055.6938487838595;1057.413135709673;1058.317385286486;18598;18915.71626425577;18954;19093.045347732837;19209.936449456556;54625.1806222899;54889;55021;55290;56754.58113547029;77883.83174252504;79992.60003699944;80127.59936200282;80428;80797;7853.685852566062;8060.193980601893;8209.79475513117;8264.380171487042;8285.627146778288;12295.016398688262;12804.487820487077;13083.345832708135;13225.603231903058;13427.992900532694;11048.06091482233;11056;11265.26775759573;11385.886141138482;11402.714932126763;10612.151027917902;11063.889361106609;11101.833472498081;11213.66359009231;11403.942980285046;8064.6370913307865;11012.284201526874;11177.608783692533;11184.049355804847;11286.322820630789;6973.825654358681;7886.960565197137;8184.54984975832;8197.549134797644;8391.496510209407;8339.749807505785;10987.505562249558;11284.153688473561;11298.49156787963;11300.378479183395 09:10:52 INFO - PROCESS | 1657 | |3;mootools.html;1526.6183454136462;1567.255553612034;1766.4877185616172;1854.6290741851617;1925.4223732880141;6925.688344024518;8276.379271554635;8833.867491987608;8836.381453298272;9070.773230669236;6863.931360686392;7736.071671399426;8336.04135524415;8548.187922147401;8623.568821558929;2339.6490526421044;2378.3816207786012;2378.52429514097;2380.452495925938;2383.892724827378;2339.368370539953;2348.729896061958;2378.8096952243864;2379.7620237976153;2382.154335211001;2336.8247381446376;2345.85924844509;2351.729551101628;2361.161787565415;2366.065404165354;2321.5356928614347;2334.533093381322;2338.3920180752957;2339.532093581282;2357.57563638545;2327.325075728037;2327.44141406063;2331.184085570054;2331.2306938710185;2331.75516570761;8543.017552981424;8666.6100025499;8723.99674037481;8804.295656347476;8807.911920880773;5103.183490641517;5278.47215278473;5283.894322113536;5285.048691235576;5301.1783173608155;3579.4093974494176;3602.0454579536445;3652.9269414611827;3664.120611053355;3670.06413364593;1079.7300674831292;1085.8914108589156;1088.6570730219955;1108.22978030269;1113.4377139544558;11533.308001519936;11627.534898604046;11628.767424651543;11652.883471165349;11664.416779161009;4082.632563069338;4445.777111444278;4547.909041819211;4710.105080034782;4755.38180036593;9853.901460985442;9858.40849549015;9861;9863.16163126128;9886.80226395468;5276.07668657991;5281.445448227958;5285.365756109291;5288.576913846883;5293.7353132344;4353.956460435418;4518.028623845889;4674.228752255908;4803.135435621622;4823.710577365369;3859.729818912649;3893.922121557553;3991.600839915985;4007.6393124618926;4026.7382620129597;1273.8471383434048;1275.4005617359826;1283.1851774123313;1284.3000564692265;1298.0589072922055;750.2572453271331;856.1866227084295;904.8461761500561;907.2923119966437;946.8968651521038;5423.810166644227;5656;5736.13957906309;5923.644581325134;5951.940480595225;819.9303059240032;921.1663444582664;940.6331530703031;945.579217248318;977.3451787302524;3176.8093914365213;3927.9410808837893;3992.6207010333974;4008.398740188995;4081.77550234734;10201.489925503694;10624.681259562225;10635;10749.89250107489;10764.085052770602;10710.839337409945;10714.839277410845;10738.946305268424;10742.462876856125;10752.677419677422;8019.799505012421;8219.260266575917;8223.876641850376;8227.99999999988;8235.1353107924;5734.283214598176;5848.707564621837;6069.332373439007;6125.448709616156;6135.84660383494;9438.669646562337;9828.31201815866;9846.261530385107;9863.852042219516;9864.408135511892;10257.435841028517;10266.845997310196;10278.588856445958;10282.897171028193;10283.228757843042;5977.312609049841;7240.420766338575;7396.14944281393;7582.393408527194;7766.766996990099;8201.26188643025;8488.363372746946;8488.61801218959;8507.276881465144;8528.91471085306;7370.22612625688;7462.216467270859;7476.813079673052;7552.093748749965;7618.961905190438;7265.564066156047;7315.049043624294;7316.707331706672;7505.211952744883;7507.88738168917;6915.481338899502;7064.576125432491;7067.858642827217;7070.787876363717;7073.115860517435;4954.380702412199;4993.450720420823;5032.949670503394;5040.168372218543;5106.10643137442;4887.242477416006;4958.380202474691;5049.924251136309;5068.771905264346;5176.094183517945 09:10:52 INFO - PROCESS | 1657 | |4;prototype.html;294.8275258973502;295.1102426185052;307.7753240134701;312.70137019146716;314.51564590530586;5362.418086664434;5436.972815135924;5439.292891924054;5463.644863083897;5468.004178474853;4689.882752931178;4761.90476190476;4941.922913596289;5180.611454140936;5336.38631557371;3298.47224444089;3970.900727481822;3995.4206640037105;4019.216252830699;4027.6173763492566;3714.702823774105;3986.9202615947665;3995.480587523618;4017.1965606878593;4021.8190181441905;3886.8533782534078;3970.2456533258733;4003.719739618228;4028.7237710693366;4052.49343832021;3620.6784523648944;3998.5001874765653;4003.919921601552;4016.3573828187496;4062.796860156995;2934.413117376533;3500.7724497907557;3517.296540691872;3527.5836052304;3528.1179705073732;4283.614474697292;5087.923681144785;5131.151636272795;5161.948380516184;5167.276581278624;4296.269634162169;4596.609288210473;4647.9535204647855;4664.930026049612;4667.276572131325;4931.679440836334;5655.943440565583;5665.943340566624;5688.260526131618;5713.971430142864;3316.8507417166284;3451.2579795343872;3549.219171782204;3779.508663873706;3829.48301979232;4843.903121937541;5553.444655534455;5636.857993962309;5905.881882362329;5921.897726307142;2946.5138252188576;3707.610700876423;3802.954187598433;3835.7314987951136;3854.2291541691775;3396.8790299201205;3864.806759662006;3916.315984126853;3924.5486769021927;3925.980370098131;4279.443672322641;4568.817247310137;4577.176108300538;4622.722636641813;4634.679116451795;4908.435529914105;5360.490753378423;5509.889802203934;5684.573656975661;5754.338251101177;1189.238887112249;1201.3212534917743;1271.790154624495;1348.5077946549634;1352.2968056610705;695.6695569604398;841.8526757817358;877.4603618774407;896.1173244354305;903.701778413122;4352.194843953878;5164.457731938168;5169.612279079084;5187.792488300426;5293.973530132402;5705.5150312223095;5743.9425605744245;5746.913796293059;5767.826965191051;5804.390538993345;4845.982343707861;5142.331496905454;5152.793888244429;5159.664621799571;5177.058603023866;2980.552917062458;2997.310618557744;3002.8198308101582;3007.9849600751854;3013.367192889518;5571.247881536022;5873.6490607160595;5908.675022873697;5934.584579079509;5935.73289201987;5087.542121209109;6018.247719035121;6019.939800601938;6031.336552979169;6047.2743270806905;5460.754266058037;5516.841463292753;6049.879002419927;6066.545009124245;6081.422264884741;5566.7971127063165;5773.740181691918;5789.305283366023;5856.385079566584;5862.801449456454;5018.4981501849525;5778.913316300175;5781.248437703071;5801.82594522165;5809.2738407699035;5038.967011762653;5336.6797992119045;5748.626339287933;6069.602507009795;6112.266528016667;3265.8530366134055;3504.7371447142077;3870;3870.458135861038;3899.415087736862;5811.360750317377;5834.358220595646;5847.970760146172;5851.590388672752;5859.707014649336;5205.843824685266;5668.894565559676;5680.989075789838;5735.713214339183;5755.913661295001;5110.61670374716;5290.285811415563;5627.380988091225;5684;5702.771889124555;4871.48849370811;5310.867228319323;5458.372287187024;5558.833235002957;5590.385057643574;4595.9310610341545;5640.548756099584;5652.265205523256;5661.575381846295;5678.716064196857;5523.254360661259;5538.723063846872;5546.306711661043;5547.528460080938;5569.331680198402 09:10:52 INFO - PROCESS | 1657 | |5;yui.html;718.6694120704476;727.9752627831359;742.8997085393473;819.8032472206672;828.892244008279;12467;16455.424060157897;16488;16493.25780339886;16578.58553536162;14847.406103755864;14977.326020329085;15009.774853377208;15021.248937553133;15026.17356045417;670.4602794750224;698.1482591238681;828.1015098618007;842.9325653947685;859.6045818923303;840.0255703384075;861.5821326656567;864.1401805203831;864.4942708515526;865.7272959017889;905.9762468410687;908.591133989704;908.9181973622373;910.6630546697731;911.2391153386897;707.331571664777;879.8064425826308;902.5351943748974;902.7697937026049;904.4573256046385;669.7388018672722;671.0873212431089;671.5030877150922;672.1933679584519;673.3064943108606;14701.55895323142;14735.926320368437;14744.262786860614;14753.926230368887;14761.630959225999;13695.31523423825;13869.653258668613;13946;14108.647283817883;14174.787378189336;12788.680282992907;12859.292738899358;12953.87046129536;13031.152975056591;13444.260565668885;4589.288660257632;4641.907161856778;4654.162250794856;4680.4149481314835;4815.6388270879825;116952.41523792411;120405.79594204121;121034.13278136893;122696.38651806772;124226;10832.78334433307;10966.835497467544;11047.005769480786;11166.665000050012;11534.711632209093;17874.731879021823;21545.922703864744;21600.891995540234;21613.67579486309;21633.134674613153;7300.780976570712;7640.847183056308;7847.607619618996;7970.123286438487;8173.427860049858;4350.564943505624;4427.335899615084;4441.844535441309;4611.239145541015;4697.976510117427;3419.1623052352334;3565.180008598037;3568.3398571264397;3569.714422846218;3569.8572057117944;646.6831252686244;668.4719071933118;671.392389887153;672.5460314287836;674.2044387622554;531.6677076826983;551.302602208207;557.2699763310077;589.2016317889198;628.4061561824033;7861.724839630586;8563.272121869586;8699.608517616722;9271.211946984447;9525.666406703067;543.760745272079;587.9764809407576;609.9573029887865;694.2086021934998;710.296806161896;4603.240465323252;4695.483496815347;4757.458980572898;4763.571278584944;4779.801866304364;96982;131297;134384;139216;141695;73640.89538656925;105846.47076764567;114569;114655.2801707975;119511.40244298722;101658.99999999852;101938;105002.94997050085;105724;105908;8817.823643526965;9069.77325566866;9089.863652045093;9147.201091965126;9221.262299016196;56953.71523142358;57203.6940998129;59124;59775;59840.40159598348;86747.13252867643;90369;92277;92431;94226.52886735796;11952.81494924498;12056.397180141134;12390.194637348544;12405.44175512086;12538.749225015632;12988.480460781462;13503.12229705066;13593.980451465983;13997.370118344495;14065;11784.414992218304;12049.397530123284;12061.216020958609;12086;12740.362981851056;12287.447064881922;12411.875881241072;12437.502499899903;12597.307148106942;12688.345728682805;12176.939115304367;12228.08289378318;12244.877551224374;12533.060020498317;12701.36493175319;10333.328333658288;10690.83963740529;10797.190210734068;10816.4050977197;11008.724781880517;9427.245820334494;10079.294449388472;10776.29954052984;10898.073663738354;10991.340519568852 09:10:52 INFO - PROCESS | 1657 | __end_tp_report 09:10:52 INFO - PROCESS | 1657 | __start_cc_report 09:10:52 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1324 09:10:52 INFO - PROCESS | 1657 | __end_cc_report 09:10:52 INFO - PROCESS | 1657 | __startTimestamp1470759052325__endTimestamp 09:10:52 INFO - PROCESS | 1657 | 09:10:52 INFO - PROCESS | 1657 | ------- Summary: start ------- 09:10:52 INFO - PROCESS | 1657 | Number of tests: 6 09:10:52 INFO - PROCESS | 1657 | 09:10:52 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5785.99 Median:5989.22 stddev:663.80 (11.1%) stddev-sans-first:624.70 09:10:52 INFO - PROCESS | 1657 | Values: 2853.3 3367.7 3373.5 3397.6 3431.8 5629.7 5680.0 5742.8 5752.5 5756.3 5769.0 5861.6 5895.6 5913.9 5947.9 5168.7 5238.7 5268.3 5315.1 5391.8 5375.9 5380.0 5381.7 5387.4 5405.6 5205.6 5242.2 5308.7 5332.8 5351.8 5265.8 5293.8 5296.9 5310.4 5310.4 5218.5 5259.9 5268.3 5290.1 5296.0 5790.4 5791.1 5794.0 5808.2 5812.9 5000.4 6212.5 6241.3 6279.2 6301.8 6229.6 6339.9 6341.2 6358.8 6366.0 5269.1 5933.5 6005.3 6008.0 6010.3 5282.4 6226.3 6236.3 6255.6 6288.1 6222.7 6255.6 6268.2 6269.4 6275.6 6339.6 6339.8 6368.0 6370.8 6372.0 5218.7 6096.9 6184.7 6255.8 6324.6 6309.5 6324.4 6324.6 6331.1 6347.9 5045.9 5048.0 5054.6 5061.1 5102.5 3750.5 4431.7 4497.3 4498.2 4531.1 5783.4 5829.2 5832.9 5848.2 5867.2 6306.3 6315.0 6327.6 6330.2 6339.1 5654.9 5718.5 5725.2 5778.1 5832.1 5443.6 5503.3 5507.9 5509.1 5515.8 6264.6 6309.3 6309.3 6312.2 6325.6 6262.7 6305.4 6317.1 6339.2 6345.1 6378.6 6388.5 6395.3 6402.2 6405.6 6143.6 6183.5 6199.1 6246.1 6248.8 6118.0 6263.6 6274.0 6278.6 6293.9 6222.6 6239.4 6246.1 6249.8 6271.3 5956.4 5989.2 6074.0 6143.8 6241.3 5246.0 5984.0 6038.5 6051.1 6052.8 6141.4 6146.5 6155.6 6162.1 6164.4 5859.5 5879.4 5963.8 5988.9 6002.0 09:10:52 INFO - PROCESS | 1657 | 09:10:52 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:71364.12 Median:41810.48 stddev:159368.91 (381.2%) stddev-sans-first:159727.10 09:10:52 INFO - PROCESS | 1657 | Values: 475.2 476.4 519.4 534.0 546.6 31339.7 41851.0 42894.8 43010.4 45165.6 44124.8 44517.0 44550.1 44577.0 44593.8 9727.2 9869.9 9879.1 9882.7 9900.2 9605.3 9707.4 9717.9 9719.7 9728.3 9685.3 9721.7 9748.5 9771.8 9779.2 9694.4 9716.8 9751.0 9752.6 9754.6 8341.8 9646.8 9723.2 9729.7 9735.1 41770.0 42097.8 42117.8 42153.0 42210.8 3508.7 3518.4 3522.6 3594.9 3677.7 32128.9 32421.4 33342.7 33619.0 33726.5 3246.7 3285.7 3309.5 3313.7 3429.6 498969.0 504145.0 505548.0 505616.5 507588.9 34320.0 61492.0 61948.0 61955.0 62002.4 34368.8 35910.3 35911.5 35974.0 36039.5 14685.6 14794.0 14837.5 14851.3 14854.4 12694.9 12772.5 12819.4 12823.0 12833.3 7879.7 7892.8 7908.5 7985.4 7996.3 3247.8 3260.5 3265.4 3267.6 3305.5 974.3 989.4 996.1 1032.5 1063.4 25273.7 27897.9 31635.5 32146.5 33076.8 1005.4 1117.7 1122.7 1173.9 1195.3 14226.7 16027.1 16045.9 16136.4 16453.3 687797.0 696536.0 696915.0 698787.5 700248.0 59802.0 60668.0 60690.7 60784.7 60945.4 1232.3 1345.7 1353.8 1377.6 1398.1 31150.8 31884.2 31985.7 32799.0 33014.7 52114.0 52683.7 52849.9 52901.7 53067.0 564519.0 567979.0 569138.0 569838.0 569945.0 26511.9 27584.6 27663.7 27667.2 27701.9 49425.5 49849.8 49866.0 51012.5 52854.5 25063.5 39959.2 41442.0 41485.4 43771.1 40729.6 40905.4 41365.8 41955.6 42391.6 39611.4 40177.8 40303.6 40318.8 42071.7 31063.4 34938.7 34962.2 35074.5 35365.9 25769.4 25920.6 25954.4 26009.6 26226.4 09:10:52 INFO - PROCESS | 1657 | 09:10:52 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34725.61 Median:21789.30 stddev:99835.75 (458.2%) stddev-sans-first:100082.46 09:10:52 INFO - PROCESS | 1657 | Values: 352.8 371.5 374.6 379.8 398.5 15458.9 16036.7 19946.5 20762.9 20859.5 19774.0 20370.8 20372.0 20381.9 21152.0 5203.7 5868.9 6013.7 6109.3 6124.9 6020.7 6105.7 6114.0 6117.6 6127.2 5679.8 5976.9 5981.4 6062.8 6069.3 6000.0 6065.5 6080.2 6085.8 6091.6 5641.5 5830.7 5838.8 5838.8 5846.3 12425.8 12654.6 12657.6 13027.9 13266.5 2051.0 2138.3 2233.9 2245.9 2894.7 9849.4 10155.5 10308.5 12395.8 14792.9 1446.3 1859.4 1877.7 1909.5 1913.4 113086.0 119342.0 121694.0 122746.4 126189.0 11050.6 11329.8 11555.1 11572.9 11730.4 14568.2 14586.1 14592.9 14626.6 14640.3 6731.7 8318.7 8377.3 8439.7 8550.3 8217.8 8258.7 8276.8 8413.0 8446.4 4419.4 4515.1 4548.4 4575.3 4622.8 1732.6 1819.6 1881.2 1918.5 1950.2 651.8 724.5 763.4 950.2 959.3 20247.7 21774.1 21804.5 21864.3 21865.2 910.8 939.0 957.4 994.5 1011.5 10459.4 11125.8 11241.4 11427.8 11437.4 592661.0 596081.0 597101.0 600713.0 603404.0 117194.0 119410.0 121341.4 128427.0 128472.7 975.3 1020.1 1055.7 1057.4 1058.3 18598.0 18915.7 18954.0 19093.0 19209.9 54625.2 54889.0 55021.0 55290.0 56754.6 77883.8 79992.6 80127.6 80428.0 80797.0 7853.7 8060.2 8209.8 8264.4 8285.6 12295.0 12804.5 13083.3 13225.6 13428.0 11048.1 11056.0 11265.3 11385.9 11402.7 10612.2 11063.9 11101.8 11213.7 11403.9 8064.6 11012.3 11177.6 11184.0 11286.3 6973.8 7887.0 8184.5 8197.5 8391.5 8339.7 10987.5 11284.2 11298.5 11300.4 09:10:52 INFO - PROCESS | 1657 | 09:10:52 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5673.62 Median:5045.05 stddev:3170.43 (62.8%) stddev-sans-first:3164.01 09:10:52 INFO - PROCESS | 1657 | Values: 1526.6 1567.3 1766.5 1854.6 1925.4 6925.7 8276.4 8833.9 8836.4 9070.8 6863.9 7736.1 8336.0 8548.2 8623.6 2339.6 2378.4 2378.5 2380.5 2383.9 2339.4 2348.7 2378.8 2379.8 2382.2 2336.8 2345.9 2351.7 2361.2 2366.1 2321.5 2334.5 2338.4 2339.5 2357.6 2327.3 2327.4 2331.2 2331.2 2331.8 8543.0 8666.6 8724.0 8804.3 8807.9 5103.2 5278.5 5283.9 5285.0 5301.2 3579.4 3602.0 3652.9 3664.1 3670.1 1079.7 1085.9 1088.7 1108.2 1113.4 11533.3 11627.5 11628.8 11652.9 11664.4 4082.6 4445.8 4547.9 4710.1 4755.4 9853.9 9858.4 9861.0 9863.2 9886.8 5276.1 5281.4 5285.4 5288.6 5293.7 4354.0 4518.0 4674.2 4803.1 4823.7 3859.7 3893.9 3991.6 4007.6 4026.7 1273.8 1275.4 1283.2 1284.3 1298.1 750.3 856.2 904.8 907.3 946.9 5423.8 5656.0 5736.1 5923.6 5951.9 819.9 921.2 940.6 945.6 977.3 3176.8 3927.9 3992.6 4008.4 4081.8 10201.5 10624.7 10635.0 10749.9 10764.1 10710.8 10714.8 10738.9 10742.5 10752.7 8019.8 8219.3 8223.9 8228.0 8235.1 5734.3 5848.7 6069.3 6125.4 6135.8 9438.7 9828.3 9846.3 9863.9 9864.4 10257.4 10266.8 10278.6 10282.9 10283.2 5977.3 7240.4 7396.1 7582.4 7766.8 8201.3 8488.4 8488.6 8507.3 8528.9 7370.2 7462.2 7476.8 7552.1 7619.0 7265.6 7315.0 7316.7 7505.2 7507.9 6915.5 7064.6 7067.9 7070.8 7073.1 4954.4 4993.5 5032.9 5040.2 5106.1 4887.2 4958.4 5049.9 5068.8 5176.1 09:10:52 INFO - PROCESS | 1657 | 09:10:52 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4557.20 Median:5163.20 stddev:1435.53 (27.8%) stddev-sans-first:1403.46 09:10:52 INFO - PROCESS | 1657 | Values: 294.8 295.1 307.8 312.7 314.5 5362.4 5437.0 5439.3 5463.6 5468.0 4689.9 4761.9 4941.9 5180.6 5336.4 3298.5 3970.9 3995.4 4019.2 4027.6 3714.7 3986.9 3995.5 4017.2 4021.8 3886.9 3970.2 4003.7 4028.7 4052.5 3620.7 3998.5 4003.9 4016.4 4062.8 2934.4 3500.8 3517.3 3527.6 3528.1 4283.6 5087.9 5131.2 5161.9 5167.3 4296.3 4596.6 4648.0 4664.9 4667.3 4931.7 5655.9 5665.9 5688.3 5714.0 3316.9 3451.3 3549.2 3779.5 3829.5 4843.9 5553.4 5636.9 5905.9 5921.9 2946.5 3707.6 3803.0 3835.7 3854.2 3396.9 3864.8 3916.3 3924.5 3926.0 4279.4 4568.8 4577.2 4622.7 4634.7 4908.4 5360.5 5509.9 5684.6 5754.3 1189.2 1201.3 1271.8 1348.5 1352.3 695.7 841.9 877.5 896.1 903.7 4352.2 5164.5 5169.6 5187.8 5294.0 5705.5 5743.9 5746.9 5767.8 5804.4 4846.0 5142.3 5152.8 5159.7 5177.1 2980.6 2997.3 3002.8 3008.0 3013.4 5571.2 5873.6 5908.7 5934.6 5935.7 5087.5 6018.2 6019.9 6031.3 6047.3 5460.8 5516.8 6049.9 6066.5 6081.4 5566.8 5773.7 5789.3 5856.4 5862.8 5018.5 5778.9 5781.2 5801.8 5809.3 5039.0 5336.7 5748.6 6069.6 6112.3 3265.9 3504.7 3870.0 3870.5 3899.4 5811.4 5834.4 5848.0 5851.6 5859.7 5205.8 5668.9 5681.0 5735.7 5755.9 5110.6 5290.3 5627.4 5684.0 5702.8 4871.5 5310.9 5458.4 5558.8 5590.4 4595.9 5640.5 5652.3 5661.6 5678.7 5523.3 5538.7 5546.3 5547.5 5569.3 09:10:52 INFO - PROCESS | 1657 | 09:10:52 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:23540.85 Median:3569.79 stddev:36808.57 (1031.1%) stddev-sans-first:36871.94 09:10:52 INFO - PROCESS | 1657 | Values: 718.7 728.0 742.9 819.8 828.9 12467.0 16455.4 16488.0 16493.3 16578.6 14847.4 14977.3 15009.8 15021.2 15026.2 670.5 698.1 828.1 842.9 859.6 840.0 861.6 864.1 864.5 865.7 906.0 908.6 908.9 910.7 911.2 707.3 879.8 902.5 902.8 904.5 669.7 671.1 671.5 672.2 673.3 14701.6 14735.9 14744.3 14753.9 14761.6 13695.3 13869.7 13946.0 14108.6 14174.8 12788.7 12859.3 12953.9 13031.2 13444.3 4589.3 4641.9 4654.2 4680.4 4815.6 116952.4 120405.8 121034.1 122696.4 124226.0 10832.8 10966.8 11047.0 11166.7 11534.7 17874.7 21545.9 21600.9 21613.7 21633.1 7300.8 7640.8 7847.6 7970.1 8173.4 4350.6 4427.3 4441.8 4611.2 4698.0 3419.2 3565.2 3568.3 3569.7 3569.9 646.7 668.5 671.4 672.5 674.2 531.7 551.3 557.3 589.2 628.4 7861.7 8563.3 8699.6 9271.2 9525.7 543.8 588.0 610.0 694.2 710.3 4603.2 4695.5 4757.5 4763.6 4779.8 96982.0 131297.0 134384.0 139216.0 141695.0 73640.9 105846.5 114569.0 114655.3 119511.4 101659.0 101938.0 105002.9 105724.0 105908.0 8817.8 9069.8 9089.9 9147.2 9221.3 56953.7 57203.7 59124.0 59775.0 59840.4 86747.1 90369.0 92277.0 92431.0 94226.5 11952.8 12056.4 12390.2 12405.4 12538.7 12988.5 13503.1 13594.0 13997.4 14065.0 11784.4 12049.4 12061.2 12086.0 12740.4 12287.4 12411.9 12437.5 12597.3 12688.3 12176.9 12228.1 12244.9 12533.1 12701.4 10333.3 10690.8 10797.2 10816.4 11008.7 9427.2 10079.3 10776.3 10898.1 10991.3 09:10:52 INFO - PROCESS | 1657 | -------- Summary: end -------- 09:10:52 INFO - PROCESS | 1657 | 09:10:52 INFO - TEST-INFO | 1657: exit 0 09:10:52 INFO - TEST-OK | dromaeo_css | took 1118225ms 09:10:52 INFO - TEST-START | kraken 09:10:52 INFO - operating with platform_type : mac_ 09:10:52 INFO - Initialising browser for kraken test... 09:10:52 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmplfjqhS/profile http://localhost:49279/getInfo.html) 09:10:55 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 09:10:55 INFO - PROCESS | 1666 | colorDepth:24 09:10:55 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 09:10:55 INFO - PROCESS | 1666 | __metrics 09:10:55 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:10:55 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:56 INFO - TEST-INFO | 1666: exit 0 09:10:56 INFO - Browser initialized. 09:10:56 INFO - Running cycle 1/1 for kraken test... 09:10:56 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmplfjqhS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:07 INFO - PROCESS | 1667 | RSS: Main: 243437568 09:11:07 INFO - PROCESS | 1667 | 09:11:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:11 INFO - PROCESS | 1667 | RSS: Main: 293199872 09:11:11 INFO - PROCESS | 1667 | 09:11:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 09:11:14 INFO - PROCESS | 1667 | RSS: Main: 299659264 09:11:14 INFO - PROCESS | 1667 | 09:11:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 09:11:18 INFO - PROCESS | 1667 | RSS: Main: 394215424 09:11:18 INFO - PROCESS | 1667 | 09:11:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 09:11:21 INFO - PROCESS | 1667 | RSS: Main: 295899136 09:11:21 INFO - PROCESS | 1667 | 09:11:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:24 INFO - PROCESS | 1667 | RSS: Main: 300253184 09:11:24 INFO - PROCESS | 1667 | 09:11:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:27 INFO - PROCESS | 1667 | RSS: Main: 339062784 09:11:27 INFO - PROCESS | 1667 | 09:11:30 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:31 INFO - PROCESS | 1667 | RSS: Main: 339771392 09:11:31 INFO - PROCESS | 1667 | 09:11:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 09:11:34 INFO - PROCESS | 1667 | RSS: Main: 339304448 09:11:34 INFO - PROCESS | 1667 | 09:11:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:36 INFO - PROCESS | 1667 | RSS: Main: 313835520 09:11:36 INFO - PROCESS | 1667 | 09:11:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:39 INFO - PROCESS | 1667 | RSS: Main: 320905216 09:11:39 INFO - PROCESS | 1667 | 09:11:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:42 INFO - PROCESS | 1667 | RSS: Main: 323407872 09:11:42 INFO - PROCESS | 1667 | 09:11:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:45 INFO - PROCESS | 1667 | RSS: Main: 328998912 09:11:45 INFO - PROCESS | 1667 | 09:11:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:48 INFO - PROCESS | 1667 | RSS: Main: 330493952 09:11:48 INFO - PROCESS | 1667 | 09:11:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 09:11:51 INFO - PROCESS | 1667 | RSS: Main: 373805056 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | __start_tp_report 09:11:51 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 09:11:51 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 09:11:51 INFO - PROCESS | 1667 | |i|pagename|runs| 09:11:51 INFO - PROCESS | 1667 | |0;ai-astar;103;114;114;114;112;114;113;114;115;113 09:11:51 INFO - PROCESS | 1667 | |1;audio-beat-detection;145;109;108;167;108;106;130;107;140;98 09:11:51 INFO - PROCESS | 1667 | |2;audio-dft;186;185;182;184;182;184;183;183;181;183 09:11:51 INFO - PROCESS | 1667 | |3;audio-fft;79;57;61;83;48;72;89;89;83;57 09:11:51 INFO - PROCESS | 1667 | |4;audio-oscillator;82;69;100;70;74;67;97;70;68;102 09:11:51 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;89;86;89;85;88;86;136;86;103;132 09:11:51 INFO - PROCESS | 1667 | |6;imaging-darkroom;94;93;95;94;94;93;93;101;94;94 09:11:51 INFO - PROCESS | 1667 | |7;imaging-desaturate;84;87;86;85;84;86;85;83;83;85 09:11:51 INFO - PROCESS | 1667 | |8;json-parse-financial;53;51;52;52;51;53;54;51;54;54 09:11:51 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;64;67;78;77;72;68;67;70;69;71 09:11:51 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;86;83;84;84;81;81;82;83;83;87 09:11:51 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;140;135;143;143;148;146;133;137;156;139 09:11:51 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;166;167;164;167;166;164;164;169;165;166 09:11:51 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;67;67;79;85;87;86;85;66;67;66 09:11:51 INFO - PROCESS | 1667 | __end_tp_report 09:11:51 INFO - PROCESS | 1667 | __start_cc_report 09:11:51 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2019 09:11:51 INFO - PROCESS | 1667 | __end_cc_report 09:11:51 INFO - PROCESS | 1667 | __startTimestamp1470759111055__endTimestamp 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | ------- Summary: start ------- 09:11:51 INFO - PROCESS | 1667 | Number of tests: 14 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.47 (3.0%) stddev-sans-first:0.87 09:11:51 INFO - PROCESS | 1667 | Values: 103.0 114.0 114.0 114.0 112.0 114.0 113.0 114.0 115.0 113.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:135.00 stddev:22.51 (16.7%) stddev-sans-first:22.25 09:11:51 INFO - PROCESS | 1667 | Values: 145.0 109.0 108.0 167.0 108.0 106.0 130.0 107.0 140.0 98.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.49 (0.8%) stddev-sans-first:1.22 09:11:51 INFO - PROCESS | 1667 | Values: 186.0 185.0 182.0 184.0 182.0 184.0 183.0 183.0 181.0 183.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:71.80 Median:81.00 stddev:14.97 (18.5%) stddev-sans-first:15.64 09:11:51 INFO - PROCESS | 1667 | Values: 79.0 57.0 61.0 83.0 48.0 72.0 89.0 89.0 83.0 57.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:70.00 stddev:14.33 (20.5%) stddev-sans-first:15.17 09:11:51 INFO - PROCESS | 1667 | Values: 82.0 69.0 100.0 70.0 74.0 67.0 97.0 70.0 68.0 102.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:98.00 Median:86.00 stddev:19.69 (22.9%) stddev-sans-first:20.61 09:11:51 INFO - PROCESS | 1667 | Values: 89.0 86.0 89.0 85.0 88.0 86.0 136.0 86.0 103.0 132.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:2.37 (2.5%) stddev-sans-first:2.51 09:11:51 INFO - PROCESS | 1667 | Values: 94.0 93.0 95.0 94.0 94.0 93.0 93.0 101.0 94.0 94.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.32 (1.5%) stddev-sans-first:1.36 09:11:51 INFO - PROCESS | 1667 | Values: 84.0 87.0 86.0 85.0 84.0 86.0 85.0 83.0 83.0 85.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:1.27 (2.4%) stddev-sans-first:1.33 09:11:51 INFO - PROCESS | 1667 | Values: 53.0 51.0 52.0 52.0 51.0 53.0 54.0 51.0 54.0 54.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:4.42 (6.3%) stddev-sans-first:4.06 09:11:51 INFO - PROCESS | 1667 | Values: 64.0 67.0 78.0 77.0 72.0 68.0 67.0 70.0 69.0 71.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:1.96 (2.3%) stddev-sans-first:1.83 09:11:51 INFO - PROCESS | 1667 | Values: 86.0 83.0 84.0 84.0 81.0 81.0 82.0 83.0 83.0 87.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:143.00 stddev:6.82 (4.8%) stddev-sans-first:7.19 09:11:51 INFO - PROCESS | 1667 | Values: 140.0 135.0 143.0 143.0 148.0 146.0 133.0 137.0 156.0 139.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.00 stddev:1.62 (1.0%) stddev-sans-first:1.72 09:11:51 INFO - PROCESS | 1667 | Values: 166.0 167.0 164.0 167.0 166.0 164.0 164.0 169.0 165.0 166.0 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:82.00 stddev:9.62 (11.7%) stddev-sans-first:9.70 09:11:51 INFO - PROCESS | 1667 | Values: 67.0 67.0 79.0 85.0 87.0 86.0 85.0 66.0 67.0 66.0 09:11:51 INFO - PROCESS | 1667 | -------- Summary: end -------- 09:11:51 INFO - PROCESS | 1667 | 09:11:51 INFO - TEST-INFO | 1667: exit 0 09:11:51 INFO - TEST-OK | kraken | took 58947ms 09:11:51 INFO - SUITE-END | took 1177s 09:11:52 INFO - Completed test suite (00:19:37) 09:11:52 INFO - javascript benchmark 09:11:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2853.32946757512, 3367.730581553476, 3373.460246360583, 3397.558317418735, 3431.7597768156224, 5629.746661400237, 5679.971600141998, 5742.79900203493, 5752.5110365618975, 5756.338021127572, 5768.971155144229, 5861.618994765337, 5895.557833162519, 5913.9112913306335, 5947.9107813382725, 5168.689878607295, 5238.738063096849, 5268.31511903452, 5315.0698627740185, 5391.838244852661, 5375.946240537603, 5379.9731001345135, 5381.650192737479, 5387.380451248117, 5405.567554595643, 5205.609579281569, 5242.18746094356, 5308.734563271821, 5332.760025798849, 5351.785928562853, 5265.815696450644, 5293.841184764463, 5296.92054619181, 5310.389305229909, 5310.389305229909, 5218.5380557649, 5259.921101183485, 5268.341457317835, 5290.127129023706, 5296.0, 5790.36306006339, 5791.131330300446, 5794.0, 5808.1578171165365, 5812.912806307909, 5000.399952005746, 6212.471939885115, 6241.313455519935, 6279.152314437538, 6301.8109456716375, 6229.595076320024, 6339.904901426482, 6341.207349081365, 6358.841028974266, 6366.0, 5269.104252277122, 5933.525317974551, 6005.309389420273, 6008.038713805814, 6010.308814486302, 5282.392524859613, 6226.25284965807, 6236.282827474808, 6255.56211065221, 6288.056791481223, 6222.657753823583, 6255.56211065221, 6268.216472940882, 6269.435750782452, 6275.592086514362, 6339.587926784744, 6339.809805705836, 6368.044793281045, 6370.8088757337355, 6372.0, 5218.6868787872845, 6096.878062438726, 6184.6598437086395, 6255.843603909939, 6324.588901721373, 6309.463695585835, 6324.367563243731, 6324.620522768557, 6331.145295385156, 6347.936520634735, 5045.873853153627, 5047.974760126176, 5054.646174767731, 5061.089003979319, 5102.515261050195, 3750.5499340079364, 4431.7340959542535, 4497.325401189848, 4498.190325741398, 4531.093781243764, 5783.421657834267, 5829.213056237439, 5832.941670583325, 5848.210491583667, 5867.237259156368, 6306.306306306303, 6315.0, 6327.588706734047, 6330.208723909512, 6339.11252424661, 5654.886902262014, 5718.485336319668, 5725.1698503716725, 5778.104393818965, 5832.096025116114, 5443.591730620219, 5503.257060296889, 5507.917381239285, 5509.090999985037, 5515.834524964177, 6264.59280146789, 6309.33751956038, 6309.33751956038, 6312.210973628296, 6325.620462772248, 6262.718177681924, 6305.369463053658, 6317.052442133717, 6339.175907132228, 6345.1434056401795, 6378.585391949508, 6388.520860935356, 6395.264544577247, 6402.199725034371, 6405.615663060231, 6143.56995010345, 6183.474404675473, 6199.070139478934, 6246.1255424239735, 6248.812535623939, 6118.0, 6263.561550691408, 6274.0, 6278.591891527036, 6293.874122517615, 6222.62664240147, 6239.376062393724, 6246.1255424239735, 6249.78125765596, 6271.31015588294, 5956.434138756811, 5989.221401217814, 6073.969630151998, 6143.846403839761, 6241.251049874044, 5246.029484545371, 5984.042553191469, 6038.486728628116, 6051.062085376773, 6052.788152414644, 6141.416565426277, 6146.477549408351, 6155.599886007395, 6162.137300777984, 6164.445199932027, 5859.5019423349495, 5879.441453061952, 5963.761449541969, 5988.8802223956145, 6002.009668404664], "value": 5742.705609718468, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.20166120916866, 476.44970059581186, 519.3793416866845, 533.9519443250107, 546.6200990311735, 31339.686603133963, 41850.95372615686, 42894.78552607232, 43010.35484467728, 45165.64503064905, 44124.77937610308, 44517.0, 44550.108997820025, 44577.0, 44593.77703111488, 9727.173190278834, 9869.851952220723, 9879.110880020797, 9882.654107106217, 9900.158486528653, 9605.327627066108, 9707.369021013612, 9717.90282097177, 9719.659811906584, 9728.270379721549, 9685.305071612474, 9721.659741909034, 9748.512574371289, 9771.755706107333, 9779.21766258701, 9694.369865958726, 9716.75708107296, 9751.0, 9752.609895604168, 9754.561044753003, 8341.791455213668, 9646.75883102921, 9723.173530249936, 9729.659461918869, 9735.075167859042, 41770.0, 42097.78951105256, 42117.789411053054, 42153.0, 42210.78894605507, 3508.6666766657127, 3518.437050071976, 3522.6125126236093, 3594.892153235407, 3677.724170687209, 32128.875489357994, 32421.351572968644, 33342.6665733342, 33619.0, 33726.494102588236, 3246.6593898433566, 3285.671432856719, 3309.4539400998806, 3313.7349012078976, 3429.639887811769, 498969.0, 504145.0, 505548.0, 505616.47191763803, 507588.9241107579, 34320.0, 61492.0, 61948.0, 61955.0, 62002.37997619966, 34368.82815585956, 35910.28179436397, 35911.4613280801, 35974.0, 36039.4594081089, 14685.632859178606, 14794.038387504994, 14837.480688175861, 14851.2574371281, 14854.405823767145, 12694.873051269555, 12772.489100435878, 12819.35903204836, 12823.0, 12833.294168820805, 7879.724209652634, 7892.842143157105, 7908.485948413335, 7985.441019128722, 7996.280334769898, 3247.8376081195847, 3260.494623333387, 3265.4122257993313, 3267.575215222006, 3305.504174373815, 974.2985050763439, 989.4261328429494, 996.0885789502669, 1032.4940779018227, 1063.441693111123, 25273.74726252714, 27897.860510697315, 31635.525467118012, 32146.517802232986, 33076.842310519016, 1005.3967619428284, 1117.6758739965483, 1122.7024838417826, 1173.8767429419959, 1195.2768575011992, 14226.715465690835, 16027.090284348342, 16045.876788624684, 16136.354545818036, 16453.341866325212, 687797.0, 696536.0, 696915.0, 698787.5060624664, 700247.9975200285, 59802.0, 60668.0, 60690.696546517865, 60784.696076519336, 60945.39054609397, 1232.2914324263584, 1345.6904911870324, 1353.810466534686, 1377.5522955039453, 1398.1121987537986, 31150.75396984186, 31884.202894927814, 31985.68014319827, 32799.0, 33014.66985330116, 52114.0, 52683.73658131685, 52849.88600455939, 52901.735491322295, 53067.0, 564519.0, 567979.0, 569138.0, 569838.0, 569945.0, 26511.867440662674, 27584.586231206147, 27663.723362766115, 27667.169984900484, 27701.8919243228, 49425.505744943526, 49849.750751246014, 49866.0, 51012.489875102256, 52854.47145528649, 25063.498730024934, 39959.2008159841, 41442.0, 41485.377719334836, 43771.12457750891, 40729.592704073766, 40905.38641920314, 41365.75902722923, 41955.58044419639, 42391.57608423876, 39611.405828912015, 40177.79911100426, 40303.59696402998, 40318.79840600778, 42071.73784786461, 31063.378732425677, 34938.65061349354, 34962.211614956046, 35074.473882892285, 35365.939021829385, 25769.355766105997, 25920.611190831776, 25954.35114122162, 26009.6098558518, 26226.40852253734], "value": 19178.46136608005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.81653540159135, 371.5133175540043, 374.6085340818844, 379.8461623042668, 398.53172522286326, 15458.92270538647, 16036.67926641468, 19946.501337466572, 20762.85804280764, 20859.478513037164, 19774.011299435042, 20370.796292037074, 20371.98140092993, 20381.898090509563, 21152.0, 5203.739813009353, 5868.911966320508, 6013.669248191348, 6109.327973922865, 6124.877502449948, 6020.698965051752, 6105.694715264219, 6114.0, 6117.632942023471, 6127.234095738033, 5679.772809087653, 5976.910346344808, 5981.401859814027, 6062.757489700407, 6069.3323734389405, 5999.950008748451, 6065.4844338231305, 6080.209572755558, 6085.78699745509, 6091.604045737035, 5641.548676105902, 5830.679312637803, 5838.766449342063, 5838.795642152504, 5846.298444186682, 12425.813612795815, 12654.620361389174, 12657.556985505555, 13027.934860325733, 13266.469341226339, 2050.98974505128, 2138.272987184365, 2233.932982010542, 2245.9213927512624, 2894.6526416829906, 9849.409035457824, 10155.492225388702, 10308.53611587473, 12395.822396872283, 14792.926035369863, 1446.349142885695, 1859.395696398676, 1877.676238252029, 1909.5035290824346, 1913.435536516717, 113086.0, 119342.0, 121694.0, 122746.38626806809, 126189.0, 11050.613228536962, 11329.830052549218, 11555.075593952464, 11572.94213528927, 11730.413479326, 14568.198749068903, 14586.051906626035, 14592.927035364755, 14626.63433414152, 14640.341184646717, 6731.663416829139, 8318.70884519039, 8377.287930525852, 8439.66241350339, 8550.273226775793, 8217.8356432871, 8258.710945117013, 8276.751697449086, 8412.990441147102, 8446.366522510836, 4419.359192917073, 4515.0518391137575, 4548.408706868086, 4575.267957126844, 4622.791974361162, 1732.5841797968649, 1819.6178802451368, 1881.2286962345372, 1918.4915997260457, 1950.2101648832245, 651.794684674326, 724.5399171526119, 763.3778470546487, 950.1923365139714, 959.3284700709531, 20247.696284555743, 21774.061808515216, 21804.541124166553, 21864.344069677936, 21865.234716785155, 910.7859652981545, 938.9530523473799, 957.4255446731905, 994.5077186792583, 1011.4841430870309, 10459.424731639681, 11125.833112503318, 11241.381724005258, 11427.771444571228, 11437.370944598128, 592661.0, 596081.0, 597101.0, 600713.0, 603404.0, 117194.0, 119410.0, 121341.39329303474, 128427.0, 128472.71527284608, 975.2636759246865, 1020.1481762728205, 1055.6938487838595, 1057.413135709673, 1058.317385286486, 18598.0, 18915.71626425577, 18954.0, 19093.045347732837, 19209.936449456556, 54625.1806222899, 54889.0, 55021.0, 55290.0, 56754.58113547029, 77883.83174252504, 79992.60003699944, 80127.59936200282, 80428.0, 80797.0, 7853.685852566062, 8060.193980601893, 8209.79475513117, 8264.380171487042, 8285.627146778288, 12295.016398688262, 12804.487820487077, 13083.345832708135, 13225.603231903058, 13427.992900532694, 11048.06091482233, 11056.0, 11265.26775759573, 11385.886141138482, 11402.714932126763, 10612.151027917902, 11063.889361106609, 11101.833472498081, 11213.66359009231, 11403.942980285046, 8064.6370913307865, 11012.284201526874, 11177.608783692533, 11184.049355804847, 11286.322820630789, 6973.825654358681, 7886.960565197137, 8184.54984975832, 8197.549134797644, 8391.496510209407, 8339.749807505785, 10987.505562249558, 11284.153688473561, 11298.49156787963, 11300.378479183395], "value": 9392.435997290166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.6183454136462, 1567.255553612034, 1766.4877185616172, 1854.6290741851617, 1925.4223732880141, 6925.688344024518, 8276.379271554635, 8833.867491987608, 8836.381453298272, 9070.773230669236, 6863.931360686392, 7736.071671399426, 8336.04135524415, 8548.187922147401, 8623.568821558929, 2339.6490526421044, 2378.3816207786012, 2378.52429514097, 2380.452495925938, 2383.892724827378, 2339.368370539953, 2348.729896061958, 2378.8096952243864, 2379.7620237976153, 2382.154335211001, 2336.8247381446376, 2345.85924844509, 2351.729551101628, 2361.161787565415, 2366.065404165354, 2321.5356928614347, 2334.533093381322, 2338.3920180752957, 2339.532093581282, 2357.57563638545, 2327.325075728037, 2327.44141406063, 2331.184085570054, 2331.2306938710185, 2331.75516570761, 8543.017552981424, 8666.6100025499, 8723.99674037481, 8804.295656347476, 8807.911920880773, 5103.183490641517, 5278.47215278473, 5283.894322113536, 5285.048691235576, 5301.1783173608155, 3579.4093974494176, 3602.0454579536445, 3652.9269414611827, 3664.120611053355, 3670.06413364593, 1079.7300674831292, 1085.8914108589156, 1088.6570730219955, 1108.22978030269, 1113.4377139544558, 11533.308001519936, 11627.534898604046, 11628.767424651543, 11652.883471165349, 11664.416779161009, 4082.632563069338, 4445.777111444278, 4547.909041819211, 4710.105080034782, 4755.38180036593, 9853.901460985442, 9858.40849549015, 9861.0, 9863.16163126128, 9886.80226395468, 5276.07668657991, 5281.445448227958, 5285.365756109291, 5288.576913846883, 5293.7353132344, 4353.956460435418, 4518.028623845889, 4674.228752255908, 4803.135435621622, 4823.710577365369, 3859.729818912649, 3893.922121557553, 3991.600839915985, 4007.6393124618926, 4026.7382620129597, 1273.8471383434048, 1275.4005617359826, 1283.1851774123313, 1284.3000564692265, 1298.0589072922055, 750.2572453271331, 856.1866227084295, 904.8461761500561, 907.2923119966437, 946.8968651521038, 5423.810166644227, 5656.0, 5736.13957906309, 5923.644581325134, 5951.940480595225, 819.9303059240032, 921.1663444582664, 940.6331530703031, 945.579217248318, 977.3451787302524, 3176.8093914365213, 3927.9410808837893, 3992.6207010333974, 4008.398740188995, 4081.77550234734, 10201.489925503694, 10624.681259562225, 10635.0, 10749.89250107489, 10764.085052770602, 10710.839337409945, 10714.839277410845, 10738.946305268424, 10742.462876856125, 10752.677419677422, 8019.799505012421, 8219.260266575917, 8223.876641850376, 8227.99999999988, 8235.1353107924, 5734.283214598176, 5848.707564621837, 6069.332373439007, 6125.448709616156, 6135.84660383494, 9438.669646562337, 9828.31201815866, 9846.261530385107, 9863.852042219516, 9864.408135511892, 10257.435841028517, 10266.845997310196, 10278.588856445958, 10282.897171028193, 10283.228757843042, 5977.312609049841, 7240.420766338575, 7396.14944281393, 7582.393408527194, 7766.766996990099, 8201.26188643025, 8488.363372746946, 8488.61801218959, 8507.276881465144, 8528.91471085306, 7370.22612625688, 7462.216467270859, 7476.813079673052, 7552.093748749965, 7618.961905190438, 7265.564066156047, 7315.049043624294, 7316.707331706672, 7505.211952744883, 7507.88738168917, 6915.481338899502, 7064.576125432491, 7067.858642827217, 7070.787876363717, 7073.115860517435, 4954.380702412199, 4993.450720420823, 5032.949670503394, 5040.168372218543, 5106.10643137442, 4887.242477416006, 4958.380202474691, 5049.924251136309, 5068.771905264346, 5176.094183517945], "value": 4571.840513230626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.8275258973502, 295.1102426185052, 307.7753240134701, 312.70137019146716, 314.51564590530586, 5362.418086664434, 5436.972815135924, 5439.292891924054, 5463.644863083897, 5468.004178474853, 4689.882752931178, 4761.90476190476, 4941.922913596289, 5180.611454140936, 5336.38631557371, 3298.47224444089, 3970.900727481822, 3995.4206640037105, 4019.216252830699, 4027.6173763492566, 3714.702823774105, 3986.9202615947665, 3995.480587523618, 4017.1965606878593, 4021.8190181441905, 3886.8533782534078, 3970.2456533258733, 4003.719739618228, 4028.7237710693366, 4052.49343832021, 3620.6784523648944, 3998.5001874765653, 4003.919921601552, 4016.3573828187496, 4062.796860156995, 2934.413117376533, 3500.7724497907557, 3517.296540691872, 3527.5836052304, 3528.1179705073732, 4283.614474697292, 5087.923681144785, 5131.151636272795, 5161.948380516184, 5167.276581278624, 4296.269634162169, 4596.609288210473, 4647.9535204647855, 4664.930026049612, 4667.276572131325, 4931.679440836334, 5655.943440565583, 5665.943340566624, 5688.260526131618, 5713.971430142864, 3316.8507417166284, 3451.2579795343872, 3549.219171782204, 3779.508663873706, 3829.48301979232, 4843.903121937541, 5553.444655534455, 5636.857993962309, 5905.881882362329, 5921.897726307142, 2946.5138252188576, 3707.610700876423, 3802.954187598433, 3835.7314987951136, 3854.2291541691775, 3396.8790299201205, 3864.806759662006, 3916.315984126853, 3924.5486769021927, 3925.980370098131, 4279.443672322641, 4568.817247310137, 4577.176108300538, 4622.722636641813, 4634.679116451795, 4908.435529914105, 5360.490753378423, 5509.889802203934, 5684.573656975661, 5754.338251101177, 1189.238887112249, 1201.3212534917743, 1271.790154624495, 1348.5077946549634, 1352.2968056610705, 695.6695569604398, 841.8526757817358, 877.4603618774407, 896.1173244354305, 903.701778413122, 4352.194843953878, 5164.457731938168, 5169.612279079084, 5187.792488300426, 5293.973530132402, 5705.5150312223095, 5743.9425605744245, 5746.913796293059, 5767.826965191051, 5804.390538993345, 4845.982343707861, 5142.331496905454, 5152.793888244429, 5159.664621799571, 5177.058603023866, 2980.552917062458, 2997.310618557744, 3002.8198308101582, 3007.9849600751854, 3013.367192889518, 5571.247881536022, 5873.6490607160595, 5908.675022873697, 5934.584579079509, 5935.73289201987, 5087.542121209109, 6018.247719035121, 6019.939800601938, 6031.336552979169, 6047.2743270806905, 5460.754266058037, 5516.841463292753, 6049.879002419927, 6066.545009124245, 6081.422264884741, 5566.7971127063165, 5773.740181691918, 5789.305283366023, 5856.385079566584, 5862.801449456454, 5018.4981501849525, 5778.913316300175, 5781.248437703071, 5801.82594522165, 5809.2738407699035, 5038.967011762653, 5336.6797992119045, 5748.626339287933, 6069.602507009795, 6112.266528016667, 3265.8530366134055, 3504.7371447142077, 3870.0, 3870.458135861038, 3899.415087736862, 5811.360750317377, 5834.358220595646, 5847.970760146172, 5851.590388672752, 5859.707014649336, 5205.843824685266, 5668.894565559676, 5680.989075789838, 5735.713214339183, 5755.913661295001, 5110.61670374716, 5290.285811415563, 5627.380988091225, 5684.0, 5702.771889124555, 4871.48849370811, 5310.867228319323, 5458.372287187024, 5558.833235002957, 5590.385057643574, 4595.9310610341545, 5640.548756099584, 5652.265205523256, 5661.575381846295, 5678.716064196857, 5523.254360661259, 5538.723063846872, 5546.306711661043, 5547.528460080938, 5569.331680198402], "value": 4092.8240638826323, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.6694120704476, 727.9752627831359, 742.8997085393473, 819.8032472206672, 828.892244008279, 12467.0, 16455.424060157897, 16488.0, 16493.25780339886, 16578.58553536162, 14847.406103755864, 14977.326020329085, 15009.774853377208, 15021.248937553133, 15026.17356045417, 670.4602794750224, 698.1482591238681, 828.1015098618007, 842.9325653947685, 859.6045818923303, 840.0255703384075, 861.5821326656567, 864.1401805203831, 864.4942708515526, 865.7272959017889, 905.9762468410687, 908.591133989704, 908.9181973622373, 910.6630546697731, 911.2391153386897, 707.331571664777, 879.8064425826308, 902.5351943748974, 902.7697937026049, 904.4573256046385, 669.7388018672722, 671.0873212431089, 671.5030877150922, 672.1933679584519, 673.3064943108606, 14701.55895323142, 14735.926320368437, 14744.262786860614, 14753.926230368887, 14761.630959225999, 13695.31523423825, 13869.653258668613, 13946.0, 14108.647283817883, 14174.787378189336, 12788.680282992907, 12859.292738899358, 12953.87046129536, 13031.152975056591, 13444.260565668885, 4589.288660257632, 4641.907161856778, 4654.162250794856, 4680.4149481314835, 4815.6388270879825, 116952.41523792411, 120405.79594204121, 121034.13278136893, 122696.38651806772, 124226.0, 10832.78334433307, 10966.835497467544, 11047.005769480786, 11166.665000050012, 11534.711632209093, 17874.731879021823, 21545.922703864744, 21600.891995540234, 21613.67579486309, 21633.134674613153, 7300.780976570712, 7640.847183056308, 7847.607619618996, 7970.123286438487, 8173.427860049858, 4350.564943505624, 4427.335899615084, 4441.844535441309, 4611.239145541015, 4697.976510117427, 3419.1623052352334, 3565.180008598037, 3568.3398571264397, 3569.714422846218, 3569.8572057117944, 646.6831252686244, 668.4719071933118, 671.392389887153, 672.5460314287836, 674.2044387622554, 531.6677076826983, 551.302602208207, 557.2699763310077, 589.2016317889198, 628.4061561824033, 7861.724839630586, 8563.272121869586, 8699.608517616722, 9271.211946984447, 9525.666406703067, 543.760745272079, 587.9764809407576, 609.9573029887865, 694.2086021934998, 710.296806161896, 4603.240465323252, 4695.483496815347, 4757.458980572898, 4763.571278584944, 4779.801866304364, 96982.0, 131297.0, 134384.0, 139216.0, 141695.0, 73640.89538656925, 105846.47076764567, 114569.0, 114655.2801707975, 119511.40244298722, 101658.99999999852, 101938.0, 105002.94997050085, 105724.0, 105908.0, 8817.823643526965, 9069.77325566866, 9089.863652045093, 9147.201091965126, 9221.262299016196, 56953.71523142358, 57203.6940998129, 59124.0, 59775.0, 59840.40159598348, 86747.13252867643, 90369.0, 92277.0, 92431.0, 94226.52886735796, 11952.81494924498, 12056.397180141134, 12390.194637348544, 12405.44175512086, 12538.749225015632, 12988.480460781462, 13503.12229705066, 13593.980451465983, 13997.370118344495, 14065.0, 11784.414992218304, 12049.397530123284, 12061.216020958609, 12086.0, 12740.362981851056, 12287.447064881922, 12411.875881241072, 12437.502499899903, 12597.307148106942, 12688.345728682805, 12176.939115304367, 12228.08289378318, 12244.877551224374, 12533.060020498317, 12701.36493175319, 10333.328333658288, 10690.83963740529, 10797.190210734068, 10816.4050977197, 11008.724781880517, 9427.245820334494, 10079.294449388472, 10776.29954052984, 10898.073663738354, 10991.340519568852], "value": 7656.647164673144, "unit": "score"}], "name": "dromaeo_css", "value": 7274.741714189626, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 114.0, 112.0, 114.0, 113.0, 114.0, 115.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 108.0, 167.0, 108.0, 106.0, 130.0, 107.0, 140.0, 98.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 182.0, 184.0, 182.0, 184.0, 183.0, 183.0, 181.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 61.0, 83.0, 48.0, 72.0, 89.0, 89.0, 83.0, 57.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 100.0, 70.0, 74.0, 67.0, 97.0, 70.0, 68.0, 102.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 88.0, 86.0, 136.0, 86.0, 103.0, 132.0], "value": 98.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 94.0, 94.0, 93.0, 93.0, 101.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 86.0, 85.0, 84.0, 86.0, 85.0, 83.0, 83.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 52.0, 51.0, 53.0, 54.0, 51.0, 54.0, 54.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 78.0, 77.0, 72.0, 68.0, 67.0, 70.0, 69.0, 71.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 84.0, 81.0, 81.0, 82.0, 83.0, 83.0, 87.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 143.0, 143.0, 148.0, 146.0, 133.0, 137.0, 156.0, 139.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 164.0, 167.0, 166.0, 164.0, 164.0, 169.0, 165.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 79.0, 85.0, 87.0, 86.0, 85.0, 66.0, 67.0, 66.0], "value": 75.5, "unit": "score"}], "name": "kraken", "value": 1436.1999999999998, "alertThreshold": 2.0}]} 09:11:52 INFO - Return code: 0 09:11:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:11:52 INFO - # TBPL SUCCESS # 09:11:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:11:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:11:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:11:52 INFO - 2016-08-09 09:11:52.350 screenresolution[1671:9552] starting screenresolution argv=screenresolution get 09:11:52 INFO - 2016-08-09 09:11:52.352 screenresolution[1671:9552] Display 0: 1600x1200x32@60 09:11:52 INFO - 2016-08-09 09:11:52.358 screenresolution[1672:9555] starting screenresolution argv=screenresolution list 09:11:52 INFO - Available Modes on Display 0 09:11:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:11:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:11:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:11:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:11:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:11:52 INFO - Intel Iris: 09:11:52 INFO - Chipset Model: Intel Iris 09:11:52 INFO - Type: GPU 09:11:52 INFO - Bus: Built-In 09:11:52 INFO - VRAM (Dynamic, Max): 1536 MB 09:11:52 INFO - Vendor: Intel (0x8086) 09:11:52 INFO - Device ID: 0x0a2e 09:11:52 INFO - Revision ID: 0x0009 09:11:52 INFO - Displays: 09:11:52 INFO - Display: 09:11:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:11:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:11:52 INFO - Display Serial Number: 1600x1200 60 09:11:52 INFO - Main Display: Yes 09:11:52 INFO - Mirror: Off 09:11:52 INFO - Online: Yes 09:11:52 INFO - Rotation: Supported 09:11:52 INFO - Return code: 0 09:11:52 INFO - Running post-action listener: _resource_record_post_action 09:11:52 INFO - [mozharness: 2016-08-09 16:11:52.595457Z] Finished run-tests step (success) 09:11:52 INFO - Running post-run listener: _resource_record_post_run 09:11:52 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 37139456; Write bytes: 701094400; Read time: 251; Write time: 1958 09:11:52 INFO - TinderboxPrint: CPU usage
53.5% 09:11:52 INFO - TinderboxPrint: I/O read bytes / time
37,139,456 / 251 09:11:52 INFO - TinderboxPrint: I/O write bytes / time
701,094,400 / 1,958 09:11:52 INFO - TinderboxPrint: CPU idle
2,257.2 (46.5%) 09:11:52 INFO - TinderboxPrint: CPU system
969.0 (20.0%) 09:11:52 INFO - TinderboxPrint: CPU user
1,623.5 (33.5%) 09:11:52 INFO - TinderboxPrint: Swap in / out
440,360,960 / 0 09:11:52 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403255808; Write bytes: 399183360; Read time: 29811; Write time: 866 09:11:52 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34493440; Write bytes: 292097024; Read time: 228; Write time: 1060 09:11:53 INFO - Running post-run listener: _upload_blobber_files 09:11:53 INFO - Blob upload gear active. 09:11:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11: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 09:11: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'] 09:11: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 09:11:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:54 INFO - (blobuploader) - INFO - Done attempting. 09:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:55 INFO - (blobuploader) - INFO - Done attempting. 09:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:58 INFO - (blobuploader) - INFO - Done attempting. 09:11:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:58 INFO - Return code: 0 09:11:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdbed16fe67c1ad48f1c78641847bd833069dc214eea1e2144841b3afbb5a972ee5cddd8df429dbcbd8d5a03ee8c80b503d18f89e65c3541ef1a0c2781817898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4e539296443c633c318e18f042e47d319aa24797aa64a12798c3b9adcf5a9eaa63a1e312b84fa720e4d33e8411b91e535eacd7c55a9331cd71ec93da887d9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8a27b4bd7a249c35bad74887be0003aa4e68e38f3466a3ceeb234b8463c7b0101b38a4895c5be7ac4879ab2e1b4e9ac6e24ce94ef4c8a9b7c029931145f90d"} 09:11:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:58 INFO - Contents: 09:11:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdbed16fe67c1ad48f1c78641847bd833069dc214eea1e2144841b3afbb5a972ee5cddd8df429dbcbd8d5a03ee8c80b503d18f89e65c3541ef1a0c2781817898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4e539296443c633c318e18f042e47d319aa24797aa64a12798c3b9adcf5a9eaa63a1e312b84fa720e4d33e8411b91e535eacd7c55a9331cd71ec93da887d9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8a27b4bd7a249c35bad74887be0003aa4e68e38f3466a3ceeb234b8463c7b0101b38a4895c5be7ac4879ab2e1b4e9ac6e24ce94ef4c8a9b7c029931145f90d"} 09:11:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:58 INFO - Copying logs to upload dir... 09:11:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.032824 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-09 09:11:58.336655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 09:11:58.340123) ========= 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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdbed16fe67c1ad48f1c78641847bd833069dc214eea1e2144841b3afbb5a972ee5cddd8df429dbcbd8d5a03ee8c80b503d18f89e65c3541ef1a0c2781817898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4e539296443c633c318e18f042e47d319aa24797aa64a12798c3b9adcf5a9eaa63a1e312b84fa720e4d33e8411b91e535eacd7c55a9331cd71ec93da887d9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8a27b4bd7a249c35bad74887be0003aa4e68e38f3466a3ceeb234b8463c7b0101b38a4895c5be7ac4879ab2e1b4e9ac6e24ce94ef4c8a9b7c029931145f90d"} build_url:https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/PW1bgKdlTYmwig-HuUkgBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdbed16fe67c1ad48f1c78641847bd833069dc214eea1e2144841b3afbb5a972ee5cddd8df429dbcbd8d5a03ee8c80b503d18f89e65c3541ef1a0c2781817898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4e539296443c633c318e18f042e47d319aa24797aa64a12798c3b9adcf5a9eaa63a1e312b84fa720e4d33e8411b91e535eacd7c55a9331cd71ec93da887d9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8a27b4bd7a249c35bad74887be0003aa4e68e38f3466a3ceeb234b8463c7b0101b38a4895c5be7ac4879ab2e1b4e9ac6e24ce94ef4c8a9b7c029931145f90d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 09:11:58.373456) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:11:58.374006) ========= 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.Fmu2VB7gJG/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.h3UUiWqGwD/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.005373 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:11:58.423647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 09:11:58.423961) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 09:11:58.424295) ========= ========= Total master_lag: 0.17 =========