builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0200 starttime: 1464430191.36 results: success (0) buildid: 20160525183450 builduid: 63f91898e679451db7d589c242ad058b revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:51.356229) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:51.356598) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:51.356867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:51.435250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:51.435575) ========= 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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners TMPDIR=/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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-05-28 03:09:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 97.3M=0s 2016-05-28 03:09:51 (97.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:51.625218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:51.625521) ========= 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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners TMPDIR=/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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.027728 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:51.675781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-28 03:09:51.676154) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33693d8bdec17f07fc460ca7cc908ade88f97b86 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33693d8bdec17f07fc460ca7cc908ade88f97b86 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GpwuDFOjLx/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.vgyGn8Hivv/Listeners TMPDIR=/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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-05-28 03:09:51,686 truncating revision to first 12 chars 2016-05-28 03:09:51,686 Setting DEBUG logging. 2016-05-28 03:09:51,686 attempt 1/10 2016-05-28 03:09:51,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33693d8bdec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:09:53,494 unpacking tar archive at: mozilla-aurora-33693d8bdec1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.100048 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-28 03:09:53.795510) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:53.795779) ========= script_repo_revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:53.796158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:53.796438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:09:53.812434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-28 03:09:53.812696) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GpwuDFOjLx/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.vgyGn8Hivv/Listeners TMPDIR=/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:09:53 INFO - MultiFileLogger online at 20160528 03:09:53 in /builds/slave/test 03:09:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:09:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:53 INFO - {'append_to_log': False, 03:09:53 INFO - 'base_work_dir': '/builds/slave/test', 03:09:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:09:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:53 INFO - 'branch': 'Mozilla-Aurora', 03:09:53 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:53 INFO - 'config_files': ('talos/mac_config.py',), 03:09:53 INFO - 'default_actions': ('clobber', 03:09:53 INFO - 'read-buildbot-config', 03:09:53 INFO - 'download-and-extract', 03:09:53 INFO - 'populate-webroot', 03:09:53 INFO - 'create-virtualenv', 03:09:53 INFO - 'install', 03:09:53 INFO - 'run-tests'), 03:09:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:53 INFO - 'download_minidump_stackwalk': True, 03:09:53 INFO - 'download_symbols': 'ondemand', 03:09:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:09:53 INFO - 'tooltool.py': '/tools/tooltool.py', 03:09:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:09:53 INFO - '/tools/misc-python/virtualenv.py')}, 03:09:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:53 INFO - 'installer_path': 'installer.exe', 03:09:53 INFO - 'log_level': 'info', 03:09:53 INFO - 'log_name': 'talos', 03:09:53 INFO - 'log_to_console': True, 03:09:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:09:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:09:53 INFO - 'opt_config_files': (), 03:09:53 INFO - 'pip_index': False, 03:09:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:09:53 INFO - 'cmd': ('bash', 03:09:53 INFO - '-c', 03:09:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:09:53 INFO - 'enabled': True, 03:09:53 INFO - 'halt_on_failure': False, 03:09:53 INFO - 'name': 'check_screen_resolution'},), 03:09:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:09:53 INFO - 'cmd': ('bash', 03:09:53 INFO - '-c', 03:09:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:09:53 INFO - 'enabled': True, 03:09:53 INFO - 'halt_on_failure': False, 03:09:53 INFO - 'name': 'check_screen_resolution'},), 03:09:53 INFO - 'run_cmd_checks_enabled': True, 03:09:53 INFO - 'sps_profile': False, 03:09:53 INFO - 'sps_profile_interval': 0, 03:09:53 INFO - 'suite': 'dromaeojs-e10s', 03:09:53 INFO - 'system_bits': '32', 03:09:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:53 INFO - 'title': 't-yosemite-r7-0200', 03:09:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:53 INFO - 'use_talos_json': True, 03:09:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:53 INFO - 'work_dir': 'build'} 03:09:53 INFO - ##### 03:09:53 INFO - ##### Running clobber step. 03:09:53 INFO - ##### 03:09:53 INFO - Running pre-action listener: _resource_record_pre_action 03:09:53 INFO - Running main action method: clobber 03:09:53 INFO - rmtree: /builds/slave/test/build 03:09:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:55 INFO - Running post-action listener: _resource_record_post_action 03:09:55 INFO - ##### 03:09:55 INFO - ##### Running read-buildbot-config step. 03:09:55 INFO - ##### 03:09:55 INFO - Running pre-action listener: _resource_record_pre_action 03:09:55 INFO - Running main action method: read_buildbot_config 03:09:55 INFO - Using buildbot properties: 03:09:55 INFO - { 03:09:55 INFO - "project": "", 03:09:55 INFO - "product": "firefox", 03:09:55 INFO - "script_repo_revision": "production", 03:09:55 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:09:55 INFO - "repository": "", 03:09:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:09:55 INFO - "buildid": "20160525183450", 03:09:55 INFO - "pgo_build": "False", 03:09:55 INFO - "basedir": "/builds/slave/test", 03:09:55 INFO - "buildnumber": 300, 03:09:55 INFO - "slavename": "t-yosemite-r7-0200", 03:09:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:09:55 INFO - "platform": "yosemite_r7", 03:09:55 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:09:55 INFO - "branch": "mozilla-aurora", 03:09:55 INFO - "repo_path": "releases/mozilla-aurora", 03:09:55 INFO - "revision": "33693d8bdec17f07fc460ca7cc908ade88f97b86", 03:09:55 INFO - "stage_platform": "macosx64", 03:09:55 INFO - "builduid": "63f91898e679451db7d589c242ad058b", 03:09:55 INFO - "slavebuilddir": "test" 03:09:55 INFO - } 03:09:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 03:09:55 INFO - Running post-action listener: _resource_record_post_action 03:09:55 INFO - ##### 03:09:55 INFO - ##### Running download-and-extract step. 03:09:55 INFO - ##### 03:09:55 INFO - Running pre-action listener: _resource_record_pre_action 03:09:55 INFO - Running main action method: download_and_extract 03:09:55 INFO - mkdir: /builds/slave/test/build/tests 03:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:55 INFO - https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:09:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:09:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:09:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 03:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 03:10:02 INFO - Downloaded 1199 bytes. 03:10:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 03:10:02 INFO - Using the following test package requirements: 03:10:02 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:10:02 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:10:02 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 03:10:02 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:10:02 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 03:10:02 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:10:02 INFO - u'jsshell-mac.zip'], 03:10:02 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:10:02 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 03:10:02 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:10:02 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:10:02 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 03:10:02 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:10:02 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 03:10:02 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:10:02 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 03:10:02 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:10:02 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 03:10:02 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:02 INFO - https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:10:04 INFO - Downloaded 18425354 bytes. 03:10:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:10:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:10:07 INFO - Return code: 0 03:10:07 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:07 INFO - https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:10:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:10:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:10:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:10:08 INFO - Downloaded 18425354 bytes. 03:10:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:10:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:10:12 INFO - Return code: 0 03:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:12 INFO - https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:10:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:10:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:10:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:10:13 INFO - Downloaded 10840145 bytes. 03:10:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:10:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:10:13 INFO - Return code: 0 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:13 INFO - https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 03:10:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:10:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:10:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 03:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 03:10:16 INFO - Downloaded 114134973 bytes. 03:10:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:10:16 INFO - mkdir: /builds/slave/test/properties 03:10:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:10:16 INFO - Writing to file /builds/slave/test/properties/build_url 03:10:16 INFO - Contents: 03:10:16 INFO - build_url:https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:10:17 INFO - Running post-action listener: _resource_record_post_action 03:10:17 INFO - Running post-action listener: set_extra_try_arguments 03:10:17 INFO - ##### 03:10:17 INFO - ##### Running populate-webroot step. 03:10:17 INFO - ##### 03:10:17 INFO - Running pre-action listener: _resource_record_pre_action 03:10:17 INFO - Running main action method: populate_webroot 03:10:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:10:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:10:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:10:17 INFO - '--tppagecycles', 03:10:17 INFO - '7'], 03:10:17 INFO - 'tests': ['tsvgm']}}, 03:10:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:10:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:10:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:10:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:10:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:17 INFO - 'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:17 INFO - 'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['damp', 'tps']}, 03:10:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:17 INFO - 'tests': ['damp', 'tps']}, 03:10:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['dromaeo_dom']}, 03:10:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:10:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['a11yr', 03:10:17 INFO - 'ts_paint', 03:10:17 INFO - 'tpaint', 03:10:17 INFO - 'sessionrestore', 03:10:17 INFO - 'sessionrestore_no_auto_restore', 03:10:17 INFO - 'tabpaint']}, 03:10:17 INFO - 'other-e10s': {'tests': ['a11yr', 03:10:17 INFO - 'ts_paint', 03:10:17 INFO - 'tpaint', 03:10:17 INFO - 'sessionrestore', 03:10:17 INFO - 'sessionrestore_no_auto_restore', 03:10:17 INFO - 'tabpaint']}, 03:10:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:10:17 INFO - 'ts_paint', 03:10:17 INFO - 'tpaint', 03:10:17 INFO - 'sessionrestore', 03:10:17 INFO - 'sessionrestore_no_auto_restore', 03:10:17 INFO - 'tabpaint']}, 03:10:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:10:17 INFO - 'ts_paint', 03:10:17 INFO - 'tpaint', 03:10:17 INFO - 'sessionrestore', 03:10:17 INFO - 'sessionrestore_no_auto_restore', 03:10:17 INFO - 'tabpaint']}, 03:10:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['a11yr', 03:10:17 INFO - 'ts_paint', 03:10:17 INFO - 'tpaint', 03:10:17 INFO - 'sessionrestore', 03:10:17 INFO - 'sessionrestore_no_auto_restore', 03:10:17 INFO - 'tabpaint']}, 03:10:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['a11yr', 03:10:17 INFO - 'ts_paint', 03:10:17 INFO - 'tpaint', 03:10:17 INFO - 'sessionrestore', 03:10:17 INFO - 'sessionrestore_no_auto_restore', 03:10:17 INFO - 'tabpaint']}, 03:10:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['tsvgx', 03:10:17 INFO - 'tsvgr_opacity', 03:10:17 INFO - 'tart', 03:10:17 INFO - 'tscrollx', 03:10:17 INFO - 'cart']}, 03:10:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:10:17 INFO - 'tsvgr_opacity', 03:10:17 INFO - 'tart', 03:10:17 INFO - 'tscrollx', 03:10:17 INFO - 'cart']}, 03:10:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:17 INFO - 'talos_options': ['--disable-e10s'], 03:10:17 INFO - 'tests': ['tp5o']}, 03:10:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:17 INFO - 'tests': ['tp5o']}, 03:10:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:17 INFO - 'talos_options': ['--disable-e10s', 03:10:17 INFO - '--xperf_path', 03:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:17 INFO - 'tests': ['tp5n']}, 03:10:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:17 INFO - 'talos_options': ['--xperf_path', 03:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:17 INFO - 'tests': ['tp5n']}}, 03:10:17 INFO - 'talos.zip': {'path': '', 03:10:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:10:17 INFO - Running post-action listener: _resource_record_post_action 03:10:17 INFO - ##### 03:10:17 INFO - ##### Running create-virtualenv step. 03:10:17 INFO - ##### 03:10:17 INFO - Running pre-action listener: _resource_record_pre_action 03:10:17 INFO - Running main action method: create_virtualenv 03:10:17 INFO - Creating virtualenv /builds/slave/test/build/venv 03:10:17 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 03:10:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:10:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:10:17 INFO - Using real prefix '/tools/python27' 03:10:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:10:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:10:21 INFO - Installing pip.................done. 03:10:21 INFO - Return code: 0 03:10:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104927a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104937420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd855c680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, '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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:10: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', 'pip>=1.5'] in /builds/slave/test/build 03:10: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 pip>=1.5 03:10:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:10:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:21 INFO - 'HOME': '/Users/cltbld', 03:10:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:21 INFO - 'LOGNAME': 'cltbld', 03:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:21 INFO - 'MOZ_NO_REMOTE': '1', 03:10:21 INFO - 'NO_EM_RESTART': '1', 03:10:21 INFO - 'PAGER': '/bin/cat', 03:10:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:21 INFO - 'PWD': '/builds/slave/test', 03:10:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:21 INFO - 'SHELL': '/bin/bash', 03:10:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:10:21 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:10:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:21 INFO - 'USER': 'cltbld', 03:10:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:21 INFO - 'XPC_FLAGS': '0x0', 03:10:21 INFO - 'XPC_SERVICE_NAME': '0', 03:10:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:21 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 03:10:21 INFO - Cleaning up... 03:10:21 INFO - Return code: 0 03:10:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104927a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104937420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd855c680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, '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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:10: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:10: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 psutil>=0.7.1 03:10:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:10:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:21 INFO - 'HOME': '/Users/cltbld', 03:10:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:21 INFO - 'LOGNAME': 'cltbld', 03:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:21 INFO - 'MOZ_NO_REMOTE': '1', 03:10:21 INFO - 'NO_EM_RESTART': '1', 03:10:21 INFO - 'PAGER': '/bin/cat', 03:10:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:21 INFO - 'PWD': '/builds/slave/test', 03:10:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:21 INFO - 'SHELL': '/bin/bash', 03:10:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:10:21 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:10:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:21 INFO - 'USER': 'cltbld', 03:10:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:21 INFO - 'XPC_FLAGS': '0x0', 03:10:21 INFO - 'XPC_SERVICE_NAME': '0', 03:10:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:21 INFO - Downloading/unpacking psutil>=0.7.1 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:25 INFO - Installing collected packages: psutil 03:10:25 INFO - Running setup.py install for psutil 03:10:25 INFO - building 'psutil._psutil_osx' extension 03:10:25 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 03:10:26 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 03:10:26 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 03:10:26 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 03:10:26 INFO - building 'psutil._psutil_posix' extension 03:10:26 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 03:10:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:10:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:10:26 INFO - ^ 03:10:26 INFO - 1 warning generated. 03:10:26 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 03:10:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:26 INFO - Successfully installed psutil 03:10:26 INFO - Cleaning up... 03:10:26 INFO - Return code: 0 03:10:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104927a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104937420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd855c680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, '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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:26 INFO - 'HOME': '/Users/cltbld', 03:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:26 INFO - 'LOGNAME': 'cltbld', 03:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:26 INFO - 'MOZ_NO_REMOTE': '1', 03:10:26 INFO - 'NO_EM_RESTART': '1', 03:10:26 INFO - 'PAGER': '/bin/cat', 03:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:26 INFO - 'PWD': '/builds/slave/test', 03:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:26 INFO - 'SHELL': '/bin/bash', 03:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:10:26 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:26 INFO - 'USER': 'cltbld', 03:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:26 INFO - 'XPC_FLAGS': '0x0', 03:10:26 INFO - 'XPC_SERVICE_NAME': '0', 03:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:10:26 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 03:10:26 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 03:10:26 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 03:10:26 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 03:10:26 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 03:10:26 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 03:10:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:10:29 INFO - Installing collected packages: mozsystemmonitor 03:10:29 INFO - Running setup.py install for mozsystemmonitor 03:10:29 INFO - Successfully installed mozsystemmonitor 03:10:29 INFO - Cleaning up... 03:10:29 INFO - Return code: 0 03:10:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:29 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 0x104927a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104937420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd855c680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, '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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:10:29 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 03:10:29 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 03:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:29 INFO - 'HOME': '/Users/cltbld', 03:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:29 INFO - 'LOGNAME': 'cltbld', 03:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:29 INFO - 'MOZ_NO_REMOTE': '1', 03:10:29 INFO - 'NO_EM_RESTART': '1', 03:10:29 INFO - 'PAGER': '/bin/cat', 03:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:29 INFO - 'PWD': '/builds/slave/test', 03:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:29 INFO - 'SHELL': '/bin/bash', 03:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:10:29 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:29 INFO - 'USER': 'cltbld', 03:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:29 INFO - 'XPC_FLAGS': '0x0', 03:10:29 INFO - 'XPC_SERVICE_NAME': '0', 03:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:29 INFO - Downloading/unpacking blobuploader==1.2.4 03:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:10:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:10:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:10:33 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 03:10:33 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 03:10:33 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 03:10:33 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 03:10:33 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 03:10:33 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 03:10:33 INFO - Downloading docopt-0.6.1.tar.gz 03:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:10:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:10:33 INFO - Running setup.py install for blobuploader 03:10:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:10:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:10:33 INFO - Running setup.py install for requests 03:10:34 INFO - Running setup.py install for docopt 03:10:34 INFO - Successfully installed blobuploader requests docopt 03:10:34 INFO - Cleaning up... 03:10:34 INFO - Return code: 0 03:10:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:34 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 0x104927a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104937420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd855c680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, '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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:10:34 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 03:10:34 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 03:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:34 INFO - 'HOME': '/Users/cltbld', 03:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:34 INFO - 'LOGNAME': 'cltbld', 03:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:34 INFO - 'MOZ_NO_REMOTE': '1', 03:10:34 INFO - 'NO_EM_RESTART': '1', 03:10:34 INFO - 'PAGER': '/bin/cat', 03:10:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:34 INFO - 'PWD': '/builds/slave/test', 03:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:34 INFO - 'SHELL': '/bin/bash', 03:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:10:34 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:34 INFO - 'USER': 'cltbld', 03:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:34 INFO - 'XPC_FLAGS': '0x0', 03:10:34 INFO - 'XPC_SERVICE_NAME': '0', 03:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:34 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-b29QvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:34 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-qi4Zrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:34 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-91JHgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-VVxj3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-0C6eB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-CYZtvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-4PL1fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-WK3pWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-XPZk1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-wslofs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-L5klai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-364_Ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:35 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-V5e22w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:36 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-5KQ0td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:36 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-4uYW7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:36 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-SaBhp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:36 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-fjdj3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:10:36 INFO - Running setup.py install for manifestparser 03:10:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:10:36 INFO - Running setup.py install for mozcrash 03:10:36 INFO - Running setup.py install for mozdebug 03:10:36 INFO - Running setup.py install for mozdevice 03:10:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for mozfile 03:10:37 INFO - Running setup.py install for mozhttpd 03:10:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for mozinfo 03:10:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for mozInstall 03:10:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for mozleak 03:10:37 INFO - Running setup.py install for mozlog 03:10:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:10:37 INFO - Running setup.py install for moznetwork 03:10:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:10:38 INFO - Running setup.py install for mozprocess 03:10:38 INFO - Running setup.py install for mozprofile 03:10:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:10:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:10:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:10:38 INFO - Running setup.py install for mozrunner 03:10:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:10:38 INFO - Running setup.py install for mozscreenshot 03:10:38 INFO - Running setup.py install for moztest 03:10:38 INFO - Running setup.py install for mozversion 03:10:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:10:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:39 INFO - Cleaning up... 03:10:39 INFO - Return code: 0 03:10:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:39 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 0x104927a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104937420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd855c680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, '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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:10:39 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 03:10:39 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 03:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:39 INFO - 'HOME': '/Users/cltbld', 03:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:39 INFO - 'LOGNAME': 'cltbld', 03:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:39 INFO - 'MOZ_NO_REMOTE': '1', 03:10:39 INFO - 'NO_EM_RESTART': '1', 03:10:39 INFO - 'PAGER': '/bin/cat', 03:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:39 INFO - 'PWD': '/builds/slave/test', 03:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:39 INFO - 'SHELL': '/bin/bash', 03:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:10:39 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:39 INFO - 'USER': 'cltbld', 03:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:39 INFO - 'XPC_FLAGS': '0x0', 03:10:39 INFO - 'XPC_SERVICE_NAME': '0', 03:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:39 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-c3z7qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:39 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-c5hxTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:39 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-VDPRxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:39 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)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:39 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-2Q9pW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:39 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-ia280G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:39 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-owMJFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:39 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-0y8rYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:40 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-GadfFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:40 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-aJ690z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:40 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-KGSQpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 03:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:40 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-phhQ2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:40 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-AXvHMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 03:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:40 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-tL5RYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:40 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-kXQSrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 03:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:40 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-ZiX7NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:40 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-PwR4eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:41 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)) 03:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:41 INFO - Running setup.py (path:/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/pip-CWQkfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:41 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)) 03:10:41 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)) 03:10:41 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)) 03:10:41 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)) 03:10:41 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)) 03:10:41 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)) 03:10:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10:41 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 03:10:41 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 03:10:41 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 03:10:41 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 03:10:41 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 03:10:41 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 03:10:43 INFO - Downloading blessings-1.6.tar.gz 03:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:43 INFO - Installing collected packages: blessings 03:10:43 INFO - Running setup.py install for blessings 03:10:43 INFO - Successfully installed blessings 03:10:43 INFO - Cleaning up... 03:10:43 INFO - Return code: 0 03:10:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:44 INFO - Reading from file tmpfile_stdout 03:10:44 INFO - Current package versions: 03:10:44 INFO - blessings == 1.6 03:10:44 INFO - blobuploader == 1.2.4 03:10:44 INFO - docopt == 0.6.1 03:10:44 INFO - manifestparser == 1.1 03:10:44 INFO - mozInstall == 1.12 03:10:44 INFO - mozcrash == 0.17 03:10:44 INFO - mozdebug == 0.1 03:10:44 INFO - mozdevice == 0.48 03:10:44 INFO - mozfile == 1.2 03:10:44 INFO - mozhttpd == 0.7 03:10:44 INFO - mozinfo == 0.9 03:10:44 INFO - mozleak == 0.1 03:10:44 INFO - mozlog == 3.1 03:10:44 INFO - moznetwork == 0.27 03:10:44 INFO - mozprocess == 0.22 03:10:44 INFO - mozprofile == 0.28 03:10:44 INFO - mozrunner == 6.11 03:10:44 INFO - mozscreenshot == 0.1 03:10:44 INFO - mozsystemmonitor == 0.0 03:10:44 INFO - moztest == 0.7 03:10:44 INFO - mozversion == 1.4 03:10:44 INFO - psutil == 3.1.1 03:10:44 INFO - requests == 1.2.3 03:10:44 INFO - wsgiref == 0.1.2 03:10:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:44 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 0x104927a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104937420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd855c680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, '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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:10:44 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 03:10:44 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 03:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:44 INFO - 'HOME': '/Users/cltbld', 03:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:44 INFO - 'LOGNAME': 'cltbld', 03:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:44 INFO - 'MOZ_NO_REMOTE': '1', 03:10:44 INFO - 'NO_EM_RESTART': '1', 03:10:44 INFO - 'PAGER': '/bin/cat', 03:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:44 INFO - 'PWD': '/builds/slave/test', 03:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:44 INFO - 'SHELL': '/bin/bash', 03:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:10:44 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:44 INFO - 'USER': 'cltbld', 03:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:44 INFO - 'XPC_FLAGS': '0x0', 03:10:44 INFO - 'XPC_SERVICE_NAME': '0', 03:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:44 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)) 03:10:44 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)) 03:10:44 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)) 03:10:44 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)) 03:10:44 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)) 03:10:44 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)) 03:10:44 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)) 03:10:44 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)) 03:10:44 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)) 03:10:44 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)) 03:10:44 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)) 03:10:44 INFO - Cleaning up... 03:10:44 INFO - Return code: 0 03:10:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:10:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:44 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 0x104927a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104937420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd855c680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, '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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:10:44 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 03:10:44 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 03:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:44 INFO - 'HOME': '/Users/cltbld', 03:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:44 INFO - 'LOGNAME': 'cltbld', 03:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:44 INFO - 'MOZ_NO_REMOTE': '1', 03:10:44 INFO - 'NO_EM_RESTART': '1', 03:10:44 INFO - 'PAGER': '/bin/cat', 03:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:44 INFO - 'PWD': '/builds/slave/test', 03:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:44 INFO - 'SHELL': '/bin/bash', 03:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:10:44 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:44 INFO - 'USER': 'cltbld', 03:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:44 INFO - 'XPC_FLAGS': '0x0', 03:10:44 INFO - 'XPC_SERVICE_NAME': '0', 03:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:44 INFO - Downloading/unpacking jsonschema 03:10:44 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 03:10:44 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 03:10:44 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 03:10:44 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 03:10:44 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 03:10:44 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 03:10:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:10:47 INFO - Downloading/unpacking functools32 (from jsonschema) 03:10:47 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 03:10:47 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 03:10:47 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 03:10:47 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 03:10:47 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 03:10:47 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 03:10:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:10:47 INFO - warning: no files found matching '*.txt' 03:10:47 INFO - no previously-included directories found matching 'build' 03:10:47 INFO - no previously-included directories found matching 'dist' 03:10:47 INFO - no previously-included directories found matching '.git*' 03:10:47 INFO - Installing collected packages: jsonschema, functools32 03:10:47 INFO - Running setup.py install for functools32 03:10:47 INFO - warning: no files found matching '*.txt' 03:10:47 INFO - no previously-included directories found matching 'build' 03:10:47 INFO - no previously-included directories found matching 'dist' 03:10:47 INFO - no previously-included directories found matching '.git*' 03:10:47 INFO - Successfully installed jsonschema functools32 03:10:47 INFO - Cleaning up... 03:10:47 INFO - Return code: 0 03:10:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:47 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104927a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104937420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd855c680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, '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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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 03:10:47 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', 'flake8'] in /builds/slave/test/build 03:10:47 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 flake8 03:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:47 INFO - 'HOME': '/Users/cltbld', 03:10:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:47 INFO - 'LOGNAME': 'cltbld', 03:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:47 INFO - 'MOZ_NO_REMOTE': '1', 03:10:47 INFO - 'NO_EM_RESTART': '1', 03:10:47 INFO - 'PAGER': '/bin/cat', 03:10:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:47 INFO - 'PWD': '/builds/slave/test', 03:10:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:47 INFO - 'SHELL': '/bin/bash', 03:10:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:10:47 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:10:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:47 INFO - 'USER': 'cltbld', 03:10:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:47 INFO - 'XPC_FLAGS': '0x0', 03:10:47 INFO - 'XPC_SERVICE_NAME': '0', 03:10:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:48 INFO - Downloading/unpacking flake8 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 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 03:10:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:10:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:10:50 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 03:10:50 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 03:10:50 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 03:10:50 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 03:10:50 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 03:10:50 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 03:10:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:10:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:10:50 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 03:10:50 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 03:10:50 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 03:10:50 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 03:10:50 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 03:10:50 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 03:10:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:10:51 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 03:10:51 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 03:10:51 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 03:10:51 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 03:10:51 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 03:10:51 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 03:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:10:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:51 INFO - no previously-included directories found matching 'docs/_build' 03:10:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:10:52 INFO - Running setup.py install for pep8 03:10:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:52 INFO - no previously-included directories found matching 'docs/_build' 03:10:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:10:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:10:52 INFO - Cleaning up... 03:10:52 INFO - Return code: 0 03:10:52 INFO - Running post-action listener: _resource_record_post_action 03:10:52 INFO - Running post-action listener: _start_resource_monitoring 03:10:52 INFO - Starting resource monitoring. 03:10:52 INFO - ##### 03:10:52 INFO - ##### Running install step. 03:10:52 INFO - ##### 03:10:52 INFO - Running pre-action listener: _resource_record_pre_action 03:10:52 INFO - Running main action method: install 03:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:52 INFO - Reading from file tmpfile_stdout 03:10:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:10:52 INFO - Reading from file tmpfile_stdout 03:10:52 INFO - Output received: 03:10:52 INFO - Usage: mozinstall [options] installer 03:10:52 INFO - Options: 03:10:52 INFO - -h, --help show this help message and exit 03:10:52 INFO - -d DEST, --destination=DEST 03:10:52 INFO - Directory to install application into. [default: 03:10:52 INFO - "/builds/slave/test"] 03:10:52 INFO - --app=APP Application being installed. [default: firefox] 03:10:52 INFO - mkdir: /builds/slave/test/build/application 03:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:11:24 INFO - Reading from file tmpfile_stdout 03:11:24 INFO - Output received: 03:11:24 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:11:24 INFO - Running post-action listener: _resource_record_post_action 03:11:24 INFO - ##### 03:11:24 INFO - ##### Running run-tests step. 03:11:24 INFO - ##### 03:11:24 INFO - Running pre-action listener: _resource_record_pre_action 03:11:24 INFO - Running main action method: run_tests 03:11:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:11:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:11:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:11:24 INFO - 2016-05-28 03:11:24.941 screenresolution[1656:9341] starting screenresolution argv=screenresolution get 03:11:24 INFO - 2016-05-28 03:11:24.944 screenresolution[1656:9341] Display 0: 1600x1200x32@60 03:11:24 INFO - 2016-05-28 03:11:24.950 screenresolution[1657:9343] starting screenresolution argv=screenresolution list 03:11:24 INFO - Available Modes on Display 0 03:11:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:11:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:11:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:11:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:11:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:11:25 INFO - Intel Iris: 03:11:25 INFO - Chipset Model: Intel Iris 03:11:25 INFO - Type: GPU 03:11:25 INFO - Bus: Built-In 03:11:25 INFO - VRAM (Dynamic, Max): 1536 MB 03:11:25 INFO - Vendor: Intel (0x8086) 03:11:25 INFO - Device ID: 0x0a2e 03:11:25 INFO - Revision ID: 0x0009 03:11:25 INFO - Displays: 03:11:25 INFO - Display: 03:11:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:11:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:11:25 INFO - Display Serial Number: 1600x1200 60 03:11:25 INFO - Main Display: Yes 03:11:25 INFO - Mirror: Off 03:11:25 INFO - Online: Yes 03:11:25 INFO - Rotation: Supported 03:11:25 INFO - Return code: 0 03:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:11:25 INFO - Python 2.7.3 03:11:25 INFO - Return code: 0 03:11:25 INFO - grabbing minidump binary from tooltool 03:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:25 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047c6e00>, '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 0x10462fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047c1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:11:25 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 03:11:25 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 03:11:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:11:25 INFO - Return code: 0 03:11:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:11:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:11:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:11:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:11:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:11:26 INFO - Return code: 0 03:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0200', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0200 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:11:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GpwuDFOjLx/Render', 03:11:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:26 INFO - 'HOME': '/Users/cltbld', 03:11:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:26 INFO - 'LOGNAME': 'cltbld', 03:11:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:11:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:26 INFO - 'MOZ_NO_REMOTE': '1', 03:11:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:11:26 INFO - 'NO_EM_RESTART': '1', 03:11:26 INFO - 'PAGER': '/bin/cat', 03:11:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:26 INFO - 'PWD': '/builds/slave/test', 03:11:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:11:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:26 INFO - 'SHELL': '/bin/bash', 03:11:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vgyGn8Hivv/Listeners', 03:11:26 INFO - 'TMPDIR': '/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/', 03:11:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:26 INFO - 'USER': 'cltbld', 03:11:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:26 INFO - 'XPC_FLAGS': '0x0', 03:11:26 INFO - 'XPC_SERVICE_NAME': '0', 03:11:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0200', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:11:26 INFO - mozversion application_buildid: 20160525183450 03:11:26 INFO - mozversion application_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:11:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:11:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:11:26 INFO - mozversion application_name: Firefox 03:11:26 INFO - mozversion application_remotingname: firefox-dev 03:11:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:11:26 INFO - mozversion application_vendor: Mozilla 03:11:26 INFO - mozversion application_version: 48.0a2 03:11:26 INFO - mozversion platform_buildid: 20160525183450 03:11:26 INFO - mozversion platform_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:11:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:11:26 INFO - mozversion platform_version: 48.0a2 03:11:26 INFO - using testdate: 1464430286 03:11:26 INFO - actual date: 1464430286 03:11:26 INFO - starting webserver on 'localhost:49279' 03:11:26 INFO - SUITE-START | Running 2 tests 03:11:26 INFO - TEST-START | dromaeo_css 03:11:26 INFO - operating with platform_type : mac_ 03:11:26 INFO - Initialising browser for dromaeo_css test... 03:11:26 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/tmpWcgY5J/profile http://localhost:49279/getInfo.html) 03:11:29 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 03:11:29 INFO - PROCESS | 1675 | colorDepth:24 03:11:29 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 03:11:29 INFO - PROCESS | 1675 | __metrics 03:11:29 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:11:30 INFO - TEST-INFO | 1675: exit 0 03:11:30 INFO - Browser initialized. 03:11:30 INFO - Running cycle 1/1 for dromaeo_css test... 03:11:30 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/tmpWcgY5J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:42 INFO - PROCESS | 1679 | RSS: Main: 220483584 03:11:42 INFO - PROCESS | 1679 | 03:12:31 INFO - PROCESS | 1679 | 1464430351687 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] 03:14:42 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 03:14:43 INFO - PROCESS | 1679 | RSS: Main: 231268352 03:14:43 INFO - PROCESS | 1679 | 03:17:45 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 03:17:46 INFO - PROCESS | 1679 | RSS: Main: 242790400 03:17:46 INFO - PROCESS | 1679 | 03:20:48 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 03:20:48 INFO - PROCESS | 1679 | RSS: Main: 244826112 03:20:48 INFO - PROCESS | 1679 | 03:23:50 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 03:23:51 INFO - PROCESS | 1679 | RSS: Main: 246562816 03:23:51 INFO - PROCESS | 1679 | 03:26:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 03:26:54 INFO - PROCESS | 1679 | RSS: Main: 250081280 03:26:54 INFO - PROCESS | 1679 | 03:29:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 03:29:56 INFO - PROCESS | 1679 | RSS: Main: 250531840 03:29:56 INFO - PROCESS | 1679 | 03:29:56 INFO - PROCESS | 1679 | __start_tp_report 03:29:56 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 03:29:56 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 03:29:56 INFO - PROCESS | 1679 | |i|pagename|runs| 03:29:56 INFO - PROCESS | 1679 | |0;dojo.html;3276.9508457373145;3417.094469965458;3447.103753024213;3459.446488561829;3488.860445582177;5518.365387980373;5547.556195504355;5548.500634942854;5550.139728342103;5614.270144881165;5515.4760297771745;5529.474699903502;5559.388467268597;5583.609147359686;5584.944150558493;5087.592992560586;5115.590752739772;5138.177891537355;5142.485751424846;5172.09488339541;4844.806207751686;5035.521625445577;5118.641695081327;5197.818076367309;5294.047071527124;5194.766235519392;5200.08998425276;5201.739913004353;5203.9219411708855;5211.5049070338255;5155.974220128913;5169.198774190007;5213.426523082477;5244.108501554745;5275.050490911634;5024.974875125601;5117.6161787865685;5118.564921981636;5131.820386286499;5160.329157209576;4352.477702675667;5425.104857698475;5482.945170548323;5509.256250406184;5548.611597188198;5851.210086638292;6123.295820980599;6143.723532441051;6147.969260153715;6161.691915404212;6135.386461353829;6186.783462578788;6190.907136392958;6207.4723648489935;6213.844653883644;5745.052066409037;5759.704066585026;5762.654240745569;5767.36558978512;5772.0476121439915;6141.915626108677;6191.938080619227;6232.127502149703;6293;6331.905021424683;6049.606775559574;6051.667158306335;6054.727537260834;6070.757169713251;6131.386861313833;6150.846228844225;6158.414950579688;6163.660998645118;6173.9073913891325;6177.042558403455;4900;5953.047512398082;6053.667048312385;6108.419700128481;6109.327973922865;6108.358622344679;6114.449440885012;6136.447719705248;6147.692615369214;6158.846028849225;4783.6651434399255;4897.14299997499;4912.1158191525155;4916.06594746997;4945.975270123627;4305.095929854703;4311.267084595626;4379.189849877783;4396.098799746044;4416.9620139267245;4773.451053128865;5559.8888022240135;5620.887582248332;5627.43725627434;5667.149927510906;5621.943780562224;5735.11105778605;5780.84383123377;6098.420650038239;6123.908141377883;4492;5586.469285417878;5596.664200148004;5625.803096891589;5665.915011274834;5297;5325.8934821303355;5349.331333583302;5358.678479291177;5359.222912677717;6276.905846412307;6292.182016337847;6304.65324407162;6351.047342898694;6378.808635740936;6008.459238668541;6103.05402662588;6130.000698177663;6132.47873930703;6139.508839292756;5331.360236771612;6173.290071641819;6236.906446403398;6341.90487142684;6355.110284560258;6034.818955431344;6036.215292012011;6036.577439579188;6036.728347224298;6042.667653279112;5971.044632858721;6028.849278768066;6086.178365920544;6100.1459795629535;6103.176071230327;5128.1794912813775;5849.736761845812;5927.525797936241;5971.880562388815;6057.545684073801;4380.540043295536;5702.8289151325525;5891.558133139946;5971.3132989705;5995.670238136944;5629.183768353648;5825.126231065374;5832.358440571449;5840.912386314124;5848.883022339444;5943.138244954544;5959.582829202088;5985.610935289193;6025.548083893813;6061.212042434456;5825.3883342248455;5844.853878652898;5865.589408741347;5882.205902203148;5883.646981181143 03:29:56 INFO - PROCESS | 1679 | |1;ext.html;488.61887727572486;528.7831988884557;561.444170271431;599.3706608061535;620.3207487800856;35597.11007224821;38919.610803891956;38978;39013.02467438315;39023.60976390235;40870;40967.38548921761;41459.37810932838;41506.37740433896;41510.58489415105;8734.475931444134;9180.265578753717;9405.247580193585;9705.514724263794;9734.172595329406;9576.904230957705;9697.999999999965;9723.562439690195;9822.705318840446;9886.604535818558;9762.658306959258;9814.901850981505;9831.65589204378;9839.163671087967;9854.950725246365;8640.351973602004;9640.276979226515;9720.854187187198;9807.019298070207;9869.555869985832;9652.083052110109;9717.076877696607;9809.754756131082;9814.90185098147;10296.536655850505;39119.217615647525;39149.217015659815;39289.41065884014;39564.60435395667;39692.801535992425;3164.2722173900133;3669.376206044979;3757.248550289953;3822.7132965027454;3838.5777564467885;25238;28019.299517512023;28664.713352866413;28899.133026009255;29109.708902910912;2740.410811675499;2788.3029242689327;2801.341684704093;2873.956890646642;2874.7412732853936;335972;336837;338706;340910;340939.9999999975;60190.9904504773;61278.693606531684;61493.69253153705;61872.690636546526;62044;48957.51042489529;64971.675141623986;65846.36614535461;66157.33842661511;66294;16190.676186476205;16669.83330166707;16678;16921.57696057584;16950.57623559421;12505.249685018927;12906.67733306656;12991.610251692464;12999.740005199843;13048.869511304956;16109.516714498584;16303.91848040776;16332.428365007405;16334.18329083541;16772;6181.258249010148;7231.938897414317;7309.966363958897;7336.413086953031;7394.963025184839;912.397817440486;962.6341990043738;965.2278177458005;983.326421401328;997.67575537949;28353.574696379572;29876.253093672396;30052;30550.54174187389;30561.08316750501;1063.5373612478597;1091.5961094394966;1122.9719257018476;1123.337231033694;1125.150511363915;15042.097474151586;15488.5353439397;15602;15625.531234062997;15812.446564370191;602967.9703203;603206;607168;607987.9600601968;612509;59563.702181488814;60312.79374412487;60569.69715151484;60932;61173.38826611766;1486.598618373055;1492.634304595381;1503.240863363994;1512.901661392006;1519.54413675899;29541.85229073841;29754.10737677873;29877.551836722032;30382.84808575943;30523.389532209676;50883;50885.23672144847;51028;51445.7427712874;51656.74171629118;567269;570931;571090;571591;572721;38016;39702.2059558813;39949;40275.3958690614;41155.58844411517;45622.771886140355;45674.77162614166;45780.31329530126;46857.297140542236;47689.5231047699;37564.24871502609;38390.808045959595;38629.613703862604;39263.41104883486;39479.60520394874;37497.00813786496;38271.234575308896;38667.613323866404;38784.22431551297;38973;27077.72922270752;32380.514292285163;37691.43462848005;38695;39463.80268098641;24987.37582057233;32144;32833.50749738803;32930.152222790275;33294.667053329154;21293.893530532867;23781.335306528377;25180;25184;25197.37006574777 03:29:56 INFO - PROCESS | 1679 | |2;jquery.html;378.2605007210902;395.61427608082107;399.3969106648959;405.7829061452123;408.8957315884451;15613.765793513106;15786.921065394685;17275.913620431882;20224.39326820196;20981.74109553428;11790.882091179086;12304.81542776859;20142.798572014275;20593.588128237465;20649.793502064975;5210.635255532105;5384.596155288349;5402.810901618444;5404.891902161954;5417.26866872971;5177.145770947789;5382.515573598375;5396.325459317585;5426.62013659044;5450.700211488366;4718.4337879454515;5311.415744268127;5340.439253878345;5414.675119492843;5432.91850622241;5289.656172348804;5374.086405311087;5417.972910135444;5575.804846830341;5887.70561471929;5767.1349297605275;5786.971065144689;5795.594308398414;5797.594168408213;5799.739011744439;24711.38221544476;25976;25997.609323637775;26158.476830463285;26734.46531069387;2115.069369477425;2196.3410976706923;2369.336585755991;2396.4488167721347;2822.237995741159;9777.511124443748;10205.38767673942;10279.537420816081;12835.358232088358;14049.08680935746;1706.3771723321022;1729.2304924308687;1762.436020473449;1767.6729804986119;1768.5401795533126;111405;114418.42790785992;117324.82675173224;119026.40486797597;119712.80287197104;9789.706308810748;11927.642170734893;11954.222975506738;12123.696907577381;12182.329971851634;15236.771448428282;15300.158491283086;15301.6174595636;15316.540503784905;15377.769333460006;6820.761273355409;8935.642574296955;8986.460812351279;9025.503597302211;9046.909530904739;8961.910380896237;8988.59551320192;8995.055519170524;9019.503927283931;9116.1339672731;3978.741381810173;4691.132140554008;4741.857744267678;4790.808367665324;4792.592629626451;1956.9412917612494;2000.739903812495;2005.7994200579826;2047.4676584088245;2054.5479994401207;761.4213197969473;876.2639382918252;962.3840741925173;969.9418034917927;984.9704508864745;19522.316718914768;20000.399988000383;20140.093695783726;20281.797182028287;20478.283260085824;949.4161090929028;955.5604421965835;973.1387721866058;995.711243739322;1035.668586052471;8555.99068061275;10581.365118092785;10621.787564248672;10666.679999600025;10774.407407592658;616138;622108;636076;643684;644968;99121.6263372511;110899;114541;116726.41636791761;119985;940.4921342475124;949.4303417949175;958.4872093429982;966.79213968997;968.6270785747538;17832.821671783637;18178.545536361697;18204.544886377946;18221.726674099635;18514.259429623202;50089.74955125201;50901.472955809906;52128.99999999848;52846.735766320926;53005.20492192543;73211.26788732044;74165.62917185595;74398;75236.49527009539;76370.6181469089;7819.296263336099;7954.84090318202;7968.16334284915;7983.72056978003;7992.6802927884555;8753.6936207235;10024.74690663667;11740;11866.288022718665;12170.634880953585;8644.827103458021;8884.955575222082;10379.858215596429;10641.04230619248;11008.944955275492;10704.678859634223;10720.678379648623;11113.333200008025;11127.22109452363;11150.944245278723;11281.830772538582;11328.150388721044;11402.94298528502;11463.369514676773;11465.426728663366;8301.418900676894;8305.543195124326;8389.622466989122;8478.788030299293;8509.446885952393;6438.356164383524;6528.824811533969;7752.3798096153305;7783.338416234684;8563.529005904735 03:29:56 INFO - PROCESS | 1679 | |3;mootools.html;1401.6636007358234;1559.5945054285885;1788.3919467381088;1886.9433916982478;1933.2460340467212;7842.176571460001;8489.278411335028;8518.787030324245;8740.737777866667;8784.5607719614;8537.57312134394;8557.400981931267;8638.17937295956;8682.435641683287;8693.304535637133;2423.1397853761882;2449.5835707929605;2456.7174774900845;2457.201409541897;2457.7665121813397;2411.2884020004713;2447.7674620911075;2449.497852940152;2451.4361696809747;2458.766417190373;2430.234476140019;2430.295214387834;2436.3909022744315;2462.384403899025;2465.4329504214043;2359.362971997551;2400.087966572709;2438.5366780311683;2443.4380092578717;2450.534398464295;2405.542946840095;2422.527607116613;2426.8301218914685;2426.9393265168337;2427.708674959016;8735.43219690718;8804.515751633657;8807.471551706918;8820.779480512974;8824.205821476035;5257.553107985826;5299.205119232108;5371.167469042305;5412.512873841373;5420.214068959979;3401.4727717203873;3447.827608619559;3453.205762674599;3483.9477407838904;3493.406120959443;839.7816567692444;966.6906589891238;978.2711879649636;989.3816364772017;1014.1683819268203;11577.6526704199;11627.534898604046;11678.124140689397;11739.236949598335;11797.351145686984;4680.695754775928;4806.182948898696;4816.446108697474;4816.783244753994;4820.108279968217;10046.748831279276;10096.899031009596;10111.949440252753;10113.747156321151;10123.1901447884;4611.169989401873;5303.257543943851;5329.54698850602;5366.838994830161;5393.406725260218;4389.539098394686;4784.784684689197;4811.639127065484;4874.4150701916;4877.219644856806;4004.939925901114;4005.7997100144876;4074.103697186614;4084.264832330209;4114.218298523271;1349.8582648821732;1360.9591712248648;1364.4070746297025;1367.9931600341934;1375.8280214973129;844.9185043144785;846.3271698999188;858.3262139220807;939.145377706284;943.6178347769164;5022.246663000579;5723.656580605177;5831.011146496799;5851.561132915049;5873.177755114288;910.5037754423855;955.2214944820089;973.5764942250003;983.9458829764288;1007.8437842134481;3620.8551657933913;3808.6762625176616;3888.9027774305305;3928.64642182205;3972.7020473464604;10139.898601014043;10302;10454.111400530888;10504.474776261157;10536.420496872592;10099.14157296638;10348.637797677045;10391.220658450646;10435.32170408921;10437.947810261052;8163.755087347389;8283.544405057659;8299.792505187419;8364.749057528163;8393;5542.861428464321;5628.127640215773;5636.605437619327;5694.943050569441;5724.341700704473;7081.82295442618;8087.919120808717;8410.579471026547;9341.486218258062;9553.665621703207;9466.715998520056;9766.75583110428;9881.50592470388;9882.752931176778;10146.898531014891;6354.6822658867795;6601.174853143357;6757.087793147862;7014.298570142945;7101.183363913009;7872.212778722082;7885.1720569339395;7966.3626909848235;7969.043714754266;7972.960135199519;6943.201531823703;7061.2585678505075;7099.680514376762;7147.392471639969;7188.964055179691;6889.517733758589;6923.6192009439965;6983.930160698328;7041.155061392461;7077.186123595852;6667.233268174028;6695.933040669531;6746.730130794714;6802.455803535804;6816.693248803716;4717.033008233372;4775.641826863069;4781.163296423181;4790.688605240648;4795.160846851857;4808.543188397097;4812.735299558558;4816.638752093537;4888.853334399973;5020.673656212334 03:29:56 INFO - PROCESS | 1679 | |4;prototype.html;324.8505687383804;325.5231086458338;331.76113198497075;334.31131868351184;337.6370401818046;5504.4495550444935;6688.799336019921;6775.932240677592;6781.966090169549;6815.5569887957245;6759.45924326054;6761.154855643044;6784.966075169629;6790.490713196517;6830.146231721035;4823.734694591796;4886.51134886512;5027.195648696209;5028.924566131493;5040.966601846612;4126.7523948563185;4957.876053098684;5027.572656324217;5051.242313652963;5102.897942041157;5015.974920125394;5043.1678773002595;5049.545540901318;5051.267566202899;5088.491150884919;4091.8158682859344;4515.63874890008;4645.606318104555;5021.673591216596;5060.974695126538;4327.37253098299;4329.393884856123;4339.652827773771;4340.457442819647;4344.326629372453;5555.722213889289;6295;6565.704543295516;6626.801195964129;6660.800175994679;5927.407259274081;5933.762649494015;5995.100734889757;5995.61028533144;6024.367441418632;6180.85654153983;7042.859142817115;7289.343959043712;7290.63546822662;7299.19708832028;4817.638677099197;4834.637402194814;4844.2733589961435;4862.319275301461;4874.902501949977;7478.588677622729;7743.148253692089;7773.494722842997;7803.414743894174;7806.687732490694;4331.870043898688;4965.851024469272;4973.577245934136;4976.5023497649945;4980.12847751642;5035.471275516092;5062.544371006627;5065.544101030851;5068.82259120929;5078.5175408336145;5977.581569290108;5983.982722937111;5999.5500337473995;6007.15899774032;6018.729157187937;5903.616264942765;7357.8160545986775;7371.894215867663;7376.077990251219;7376.114866216089;1729.0663041957202;1756.7452719355622;1760.7358896165679;1763.2858692229668;1768.8408043276168;1023.1814548361281;1054.2409465185056;1059.1473863539925;1068.9198310126772;1068.9946550267355;6738.629375384303;6791;6808.4212841908;6854.8004099282425;6865.141857267841;7366.521176123535;7537.283958024089;7564.865270209512;7581.090269167625;7589.696412143452;6727.596344219362;6870.896936545956;6878.312168783082;6900.930990690129;6917.792466226021;3286.5234540991423;3995.62041606047;4025.5974402560096;4043.6562892153906;4048;8037.437379383387;8046.356291496666;8055.758327250074;8066.072401673765;8070.112287648354;7659.502132361378;7853.7251196209;7885.093214280317;7890.842183156305;7897.447178697551;7046.43628509718;7357.926420735724;8029.357651387875;8037.598120093972;8049.182786024844;7629.7329593463965;7650.426218033558;7662.923370766221;7675.347595454449;7707.15221325665;7525.2098529653595;7539.32146106853;7541.849163016818;7545.849083018199;7571.545707257582;6524.608523488606;7821.882671759814;8023.919760802551;8088.988876390451;8114.918850811417;4895.608351331956;4949.950500494949;4952.876178095432;4955.2567114933045;4956.925646115384;7397.445191610758;7419.851602968019;7427.888581671387;7431.108267007994;7439.776806695808;7133;7168.2831716827895;7174.748883789042;7182.4613154014705;7194.2086370498155;6936.34104760047;7143.999840022505;7157.928420715726;7178.5692858428665;7189.7483588074165;5541.639793413416;5620.634658747168;6921.1002569665625;6998.16022077354;7017.964910175417;7068.187158476635;7160.283971602798;7163.606001669749;7164.462665300019;7176.533525320838;5990.251218597676;6253.624782513064;6949.166100068024;6990.09128813251;7012.439004879496 03:29:56 INFO - PROCESS | 1679 | |5;yui.html;643.276314146585;709.58489283769;749.9850002999937;756.1455555222598;782.7456076775046;14940.5517834465;15015.47445839396;15027.398904043852;15075;15194.620134496628;11302.886971130287;13616.319184040807;13683.794743078863;13717.72564548711;15441.845581544181;925.5233554719308;930.8091841172543;937.8311903857303;939.1219210038636;946.1012038563358;900.1718419054453;920.7744102694849;932.9953350233274;933.9299552533587;936.7377134402378;939.4926739560664;979.3829887171108;980.5293459139617;984.8375018122001;988.3575675810708;948.4641177734593;953.9379940303858;966.5360626899128;982.9606815727362;985.6845809340978;693.4036728413561;693.5699866083061;717.0248462091552;718.0127324928224;731.4769939493287;15003.549893503212;15216.847831521654;15251.38994440221;15265.694686106215;15266.542003739905;12329.568465103768;12346.753064938652;12517.186382885175;12562;12807.615771526776;9970.40177589347;10169.796604067877;10212.897871021269;10231;10278.948605257001;3427.622961474236;3478.4260597001467;3494.0740703713536;3527.629598892105;3537.876174333912;59643.70178149125;80744.19255807484;81501.59249203776;82904;83833.16166838315;9133.40632858862;9242.445453272825;9550.474723890115;9597.952010239904;9608;21294.680579791315;21340.35978920604;21436.678449823266;21511.784882151293;21533.353999380044;6925.099737034153;6944.51388402807;7032.226455089936;7115.1106111736035;7184.425245980309;3792.867249646249;3999.7400168988925;4023.939640905389;4068.7558746475306;4077.7145599808323;3370.4607262838317;3419.316136772655;3424.298018906118;3425.0581090200394;3426.691597756214;609.9268087829489;622.5859803230892;632.181325183888;639.5171645407687;644.7324360390479;479.7385424943414;528.4715284715285;570.823044856096;582.7115577788937;594.2275042444804;8108.959455202804;8190.017197936286;8209.671613135408;8214.917850821535;8480.703175388955;526.6655673647261;527.6148411659433;544.6595877576515;570.1447828257614;608.2427377914524;3296.258341873059;3690.6862916652385;3770.811459427018;3848.4804551385764;3887.6501114899793;77784.22215777883;91504.54247728719;91763.08236917679;93681;95026.52486737522;72036.63981680163;76329;78666.60666696745;79106;79521;65431.67284163644;65807;66457;66589.6682066356;67084;7582.582957937367;7726.729564465441;7891.84216315682;7954.244346787046;8088;47781.522184779096;48399.5160048395;49473.75263123661;49512.76218094576;49699.75150124226;62018.68990655018;67353.32646673471;67754.66122669552;68069;68856;9806.460644664612;9987.350822196535;10112.544935477774;10139.898601013896;10170.74573135648;10762;10829.350238985686;10848.783024339627;10921.290116142425;11578.957893789599;8315;10285.228607854291;10291.691249262534;10378.42918639482;10636.787264254826;10135.797284054424;10354.223433242687;10689.25175237757;10700.197485188797;10890.29213101146;9637;10110.292279540656;10193.74515637115;10288.588456461657;10308.175345972455;8811.603477843384;8973.551322433721;8980.326475514232;9006.324525660733;9024.864627030469;8106.351491880518;8453.995079475684;8775.648974040967;8787.25308348772;8799.648014079365 03:29:56 INFO - PROCESS | 1679 | __end_tp_report 03:29:56 INFO - PROCESS | 1679 | __start_cc_report 03:29:56 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,420 03:29:56 INFO - PROCESS | 1679 | __end_cc_report 03:29:56 INFO - PROCESS | 1679 | __startTimestamp1464431396706__endTimestamp 03:29:56 INFO - PROCESS | 1679 | 03:29:56 INFO - PROCESS | 1679 | ------- Summary: start ------- 03:29:56 INFO - PROCESS | 1679 | Number of tests: 6 03:29:56 INFO - PROCESS | 1679 | 03:29:56 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5604.57 Median:5772.05 stddev:635.34 (11.0%) stddev-sans-first:610.49 03:29:56 INFO - PROCESS | 1679 | Values: 3277.0 3417.1 3447.1 3459.4 3488.9 5518.4 5547.6 5548.5 5550.1 5614.3 5515.5 5529.5 5559.4 5583.6 5584.9 5087.6 5115.6 5138.2 5142.5 5172.1 4844.8 5035.5 5118.6 5197.8 5294.0 5194.8 5200.1 5201.7 5203.9 5211.5 5156.0 5169.2 5213.4 5244.1 5275.1 5025.0 5117.6 5118.6 5131.8 5160.3 4352.5 5425.1 5482.9 5509.3 5548.6 5851.2 6123.3 6143.7 6148.0 6161.7 6135.4 6186.8 6190.9 6207.5 6213.8 5745.1 5759.7 5762.7 5767.4 5772.0 6141.9 6191.9 6232.1 6293.0 6331.9 6049.6 6051.7 6054.7 6070.8 6131.4 6150.8 6158.4 6163.7 6173.9 6177.0 4900.0 5953.0 6053.7 6108.4 6109.3 6108.4 6114.4 6136.4 6147.7 6158.8 4783.7 4897.1 4912.1 4916.1 4946.0 4305.1 4311.3 4379.2 4396.1 4417.0 4773.5 5559.9 5620.9 5627.4 5667.1 5621.9 5735.1 5780.8 6098.4 6123.9 4492.0 5586.5 5596.7 5625.8 5665.9 5297.0 5325.9 5349.3 5358.7 5359.2 6276.9 6292.2 6304.7 6351.0 6378.8 6008.5 6103.1 6130.0 6132.5 6139.5 5331.4 6173.3 6236.9 6341.9 6355.1 6034.8 6036.2 6036.6 6036.7 6042.7 5971.0 6028.8 6086.2 6100.1 6103.2 5128.2 5849.7 5927.5 5971.9 6057.5 4380.5 5702.8 5891.6 5971.3 5995.7 5629.2 5825.1 5832.4 5840.9 5848.9 5943.1 5959.6 5985.6 6025.5 6061.2 5825.4 5844.9 5865.6 5882.2 5883.6 03:29:56 INFO - PROCESS | 1679 | 03:29:56 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:64989.32 Median:39206.31 stddev:138717.04 (353.8%) stddev-sans-first:139021.64 03:29:56 INFO - PROCESS | 1679 | Values: 488.6 528.8 561.4 599.4 620.3 35597.1 38919.6 38978.0 39013.0 39023.6 40870.0 40967.4 41459.4 41506.4 41510.6 8734.5 9180.3 9405.2 9705.5 9734.2 9576.9 9698.0 9723.6 9822.7 9886.6 9762.7 9814.9 9831.7 9839.2 9855.0 8640.4 9640.3 9720.9 9807.0 9869.6 9652.1 9717.1 9809.8 9814.9 10296.5 39119.2 39149.2 39289.4 39564.6 39692.8 3164.3 3669.4 3757.2 3822.7 3838.6 25238.0 28019.3 28664.7 28899.1 29109.7 2740.4 2788.3 2801.3 2874.0 2874.7 335972.0 336837.0 338706.0 340910.0 340940.0 60191.0 61278.7 61493.7 61872.7 62044.0 48957.5 64971.7 65846.4 66157.3 66294.0 16190.7 16669.8 16678.0 16921.6 16950.6 12505.2 12906.7 12991.6 12999.7 13048.9 16109.5 16303.9 16332.4 16334.2 16772.0 6181.3 7231.9 7310.0 7336.4 7395.0 912.4 962.6 965.2 983.3 997.7 28353.6 29876.3 30052.0 30550.5 30561.1 1063.5 1091.6 1123.0 1123.3 1125.2 15042.1 15488.5 15602.0 15625.5 15812.4 602968.0 603206.0 607168.0 607988.0 612509.0 59563.7 60312.8 60569.7 60932.0 61173.4 1486.6 1492.6 1503.2 1512.9 1519.5 29541.9 29754.1 29877.6 30382.8 30523.4 50883.0 50885.2 51028.0 51445.7 51656.7 567269.0 570931.0 571090.0 571591.0 572721.0 38016.0 39702.2 39949.0 40275.4 41155.6 45622.8 45674.8 45780.3 46857.3 47689.5 37564.2 38390.8 38629.6 39263.4 39479.6 37497.0 38271.2 38667.6 38784.2 38973.0 27077.7 32380.5 37691.4 38695.0 39463.8 24987.4 32144.0 32833.5 32930.2 33294.7 21293.9 23781.3 25180.0 25184.0 25197.4 03:29:56 INFO - PROCESS | 1679 | 03:29:56 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:35036.10 Median:4704.78 stddev:104939.45 (2230.5%) stddev-sans-first:105201.57 03:29:56 INFO - PROCESS | 1679 | Values: 378.3 395.6 399.4 405.8 408.9 15613.8 15786.9 17275.9 20224.4 20981.7 11790.9 12304.8 20142.8 20593.6 20649.8 5210.6 5384.6 5402.8 5404.9 5417.3 5177.1 5382.5 5396.3 5426.6 5450.7 4718.4 5311.4 5340.4 5414.7 5432.9 5289.7 5374.1 5418.0 5575.8 5887.7 5767.1 5787.0 5795.6 5797.6 5799.7 24711.4 25976.0 25997.6 26158.5 26734.5 2115.1 2196.3 2369.3 2396.4 2822.2 9777.5 10205.4 10279.5 12835.4 14049.1 1706.4 1729.2 1762.4 1767.7 1768.5 111405.0 114418.4 117324.8 119026.4 119712.8 9789.7 11927.6 11954.2 12123.7 12182.3 15236.8 15300.2 15301.6 15316.5 15377.8 6820.8 8935.6 8986.5 9025.5 9046.9 8961.9 8988.6 8995.1 9019.5 9116.1 3978.7 4691.1 4741.9 4790.8 4792.6 1956.9 2000.7 2005.8 2047.5 2054.5 761.4 876.3 962.4 969.9 985.0 19522.3 20000.4 20140.1 20281.8 20478.3 949.4 955.6 973.1 995.7 1035.7 8556.0 10581.4 10621.8 10666.7 10774.4 616138.0 622108.0 636076.0 643684.0 644968.0 99121.6 110899.0 114541.0 116726.4 119985.0 940.5 949.4 958.5 966.8 968.6 17832.8 18178.5 18204.5 18221.7 18514.3 50089.7 50901.5 52129.0 52846.7 53005.2 73211.3 74165.6 74398.0 75236.5 76370.6 7819.3 7954.8 7968.2 7983.7 7992.7 8753.7 10024.7 11740.0 11866.3 12170.6 8644.8 8885.0 10379.9 10641.0 11008.9 10704.7 10720.7 11113.3 11127.2 11150.9 11281.8 11328.2 11402.9 11463.4 11465.4 8301.4 8305.5 8389.6 8478.8 8509.4 6438.4 6528.8 7752.4 7783.3 8563.5 03:29:56 INFO - PROCESS | 1679 | 03:29:56 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:5583.52 Median:4875.82 stddev:3076.11 (63.1%) stddev-sans-first:3068.68 03:29:56 INFO - PROCESS | 1679 | Values: 1401.7 1559.6 1788.4 1886.9 1933.2 7842.2 8489.3 8518.8 8740.7 8784.6 8537.6 8557.4 8638.2 8682.4 8693.3 2423.1 2449.6 2456.7 2457.2 2457.8 2411.3 2447.8 2449.5 2451.4 2458.8 2430.2 2430.3 2436.4 2462.4 2465.4 2359.4 2400.1 2438.5 2443.4 2450.5 2405.5 2422.5 2426.8 2426.9 2427.7 8735.4 8804.5 8807.5 8820.8 8824.2 5257.6 5299.2 5371.2 5412.5 5420.2 3401.5 3447.8 3453.2 3483.9 3493.4 839.8 966.7 978.3 989.4 1014.2 11577.7 11627.5 11678.1 11739.2 11797.4 4680.7 4806.2 4816.4 4816.8 4820.1 10046.7 10096.9 10111.9 10113.7 10123.2 4611.2 5303.3 5329.5 5366.8 5393.4 4389.5 4784.8 4811.6 4874.4 4877.2 4004.9 4005.8 4074.1 4084.3 4114.2 1349.9 1361.0 1364.4 1368.0 1375.8 844.9 846.3 858.3 939.1 943.6 5022.2 5723.7 5831.0 5851.6 5873.2 910.5 955.2 973.6 983.9 1007.8 3620.9 3808.7 3888.9 3928.6 3972.7 10139.9 10302.0 10454.1 10504.5 10536.4 10099.1 10348.6 10391.2 10435.3 10437.9 8163.8 8283.5 8299.8 8364.7 8393.0 5542.9 5628.1 5636.6 5694.9 5724.3 7081.8 8087.9 8410.6 9341.5 9553.7 9466.7 9766.8 9881.5 9882.8 10146.9 6354.7 6601.2 6757.1 7014.3 7101.2 7872.2 7885.2 7966.4 7969.0 7973.0 6943.2 7061.3 7099.7 7147.4 7189.0 6889.5 6923.6 6983.9 7041.2 7077.2 6667.2 6695.9 6746.7 6802.5 6816.7 4717.0 4775.6 4781.2 4790.7 4795.2 4808.5 4812.7 4816.6 4888.9 5020.7 03:29:56 INFO - PROCESS | 1679 | 03:29:56 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:5934.92 Median:6749.04 stddev:1899.22 (28.1%) stddev-sans-first:1857.29 03:29:56 INFO - PROCESS | 1679 | Values: 324.9 325.5 331.8 334.3 337.6 5504.4 6688.8 6775.9 6782.0 6815.6 6759.5 6761.2 6785.0 6790.5 6830.1 4823.7 4886.5 5027.2 5028.9 5041.0 4126.8 4957.9 5027.6 5051.2 5102.9 5016.0 5043.2 5049.5 5051.3 5088.5 4091.8 4515.6 4645.6 5021.7 5061.0 4327.4 4329.4 4339.7 4340.5 4344.3 5555.7 6295.0 6565.7 6626.8 6660.8 5927.4 5933.8 5995.1 5995.6 6024.4 6180.9 7042.9 7289.3 7290.6 7299.2 4817.6 4834.6 4844.3 4862.3 4874.9 7478.6 7743.1 7773.5 7803.4 7806.7 4331.9 4965.9 4973.6 4976.5 4980.1 5035.5 5062.5 5065.5 5068.8 5078.5 5977.6 5984.0 5999.6 6007.2 6018.7 5903.6 7357.8 7371.9 7376.1 7376.1 1729.1 1756.7 1760.7 1763.3 1768.8 1023.2 1054.2 1059.1 1068.9 1069.0 6738.6 6791.0 6808.4 6854.8 6865.1 7366.5 7537.3 7564.9 7581.1 7589.7 6727.6 6870.9 6878.3 6900.9 6917.8 3286.5 3995.6 4025.6 4043.7 4048.0 8037.4 8046.4 8055.8 8066.1 8070.1 7659.5 7853.7 7885.1 7890.8 7897.4 7046.4 7357.9 8029.4 8037.6 8049.2 7629.7 7650.4 7662.9 7675.3 7707.2 7525.2 7539.3 7541.8 7545.8 7571.5 6524.6 7821.9 8023.9 8089.0 8114.9 4895.6 4950.0 4952.9 4955.3 4956.9 7397.4 7419.9 7427.9 7431.1 7439.8 7133.0 7168.3 7174.7 7182.5 7194.2 6936.3 7144.0 7157.9 7178.6 7189.7 5541.6 5620.6 6921.1 6998.2 7018.0 7068.2 7160.3 7163.6 7164.5 7176.5 5990.3 6253.6 6949.2 6990.1 7012.4 03:29:56 INFO - PROCESS | 1679 | 03:29:56 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:17725.83 Median:641.40 stddev:25092.01 (3912.1%) stddev-sans-first:25129.62 03:29:56 INFO - PROCESS | 1679 | Values: 643.3 709.6 750.0 756.1 782.7 14940.6 15015.5 15027.4 15075.0 15194.6 11302.9 13616.3 13683.8 13717.7 15441.8 925.5 930.8 937.8 939.1 946.1 900.2 920.8 933.0 933.9 936.7 939.5 979.4 980.5 984.8 988.4 948.5 953.9 966.5 983.0 985.7 693.4 693.6 717.0 718.0 731.5 15003.5 15216.8 15251.4 15265.7 15266.5 12329.6 12346.8 12517.2 12562.0 12807.6 9970.4 10169.8 10212.9 10231.0 10278.9 3427.6 3478.4 3494.1 3527.6 3537.9 59643.7 80744.2 81501.6 82904.0 83833.2 9133.4 9242.4 9550.5 9598.0 9608.0 21294.7 21340.4 21436.7 21511.8 21533.4 6925.1 6944.5 7032.2 7115.1 7184.4 3792.9 3999.7 4023.9 4068.8 4077.7 3370.5 3419.3 3424.3 3425.1 3426.7 609.9 622.6 632.2 639.5 644.7 479.7 528.5 570.8 582.7 594.2 8109.0 8190.0 8209.7 8214.9 8480.7 526.7 527.6 544.7 570.1 608.2 3296.3 3690.7 3770.8 3848.5 3887.7 77784.2 91504.5 91763.1 93681.0 95026.5 72036.6 76329.0 78666.6 79106.0 79521.0 65431.7 65807.0 66457.0 66589.7 67084.0 7582.6 7726.7 7891.8 7954.2 8088.0 47781.5 48399.5 49473.8 49512.8 49699.8 62018.7 67353.3 67754.7 68069.0 68856.0 9806.5 9987.4 10112.5 10139.9 10170.7 10762.0 10829.4 10848.8 10921.3 11579.0 8315.0 10285.2 10291.7 10378.4 10636.8 10135.8 10354.2 10689.3 10700.2 10890.3 9637.0 10110.3 10193.7 10288.6 10308.2 8811.6 8973.6 8980.3 9006.3 9024.9 8106.4 8454.0 8775.6 8787.3 8799.6 03:29:56 INFO - PROCESS | 1679 | -------- Summary: end -------- 03:29:56 INFO - PROCESS | 1679 | 03:29:57 INFO - TEST-INFO | 1679: exit 0 03:29:57 INFO - TEST-OK | dromaeo_css | took 1110611ms 03:29:57 INFO - TEST-START | kraken 03:29:57 INFO - operating with platform_type : mac_ 03:29:57 INFO - Initialising browser for kraken test... 03:29:57 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/tmpIUkf63/profile http://localhost:49279/getInfo.html) 03:30:00 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 03:30:00 INFO - PROCESS | 1688 | colorDepth:24 03:30:00 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 03:30:00 INFO - PROCESS | 1688 | __metrics 03:30:00 ERROR - PROCESS | 1688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:30:00 INFO - TEST-INFO | 1688: exit 0 03:30:00 INFO - Browser initialized. 03:30:00 INFO - Running cycle 1/1 for kraken test... 03:30:00 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/tmpIUkf63/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:12 INFO - PROCESS | 1692 | RSS: Main: 221368320 03:30:12 INFO - PROCESS | 1692 | 03:30:15 INFO - PROCESS | 1692 | 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) 03:30:16 INFO - PROCESS | 1692 | RSS: Main: 233127936 03:30:16 INFO - PROCESS | 1692 | 03:30:19 INFO - PROCESS | 1692 | 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) 03:30:19 INFO - PROCESS | 1692 | RSS: Main: 242069504 03:30:19 INFO - PROCESS | 1692 | 03:30:22 INFO - PROCESS | 1692 | 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) 03:30:23 INFO - PROCESS | 1692 | RSS: Main: 246661120 03:30:23 INFO - PROCESS | 1692 | 03:30:25 INFO - PROCESS | 1692 | 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) 03:30:26 INFO - PROCESS | 1692 | RSS: Main: 247496704 03:30:26 INFO - PROCESS | 1692 | 03:30:28 INFO - PROCESS | 1692 | 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) 03:30:29 INFO - PROCESS | 1692 | RSS: Main: 247582720 03:30:29 INFO - PROCESS | 1692 | 03:30:31 INFO - PROCESS | 1692 | 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) 03:30:32 INFO - PROCESS | 1692 | RSS: Main: 248156160 03:30:32 INFO - PROCESS | 1692 | 03:30:35 INFO - PROCESS | 1692 | 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) 03:30:35 INFO - PROCESS | 1692 | RSS: Main: 248127488 03:30:35 INFO - PROCESS | 1692 | 03:30:38 INFO - PROCESS | 1692 | 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) 03:30:39 INFO - PROCESS | 1692 | RSS: Main: 248107008 03:30:39 INFO - PROCESS | 1692 | 03:30:41 INFO - PROCESS | 1692 | 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) 03:30:41 INFO - PROCESS | 1692 | RSS: Main: 247390208 03:30:41 INFO - PROCESS | 1692 | 03:30:43 INFO - PROCESS | 1692 | 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) 03:30:44 INFO - PROCESS | 1692 | RSS: Main: 247615488 03:30:44 INFO - PROCESS | 1692 | 03:30:46 INFO - PROCESS | 1692 | 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) 03:30:47 INFO - PROCESS | 1692 | RSS: Main: 247721984 03:30:47 INFO - PROCESS | 1692 | 03:30:49 INFO - PROCESS | 1692 | 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) 03:30:50 INFO - PROCESS | 1692 | RSS: Main: 247918592 03:30:50 INFO - PROCESS | 1692 | 03:30:53 INFO - PROCESS | 1692 | 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) 03:30:53 INFO - PROCESS | 1692 | RSS: Main: 247873536 03:30:53 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | 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) 03:30:55 INFO - PROCESS | 1692 | RSS: Main: 249856000 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | __start_tp_report 03:30:55 INFO - PROCESS | 1692 | _x_x_mozilla_page_load 03:30:55 INFO - PROCESS | 1692 | _x_x_mozilla_page_load_details 03:30:55 INFO - PROCESS | 1692 | |i|pagename|runs| 03:30:55 INFO - PROCESS | 1692 | |0;ai-astar;113;124;117;117;120;117;106;117;116;120 03:30:55 INFO - PROCESS | 1692 | |1;audio-beat-detection;151;123;158;193;140;143;139;123;171;122 03:30:55 INFO - PROCESS | 1692 | |2;audio-dft;195;197;190;209;231;195;196;201;197;193 03:30:55 INFO - PROCESS | 1692 | |3;audio-fft;67;81;74;152;87;84;85;64;129;62 03:30:55 INFO - PROCESS | 1692 | |4;audio-oscillator;77;82;122;101;113;120;153;75;83;120 03:30:55 INFO - PROCESS | 1692 | |5;imaging-gaussian-blur;90;87;89;89;91;87;90;87;90;86 03:30:55 INFO - PROCESS | 1692 | |6;imaging-darkroom;96;96;95;96;95;96;95;111;151;123 03:30:55 INFO - PROCESS | 1692 | |7;imaging-desaturate;90;94;90;92;92;90;89;91;92;132 03:30:55 INFO - PROCESS | 1692 | |8;json-parse-financial;59;64;65;64;67;66;66;98;51;48 03:30:55 INFO - PROCESS | 1692 | |9;json-stringify-tinderbox;67;67;67;70;75;75;67;68;67;89 03:30:55 INFO - PROCESS | 1692 | |10;stanford-crypto-aes;83;83;75;81;83;82;84;81;85;83 03:30:55 INFO - PROCESS | 1692 | |11;stanford-crypto-ccm;127;155;146;153;152;129;130;136;186;159 03:30:55 INFO - PROCESS | 1692 | |12;stanford-crypto-pbkdf2;168;169;173;165;172;166;183;171;166;172 03:30:55 INFO - PROCESS | 1692 | |13;stanford-crypto-sha256-iterative;69;67;66;69;66;68;66;70;66;71 03:30:55 INFO - PROCESS | 1692 | __end_tp_report 03:30:55 INFO - PROCESS | 1692 | __start_cc_report 03:30:55 INFO - PROCESS | 1692 | _x_x_mozilla_cycle_collect,1088 03:30:55 INFO - PROCESS | 1692 | __end_cc_report 03:30:55 INFO - PROCESS | 1692 | __startTimestamp1464431455857__endTimestamp 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | ------- Summary: start ------- 03:30:55 INFO - PROCESS | 1692 | Number of tests: 14 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#0] ai-astar Cycles:10 Average:116.70 Median:117.00 stddev:4.76 (4.1%) stddev-sans-first:4.86 03:30:55 INFO - PROCESS | 1692 | Values: 113.0 124.0 117.0 117.0 120.0 117.0 106.0 117.0 116.0 120.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:147.00 stddev:22.93 (15.6%) stddev-sans-first:24.25 03:30:55 INFO - PROCESS | 1692 | Values: 151.0 123.0 158.0 193.0 140.0 143.0 139.0 123.0 171.0 122.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#2] audio-dft Cycles:10 Average:200.40 Median:197.00 stddev:11.90 (6.0%) stddev-sans-first:12.46 03:30:55 INFO - PROCESS | 1692 | Values: 195.0 197.0 190.0 209.0 231.0 195.0 196.0 201.0 197.0 193.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#3] audio-fft Cycles:10 Average:88.50 Median:77.50 stddev:29.32 (37.8%) stddev-sans-first:30.05 03:30:55 INFO - PROCESS | 1692 | Values: 67.0 81.0 74.0 152.0 87.0 84.0 85.0 64.0 129.0 62.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:114.00 stddev:25.43 (22.3%) stddev-sans-first:24.93 03:30:55 INFO - PROCESS | 1692 | Values: 77.0 82.0 122.0 101.0 113.0 120.0 153.0 75.0 83.0 120.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:89.50 stddev:1.71 (1.9%) stddev-sans-first:1.74 03:30:55 INFO - PROCESS | 1692 | Values: 90.0 87.0 89.0 89.0 91.0 87.0 90.0 87.0 90.0 86.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#6] imaging-darkroom Cycles:10 Average:105.40 Median:95.50 stddev:18.55 (19.4%) stddev-sans-first:19.37 03:30:55 INFO - PROCESS | 1692 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 95.0 111.0 151.0 123.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:91.50 stddev:13.01 (14.2%) stddev-sans-first:13.66 03:30:55 INFO - PROCESS | 1692 | Values: 90.0 94.0 90.0 92.0 92.0 90.0 89.0 91.0 92.0 132.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.50 stddev:13.41 (20.5%) stddev-sans-first:14.05 03:30:55 INFO - PROCESS | 1692 | Values: 59.0 64.0 65.0 64.0 67.0 66.0 66.0 98.0 51.0 48.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:69.00 stddev:7.04 (10.2%) stddev-sans-first:7.30 03:30:55 INFO - PROCESS | 1692 | Values: 67.0 67.0 67.0 70.0 75.0 75.0 67.0 68.0 67.0 89.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:83.00 stddev:2.75 (3.3%) stddev-sans-first:2.89 03:30:55 INFO - PROCESS | 1692 | Values: 83.0 83.0 75.0 81.0 83.0 82.0 84.0 81.0 85.0 83.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:152.50 stddev:18.02 (11.8%) stddev-sans-first:17.56 03:30:55 INFO - PROCESS | 1692 | Values: 127.0 155.0 146.0 153.0 152.0 129.0 130.0 136.0 186.0 159.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.50 stddev:5.23 (3.1%) stddev-sans-first:5.47 03:30:55 INFO - PROCESS | 1692 | Values: 168.0 169.0 173.0 165.0 172.0 166.0 183.0 171.0 166.0 172.0 03:30:55 INFO - PROCESS | 1692 | 03:30:55 INFO - PROCESS | 1692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.87 (2.7%) stddev-sans-first:1.94 03:30:55 INFO - PROCESS | 1692 | Values: 69.0 67.0 66.0 69.0 66.0 68.0 66.0 70.0 66.0 71.0 03:30:55 INFO - PROCESS | 1692 | -------- Summary: end -------- 03:30:55 INFO - PROCESS | 1692 | 03:30:56 INFO - TEST-INFO | 1692: exit 0 03:30:56 INFO - TEST-OK | kraken | took 59627ms 03:30:56 INFO - SUITE-END | took 1170s 03:30:57 INFO - Completed test suite (00:19:30) 03:30:57 INFO - javascript benchmark 03:30:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.9508457373145, 3417.094469965458, 3447.103753024213, 3459.446488561829, 3488.860445582177, 5518.365387980373, 5547.556195504355, 5548.500634942854, 5550.139728342103, 5614.270144881165, 5515.4760297771745, 5529.474699903502, 5559.388467268597, 5583.609147359686, 5584.944150558493, 5087.592992560586, 5115.590752739772, 5138.177891537355, 5142.485751424846, 5172.09488339541, 4844.806207751686, 5035.521625445577, 5118.641695081327, 5197.818076367309, 5294.047071527124, 5194.766235519392, 5200.08998425276, 5201.739913004353, 5203.9219411708855, 5211.5049070338255, 5155.974220128913, 5169.198774190007, 5213.426523082477, 5244.108501554745, 5275.050490911634, 5024.974875125601, 5117.6161787865685, 5118.564921981636, 5131.820386286499, 5160.329157209576, 4352.477702675667, 5425.104857698475, 5482.945170548323, 5509.256250406184, 5548.611597188198, 5851.210086638292, 6123.295820980599, 6143.723532441051, 6147.969260153715, 6161.691915404212, 6135.386461353829, 6186.783462578788, 6190.907136392958, 6207.4723648489935, 6213.844653883644, 5745.052066409037, 5759.704066585026, 5762.654240745569, 5767.36558978512, 5772.0476121439915, 6141.915626108677, 6191.938080619227, 6232.127502149703, 6293.0, 6331.905021424683, 6049.606775559574, 6051.667158306335, 6054.727537260834, 6070.757169713251, 6131.386861313833, 6150.846228844225, 6158.414950579688, 6163.660998645118, 6173.9073913891325, 6177.042558403455, 4900.0, 5953.047512398082, 6053.667048312385, 6108.419700128481, 6109.327973922865, 6108.358622344679, 6114.449440885012, 6136.447719705248, 6147.692615369214, 6158.846028849225, 4783.6651434399255, 4897.14299997499, 4912.1158191525155, 4916.06594746997, 4945.975270123627, 4305.095929854703, 4311.267084595626, 4379.189849877783, 4396.098799746044, 4416.9620139267245, 4773.451053128865, 5559.8888022240135, 5620.887582248332, 5627.43725627434, 5667.149927510906, 5621.943780562224, 5735.11105778605, 5780.84383123377, 6098.420650038239, 6123.908141377883, 4492.0, 5586.469285417878, 5596.664200148004, 5625.803096891589, 5665.915011274834, 5297.0, 5325.8934821303355, 5349.331333583302, 5358.678479291177, 5359.222912677717, 6276.905846412307, 6292.182016337847, 6304.65324407162, 6351.047342898694, 6378.808635740936, 6008.459238668541, 6103.05402662588, 6130.000698177663, 6132.47873930703, 6139.508839292756, 5331.360236771612, 6173.290071641819, 6236.906446403398, 6341.90487142684, 6355.110284560258, 6034.818955431344, 6036.215292012011, 6036.577439579188, 6036.728347224298, 6042.667653279112, 5971.044632858721, 6028.849278768066, 6086.178365920544, 6100.1459795629535, 6103.176071230327, 5128.1794912813775, 5849.736761845812, 5927.525797936241, 5971.880562388815, 6057.545684073801, 4380.540043295536, 5702.8289151325525, 5891.558133139946, 5971.3132989705, 5995.670238136944, 5629.183768353648, 5825.126231065374, 5832.358440571449, 5840.912386314124, 5848.883022339444, 5943.138244954544, 5959.582829202088, 5985.610935289193, 6025.548083893813, 6061.212042434456, 5825.3883342248455, 5844.853878652898, 5865.589408741347, 5882.205902203148, 5883.646981181143], "value": 5567.659083388896, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.61887727572486, 528.7831988884557, 561.444170271431, 599.3706608061535, 620.3207487800856, 35597.11007224821, 38919.610803891956, 38978.0, 39013.02467438315, 39023.60976390235, 40870.0, 40967.38548921761, 41459.37810932838, 41506.37740433896, 41510.58489415105, 8734.475931444134, 9180.265578753717, 9405.247580193585, 9705.514724263794, 9734.172595329406, 9576.904230957705, 9697.999999999965, 9723.562439690195, 9822.705318840446, 9886.604535818558, 9762.658306959258, 9814.901850981505, 9831.65589204378, 9839.163671087967, 9854.950725246365, 8640.351973602004, 9640.276979226515, 9720.854187187198, 9807.019298070207, 9869.555869985832, 9652.083052110109, 9717.076877696607, 9809.754756131082, 9814.90185098147, 10296.536655850505, 39119.217615647525, 39149.217015659815, 39289.41065884014, 39564.60435395667, 39692.801535992425, 3164.2722173900133, 3669.376206044979, 3757.248550289953, 3822.7132965027454, 3838.5777564467885, 25238.0, 28019.299517512023, 28664.713352866413, 28899.133026009255, 29109.708902910912, 2740.410811675499, 2788.3029242689327, 2801.341684704093, 2873.956890646642, 2874.7412732853936, 335972.0, 336837.0, 338706.0, 340910.0, 340939.9999999975, 60190.9904504773, 61278.693606531684, 61493.69253153705, 61872.690636546526, 62044.0, 48957.51042489529, 64971.675141623986, 65846.36614535461, 66157.33842661511, 66294.0, 16190.676186476205, 16669.83330166707, 16678.0, 16921.57696057584, 16950.57623559421, 12505.249685018927, 12906.67733306656, 12991.610251692464, 12999.740005199843, 13048.869511304956, 16109.516714498584, 16303.91848040776, 16332.428365007405, 16334.18329083541, 16772.0, 6181.258249010148, 7231.938897414317, 7309.966363958897, 7336.413086953031, 7394.963025184839, 912.397817440486, 962.6341990043738, 965.2278177458005, 983.326421401328, 997.67575537949, 28353.574696379572, 29876.253093672396, 30052.0, 30550.54174187389, 30561.08316750501, 1063.5373612478597, 1091.5961094394966, 1122.9719257018476, 1123.337231033694, 1125.150511363915, 15042.097474151586, 15488.5353439397, 15602.0, 15625.531234062997, 15812.446564370191, 602967.9703203, 603206.0, 607168.0, 607987.9600601968, 612509.0, 59563.702181488814, 60312.79374412487, 60569.69715151484, 60932.0, 61173.38826611766, 1486.598618373055, 1492.634304595381, 1503.240863363994, 1512.901661392006, 1519.54413675899, 29541.85229073841, 29754.10737677873, 29877.551836722032, 30382.84808575943, 30523.389532209676, 50883.0, 50885.23672144847, 51028.0, 51445.7427712874, 51656.74171629118, 567269.0, 570931.0, 571090.0, 571591.0, 572721.0, 38016.0, 39702.2059558813, 39949.0, 40275.3958690614, 41155.58844411517, 45622.771886140355, 45674.77162614166, 45780.31329530126, 46857.297140542236, 47689.5231047699, 37564.24871502609, 38390.808045959595, 38629.613703862604, 39263.41104883486, 39479.60520394874, 37497.00813786496, 38271.234575308896, 38667.613323866404, 38784.22431551297, 38973.0, 27077.72922270752, 32380.514292285163, 37691.43462848005, 38695.0, 39463.80268098641, 24987.37582057233, 32144.0, 32833.50749738803, 32930.152222790275, 33294.667053329154, 21293.893530532867, 23781.335306528377, 25180.0, 25184.0, 25197.37006574777], "value": 19795.754912045057, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.2605007210902, 395.61427608082107, 399.3969106648959, 405.7829061452123, 408.8957315884451, 15613.765793513106, 15786.921065394685, 17275.913620431882, 20224.39326820196, 20981.74109553428, 11790.882091179086, 12304.81542776859, 20142.798572014275, 20593.588128237465, 20649.793502064975, 5210.635255532105, 5384.596155288349, 5402.810901618444, 5404.891902161954, 5417.26866872971, 5177.145770947789, 5382.515573598375, 5396.325459317585, 5426.62013659044, 5450.700211488366, 4718.4337879454515, 5311.415744268127, 5340.439253878345, 5414.675119492843, 5432.91850622241, 5289.656172348804, 5374.086405311087, 5417.972910135444, 5575.804846830341, 5887.70561471929, 5767.1349297605275, 5786.971065144689, 5795.594308398414, 5797.594168408213, 5799.739011744439, 24711.38221544476, 25976.0, 25997.609323637775, 26158.476830463285, 26734.46531069387, 2115.069369477425, 2196.3410976706923, 2369.336585755991, 2396.4488167721347, 2822.237995741159, 9777.511124443748, 10205.38767673942, 10279.537420816081, 12835.358232088358, 14049.08680935746, 1706.3771723321022, 1729.2304924308687, 1762.436020473449, 1767.6729804986119, 1768.5401795533126, 111405.0, 114418.42790785992, 117324.82675173224, 119026.40486797597, 119712.80287197104, 9789.706308810748, 11927.642170734893, 11954.222975506738, 12123.696907577381, 12182.329971851634, 15236.771448428282, 15300.158491283086, 15301.6174595636, 15316.540503784905, 15377.769333460006, 6820.761273355409, 8935.642574296955, 8986.460812351279, 9025.503597302211, 9046.909530904739, 8961.910380896237, 8988.59551320192, 8995.055519170524, 9019.503927283931, 9116.1339672731, 3978.741381810173, 4691.132140554008, 4741.857744267678, 4790.808367665324, 4792.592629626451, 1956.9412917612494, 2000.739903812495, 2005.7994200579826, 2047.4676584088245, 2054.5479994401207, 761.4213197969473, 876.2639382918252, 962.3840741925173, 969.9418034917927, 984.9704508864745, 19522.316718914768, 20000.399988000383, 20140.093695783726, 20281.797182028287, 20478.283260085824, 949.4161090929028, 955.5604421965835, 973.1387721866058, 995.711243739322, 1035.668586052471, 8555.99068061275, 10581.365118092785, 10621.787564248672, 10666.679999600025, 10774.407407592658, 616138.0, 622108.0, 636076.0, 643684.0, 644968.0, 99121.6263372511, 110899.0, 114541.0, 116726.41636791761, 119985.0, 940.4921342475124, 949.4303417949175, 958.4872093429982, 966.79213968997, 968.6270785747538, 17832.821671783637, 18178.545536361697, 18204.544886377946, 18221.726674099635, 18514.259429623202, 50089.74955125201, 50901.472955809906, 52128.99999999848, 52846.735766320926, 53005.20492192543, 73211.26788732044, 74165.62917185595, 74398.0, 75236.49527009539, 76370.6181469089, 7819.296263336099, 7954.84090318202, 7968.16334284915, 7983.72056978003, 7992.6802927884555, 8753.6936207235, 10024.74690663667, 11740.0, 11866.288022718665, 12170.634880953585, 8644.827103458021, 8884.955575222082, 10379.858215596429, 10641.04230619248, 11008.944955275492, 10704.678859634223, 10720.678379648623, 11113.333200008025, 11127.22109452363, 11150.944245278723, 11281.830772538582, 11328.150388721044, 11402.94298528502, 11463.369514676773, 11465.426728663366, 8301.418900676894, 8305.543195124326, 8389.622466989122, 8478.788030299293, 8509.446885952393, 6438.356164383524, 6528.824811533969, 7752.3798096153305, 7783.338416234684, 8563.529005904735], "value": 9261.54201504607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.6636007358234, 1559.5945054285885, 1788.3919467381088, 1886.9433916982478, 1933.2460340467212, 7842.176571460001, 8489.278411335028, 8518.787030324245, 8740.737777866667, 8784.5607719614, 8537.57312134394, 8557.400981931267, 8638.17937295956, 8682.435641683287, 8693.304535637133, 2423.1397853761882, 2449.5835707929605, 2456.7174774900845, 2457.201409541897, 2457.7665121813397, 2411.2884020004713, 2447.7674620911075, 2449.497852940152, 2451.4361696809747, 2458.766417190373, 2430.234476140019, 2430.295214387834, 2436.3909022744315, 2462.384403899025, 2465.4329504214043, 2359.362971997551, 2400.087966572709, 2438.5366780311683, 2443.4380092578717, 2450.534398464295, 2405.542946840095, 2422.527607116613, 2426.8301218914685, 2426.9393265168337, 2427.708674959016, 8735.43219690718, 8804.515751633657, 8807.471551706918, 8820.779480512974, 8824.205821476035, 5257.553107985826, 5299.205119232108, 5371.167469042305, 5412.512873841373, 5420.214068959979, 3401.4727717203873, 3447.827608619559, 3453.205762674599, 3483.9477407838904, 3493.406120959443, 839.7816567692444, 966.6906589891238, 978.2711879649636, 989.3816364772017, 1014.1683819268203, 11577.6526704199, 11627.534898604046, 11678.124140689397, 11739.236949598335, 11797.351145686984, 4680.695754775928, 4806.182948898696, 4816.446108697474, 4816.783244753994, 4820.108279968217, 10046.748831279276, 10096.899031009596, 10111.949440252753, 10113.747156321151, 10123.1901447884, 4611.169989401873, 5303.257543943851, 5329.54698850602, 5366.838994830161, 5393.406725260218, 4389.539098394686, 4784.784684689197, 4811.639127065484, 4874.4150701916, 4877.219644856806, 4004.939925901114, 4005.7997100144876, 4074.103697186614, 4084.264832330209, 4114.218298523271, 1349.8582648821732, 1360.9591712248648, 1364.4070746297025, 1367.9931600341934, 1375.8280214973129, 844.9185043144785, 846.3271698999188, 858.3262139220807, 939.145377706284, 943.6178347769164, 5022.246663000579, 5723.656580605177, 5831.011146496799, 5851.561132915049, 5873.177755114288, 910.5037754423855, 955.2214944820089, 973.5764942250003, 983.9458829764288, 1007.8437842134481, 3620.8551657933913, 3808.6762625176616, 3888.9027774305305, 3928.64642182205, 3972.7020473464604, 10139.898601014043, 10302.0, 10454.111400530888, 10504.474776261157, 10536.420496872592, 10099.14157296638, 10348.637797677045, 10391.220658450646, 10435.32170408921, 10437.947810261052, 8163.755087347389, 8283.544405057659, 8299.792505187419, 8364.749057528163, 8393.0, 5542.861428464321, 5628.127640215773, 5636.605437619327, 5694.943050569441, 5724.341700704473, 7081.82295442618, 8087.919120808717, 8410.579471026547, 9341.486218258062, 9553.665621703207, 9466.715998520056, 9766.75583110428, 9881.50592470388, 9882.752931176778, 10146.898531014891, 6354.6822658867795, 6601.174853143357, 6757.087793147862, 7014.298570142945, 7101.183363913009, 7872.212778722082, 7885.1720569339395, 7966.3626909848235, 7969.043714754266, 7972.960135199519, 6943.201531823703, 7061.2585678505075, 7099.680514376762, 7147.392471639969, 7188.964055179691, 6889.517733758589, 6923.6192009439965, 6983.930160698328, 7041.155061392461, 7077.186123595852, 6667.233268174028, 6695.933040669531, 6746.730130794714, 6802.455803535804, 6816.693248803716, 4717.033008233372, 4775.641826863069, 4781.163296423181, 4790.688605240648, 4795.160846851857, 4808.543188397097, 4812.735299558558, 4816.638752093537, 4888.853334399973, 5020.673656212334], "value": 4531.76913373977, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.8505687383804, 325.5231086458338, 331.76113198497075, 334.31131868351184, 337.6370401818046, 5504.4495550444935, 6688.799336019921, 6775.932240677592, 6781.966090169549, 6815.5569887957245, 6759.45924326054, 6761.154855643044, 6784.966075169629, 6790.490713196517, 6830.146231721035, 4823.734694591796, 4886.51134886512, 5027.195648696209, 5028.924566131493, 5040.966601846612, 4126.7523948563185, 4957.876053098684, 5027.572656324217, 5051.242313652963, 5102.897942041157, 5015.974920125394, 5043.1678773002595, 5049.545540901318, 5051.267566202899, 5088.491150884919, 4091.8158682859344, 4515.63874890008, 4645.606318104555, 5021.673591216596, 5060.974695126538, 4327.37253098299, 4329.393884856123, 4339.652827773771, 4340.457442819647, 4344.326629372453, 5555.722213889289, 6295.0, 6565.704543295516, 6626.801195964129, 6660.800175994679, 5927.407259274081, 5933.762649494015, 5995.100734889757, 5995.61028533144, 6024.367441418632, 6180.85654153983, 7042.859142817115, 7289.343959043712, 7290.63546822662, 7299.19708832028, 4817.638677099197, 4834.637402194814, 4844.2733589961435, 4862.319275301461, 4874.902501949977, 7478.588677622729, 7743.148253692089, 7773.494722842997, 7803.414743894174, 7806.687732490694, 4331.870043898688, 4965.851024469272, 4973.577245934136, 4976.5023497649945, 4980.12847751642, 5035.471275516092, 5062.544371006627, 5065.544101030851, 5068.82259120929, 5078.5175408336145, 5977.581569290108, 5983.982722937111, 5999.5500337473995, 6007.15899774032, 6018.729157187937, 5903.616264942765, 7357.8160545986775, 7371.894215867663, 7376.077990251219, 7376.114866216089, 1729.0663041957202, 1756.7452719355622, 1760.7358896165679, 1763.2858692229668, 1768.8408043276168, 1023.1814548361281, 1054.2409465185056, 1059.1473863539925, 1068.9198310126772, 1068.9946550267355, 6738.629375384303, 6791.0, 6808.4212841908, 6854.8004099282425, 6865.141857267841, 7366.521176123535, 7537.283958024089, 7564.865270209512, 7581.090269167625, 7589.696412143452, 6727.596344219362, 6870.896936545956, 6878.312168783082, 6900.930990690129, 6917.792466226021, 3286.5234540991423, 3995.62041606047, 4025.5974402560096, 4043.6562892153906, 4048.0, 8037.437379383387, 8046.356291496666, 8055.758327250074, 8066.072401673765, 8070.112287648354, 7659.502132361378, 7853.7251196209, 7885.093214280317, 7890.842183156305, 7897.447178697551, 7046.43628509718, 7357.926420735724, 8029.357651387875, 8037.598120093972, 8049.182786024844, 7629.7329593463965, 7650.426218033558, 7662.923370766221, 7675.347595454449, 7707.15221325665, 7525.2098529653595, 7539.32146106853, 7541.849163016818, 7545.849083018199, 7571.545707257582, 6524.608523488606, 7821.882671759814, 8023.919760802551, 8088.988876390451, 8114.918850811417, 4895.608351331956, 4949.950500494949, 4952.876178095432, 4955.2567114933045, 4956.925646115384, 7397.445191610758, 7419.851602968019, 7427.888581671387, 7431.108267007994, 7439.776806695808, 7133.0, 7168.2831716827895, 7174.748883789042, 7182.4613154014705, 7194.2086370498155, 6936.34104760047, 7143.999840022505, 7157.928420715726, 7178.5692858428665, 7189.7483588074165, 5541.639793413416, 5620.634658747168, 6921.1002569665625, 6998.16022077354, 7017.964910175417, 7068.187158476635, 7160.283971602798, 7163.606001669749, 7164.462665300019, 7176.533525320838, 5990.251218597676, 6253.624782513064, 6949.166100068024, 6990.09128813251, 7012.439004879496], "value": 5298.118991499614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.276314146585, 709.58489283769, 749.9850002999937, 756.1455555222598, 782.7456076775046, 14940.5517834465, 15015.47445839396, 15027.398904043852, 15075.0, 15194.620134496628, 11302.886971130287, 13616.319184040807, 13683.794743078863, 13717.72564548711, 15441.845581544181, 925.5233554719308, 930.8091841172543, 937.8311903857303, 939.1219210038636, 946.1012038563358, 900.1718419054453, 920.7744102694849, 932.9953350233274, 933.9299552533587, 936.7377134402378, 939.4926739560664, 979.3829887171108, 980.5293459139617, 984.8375018122001, 988.3575675810708, 948.4641177734593, 953.9379940303858, 966.5360626899128, 982.9606815727362, 985.6845809340978, 693.4036728413561, 693.5699866083061, 717.0248462091552, 718.0127324928224, 731.4769939493287, 15003.549893503212, 15216.847831521654, 15251.38994440221, 15265.694686106215, 15266.542003739905, 12329.568465103768, 12346.753064938652, 12517.186382885175, 12562.0, 12807.615771526776, 9970.40177589347, 10169.796604067877, 10212.897871021269, 10231.0, 10278.948605257001, 3427.622961474236, 3478.4260597001467, 3494.0740703713536, 3527.629598892105, 3537.876174333912, 59643.70178149125, 80744.19255807484, 81501.59249203776, 82904.0, 83833.16166838315, 9133.40632858862, 9242.445453272825, 9550.474723890115, 9597.952010239904, 9608.0, 21294.680579791315, 21340.35978920604, 21436.678449823266, 21511.784882151293, 21533.353999380044, 6925.099737034153, 6944.51388402807, 7032.226455089936, 7115.1106111736035, 7184.425245980309, 3792.867249646249, 3999.7400168988925, 4023.939640905389, 4068.7558746475306, 4077.7145599808323, 3370.4607262838317, 3419.316136772655, 3424.298018906118, 3425.0581090200394, 3426.691597756214, 609.9268087829489, 622.5859803230892, 632.181325183888, 639.5171645407687, 644.7324360390479, 479.7385424943414, 528.4715284715285, 570.823044856096, 582.7115577788937, 594.2275042444804, 8108.959455202804, 8190.017197936286, 8209.671613135408, 8214.917850821535, 8480.703175388955, 526.6655673647261, 527.6148411659433, 544.6595877576515, 570.1447828257614, 608.2427377914524, 3296.258341873059, 3690.6862916652385, 3770.811459427018, 3848.4804551385764, 3887.6501114899793, 77784.22215777883, 91504.54247728719, 91763.08236917679, 93681.0, 95026.52486737522, 72036.63981680163, 76329.0, 78666.60666696745, 79106.0, 79521.0, 65431.67284163644, 65807.0, 66457.0, 66589.6682066356, 67084.0, 7582.582957937367, 7726.729564465441, 7891.84216315682, 7954.244346787046, 8088.0, 47781.522184779096, 48399.5160048395, 49473.75263123661, 49512.76218094576, 49699.75150124226, 62018.68990655018, 67353.32646673471, 67754.66122669552, 68069.0, 68856.0, 9806.460644664612, 9987.350822196535, 10112.544935477774, 10139.898601013896, 10170.74573135648, 10762.0, 10829.350238985686, 10848.783024339627, 10921.290116142425, 11578.957893789599, 8315.0, 10285.228607854291, 10291.691249262534, 10378.42918639482, 10636.787264254826, 10135.797284054424, 10354.223433242687, 10689.25175237757, 10700.197485188797, 10890.29213101146, 9637.0, 10110.292279540656, 10193.74515637115, 10288.588456461657, 10308.175345972455, 8811.603477843384, 8973.551322433721, 8980.326475514232, 9006.324525660733, 9024.864627030469, 8106.351491880518, 8453.995079475684, 8775.648974040967, 8787.25308348772, 8799.648014079365], "value": 6702.551881135053, "unit": "score"}], "name": "dromaeo_css", "value": 7400.581276248607, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 124.0, 117.0, 117.0, 120.0, 117.0, 106.0, 117.0, 116.0, 120.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 158.0, 193.0, 140.0, 143.0, 139.0, 123.0, 171.0, 122.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 197.0, 190.0, 209.0, 231.0, 195.0, 196.0, 201.0, 197.0, 193.0], "value": 200.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 81.0, 74.0, 152.0, 87.0, 84.0, 85.0, 64.0, 129.0, 62.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 122.0, 101.0, 113.0, 120.0, 153.0, 75.0, 83.0, 120.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 89.0, 91.0, 87.0, 90.0, 87.0, 90.0, 86.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 111.0, 151.0, 123.0], "value": 105.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 90.0, 92.0, 92.0, 90.0, 89.0, 91.0, 92.0, 132.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 65.0, 64.0, 67.0, 66.0, 66.0, 98.0, 51.0, 48.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 70.0, 75.0, 75.0, 67.0, 68.0, 67.0, 89.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 75.0, 81.0, 83.0, 82.0, 84.0, 81.0, 85.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 155.0, 146.0, 153.0, 152.0, 129.0, 130.0, 136.0, 186.0, 159.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 173.0, 165.0, 172.0, 166.0, 183.0, 171.0, 166.0, 172.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 69.0, 66.0, 68.0, 66.0, 70.0, 66.0, 71.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1549.3, "alertThreshold": 2.0}]} 03:30:57 INFO - Return code: 0 03:30:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:30:57 ERROR - # TBPL SUCCESS # 03:30:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:30:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:30:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:30:57 INFO - 2016-05-28 03:30:57.161 screenresolution[1697:12105] starting screenresolution argv=screenresolution get 03:30:57 INFO - 2016-05-28 03:30:57.164 screenresolution[1697:12105] Display 0: 1600x1200x32@60 03:30:57 INFO - 2016-05-28 03:30:57.171 screenresolution[1698:12108] starting screenresolution argv=screenresolution list 03:30:57 INFO - Available Modes on Display 0 03:30:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:30:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:30:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:30:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:30:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:30:57 INFO - Intel Iris: 03:30:57 INFO - Chipset Model: Intel Iris 03:30:57 INFO - Type: GPU 03:30:57 INFO - Bus: Built-In 03:30:57 INFO - VRAM (Dynamic, Max): 1536 MB 03:30:57 INFO - Vendor: Intel (0x8086) 03:30:57 INFO - Device ID: 0x0a2e 03:30:57 INFO - Revision ID: 0x0009 03:30:57 INFO - Displays: 03:30:57 INFO - Display: 03:30:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:30:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:30:57 INFO - Display Serial Number: 1600x1200 60 03:30:57 INFO - Main Display: Yes 03:30:57 INFO - Mirror: Off 03:30:57 INFO - Online: Yes 03:30:57 INFO - Rotation: Supported 03:30:57 INFO - Return code: 0 03:30:57 INFO - Running post-action listener: _resource_record_post_action 03:30:57 INFO - Running post-run listener: _resource_record_post_run 03:30:58 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 31776256; Write bytes: 656761856; Read time: 327; Write time: 1894 03:30:58 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 346853888; Write bytes: 346855424; Read time: 27862; Write time: 656 03:30:58 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30002688; Write bytes: 299113472; Read time: 307; Write time: 1203 03:30:58 INFO - Running post-run listener: _upload_blobber_files 03:30:58 INFO - Blob upload gear active. 03:30:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:30:58 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 03:30:58 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:30:58 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:30:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:59 INFO - (blobuploader) - INFO - Done attempting. 03:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:00 INFO - (blobuploader) - INFO - Done attempting. 03:31:00 INFO - (blobuploader) - INFO - Iteration through files over. 03:31:00 INFO - Return code: 0 03:31:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:31:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:31:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13756b0af468a89d3324828af659c18140bd0af439b65167a3af2e2e38445bc1547c5b48614087a75c840bdadaa5770c16192c42b955e935c7e70f87aa81e2c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff109a3c4dc244dc17996a0cae45928396283f7b7ae4d8299f481ae5b1551511fc0cd79395deabc3c882a61268e6e1759688ae3eb57666ea502b0b3e1fa07082"} 03:31:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:31:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:31:00 INFO - Contents: 03:31:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13756b0af468a89d3324828af659c18140bd0af439b65167a3af2e2e38445bc1547c5b48614087a75c840bdadaa5770c16192c42b955e935c7e70f87aa81e2c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff109a3c4dc244dc17996a0cae45928396283f7b7ae4d8299f481ae5b1551511fc0cd79395deabc3c882a61268e6e1759688ae3eb57666ea502b0b3e1fa07082"} 03:31:00 INFO - Running post-run listener: copy_logs_to_upload_dir 03:31:00 INFO - Copying logs to upload dir... 03:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs 03:31:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.139035 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-28 03:31:01.459663) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:01.462681) ========= 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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners TMPDIR=/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13756b0af468a89d3324828af659c18140bd0af439b65167a3af2e2e38445bc1547c5b48614087a75c840bdadaa5770c16192c42b955e935c7e70f87aa81e2c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff109a3c4dc244dc17996a0cae45928396283f7b7ae4d8299f481ae5b1551511fc0cd79395deabc3c882a61268e6e1759688ae3eb57666ea502b0b3e1fa07082"} build_url:https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/VMwW5X-0T7OWqS8rPjT9Yg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13756b0af468a89d3324828af659c18140bd0af439b65167a3af2e2e38445bc1547c5b48614087a75c840bdadaa5770c16192c42b955e935c7e70f87aa81e2c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff109a3c4dc244dc17996a0cae45928396283f7b7ae4d8299f481ae5b1551511fc0cd79395deabc3c882a61268e6e1759688ae3eb57666ea502b0b3e1fa07082"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:01.494027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:01.494338) ========= 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.GpwuDFOjLx/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.vgyGn8Hivv/Listeners TMPDIR=/var/folders/np/clqv8frd41g38z3rj4xsbrlc00000w/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.005467 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:01.542790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:31:01.543071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:31:01.543378) ========= ========= Total master_lag: 0.63 =========