builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0339 starttime: 1465220215.34 results: success (0) buildid: 20160606010529 builduid: 78750d9664274d05bee96204469a3a74 revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:55.337428) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:55.337852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:55.338139) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:55.363774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:55.364185) ========= 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.o7jxJXToAw/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.u5W6XL06sB/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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-06-06 06:36:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-06-06 06:36:55 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091699 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:55.611222) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:55.611541) ========= 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.o7jxJXToAw/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.u5W6XL06sB/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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.025223 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:55.655913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:36:55.656267) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --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 d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.o7jxJXToAw/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.u5W6XL06sB/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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-06-06 06:36:55,685 truncating revision to first 12 chars 2016-06-06 06:36:55,685 Setting DEBUG logging. 2016-06-06 06:36:55,685 attempt 1/10 2016-06-06 06:36:55,685 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d8adb38dd576?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 06:36:56,311 unpacking tar archive at: mozilla-aurora-d8adb38dd576/testing/mozharness/ program finished with exit code 0 elapsedTime=0.910665 ========= master_lag: 0.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 06:36:56.939769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:56.940116) ========= script_repo_revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:56.940505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:56.940770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:36:56.958802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-06 06:36:56.959161) ========= /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.o7jxJXToAw/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.u5W6XL06sB/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:36:57 INFO - MultiFileLogger online at 20160606 06:36:57 in /builds/slave/test 06:36:57 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 06:36:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:57 INFO - {'append_to_log': False, 06:36:57 INFO - 'base_work_dir': '/builds/slave/test', 06:36:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:36:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:57 INFO - 'branch': 'Mozilla-Aurora', 06:36:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:57 INFO - 'config_files': ('talos/mac_config.py',), 06:36:57 INFO - 'default_actions': ('clobber', 06:36:57 INFO - 'read-buildbot-config', 06:36:57 INFO - 'download-and-extract', 06:36:57 INFO - 'populate-webroot', 06:36:57 INFO - 'create-virtualenv', 06:36:57 INFO - 'install', 06:36:57 INFO - 'run-tests'), 06:36:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:57 INFO - 'download_minidump_stackwalk': True, 06:36:57 INFO - 'download_symbols': 'ondemand', 06:36:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:57 INFO - 'installer_path': 'installer.exe', 06:36:57 INFO - 'log_level': 'info', 06:36:57 INFO - 'log_name': 'talos', 06:36:57 INFO - 'log_to_console': True, 06:36:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:36:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:36:57 INFO - 'opt_config_files': (), 06:36:57 INFO - 'pip_index': False, 06:36:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:57 INFO - 'cmd': ('bash', 06:36:57 INFO - '-c', 06:36:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:57 INFO - 'enabled': True, 06:36:57 INFO - 'halt_on_failure': False, 06:36:57 INFO - 'name': 'check_screen_resolution'},), 06:36:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:57 INFO - 'cmd': ('bash', 06:36:57 INFO - '-c', 06:36:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:57 INFO - 'enabled': True, 06:36:57 INFO - 'halt_on_failure': False, 06:36:57 INFO - 'name': 'check_screen_resolution'},), 06:36:57 INFO - 'run_cmd_checks_enabled': True, 06:36:57 INFO - 'sps_profile': False, 06:36:57 INFO - 'sps_profile_interval': 0, 06:36:57 INFO - 'suite': 'dromaeojs-e10s', 06:36:57 INFO - 'system_bits': '32', 06:36:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:57 INFO - 'title': 't-yosemite-r7-0339', 06:36:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:57 INFO - 'use_talos_json': True, 06:36:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:57 INFO - 'work_dir': 'build'} 06:36:57 INFO - ##### 06:36:57 INFO - ##### Running clobber step. 06:36:57 INFO - ##### 06:36:57 INFO - Running pre-action listener: _resource_record_pre_action 06:36:57 INFO - Running main action method: clobber 06:36:57 INFO - rmtree: /builds/slave/test/build 06:36:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:58 INFO - Running post-action listener: _resource_record_post_action 06:36:58 INFO - ##### 06:36:58 INFO - ##### Running read-buildbot-config step. 06:36:58 INFO - ##### 06:36:58 INFO - Running pre-action listener: _resource_record_pre_action 06:36:58 INFO - Running main action method: read_buildbot_config 06:36:58 INFO - Using buildbot properties: 06:36:58 INFO - { 06:36:58 INFO - "project": "", 06:36:58 INFO - "product": "firefox", 06:36:58 INFO - "script_repo_revision": "production", 06:36:58 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:36:58 INFO - "repository": "", 06:36:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:36:58 INFO - "buildid": "20160606010529", 06:36:58 INFO - "pgo_build": "False", 06:36:58 INFO - "basedir": "/builds/slave/test", 06:36:58 INFO - "buildnumber": 14, 06:36:58 INFO - "slavename": "t-yosemite-r7-0339", 06:36:58 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:36:58 INFO - "platform": "yosemite_r7", 06:36:58 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:36:58 INFO - "branch": "mozilla-aurora", 06:36:58 INFO - "repo_path": "releases/mozilla-aurora", 06:36:58 INFO - "revision": "d8adb38dd576398dacbfb96d2c247f8e0158bdf1", 06:36:58 INFO - "stage_platform": "macosx64", 06:36:58 INFO - "builduid": "78750d9664274d05bee96204469a3a74", 06:36:58 INFO - "slavebuilddir": "test" 06:36:58 INFO - } 06:36:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 06:36:58 INFO - Running post-action listener: _resource_record_post_action 06:36:58 INFO - ##### 06:36:58 INFO - ##### Running download-and-extract step. 06:36:58 INFO - ##### 06:36:58 INFO - Running pre-action listener: _resource_record_pre_action 06:36:58 INFO - Running main action method: download_and_extract 06:36:58 INFO - mkdir: /builds/slave/test/build/tests 06:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:36:58 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:36:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:36:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:36:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/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 06:36:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/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 06:37:00 INFO - Downloaded 1199 bytes. 06:37:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 06:37:00 INFO - Using the following test package requirements: 06:37:00 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:37:00 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:00 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 06:37:00 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:00 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 06:37:00 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:00 INFO - u'jsshell-mac.zip'], 06:37:00 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:00 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 06:37:00 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:37:00 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:00 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 06:37:00 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:00 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 06:37:00 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:00 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 06:37:00 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:00 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 06:37:00 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:37:00 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')]} 06:37:00 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:37:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/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 06:37:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/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 06:37:01 INFO - Downloaded 18466859 bytes. 06:37:01 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'] 06:37:01 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 06:37:04 INFO - Return code: 0 06:37:04 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 06:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:37:04 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:37:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/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 06:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/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 06:37:05 INFO - Downloaded 18466859 bytes. 06:37:05 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'] 06:37:05 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 06:37:09 INFO - Return code: 0 06:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:37:09 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:37:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:37:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:37:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/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 06:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/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 06:37:10 INFO - Downloaded 10840145 bytes. 06:37:10 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'] 06:37:10 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 06:37:10 INFO - Return code: 0 06:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:37:10 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 06:37:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:37:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:37:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 06:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/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 06:37:14 INFO - Downloaded 114179823 bytes. 06:37:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:37:14 INFO - mkdir: /builds/slave/test/properties 06:37:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:14 INFO - Contents: 06:37:14 INFO - build_url:https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:37:15 INFO - Running post-action listener: _resource_record_post_action 06:37:15 INFO - Running post-action listener: set_extra_try_arguments 06:37:15 INFO - ##### 06:37:15 INFO - ##### Running populate-webroot step. 06:37:15 INFO - ##### 06:37:15 INFO - Running pre-action listener: _resource_record_pre_action 06:37:15 INFO - Running main action method: populate_webroot 06:37:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:15 INFO - '--tppagecycles', 06:37:15 INFO - '7'], 06:37:15 INFO - 'tests': ['tsvgm']}}, 06:37:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['damp', 'tps']}, 06:37:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'tests': ['damp', 'tps']}, 06:37:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['dromaeo_dom']}, 06:37:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['a11yr', 06:37:15 INFO - 'ts_paint', 06:37:15 INFO - 'tpaint', 06:37:15 INFO - 'sessionrestore', 06:37:15 INFO - 'sessionrestore_no_auto_restore', 06:37:15 INFO - 'tabpaint']}, 06:37:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['tsvgx', 06:37:15 INFO - 'tsvgr_opacity', 06:37:15 INFO - 'tart', 06:37:15 INFO - 'tscrollx', 06:37:15 INFO - 'cart']}, 06:37:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:15 INFO - 'tsvgr_opacity', 06:37:15 INFO - 'tart', 06:37:15 INFO - 'tscrollx', 06:37:15 INFO - 'cart']}, 06:37:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--disable-e10s'], 06:37:15 INFO - 'tests': ['tp5o']}, 06:37:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'tests': ['tp5o']}, 06:37:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--disable-e10s', 06:37:15 INFO - '--xperf_path', 06:37:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:15 INFO - 'tests': ['tp5n']}, 06:37:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:15 INFO - 'talos_options': ['--xperf_path', 06:37:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:15 INFO - 'tests': ['tp5n']}}, 06:37:15 INFO - 'talos.zip': {'path': '', 06:37:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:15 INFO - Running post-action listener: _resource_record_post_action 06:37:15 INFO - ##### 06:37:15 INFO - ##### Running create-virtualenv step. 06:37:15 INFO - ##### 06:37:15 INFO - Running pre-action listener: _resource_record_pre_action 06:37:15 INFO - Running main action method: create_virtualenv 06:37:15 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:37:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:16 INFO - Using real prefix '/tools/python27' 06:37:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:16 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:19 INFO - Installing pip.................done. 06:37:19 INFO - Return code: 0 06:37:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104295a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc35a59bfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, '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.o7jxJXToAw/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.u5W6XL06sB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:19 INFO - 'HOME': '/Users/cltbld', 06:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:19 INFO - 'LOGNAME': 'cltbld', 06:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:19 INFO - 'MOZ_NO_REMOTE': '1', 06:37:19 INFO - 'NO_EM_RESTART': '1', 06:37:19 INFO - 'PAGER': '/bin/cat', 06:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:19 INFO - 'PWD': '/builds/slave/test', 06:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:19 INFO - 'SHELL': '/bin/bash', 06:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:37:19 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:19 INFO - 'USER': 'cltbld', 06:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:19 INFO - 'XPC_FLAGS': '0x0', 06:37:19 INFO - 'XPC_SERVICE_NAME': '0', 06:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:37:19 INFO - Cleaning up... 06:37:19 INFO - Return code: 0 06:37:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104295a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc35a59bfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, '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.o7jxJXToAw/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.u5W6XL06sB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:19 INFO - 'HOME': '/Users/cltbld', 06:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:19 INFO - 'LOGNAME': 'cltbld', 06:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:19 INFO - 'MOZ_NO_REMOTE': '1', 06:37:19 INFO - 'NO_EM_RESTART': '1', 06:37:19 INFO - 'PAGER': '/bin/cat', 06:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:19 INFO - 'PWD': '/builds/slave/test', 06:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:19 INFO - 'SHELL': '/bin/bash', 06:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:37:19 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:19 INFO - 'USER': 'cltbld', 06:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:19 INFO - 'XPC_FLAGS': '0x0', 06:37:19 INFO - 'XPC_SERVICE_NAME': '0', 06:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:20 INFO - Downloading/unpacking psutil>=0.7.1 06:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:22 INFO - Installing collected packages: psutil 06:37:22 INFO - Running setup.py install for psutil 06:37:22 INFO - building 'psutil._psutil_osx' extension 06:37:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:37:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:37:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:37:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:37:23 INFO - building 'psutil._psutil_posix' extension 06:37:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:37:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:37:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:37:23 INFO - ^ 06:37:23 INFO - 1 warning generated. 06:37:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:23 INFO - Successfully installed psutil 06:37:23 INFO - Cleaning up... 06:37:23 INFO - Return code: 0 06:37:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:37:23 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')]} 06:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:23 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')]} 06:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:23 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 0x104295a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc35a59bfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, '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.o7jxJXToAw/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.u5W6XL06sB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:37:23 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 06:37:23 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 06:37:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:37:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:23 INFO - 'HOME': '/Users/cltbld', 06:37:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:23 INFO - 'LOGNAME': 'cltbld', 06:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:23 INFO - 'MOZ_NO_REMOTE': '1', 06:37:23 INFO - 'NO_EM_RESTART': '1', 06:37:23 INFO - 'PAGER': '/bin/cat', 06:37:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:23 INFO - 'PWD': '/builds/slave/test', 06:37:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:23 INFO - 'SHELL': '/bin/bash', 06:37:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:37:23 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:37:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:23 INFO - 'USER': 'cltbld', 06:37:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:23 INFO - 'XPC_FLAGS': '0x0', 06:37:23 INFO - 'XPC_SERVICE_NAME': '0', 06:37:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:37:26 INFO - Installing collected packages: mozsystemmonitor 06:37:26 INFO - Running setup.py install for mozsystemmonitor 06:37:26 INFO - Successfully installed mozsystemmonitor 06:37:26 INFO - Cleaning up... 06:37:26 INFO - Return code: 0 06:37:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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', '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 0x104295a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc35a59bfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, '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.o7jxJXToAw/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.u5W6XL06sB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:37: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:37: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 blobuploader==1.2.4 06:37:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:37:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:26 INFO - 'HOME': '/Users/cltbld', 06:37:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:26 INFO - 'LOGNAME': 'cltbld', 06:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:26 INFO - 'MOZ_NO_REMOTE': '1', 06:37:26 INFO - 'NO_EM_RESTART': '1', 06:37:26 INFO - 'PAGER': '/bin/cat', 06:37:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:26 INFO - 'PWD': '/builds/slave/test', 06:37:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:26 INFO - 'SHELL': '/bin/bash', 06:37:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:37:26 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:37:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:26 INFO - 'USER': 'cltbld', 06:37:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:26 INFO - 'XPC_FLAGS': '0x0', 06:37:26 INFO - 'XPC_SERVICE_NAME': '0', 06:37:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:27 INFO - Downloading/unpacking blobuploader==1.2.4 06:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:29 INFO - Downloading blobuploader-1.2.4.tar.gz 06:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:37:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:30 INFO - Downloading docopt-0.6.1.tar.gz 06:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:30 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:30 INFO - Running setup.py install for blobuploader 06:37:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:31 INFO - Running setup.py install for requests 06:37:31 INFO - Running setup.py install for docopt 06:37:31 INFO - Successfully installed blobuploader requests docopt 06:37:31 INFO - Cleaning up... 06:37:31 INFO - Return code: 0 06:37:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:31 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')]} 06:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:31 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')]} 06:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:31 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 0x104295a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc35a59bfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, '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.o7jxJXToAw/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.u5W6XL06sB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:37:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:37:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:31 INFO - 'HOME': '/Users/cltbld', 06:37:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:31 INFO - 'LOGNAME': 'cltbld', 06:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:31 INFO - 'MOZ_NO_REMOTE': '1', 06:37:31 INFO - 'NO_EM_RESTART': '1', 06:37:31 INFO - 'PAGER': '/bin/cat', 06:37:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:31 INFO - 'PWD': '/builds/slave/test', 06:37:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:31 INFO - 'SHELL': '/bin/bash', 06:37:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:37:31 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:37:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:31 INFO - 'USER': 'cltbld', 06:37:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:31 INFO - 'XPC_FLAGS': '0x0', 06:37:31 INFO - 'XPC_SERVICE_NAME': '0', 06:37:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:32 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-OZAgP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:32 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-Ux0RW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:32 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-Cvksq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:32 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-FWldkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:32 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-SSEMg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:32 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-_n5eiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:32 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-n2oX74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:32 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-cSnObY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:32 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-qyulrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:33 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-JSrlSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:33 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-8WFrrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:33 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-dZS0o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:33 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-2vt6oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:33 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-2NcLoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:33 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-8QhtgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:33 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-RV7AN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:33 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-MfQ0Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:33 INFO - Running setup.py install for manifestparser 06:37:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:34 INFO - Running setup.py install for mozcrash 06:37:34 INFO - Running setup.py install for mozdebug 06:37:34 INFO - Running setup.py install for mozdevice 06:37:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:34 INFO - Running setup.py install for mozfile 06:37:34 INFO - Running setup.py install for mozhttpd 06:37:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:34 INFO - Running setup.py install for mozinfo 06:37:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:34 INFO - Running setup.py install for mozInstall 06:37:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:35 INFO - Running setup.py install for mozleak 06:37:35 INFO - Running setup.py install for mozlog 06:37:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:35 INFO - Running setup.py install for moznetwork 06:37:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:35 INFO - Running setup.py install for mozprocess 06:37:35 INFO - Running setup.py install for mozprofile 06:37:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:35 INFO - Running setup.py install for mozrunner 06:37:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:36 INFO - Running setup.py install for mozscreenshot 06:37:36 INFO - Running setup.py install for moztest 06:37:36 INFO - Running setup.py install for mozversion 06:37:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:36 INFO - Cleaning up... 06:37:36 INFO - Return code: 0 06:37:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:36 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')]} 06:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:36 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')]} 06:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:36 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 0x104295a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc35a59bfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, '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.o7jxJXToAw/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.u5W6XL06sB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:37:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:37:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:36 INFO - 'HOME': '/Users/cltbld', 06:37:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:36 INFO - 'LOGNAME': 'cltbld', 06:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:36 INFO - 'MOZ_NO_REMOTE': '1', 06:37:36 INFO - 'NO_EM_RESTART': '1', 06:37:36 INFO - 'PAGER': '/bin/cat', 06:37:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:36 INFO - 'PWD': '/builds/slave/test', 06:37:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:36 INFO - 'SHELL': '/bin/bash', 06:37:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:37:36 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:37:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:36 INFO - 'USER': 'cltbld', 06:37:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:36 INFO - 'XPC_FLAGS': '0x0', 06:37:36 INFO - 'XPC_SERVICE_NAME': '0', 06:37:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:36 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-4iDuBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:36 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-7X01Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:36 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-9bCGoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:37 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-N3BvcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:37 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-TY7r6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:37 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-jBuaV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:37 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-x_dleC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:37 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-EVlY4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:37 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-H7NUYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:37 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-LSS1QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:37 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)) 06:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:37 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-_x9I__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:37 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-jNdWdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:38 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)) 06:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:38 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-L2HD8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:38 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-pkMJa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:38 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)) 06:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:38 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-r4rozY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:38 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-d1M97p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:38 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-R12iEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:37:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:40 INFO - Downloading blessings-1.6.tar.gz 06:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:37:41 INFO - Installing collected packages: blessings 06:37:41 INFO - Running setup.py install for blessings 06:37:41 INFO - Successfully installed blessings 06:37:41 INFO - Cleaning up... 06:37:41 INFO - Return code: 0 06:37:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:41 INFO - Reading from file tmpfile_stdout 06:37:41 INFO - Current package versions: 06:37:41 INFO - blessings == 1.6 06:37:41 INFO - blobuploader == 1.2.4 06:37:41 INFO - docopt == 0.6.1 06:37:41 INFO - manifestparser == 1.1 06:37:41 INFO - mozInstall == 1.12 06:37:41 INFO - mozcrash == 0.17 06:37:41 INFO - mozdebug == 0.1 06:37:41 INFO - mozdevice == 0.48 06:37:41 INFO - mozfile == 1.2 06:37:41 INFO - mozhttpd == 0.7 06:37:41 INFO - mozinfo == 0.9 06:37:41 INFO - mozleak == 0.1 06:37:41 INFO - mozlog == 3.1 06:37:41 INFO - moznetwork == 0.27 06:37:41 INFO - mozprocess == 0.22 06:37:41 INFO - mozprofile == 0.28 06:37:41 INFO - mozrunner == 6.11 06:37:41 INFO - mozscreenshot == 0.1 06:37:41 INFO - mozsystemmonitor == 0.0 06:37:41 INFO - moztest == 0.7 06:37:41 INFO - mozversion == 1.4 06:37:41 INFO - psutil == 3.1.1 06:37:41 INFO - requests == 1.2.3 06:37:41 INFO - wsgiref == 0.1.2 06:37:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:41 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')]} 06:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:41 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')]} 06:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:41 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 0x104295a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc35a59bfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, '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.o7jxJXToAw/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.u5W6XL06sB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:37:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:41 INFO - 'HOME': '/Users/cltbld', 06:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:41 INFO - 'LOGNAME': 'cltbld', 06:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:41 INFO - 'MOZ_NO_REMOTE': '1', 06:37:41 INFO - 'NO_EM_RESTART': '1', 06:37:41 INFO - 'PAGER': '/bin/cat', 06:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:41 INFO - 'PWD': '/builds/slave/test', 06:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:41 INFO - 'SHELL': '/bin/bash', 06:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:37:41 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:41 INFO - 'USER': 'cltbld', 06:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:41 INFO - 'XPC_FLAGS': '0x0', 06:37:41 INFO - 'XPC_SERVICE_NAME': '0', 06:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:37:41 INFO - Cleaning up... 06:37:41 INFO - Return code: 0 06:37:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:37:41 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')]} 06:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:41 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')]} 06:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:41 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 0x104295a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc35a59bfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, '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.o7jxJXToAw/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.u5W6XL06sB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:37:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:41 INFO - 'HOME': '/Users/cltbld', 06:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:41 INFO - 'LOGNAME': 'cltbld', 06:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:41 INFO - 'MOZ_NO_REMOTE': '1', 06:37:41 INFO - 'NO_EM_RESTART': '1', 06:37:41 INFO - 'PAGER': '/bin/cat', 06:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:41 INFO - 'PWD': '/builds/slave/test', 06:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:41 INFO - 'SHELL': '/bin/bash', 06:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:37:41 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:41 INFO - 'USER': 'cltbld', 06:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:41 INFO - 'XPC_FLAGS': '0x0', 06:37:41 INFO - 'XPC_SERVICE_NAME': '0', 06:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:42 INFO - Downloading/unpacking jsonschema 06:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:37:44 INFO - Downloading/unpacking functools32 (from jsonschema) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:45 INFO - Downloading functools32-3.2.3-2.tar.gz 06:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:37:45 INFO - warning: no files found matching '*.txt' 06:37:45 INFO - no previously-included directories found matching 'build' 06:37:45 INFO - no previously-included directories found matching 'dist' 06:37:45 INFO - no previously-included directories found matching '.git*' 06:37:45 INFO - Installing collected packages: jsonschema, functools32 06:37:45 INFO - Running setup.py install for functools32 06:37:45 INFO - warning: no files found matching '*.txt' 06:37:45 INFO - no previously-included directories found matching 'build' 06:37:45 INFO - no previously-included directories found matching 'dist' 06:37:45 INFO - no previously-included directories found matching '.git*' 06:37:45 INFO - Successfully installed jsonschema functools32 06:37:45 INFO - Cleaning up... 06:37:45 INFO - Return code: 0 06:37:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:37:45 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')]} 06:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:45 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')]} 06:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:45 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 0x104295a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc35a59bfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, '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.o7jxJXToAw/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.u5W6XL06sB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:37:45 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 06:37:45 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 06:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:45 INFO - 'HOME': '/Users/cltbld', 06:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:45 INFO - 'LOGNAME': 'cltbld', 06:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:45 INFO - 'MOZ_NO_REMOTE': '1', 06:37:45 INFO - 'NO_EM_RESTART': '1', 06:37:45 INFO - 'PAGER': '/bin/cat', 06:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:45 INFO - 'PWD': '/builds/slave/test', 06:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:45 INFO - 'SHELL': '/bin/bash', 06:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:37:45 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:45 INFO - 'USER': 'cltbld', 06:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:45 INFO - 'XPC_FLAGS': '0x0', 06:37:45 INFO - 'XPC_SERVICE_NAME': '0', 06:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:45 INFO - Downloading/unpacking flake8 06:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:37:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:37:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:37: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 06:37: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 06:37: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 06:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:37:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:37:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:37:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:37:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:37:49 INFO - no previously-included directories found matching 'docs/_build' 06:37:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:37:49 INFO - Running setup.py install for pep8 06:37:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:37:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:37:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:37:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:37:49 INFO - no previously-included directories found matching 'docs/_build' 06:37:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:37:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:37:49 INFO - Cleaning up... 06:37:49 INFO - Return code: 0 06:37:49 INFO - Running post-action listener: _resource_record_post_action 06:37:49 INFO - Running post-action listener: _start_resource_monitoring 06:37:49 INFO - Starting resource monitoring. 06:37:49 INFO - ##### 06:37:49 INFO - ##### Running install step. 06:37:49 INFO - ##### 06:37:49 INFO - Running pre-action listener: _resource_record_pre_action 06:37:49 INFO - Running main action method: install 06:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:50 INFO - Reading from file tmpfile_stdout 06:37:50 INFO - Detecting whether we're running mozinstall >=1.0... 06:37:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:37:50 INFO - Reading from file tmpfile_stdout 06:37:50 INFO - Output received: 06:37:50 INFO - Usage: mozinstall [options] installer 06:37:50 INFO - Options: 06:37:50 INFO - -h, --help show this help message and exit 06:37:50 INFO - -d DEST, --destination=DEST 06:37:50 INFO - Directory to install application into. [default: 06:37:50 INFO - "/builds/slave/test"] 06:37:50 INFO - --app=APP Application being installed. [default: firefox] 06:37:50 INFO - mkdir: /builds/slave/test/build/application 06:37:50 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'] 06:37:50 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 06:38:22 INFO - Reading from file tmpfile_stdout 06:38:22 INFO - Output received: 06:38:22 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:38:22 INFO - Running post-action listener: _resource_record_post_action 06:38:22 INFO - ##### 06:38:22 INFO - ##### Running run-tests step. 06:38:22 INFO - ##### 06:38:22 INFO - Running pre-action listener: _resource_record_pre_action 06:38:22 INFO - Running main action method: run_tests 06:38:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:38:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:38:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:38:22 INFO - 2016-06-06 06:38:22.106 screenresolution[1654:7547] starting screenresolution argv=screenresolution get 06:38:22 INFO - 2016-06-06 06:38:22.108 screenresolution[1654:7547] Display 0: 1600x1200x32@60 06:38:22 INFO - 2016-06-06 06:38:22.115 screenresolution[1655:7549] starting screenresolution argv=screenresolution list 06:38:22 INFO - Available Modes on Display 0 06:38:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:38:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:38:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:38:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:38:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:38:22 INFO - Intel Iris: 06:38:22 INFO - Chipset Model: Intel Iris 06:38:22 INFO - Type: GPU 06:38:22 INFO - Bus: Built-In 06:38:22 INFO - VRAM (Dynamic, Max): 1536 MB 06:38:22 INFO - Vendor: Intel (0x8086) 06:38:22 INFO - Device ID: 0x0a2e 06:38:22 INFO - Revision ID: 0x0009 06:38:22 INFO - Displays: 06:38:22 INFO - Display: 06:38:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:38:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:38:22 INFO - Display Serial Number: 1600x1200 60 06:38:22 INFO - Main Display: Yes 06:38:22 INFO - Mirror: Off 06:38:22 INFO - Online: Yes 06:38:22 INFO - Rotation: Supported 06:38:22 INFO - Return code: 0 06:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:38:22 INFO - Python 2.7.3 06:38:22 INFO - Return code: 0 06:38:22 INFO - grabbing minidump binary from tooltool 06:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:38:22 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 0x104134e00>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10412fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:38:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:38:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:38:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:38:22 INFO - Return code: 0 06:38:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:38:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:38:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:38:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:38:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:38:23 INFO - Return code: 0 06:38:23 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/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0339', '--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 06:38:23 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/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0339 --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 06:38:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o7jxJXToAw/Render', 06:38:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:23 INFO - 'HOME': '/Users/cltbld', 06:38:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:23 INFO - 'LOGNAME': 'cltbld', 06:38:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:38:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:23 INFO - 'MOZ_NO_REMOTE': '1', 06:38:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:38:23 INFO - 'NO_EM_RESTART': '1', 06:38:23 INFO - 'PAGER': '/bin/cat', 06:38:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:23 INFO - 'PWD': '/builds/slave/test', 06:38:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:38:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:23 INFO - 'SHELL': '/bin/bash', 06:38:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u5W6XL06sB/Listeners', 06:38:23 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 06:38:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:23 INFO - 'USER': 'cltbld', 06:38:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:23 INFO - 'XPC_FLAGS': '0x0', 06:38:23 INFO - 'XPC_SERVICE_NAME': '0', 06:38:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:23 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/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0339', '--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 06:38:23 INFO - mozversion application_buildid: 20160606010529 06:38:23 INFO - mozversion application_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 06:38:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:38:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:38:23 INFO - mozversion application_name: Firefox 06:38:23 INFO - mozversion application_remotingname: firefox-dev 06:38:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:38:23 INFO - mozversion application_vendor: Mozilla 06:38:23 INFO - mozversion application_version: 48.0a2 06:38:23 INFO - mozversion platform_buildid: 20160606010529 06:38:23 INFO - mozversion platform_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 06:38:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:38:23 INFO - mozversion platform_version: 48.0a2 06:38:23 INFO - using testdate: 1465220303 06:38:23 INFO - actual date: 1465220303 06:38:23 INFO - starting webserver on 'localhost:49275' 06:38:23 INFO - SUITE-START | Running 2 tests 06:38:23 INFO - TEST-START | dromaeo_css 06:38:23 INFO - operating with platform_type : mac_ 06:38:23 INFO - Initialising browser for dromaeo_css test... 06:38:23 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpJHIESF/profile http://localhost:49275/getInfo.html) 06:38:26 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 06:38:26 INFO - PROCESS | 1673 | colorDepth:24 06:38:26 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 06:38:26 INFO - PROCESS | 1673 | __metrics 06:38:26 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:38:27 INFO - TEST-INFO | 1673: exit 0 06:38:27 INFO - Browser initialized. 06:38:27 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:27 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpJHIESF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:39 INFO - PROCESS | 1676 | RSS: Main: 221347840 06:38:39 INFO - PROCESS | 1676 | 06:39:28 INFO - PROCESS | 1676 | 1465220368876 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:41:39 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 06:41:41 INFO - PROCESS | 1676 | RSS: Main: 232947712 06:41:41 INFO - PROCESS | 1676 | 06:44:43 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 06:44:43 INFO - PROCESS | 1676 | RSS: Main: 244252672 06:44:43 INFO - PROCESS | 1676 | 06:47:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 06:47:46 INFO - PROCESS | 1676 | RSS: Main: 245788672 06:47:46 INFO - PROCESS | 1676 | 06:50:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 06:50:48 INFO - PROCESS | 1676 | RSS: Main: 247463936 06:50:48 INFO - PROCESS | 1676 | 06:53:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 06:53:51 INFO - PROCESS | 1676 | RSS: Main: 250834944 06:53:51 INFO - PROCESS | 1676 | 06:56:54 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 06:56:54 INFO - PROCESS | 1676 | RSS: Main: 251863040 06:56:54 INFO - PROCESS | 1676 | 06:56:54 INFO - PROCESS | 1676 | __start_tp_report 06:56:54 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 06:56:54 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 06:56:54 INFO - PROCESS | 1676 | |i|pagename|runs| 06:56:54 INFO - PROCESS | 1676 | |0;dojo.html;3374.0552645259327;3433.450647896334;3441.6214216436188;3479.338925604135;3501.1772233525126;5636.802711905084;5702.54379649628;5707.286589176353;5711.771529138835;5752.02215623344;5614.691191984439;5676.347220069683;5676.886462270752;5687.601867869251;5743.109817978209;5149.639525233235;5219.373675158986;5220;5301.0988132017455;5325.3875804282425;5137.229415587654;5310.73446327684;5376.38171610264;5393.649412788156;5396.352437707481;4716.4340279166545;4985.950140498603;5286.154215325549;5288.995090932711;5317.6809391436445;5230.712310822903;5230.8692282692855;5248.737563121847;5266.499682530191;5289.576833853283;5171.3277273954145;5197.246399272084;5304.840854774363;5353;5380.408155102936;4816.927746083811;5668.234788303567;5695.544356451515;5703.258576385043;5724.8855022899725;5001.724905130216;6043.8186854394435;6238.812835614939;6254.030625253093;6287.371262873676;5876.9118463223085;5931.021381472052;6283;6303.243610766692;6334.809955701337;4839.37088178538;5170.405403378584;5236.266922630834;5840.474357307863;5880.558958078119;5813.157092221604;6182.1345011698395;6215.844603884939;6319.273283572356;6319.96840015797;5151.9484805152215;6110.114033465123;6152.911956916751;6155.230596175478;6171.47542458896;6158.230221222348;6159.630422174684;6167.753289868445;6170.259568851677;6192.040233763774;6137.324894261627;6139.201903752483;6140.995089002448;6168.290646575701;6171.537134714914;6122.265328160649;6145.5698101133385;6188.969055154786;6248.4064013918605;6251.781187658501;4590.357349971006;4782.928256076161;4832.540908613676;4940.580050695659;4956.107900577858;3835.4055121456217;4346.847860324937;4359.542248063971;4391.98984233628;4440.4671439427475;5717.942820571824;5792.580817699606;5821.970890145522;5860.619059761102;5884.176215329857;6123.526657168203;6131.070842498441;6234.625922444668;6237.251529816361;6244.625322480666;4818.397700287464;5588.329400471888;5700.429957004267;5831.825045248649;5924.081767325985;5403.351597808288;5416.674999500043;5422.295101636762;5427.647202931876;5438.972805135949;6159.045347971071;6313.589616674902;6348.143000694847;6352.904706429407;6370.299267080617;6224.439800417984;6235.625862448268;6272.8118156455375;6295.401936815995;6296.275928268308;6357.841053973502;6367.458766004941;6381.234251889803;6388.616682999035;6389.584676995981;5075.974620126875;6077.058056001327;6117.279373342293;6242.157308763259;6257.28041275241;6246.937530624636;6260.968695156495;6277.529185311028;6310.873782524232;6320.178376810985;5761.164631128547;6112.694365281629;6171.814845554641;6197.81406557804;6218.626882387071;5990.6705131218205;6098.75604975796;6130.061839217998;6175;6181;5924.377940316204;5990.251218597676;5999.310079340931;6010.068439391901;6069.089636554552;6156.969215153896;6170.382961703794;6181.690915454299;6204.348543402878;6207.11369213318;4981.452040275639;5871.882562348815;5933.2880054393745;5999.9100013498955;6041.607295525777 06:56:54 INFO - PROCESS | 1676 | |1;ext.html;530.4430348134456;533.4370069663255;558.2240685447229;587.3187102960567;606.2482521673127;39976.400353994715;40087.99780005501;41059.99999999996;41284;41307.38038929415;42530.574694253126;43035;43112.56887431125;43212;43263;9611.471369074698;9769.218462523017;9864.457454839981;9912.157466615346;9912.454814985173;9762.21902247822;9785.902140978606;9812.852807207897;9912.653057143001;9927.354721943051;9833.31166818323;9906.504674766269;9919;9919.057689519484;9927.056929591678;9799.608015679365;9809.705708828747;9877.60489580416;9901.504924753734;9902.603895844157;8263.545504997222;9626.085521875411;9705.805883882353;9779.364341317863;9779.53307003948;32219.51670724941;38920.610793892265;39314.60685393138;39425.802870985746;39534.406983895264;2941.4264218477406;3164.8892288769784;3174.3968645957193;3250.8862189823244;3267.640559538449;26878.5968210477;27785.305367365774;28561.428771424664;29370;29572.70427295721;2385.49904520051;2731.6312297839736;2785.8328500289845;2786.4984302825483;2820.3936153727045;420465;426687;426712.86643566896;427661;433333;35935.28129437449;36911.26177476435;64146;64528;64625.676871616284;35155.64844351524;35244;35946.28107437836;36144;36274.8186259067;12386.5664701735;14770;14861.702765944838;15185;15223.238838058052;12734.554290599785;12816.743665126645;12830.422630981628;12836.48654053846;12921.547745828851;7322.487425880137;8063.072746634095;8138.674453021813;8384.832303353898;8400.033996090528;3423.880164194291;3464.7401444891734;3469.410200265961;3478.3912815257227;3486.825658717054;946.5503885654397;986;1043.0351924469835;1051.673981065872;1108.9944550277196;28220.85889570539;28539.143825685263;30372.69627303743;31471.21321966969;32048.519272210935;1114.3703807348822;1152.740633357488;1158.0330424095973;1233.3709807997807;1266.4807428954268;14499.92750036243;14907.105573665614;15304.464343747915;15312;16462.670746585;649026;658049;664654;668304;670840;59453.40546594565;60336.69831650814;60927.695361523794;61257.38742612606;62050.689746550976;1497.1989985357782;1522.9010114342532;1524.1769444500067;1529.4111766969797;1531.364483739258;29866.552001719556;29936.101916941654;30267.545986810655;30651;31004.68995310018;50666.493335066174;52018.73990630022;52312.738436307576;52765.736171318895;52862.47137528576;631349;631899;634120.8293958501;636614;637953;26027.479450411265;26610.866945665148;26637.733622664302;26690.19929402121;26999.190024298518;45844.7707761459;46070;46170.38403655856;46909.3581724638;48506.02987940292;37416.81291593525;37682.057948551505;37899.242015160096;38050.619493804705;38290.42564361481;38094.42858357071;38109.23781524299;38138;38600.613993859704;39617.40573891336;32937.01188964335;35598.466023010194;36309.818450908635;38762.6123738759;39538.209235815695;30347.848260758554;31375.90184343537;31830.204244894063;31860.840695796374;31913;17841.821581784017;22052.88973555122;24519.26442206737;24586;24804.875975620005 06:56:54 INFO - PROCESS | 1676 | |2;jquery.html;389.351729370598;406.96540794032524;408.78130200342815;409.5147250508146;413.6897327004746;14879.032862863905;17160.570985725364;20408.469364797624;20673.586528269443;21084.472888177785;19908.50228744282;20603;20625;20865.26971555996;21180.25869094582;5625.212470254168;5804.042333015058;6017.458428741413;6132.172156758847;6141.815745527641;5761.366249712549;5945.464908158265;5995.13070604762;6003.30961939376;6019.277686677605;6019.729112189962;6047.455728984391;6053.757849686007;6055.27336719592;6073.119397687355;5715.742791574368;6066.514678825683;6068.817935461899;6069.878602427949;6070.787522436738;5807.82576522705;5848.473637372615;5962.165296858443;5973.522118230531;5982.162497250345;13425.462981480729;13787.586372408843;13861.722765544633;26121;26130.477390452084;2072.751269847613;2193.670949357609;2289.4848659051745;2294.128231272106;2450.3506570758764;9824.312298139133;9949.204063674888;10210.001735551563;12857.67855803603;14823;1490.7614781634995;1725.6548690261998;1734.254270663614;1787.294018862542;1792.4622613216113;102879.48560257225;108947.45526272398;110716.4464177682;110863;111290;11730.941345293219;11865.644030679094;11889.346085965355;11935.880641193477;11954.163208575315;15025.323860426308;15047.623809404633;15187.240637968058;15302.464413745465;15309.6172595686;8419.158084191531;8733.737987860375;8843.646254149891;8882.733517994471;8909.064548222343;8823.823523529622;8825.514596697243;8834.337424693174;8836.160564746338;8878.20096191333;4683.929741053887;4691.319758635047;4751.168545504523;4756.500567440438;4778.474367819537;1991.8605697601029;2017.2334512885009;2023.8279746221442;2061.7732049474544;2077.7298951136254;907.1971305394774;941.1294552539011;967.5452537307455;972.7081875437341;974.1573538888952;16511.917440412722;18118.728219076726;20072.69890951637;21109.83726158764;21508.56982860334;937.8218138553653;944.6127087893931;1005.2510879394752;1009.6819501856892;1037.9169666426667;11316.773664526663;11365.886341136484;11381.532564767018;11393.886061139283;11499;574494;576717;599663;652663;663535;95065;102827.4858625702;132891;134291;134380;874.6807415293372;1031.9071283584362;1047.5914393386586;1062.4209805655937;1063.4895250279908;18805.529861753017;18872.622547549247;18873;19034.33379831699;19232;51646.74176629093;52302.738486307324;52867.77332569998;53870;53893.92212155656;69984;76940;78514.4297114066;79027;79613.20386796058;8284.295834853863;8346.624401901807;8390.580470976549;8518.275946544365;8650;11896.345700986529;12618.305993170463;12766.234025958473;12788.744225115632;12859.16415432994;10867.29362591429;11195.2723073;11197.44012799373;11287.153463490107;11424.200305978502;7147.392471639969;10753.784924301313;10908.945455272673;11187.160962927976;11232.045276151619;11655.53377864876;11662.88337116652;11788.410579471163;11808.645740627795;11881.800629611858;8307.750767476744;8379.413441059067;8380.20388063133;8568.35737319691;8591.140885911358;10519.526621301906;11103.72240693989;11319.320840749582;11360.886391136313;11364.920332568392 06:56:54 INFO - PROCESS | 1676 | |3;mootools.html;1514.6213446638342;1515.3484001879187;1737;1823.3618233618226;1937.7674679038516;7859.410544209193;8497.447665901713;8630.18013288738;8842.027376988533;8904;8629.956850215756;8655.69705060323;8669.349798765086;8734.781630459242;8773.517456539903;2108.1988844239245;2353.635186546084;2434.172381390327;2446.3394883381566;2471.542764588557;2431.4043059450373;2432.8053755699502;2462.642916777066;2469.086438017936;2487.589547724623;2461.4953934443397;2481.7270100289043;2488.365466805971;2501.199616122832;2502.8248022638422;2420.818438617102;2430.258771074839;2430.6718592989896;2449.9142530011454;2470.542949554338;2075.5122546201633;2447.7919376852988;2454.2882564056404;2472.443700167466;2473.9257822265363;8745.825083498357;8827.646894124227;8853.822923541558;8899.644014239422;8920.598573064228;5357.571394288448;5358.705271210082;5429.6742195468005;5506.091494903336;5506.724663766796;3402.1834759657504;3507.754457187998;3512.6487351264923;3566;3584;922.7324076018014;1039.77644806367;1054.7626783973622;1071.571371451418;1072.9302595331278;11131.777364452666;11334.093272538177;11408.657740267723;11455.599054033151;11954.282743035359;4535.365048893158;4588.151192029485;4630.166570017429;4636.39726835516;4651.906961860744;7347.63261836906;7698.884516732253;9282.793236879297;9303.720888373224;9338.346315757968;5257.342832145981;5261.184516399964;5273.709945952933;5277.261183434322;5294.285271488377;4391.363252328394;4812.1578723723205;4907.043126590352;4916.901661966741;4984.476629953802;3888.300105980951;3897.5322961244265;3974.6621537169085;3980.24375368679;4010.6590939770444;1098.6703988803326;1231.8090695942144;1236.8082947143207;1237.0969192489533;1245.339969815999;813.2639960835453;839.3327304792705;921.3090182363228;937.9343445958717;943.1841457139662;5866.648001119861;5980.162777211107;6021.458068773743;6071.089336599545;6132;457.80085662736815;461.24586301397454;473.2309996256084;476.2522839142582;490.43844797706424;3932.3511620582285;3974.364101743707;4015.9598404015587;4033.1731994940965;4068.06434520062;10542.262041657164;10887;10927.344359338465;10959.726006849893;11012.17408694351;10575.788484230272;10576.576936922436;10604.045635892806;10633.946830265799;10701;7862.646180921873;8099.87850182236;8269.62786674601;8330.166983301742;8451.323894088458;5848.53211743068;5871.089981052944;5921.3190483094995;6013.9097913532205;6049.18336024631;9126.954365228132;9439.103285187895;9451.905480945103;9658.323917325719;9665.806683866424;9619.18236949867;9849.901500984899;9877.802443951225;9888.011198880055;9901.009899010041;6831.146106736658;7249.05762250904;7480.438967077382;7574.242575742382;7703.922960770545;8224.424290299621;8266.586670666564;8272.627731752205;8279;8310.501369917582;7225.24134965842;7366.189719130784;7382.9630851845395;7473.51422157558;7480.438967077382;7195;7205.927940720526;7237.095363079615;7251.601161935933;7334.706611735471;7046.577205367695;7077.6461176941975;7137.429005679637;7141.535800172972;7160.355567998905;4773.069251495925;4881.463039065771;4948.331975183304;4997.475265097258;5020.297158397901;4967.883487049205;4996.875078123076;5007.649464537448;5089.745512724423;5244.265802787537 06:56:54 INFO - PROCESS | 1676 | |4;prototype.html;323.50988252797015;326.8578168496704;334.5867853201296;334.84597085340744;337.6269222509129;6657;6744.08954791103;6753.561018533792;6785.525013249075;6807;6769.424598909086;6791.660416979156;6834.179898412198;6870.82822929427;6898.620575868338;4594.72431654101;5046.571041461461;5059.519345662175;5069.073751974244;5073.974630126844;5055.646104772667;5056.696598204119;5062.392512898457;5068.341115654978;5085.745712714368;4567.497575266734;5002.474740152286;5007.649464537484;5015.22264049073;5030.346055012861;4847.975760121194;5009.148444764399;5014.84955451337;5017.949820501784;5024.547790698818;4255.5744425557195;4278.272693642089;4293.527711951683;4300.075483771005;4325.762083085429;6502.967485162591;6507.837304067436;6515;6543.836404089889;6658.334166583351;5945.910811337833;5955.464008239279;5963.701814909237;5965.313988891289;5998.1002849572915;6892.172939247273;7263.709451621929;7321.194668586451;7337;7355.705771769123;3879.495665563487;4465.37484752135;4634.073185362907;4778.211595086841;4779.474257831635;7732.845343093163;7787.415943804237;7792.805179870492;7809.758950035785;7826.647800848976;4846.660733748674;4851.587615052689;4859.416869975555;4860.513948605182;4881.170201065827;4934.481879402611;4937.7777999990085;4941.407031156285;4945.060438516671;4965.0069986002945;5921.585489015728;5924.14099955504;5930.318013428425;5930.7924222652;5973.402659734079;6964.4080253179045;7330;7337.559746415232;7340.853182936311;7395.85208295831;1259.4017841525201;1371.835379754436;1654.586353411647;1658.4112640012863;1658.8175300716912;956.3592393096642;991.0535438656066;1010.7271036820165;1020.0360659177155;1039.5374058544026;5466.480684334982;5691.662459322056;5734.684592347461;6727.966360168168;6847.383735463832;6182.218001899074;6687.465002799861;6842.73409419259;7531.171571127172;7695.422843286776;6805.455563554904;6854.931450685429;6894.517383783087;6917.9308206918295;6922.826929326807;3999.060220848098;4043.8180281887385;4055.371417430303;4059.7970101494807;4061.878143655695;7149.9285007149265;7845.1762564931005;7937.563434011185;7966.681332746741;8104.230098140667;6425.935740642627;7935.64289606969;7949.7217597383815;7960.721374751856;7980.960095199487;8052.758417247492;8052.959735201286;8055.798605034921;8084;8114.350851931831;7347.963260183665;7619.885701714368;7636.732714354971;7664.616769161408;7683.500572462772;6114.57197996136;7343.41252699772;7408.851822963403;7431.851362972819;7447.702091916262;8002.999625046869;8040.517568945882;8055.637496312797;8075.353971682134;8078.3133433658795;4680.742559159279;4723.716577005391;4724.503927087744;4741;4742.52574742523;7261.854762904818;7569.243075692607;7639.121501027231;7640.8471830564185;7668.884966725615;7316.561006339637;7354.963225184054;7381.188069312264;7386.593737344498;7391.556506609621;7310.561366318038;7378.262173782578;7378.29906158914;7383.261673832574;7387.4459415545125;5913.645181289136;7192.352688258082;7196.3163499469565;7236.20401755817;7237.986681864649;7091;7358.926410735824;7435;7437.107547094383;7442.106947166375;7199.1361036675935;7233.421326293989;7237.240089790496;7247.347738703542;7258.3104605062435 06:56:54 INFO - PROCESS | 1676 | |5;yui.html;680.3264767879799;690.6684791300178;740.829609189886;759.9924000759994;782.9177936316687;14801.037932534391;14902.627434314147;14980.925095374509;15032.248387580617;15094;12102.697432564168;13629.863701362983;13692;13697.246651434167;13731.725365492684;732.3591857125016;795.5624406576388;897.9146981036791;912.0560220172123;930.8836395450569;914.9862752058724;918.7335672654956;927.2489283680206;927.7726956895536;928.6517555916531;927.3323207290773;986.57577241786;990.9157721593673;990.9990909181706;993.4784238274927;921.216965579259;922.3359181389388;923.1783712495884;925.2967744514184;929.6420877962033;685.1880521581942;687.1204857782047;717.9533330333512;722.9132504099489;730.8611363840906;13891.583252502442;14172.078814877103;14270.857291427057;14274.571762847027;14336;12489;12578.056645751514;12651;12716.491340346467;12741.36293185337;7883.724069657592;7894.486858354246;7894.605269736548;10044.799104017879;10107;3510.947335789965;3539.8938031859084;3540.5751309842726;3812.866549670748;4274.658027357804;73179;73697.5260494787;74190.62904685442;75757.10607234808;75898.62050689712;9113.81772364549;9860.260480463994;9866.30935834499;10061.39631622105;10086.697399078039;18163.36428225032;22465.775342246696;22654.66018009731;22755.31734047981;22802.543949120925;6298.338674439209;6483.740650374027;7570.5836179010685;7615.428842836809;7677.385809135256;4023.657989070903;4100.979495102505;4107.486564179478;4151.066010147753;4163.2298024865495;3083.7378822799865;3624.1845584743223;3682.263547290499;3700.16746232101;3705.9073523162137;659.1266571792394;659.8185498987817;674.4873895839197;675.0279597379757;683.9213490448562;555.8665920179128;576.0178894984042;602.8251806976016;607.7477846693573;608.7473698415108;8161.428699991063;8270.669173233124;8353.749387518385;8551.273141782895;8554.657813687507;552.4889477233543;596.4352590332277;602.5601311042875;611.3763960760089;615.6613862375675;3857.267119247334;3919;3919.510061242345;4017.9769918367333;4173.499180098408;85572.57213714016;99450.00549994552;101277.49361253147;101614;103185;57261;73942.26057739461;79514;79796.6010169957;80036.19963800404;71283.6435817828;71476.28523714696;71880.64059679773;71908.64045679843;72595.91106133412;8345.791355216168;8567.871481927652;8587.828243434971;8627.91372086271;8651.826963460822;37939.620603793606;49102;49173.80370275921;49941;50110;67769.98345024927;70244.29755702378;70732;71847;72704.63647681728;11243.381614011309;11272.83090753623;11444.885551144715;11663.24188927717;11708.531658733555;11940.402979850798;11985.340806255392;12096.637100886988;12295.077869160028;12519.687007824878;11192.552297907992;11303.378314192469;11330.433478325886;11549.14268904964;11919.642410727693;11367.550809507367;11528.654140375802;11774.705632359259;11996.160268781101;12295.086062604898;9672;11034.282771619819;11231.606893758679;11332.490037948148;11339;9702.805943881223;9792.412455252708;9838.996424362267;9992.750181245236;10180.643677471253;8217.342612591097;9629;9995.150412215044;10058.647947321808;10061.295709300572 06:56:54 INFO - PROCESS | 1676 | __end_tp_report 06:56:54 INFO - PROCESS | 1676 | __start_cc_report 06:56:54 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,409 06:56:54 INFO - PROCESS | 1676 | __end_cc_report 06:56:54 INFO - PROCESS | 1676 | __startTimestamp1465221414390__endTimestamp 06:56:54 INFO - PROCESS | 1676 | 06:56:54 INFO - PROCESS | 1676 | ------- Summary: start ------- 06:56:54 INFO - PROCESS | 1676 | Number of tests: 6 06:56:54 INFO - PROCESS | 1676 | 06:56:54 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5701.44 Median:5924.08 stddev:660.81 (11.2%) stddev-sans-first:637.11 06:56:54 INFO - PROCESS | 1676 | Values: 3374.1 3433.5 3441.6 3479.3 3501.2 5636.8 5702.5 5707.3 5711.8 5752.0 5614.7 5676.3 5676.9 5687.6 5743.1 5149.6 5219.4 5220.0 5301.1 5325.4 5137.2 5310.7 5376.4 5393.6 5396.4 4716.4 4986.0 5286.2 5289.0 5317.7 5230.7 5230.9 5248.7 5266.5 5289.6 5171.3 5197.2 5304.8 5353.0 5380.4 4816.9 5668.2 5695.5 5703.3 5724.9 5001.7 6043.8 6238.8 6254.0 6287.4 5876.9 5931.0 6283.0 6303.2 6334.8 4839.4 5170.4 5236.3 5840.5 5880.6 5813.2 6182.1 6215.8 6319.3 6320.0 5151.9 6110.1 6152.9 6155.2 6171.5 6158.2 6159.6 6167.8 6170.3 6192.0 6137.3 6139.2 6141.0 6168.3 6171.5 6122.3 6145.6 6189.0 6248.4 6251.8 4590.4 4782.9 4832.5 4940.6 4956.1 3835.4 4346.8 4359.5 4392.0 4440.5 5717.9 5792.6 5822.0 5860.6 5884.2 6123.5 6131.1 6234.6 6237.3 6244.6 4818.4 5588.3 5700.4 5831.8 5924.1 5403.4 5416.7 5422.3 5427.6 5439.0 6159.0 6313.6 6348.1 6352.9 6370.3 6224.4 6235.6 6272.8 6295.4 6296.3 6357.8 6367.5 6381.2 6388.6 6389.6 5076.0 6077.1 6117.3 6242.2 6257.3 6246.9 6261.0 6277.5 6310.9 6320.2 5761.2 6112.7 6171.8 6197.8 6218.6 5990.7 6098.8 6130.1 6175.0 6181.0 5924.4 5990.3 5999.3 6010.1 6069.1 6157.0 6170.4 6181.7 6204.3 6207.1 4981.5 5871.9 5933.3 5999.9 6041.6 06:56:54 INFO - PROCESS | 1676 | 06:56:54 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:69157.79 Median:38214.21 stddev:156720.94 (410.1%) stddev-sans-first:157075.88 06:56:54 INFO - PROCESS | 1676 | Values: 530.4 533.4 558.2 587.3 606.2 39976.4 40088.0 41060.0 41284.0 41307.4 42530.6 43035.0 43112.6 43212.0 43263.0 9611.5 9769.2 9864.5 9912.2 9912.5 9762.2 9785.9 9812.9 9912.7 9927.4 9833.3 9906.5 9919.0 9919.1 9927.1 9799.6 9809.7 9877.6 9901.5 9902.6 8263.5 9626.1 9705.8 9779.4 9779.5 32219.5 38920.6 39314.6 39425.8 39534.4 2941.4 3164.9 3174.4 3250.9 3267.6 26878.6 27785.3 28561.4 29370.0 29572.7 2385.5 2731.6 2785.8 2786.5 2820.4 420465.0 426687.0 426712.9 427661.0 433333.0 35935.3 36911.3 64146.0 64528.0 64625.7 35155.6 35244.0 35946.3 36144.0 36274.8 12386.6 14770.0 14861.7 15185.0 15223.2 12734.6 12816.7 12830.4 12836.5 12921.5 7322.5 8063.1 8138.7 8384.8 8400.0 3423.9 3464.7 3469.4 3478.4 3486.8 946.6 986.0 1043.0 1051.7 1109.0 28220.9 28539.1 30372.7 31471.2 32048.5 1114.4 1152.7 1158.0 1233.4 1266.5 14499.9 14907.1 15304.5 15312.0 16462.7 649026.0 658049.0 664654.0 668304.0 670840.0 59453.4 60336.7 60927.7 61257.4 62050.7 1497.2 1522.9 1524.2 1529.4 1531.4 29866.6 29936.1 30267.5 30651.0 31004.7 50666.5 52018.7 52312.7 52765.7 52862.5 631349.0 631899.0 634120.8 636614.0 637953.0 26027.5 26610.9 26637.7 26690.2 26999.2 45844.8 46070.0 46170.4 46909.4 48506.0 37416.8 37682.1 37899.2 38050.6 38290.4 38094.4 38109.2 38138.0 38600.6 39617.4 32937.0 35598.5 36309.8 38762.6 39538.2 30347.8 31375.9 31830.2 31860.8 31913.0 17841.8 22052.9 24519.3 24586.0 24804.9 06:56:54 INFO - PROCESS | 1676 | 06:56:54 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:34829.64 Median:21344.41 stddev:102074.82 (478.2%) stddev-sans-first:102328.41 06:56:54 INFO - PROCESS | 1676 | Values: 389.4 407.0 408.8 409.5 413.7 14879.0 17160.6 20408.5 20673.6 21084.5 19908.5 20603.0 20625.0 20865.3 21180.3 5625.2 5804.0 6017.5 6132.2 6141.8 5761.4 5945.5 5995.1 6003.3 6019.3 6019.7 6047.5 6053.8 6055.3 6073.1 5715.7 6066.5 6068.8 6069.9 6070.8 5807.8 5848.5 5962.2 5973.5 5982.2 13425.5 13787.6 13861.7 26121.0 26130.5 2072.8 2193.7 2289.5 2294.1 2450.4 9824.3 9949.2 10210.0 12857.7 14823.0 1490.8 1725.7 1734.3 1787.3 1792.5 102879.5 108947.5 110716.4 110863.0 111290.0 11730.9 11865.6 11889.3 11935.9 11954.2 15025.3 15047.6 15187.2 15302.5 15309.6 8419.2 8733.7 8843.6 8882.7 8909.1 8823.8 8825.5 8834.3 8836.2 8878.2 4683.9 4691.3 4751.2 4756.5 4778.5 1991.9 2017.2 2023.8 2061.8 2077.7 907.2 941.1 967.5 972.7 974.2 16511.9 18118.7 20072.7 21109.8 21508.6 937.8 944.6 1005.3 1009.7 1037.9 11316.8 11365.9 11381.5 11393.9 11499.0 574494.0 576717.0 599663.0 652663.0 663535.0 95065.0 102827.5 132891.0 134291.0 134380.0 874.7 1031.9 1047.6 1062.4 1063.5 18805.5 18872.6 18873.0 19034.3 19232.0 51646.7 52302.7 52867.8 53870.0 53893.9 69984.0 76940.0 78514.4 79027.0 79613.2 8284.3 8346.6 8390.6 8518.3 8650.0 11896.3 12618.3 12766.2 12788.7 12859.2 10867.3 11195.3 11197.4 11287.2 11424.2 7147.4 10753.8 10908.9 11187.2 11232.0 11655.5 11662.9 11788.4 11808.6 11881.8 8307.8 8379.4 8380.2 8568.4 8591.1 10519.5 11103.7 11319.3 11360.9 11364.9 06:56:54 INFO - PROCESS | 1676 | 06:56:54 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5651.99 Median:5013.97 stddev:3130.70 (62.4%) stddev-sans-first:3124.04 06:56:54 INFO - PROCESS | 1676 | Values: 1514.6 1515.3 1737.0 1823.4 1937.8 7859.4 8497.4 8630.2 8842.0 8904.0 8630.0 8655.7 8669.3 8734.8 8773.5 2108.2 2353.6 2434.2 2446.3 2471.5 2431.4 2432.8 2462.6 2469.1 2487.6 2461.5 2481.7 2488.4 2501.2 2502.8 2420.8 2430.3 2430.7 2449.9 2470.5 2075.5 2447.8 2454.3 2472.4 2473.9 8745.8 8827.6 8853.8 8899.6 8920.6 5357.6 5358.7 5429.7 5506.1 5506.7 3402.2 3507.8 3512.6 3566.0 3584.0 922.7 1039.8 1054.8 1071.6 1072.9 11131.8 11334.1 11408.7 11455.6 11954.3 4535.4 4588.2 4630.2 4636.4 4651.9 7347.6 7698.9 9282.8 9303.7 9338.3 5257.3 5261.2 5273.7 5277.3 5294.3 4391.4 4812.2 4907.0 4916.9 4984.5 3888.3 3897.5 3974.7 3980.2 4010.7 1098.7 1231.8 1236.8 1237.1 1245.3 813.3 839.3 921.3 937.9 943.2 5866.6 5980.2 6021.5 6071.1 6132.0 457.8 461.2 473.2 476.3 490.4 3932.4 3974.4 4016.0 4033.2 4068.1 10542.3 10887.0 10927.3 10959.7 11012.2 10575.8 10576.6 10604.0 10633.9 10701.0 7862.6 8099.9 8269.6 8330.2 8451.3 5848.5 5871.1 5921.3 6013.9 6049.2 9127.0 9439.1 9451.9 9658.3 9665.8 9619.2 9849.9 9877.8 9888.0 9901.0 6831.1 7249.1 7480.4 7574.2 7703.9 8224.4 8266.6 8272.6 8279.0 8310.5 7225.2 7366.2 7383.0 7473.5 7480.4 7195.0 7205.9 7237.1 7251.6 7334.7 7046.6 7077.6 7137.4 7141.5 7160.4 4773.1 4881.5 4948.3 4997.5 5020.3 4967.9 4996.9 5007.6 5089.7 5244.3 06:56:54 INFO - PROCESS | 1676 | 06:56:54 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5961.15 Median:6777.47 stddev:1939.55 (28.6%) stddev-sans-first:1898.27 06:56:54 INFO - PROCESS | 1676 | Values: 323.5 326.9 334.6 334.8 337.6 6657.0 6744.1 6753.6 6785.5 6807.0 6769.4 6791.7 6834.2 6870.8 6898.6 4594.7 5046.6 5059.5 5069.1 5074.0 5055.6 5056.7 5062.4 5068.3 5085.7 4567.5 5002.5 5007.6 5015.2 5030.3 4848.0 5009.1 5014.8 5017.9 5024.5 4255.6 4278.3 4293.5 4300.1 4325.8 6503.0 6507.8 6515.0 6543.8 6658.3 5945.9 5955.5 5963.7 5965.3 5998.1 6892.2 7263.7 7321.2 7337.0 7355.7 3879.5 4465.4 4634.1 4778.2 4779.5 7732.8 7787.4 7792.8 7809.8 7826.6 4846.7 4851.6 4859.4 4860.5 4881.2 4934.5 4937.8 4941.4 4945.1 4965.0 5921.6 5924.1 5930.3 5930.8 5973.4 6964.4 7330.0 7337.6 7340.9 7395.9 1259.4 1371.8 1654.6 1658.4 1658.8 956.4 991.1 1010.7 1020.0 1039.5 5466.5 5691.7 5734.7 6728.0 6847.4 6182.2 6687.5 6842.7 7531.2 7695.4 6805.5 6854.9 6894.5 6917.9 6922.8 3999.1 4043.8 4055.4 4059.8 4061.9 7149.9 7845.2 7937.6 7966.7 8104.2 6425.9 7935.6 7949.7 7960.7 7981.0 8052.8 8053.0 8055.8 8084.0 8114.4 7348.0 7619.9 7636.7 7664.6 7683.5 6114.6 7343.4 7408.9 7431.9 7447.7 8003.0 8040.5 8055.6 8075.4 8078.3 4680.7 4723.7 4724.5 4741.0 4742.5 7261.9 7569.2 7639.1 7640.8 7668.9 7316.6 7355.0 7381.2 7386.6 7391.6 7310.6 7378.3 7378.3 7383.3 7387.4 5913.6 7192.4 7196.3 7236.2 7238.0 7091.0 7358.9 7435.0 7437.1 7442.1 7199.1 7233.4 7237.2 7247.3 7258.3 06:56:54 INFO - PROCESS | 1676 | 06:56:54 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:18217.40 Median:605.29 stddev:25790.80 (4260.9%) stddev-sans-first:25829.54 06:56:54 INFO - PROCESS | 1676 | Values: 680.3 690.7 740.8 760.0 782.9 14801.0 14902.6 14980.9 15032.2 15094.0 12102.7 13629.9 13692.0 13697.2 13731.7 732.4 795.6 897.9 912.1 930.9 915.0 918.7 927.2 927.8 928.7 927.3 986.6 990.9 991.0 993.5 921.2 922.3 923.2 925.3 929.6 685.2 687.1 718.0 722.9 730.9 13891.6 14172.1 14270.9 14274.6 14336.0 12489.0 12578.1 12651.0 12716.5 12741.4 7883.7 7894.5 7894.6 10044.8 10107.0 3510.9 3539.9 3540.6 3812.9 4274.7 73179.0 73697.5 74190.6 75757.1 75898.6 9113.8 9860.3 9866.3 10061.4 10086.7 18163.4 22465.8 22654.7 22755.3 22802.5 6298.3 6483.7 7570.6 7615.4 7677.4 4023.7 4101.0 4107.5 4151.1 4163.2 3083.7 3624.2 3682.3 3700.2 3705.9 659.1 659.8 674.5 675.0 683.9 555.9 576.0 602.8 607.7 608.7 8161.4 8270.7 8353.7 8551.3 8554.7 552.5 596.4 602.6 611.4 615.7 3857.3 3919.0 3919.5 4018.0 4173.5 85572.6 99450.0 101277.5 101614.0 103185.0 57261.0 73942.3 79514.0 79796.6 80036.2 71283.6 71476.3 71880.6 71908.6 72595.9 8345.8 8567.9 8587.8 8627.9 8651.8 37939.6 49102.0 49173.8 49941.0 50110.0 67770.0 70244.3 70732.0 71847.0 72704.6 11243.4 11272.8 11444.9 11663.2 11708.5 11940.4 11985.3 12096.6 12295.1 12519.7 11192.6 11303.4 11330.4 11549.1 11919.6 11367.6 11528.7 11774.7 11996.2 12295.1 9672.0 11034.3 11231.6 11332.5 11339.0 9702.8 9792.4 9839.0 9992.8 10180.6 8217.3 9629.0 9995.2 10058.6 10061.3 06:56:54 INFO - PROCESS | 1676 | -------- Summary: end -------- 06:56:54 INFO - PROCESS | 1676 | 06:56:54 INFO - TEST-INFO | 1676: exit 0 06:56:54 INFO - TEST-OK | dromaeo_css | took 1111178ms 06:56:54 INFO - TEST-START | kraken 06:56:54 INFO - operating with platform_type : mac_ 06:56:54 INFO - Initialising browser for kraken test... 06:56:54 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpLHEsaD/profile http://localhost:49275/getInfo.html) 06:56:57 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 06:56:57 INFO - PROCESS | 1687 | colorDepth:24 06:56:57 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 06:56:57 INFO - PROCESS | 1687 | __metrics 06:56:57 ERROR - PROCESS | 1687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:56:58 INFO - TEST-INFO | 1687: exit 0 06:56:58 INFO - Browser initialized. 06:56:58 INFO - Running cycle 1/1 for kraken test... 06:56:58 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpLHEsaD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:10 INFO - PROCESS | 1690 | RSS: Main: 220794880 06:57:10 INFO - PROCESS | 1690 | 06:57:13 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:13 INFO - PROCESS | 1690 | RSS: Main: 232747008 06:57:13 INFO - PROCESS | 1690 | 06:57:16 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 06:57:17 INFO - PROCESS | 1690 | RSS: Main: 242089984 06:57:17 INFO - PROCESS | 1690 | 06:57:20 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 06:57:21 INFO - PROCESS | 1690 | RSS: Main: 245116928 06:57:21 INFO - PROCESS | 1690 | 06:57:23 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 06:57:23 INFO - PROCESS | 1690 | RSS: Main: 245559296 06:57:23 INFO - PROCESS | 1690 | 06:57:25 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:26 INFO - PROCESS | 1690 | RSS: Main: 247091200 06:57:26 INFO - PROCESS | 1690 | 06:57:29 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:30 INFO - PROCESS | 1690 | RSS: Main: 247099392 06:57:30 INFO - PROCESS | 1690 | 06:57:32 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:33 INFO - PROCESS | 1690 | RSS: Main: 247078912 06:57:33 INFO - PROCESS | 1690 | 06:57:36 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 06:57:37 INFO - PROCESS | 1690 | RSS: Main: 247431168 06:57:37 INFO - PROCESS | 1690 | 06:57:38 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:57:39 INFO - PROCESS | 1690 | RSS: Main: 247062528 06:57:39 INFO - PROCESS | 1690 | 06:57:41 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:57:41 INFO - PROCESS | 1690 | RSS: Main: 247304192 06:57:41 INFO - PROCESS | 1690 | 06:57:44 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:57:44 INFO - PROCESS | 1690 | RSS: Main: 247390208 06:57:44 INFO - PROCESS | 1690 | 06:57:47 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:57:48 INFO - PROCESS | 1690 | RSS: Main: 247472128 06:57:48 INFO - PROCESS | 1690 | 06:57:51 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:57:51 INFO - PROCESS | 1690 | RSS: Main: 247513088 06:57:51 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 06:57:53 INFO - PROCESS | 1690 | RSS: Main: 249503744 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | __start_tp_report 06:57:53 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 06:57:53 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 06:57:53 INFO - PROCESS | 1690 | |i|pagename|runs| 06:57:53 INFO - PROCESS | 1690 | |0;ai-astar;115;116;109;117;119;118;110;117;117;115 06:57:53 INFO - PROCESS | 1690 | |1;audio-beat-detection;179;157;176;172;145;171;136;158;181;142 06:57:53 INFO - PROCESS | 1690 | |2;audio-dft;195;204;200;199;197;197;195;192;196;193 06:57:53 INFO - PROCESS | 1690 | |3;audio-fft;54;92;108;171;57;54;57;63;158;76 06:57:53 INFO - PROCESS | 1690 | |4;audio-oscillator;77;84;127;76;79;98;119;82;78;119 06:57:53 INFO - PROCESS | 1690 | |5;imaging-gaussian-blur;90;128;88;85;87;85;92;85;88;120 06:57:53 INFO - PROCESS | 1690 | |6;imaging-darkroom;95;97;134;94;104;146;95;95;95;95 06:57:53 INFO - PROCESS | 1690 | |7;imaging-desaturate;117;93;90;97;91;96;92;92;92;92 06:57:53 INFO - PROCESS | 1690 | |8;json-parse-financial;60;64;64;64;68;66;66;83;63;61 06:57:53 INFO - PROCESS | 1690 | |9;json-stringify-tinderbox;66;69;67;76;77;70;67;68;68;68 06:57:53 INFO - PROCESS | 1690 | |10;stanford-crypto-aes;81;83;82;82;82;90;113;110;108;102 06:57:53 INFO - PROCESS | 1690 | |11;stanford-crypto-ccm;167;148;138;140;127;143;143;152;147;145 06:57:53 INFO - PROCESS | 1690 | |12;stanford-crypto-pbkdf2;170;169;166;172;224;163;228;216;222;164 06:57:53 INFO - PROCESS | 1690 | |13;stanford-crypto-sha256-iterative;70;67;72;68;67;69;68;69;65;70 06:57:53 INFO - PROCESS | 1690 | __end_tp_report 06:57:53 INFO - PROCESS | 1690 | __start_cc_report 06:57:53 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,1084 06:57:53 INFO - PROCESS | 1690 | __end_cc_report 06:57:53 INFO - PROCESS | 1690 | __startTimestamp1465221473786__endTimestamp 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | ------- Summary: start ------- 06:57:53 INFO - PROCESS | 1690 | Number of tests: 14 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#0] ai-astar Cycles:10 Average:115.30 Median:117.00 stddev:3.30 (2.8%) stddev-sans-first:3.50 06:57:53 INFO - PROCESS | 1690 | Values: 115.0 116.0 109.0 117.0 119.0 118.0 110.0 117.0 117.0 115.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#1] audio-beat-detection Cycles:10 Average:161.70 Median:171.50 stddev:16.44 (9.6%) stddev-sans-first:16.20 06:57:53 INFO - PROCESS | 1690 | Values: 179.0 157.0 176.0 172.0 145.0 171.0 136.0 158.0 181.0 142.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#2] audio-dft Cycles:10 Average:196.80 Median:197.00 stddev:3.52 (1.8%) stddev-sans-first:3.67 06:57:53 INFO - PROCESS | 1690 | Values: 195.0 204.0 200.0 199.0 197.0 197.0 195.0 192.0 196.0 193.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#3] audio-fft Cycles:10 Average:89.00 Median:57.00 stddev:43.71 (76.7%) stddev-sans-first:44.49 06:57:53 INFO - PROCESS | 1690 | Values: 54.0 92.0 108.0 171.0 57.0 54.0 57.0 63.0 158.0 76.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:78.50 stddev:20.26 (25.8%) stddev-sans-first:20.54 06:57:53 INFO - PROCESS | 1690 | Values: 77.0 84.0 127.0 76.0 79.0 98.0 119.0 82.0 78.0 119.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:87.50 stddev:15.67 (17.9%) stddev-sans-first:16.52 06:57:53 INFO - PROCESS | 1690 | Values: 90.0 128.0 88.0 85.0 87.0 85.0 92.0 85.0 88.0 120.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:95.00 stddev:18.88 (19.9%) stddev-sans-first:19.68 06:57:53 INFO - PROCESS | 1690 | Values: 95.0 97.0 134.0 94.0 104.0 146.0 95.0 95.0 95.0 95.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:92.00 stddev:7.96 (8.6%) stddev-sans-first:2.28 06:57:53 INFO - PROCESS | 1690 | Values: 117.0 93.0 90.0 97.0 91.0 96.0 92.0 92.0 92.0 92.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:6.45 (9.9%) stddev-sans-first:6.48 06:57:53 INFO - PROCESS | 1690 | Values: 60.0 64.0 64.0 64.0 68.0 66.0 66.0 83.0 63.0 61.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:68.50 stddev:3.81 (5.6%) stddev-sans-first:3.81 06:57:53 INFO - PROCESS | 1690 | Values: 66.0 69.0 67.0 76.0 77.0 70.0 67.0 68.0 68.0 68.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:82.00 stddev:13.38 (16.3%) stddev-sans-first:13.43 06:57:53 INFO - PROCESS | 1690 | Values: 81.0 83.0 82.0 82.0 82.0 90.0 113.0 110.0 108.0 102.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:146.00 stddev:10.28 (7.0%) stddev-sans-first:7.20 06:57:53 INFO - PROCESS | 1690 | Values: 167.0 148.0 138.0 140.0 127.0 143.0 143.0 152.0 147.0 145.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.40 Median:194.00 stddev:28.76 (14.8%) stddev-sans-first:29.63 06:57:53 INFO - PROCESS | 1690 | Values: 170.0 169.0 166.0 172.0 224.0 163.0 228.0 216.0 222.0 164.0 06:57:53 INFO - PROCESS | 1690 | 06:57:53 INFO - PROCESS | 1690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.96 (2.8%) stddev-sans-first:2.00 06:57:53 INFO - PROCESS | 1690 | Values: 70.0 67.0 72.0 68.0 67.0 69.0 68.0 69.0 65.0 70.0 06:57:53 INFO - PROCESS | 1690 | -------- Summary: end -------- 06:57:53 INFO - PROCESS | 1690 | 06:57:54 INFO - TEST-INFO | 1690: exit 0 06:57:54 INFO - TEST-OK | kraken | took 59627ms 06:57:54 INFO - SUITE-END | took 1170s 06:57:54 INFO - Completed test suite (00:19:31) 06:57:54 INFO - javascript benchmark 06:57:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.0552645259327, 3433.450647896334, 3441.6214216436188, 3479.338925604135, 3501.1772233525126, 5636.802711905084, 5702.54379649628, 5707.286589176353, 5711.771529138835, 5752.02215623344, 5614.691191984439, 5676.347220069683, 5676.886462270752, 5687.601867869251, 5743.109817978209, 5149.639525233235, 5219.373675158986, 5220.0, 5301.0988132017455, 5325.3875804282425, 5137.229415587654, 5310.73446327684, 5376.38171610264, 5393.649412788156, 5396.352437707481, 4716.4340279166545, 4985.950140498603, 5286.154215325549, 5288.995090932711, 5317.6809391436445, 5230.712310822903, 5230.8692282692855, 5248.737563121847, 5266.499682530191, 5289.576833853283, 5171.3277273954145, 5197.246399272084, 5304.840854774363, 5353.0, 5380.408155102936, 4816.927746083811, 5668.234788303567, 5695.544356451515, 5703.258576385043, 5724.8855022899725, 5001.724905130216, 6043.8186854394435, 6238.812835614939, 6254.030625253093, 6287.371262873676, 5876.9118463223085, 5931.021381472052, 6283.0, 6303.243610766692, 6334.809955701337, 4839.37088178538, 5170.405403378584, 5236.266922630834, 5840.474357307863, 5880.558958078119, 5813.157092221604, 6182.1345011698395, 6215.844603884939, 6319.273283572356, 6319.96840015797, 5151.9484805152215, 6110.114033465123, 6152.911956916751, 6155.230596175478, 6171.47542458896, 6158.230221222348, 6159.630422174684, 6167.753289868445, 6170.259568851677, 6192.040233763774, 6137.324894261627, 6139.201903752483, 6140.995089002448, 6168.290646575701, 6171.537134714914, 6122.265328160649, 6145.5698101133385, 6188.969055154786, 6248.4064013918605, 6251.781187658501, 4590.357349971006, 4782.928256076161, 4832.540908613676, 4940.580050695659, 4956.107900577858, 3835.4055121456217, 4346.847860324937, 4359.542248063971, 4391.98984233628, 4440.4671439427475, 5717.942820571824, 5792.580817699606, 5821.970890145522, 5860.619059761102, 5884.176215329857, 6123.526657168203, 6131.070842498441, 6234.625922444668, 6237.251529816361, 6244.625322480666, 4818.397700287464, 5588.329400471888, 5700.429957004267, 5831.825045248649, 5924.081767325985, 5403.351597808288, 5416.674999500043, 5422.295101636762, 5427.647202931876, 5438.972805135949, 6159.045347971071, 6313.589616674902, 6348.143000694847, 6352.904706429407, 6370.299267080617, 6224.439800417984, 6235.625862448268, 6272.8118156455375, 6295.401936815995, 6296.275928268308, 6357.841053973502, 6367.458766004941, 6381.234251889803, 6388.616682999035, 6389.584676995981, 5075.974620126875, 6077.058056001327, 6117.279373342293, 6242.157308763259, 6257.28041275241, 6246.937530624636, 6260.968695156495, 6277.529185311028, 6310.873782524232, 6320.178376810985, 5761.164631128547, 6112.694365281629, 6171.814845554641, 6197.81406557804, 6218.626882387071, 5990.6705131218205, 6098.75604975796, 6130.061839217998, 6175.0, 6181.0, 5924.377940316204, 5990.251218597676, 5999.310079340931, 6010.068439391901, 6069.089636554552, 6156.969215153896, 6170.382961703794, 6181.690915454299, 6204.348543402878, 6207.11369213318, 4981.452040275639, 5871.882562348815, 5933.2880054393745, 5999.9100013498955, 6041.607295525777], "value": 5661.310434132772, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.4430348134456, 533.4370069663255, 558.2240685447229, 587.3187102960567, 606.2482521673127, 39976.400353994715, 40087.99780005501, 41059.99999999996, 41284.0, 41307.38038929415, 42530.574694253126, 43035.0, 43112.56887431125, 43212.0, 43263.0, 9611.471369074698, 9769.218462523017, 9864.457454839981, 9912.157466615346, 9912.454814985173, 9762.21902247822, 9785.902140978606, 9812.852807207897, 9912.653057143001, 9927.354721943051, 9833.31166818323, 9906.504674766269, 9919.0, 9919.057689519484, 9927.056929591678, 9799.608015679365, 9809.705708828747, 9877.60489580416, 9901.504924753734, 9902.603895844157, 8263.545504997222, 9626.085521875411, 9705.805883882353, 9779.364341317863, 9779.53307003948, 32219.51670724941, 38920.610793892265, 39314.60685393138, 39425.802870985746, 39534.406983895264, 2941.4264218477406, 3164.8892288769784, 3174.3968645957193, 3250.8862189823244, 3267.640559538449, 26878.5968210477, 27785.305367365774, 28561.428771424664, 29370.0, 29572.70427295721, 2385.49904520051, 2731.6312297839736, 2785.8328500289845, 2786.4984302825483, 2820.3936153727045, 420465.0, 426687.0, 426712.86643566896, 427661.0, 433333.0, 35935.28129437449, 36911.26177476435, 64146.0, 64528.0, 64625.676871616284, 35155.64844351524, 35244.0, 35946.28107437836, 36144.0, 36274.8186259067, 12386.5664701735, 14770.0, 14861.702765944838, 15185.0, 15223.238838058052, 12734.554290599785, 12816.743665126645, 12830.422630981628, 12836.48654053846, 12921.547745828851, 7322.487425880137, 8063.072746634095, 8138.674453021813, 8384.832303353898, 8400.033996090528, 3423.880164194291, 3464.7401444891734, 3469.410200265961, 3478.3912815257227, 3486.825658717054, 946.5503885654397, 986.0, 1043.0351924469835, 1051.673981065872, 1108.9944550277196, 28220.85889570539, 28539.143825685263, 30372.69627303743, 31471.21321966969, 32048.519272210935, 1114.3703807348822, 1152.740633357488, 1158.0330424095973, 1233.3709807997807, 1266.4807428954268, 14499.92750036243, 14907.105573665614, 15304.464343747915, 15312.0, 16462.670746585, 649026.0, 658049.0, 664654.0, 668304.0, 670840.0, 59453.40546594565, 60336.69831650814, 60927.695361523794, 61257.38742612606, 62050.689746550976, 1497.1989985357782, 1522.9010114342532, 1524.1769444500067, 1529.4111766969797, 1531.364483739258, 29866.552001719556, 29936.101916941654, 30267.545986810655, 30651.0, 31004.68995310018, 50666.493335066174, 52018.73990630022, 52312.738436307576, 52765.736171318895, 52862.47137528576, 631349.0, 631899.0, 634120.8293958501, 636614.0, 637953.0, 26027.479450411265, 26610.866945665148, 26637.733622664302, 26690.19929402121, 26999.190024298518, 45844.7707761459, 46070.0, 46170.38403655856, 46909.3581724638, 48506.02987940292, 37416.81291593525, 37682.057948551505, 37899.242015160096, 38050.619493804705, 38290.42564361481, 38094.42858357071, 38109.23781524299, 38138.0, 38600.613993859704, 39617.40573891336, 32937.01188964335, 35598.466023010194, 36309.818450908635, 38762.6123738759, 39538.209235815695, 30347.848260758554, 31375.90184343537, 31830.204244894063, 31860.840695796374, 31913.0, 17841.821581784017, 22052.88973555122, 24519.26442206737, 24586.0, 24804.875975620005], "value": 18654.661156213428, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.351729370598, 406.96540794032524, 408.78130200342815, 409.5147250508146, 413.6897327004746, 14879.032862863905, 17160.570985725364, 20408.469364797624, 20673.586528269443, 21084.472888177785, 19908.50228744282, 20603.0, 20625.0, 20865.26971555996, 21180.25869094582, 5625.212470254168, 5804.042333015058, 6017.458428741413, 6132.172156758847, 6141.815745527641, 5761.366249712549, 5945.464908158265, 5995.13070604762, 6003.30961939376, 6019.277686677605, 6019.729112189962, 6047.455728984391, 6053.757849686007, 6055.27336719592, 6073.119397687355, 5715.742791574368, 6066.514678825683, 6068.817935461899, 6069.878602427949, 6070.787522436738, 5807.82576522705, 5848.473637372615, 5962.165296858443, 5973.522118230531, 5982.162497250345, 13425.462981480729, 13787.586372408843, 13861.722765544633, 26121.0, 26130.477390452084, 2072.751269847613, 2193.670949357609, 2289.4848659051745, 2294.128231272106, 2450.3506570758764, 9824.312298139133, 9949.204063674888, 10210.001735551563, 12857.67855803603, 14823.0, 1490.7614781634995, 1725.6548690261998, 1734.254270663614, 1787.294018862542, 1792.4622613216113, 102879.48560257225, 108947.45526272398, 110716.4464177682, 110863.0, 111290.0, 11730.941345293219, 11865.644030679094, 11889.346085965355, 11935.880641193477, 11954.163208575315, 15025.323860426308, 15047.623809404633, 15187.240637968058, 15302.464413745465, 15309.6172595686, 8419.158084191531, 8733.737987860375, 8843.646254149891, 8882.733517994471, 8909.064548222343, 8823.823523529622, 8825.514596697243, 8834.337424693174, 8836.160564746338, 8878.20096191333, 4683.929741053887, 4691.319758635047, 4751.168545504523, 4756.500567440438, 4778.474367819537, 1991.8605697601029, 2017.2334512885009, 2023.8279746221442, 2061.7732049474544, 2077.7298951136254, 907.1971305394774, 941.1294552539011, 967.5452537307455, 972.7081875437341, 974.1573538888952, 16511.917440412722, 18118.728219076726, 20072.69890951637, 21109.83726158764, 21508.56982860334, 937.8218138553653, 944.6127087893931, 1005.2510879394752, 1009.6819501856892, 1037.9169666426667, 11316.773664526663, 11365.886341136484, 11381.532564767018, 11393.886061139283, 11499.0, 574494.0, 576717.0, 599663.0, 652663.0, 663535.0, 95065.0, 102827.4858625702, 132891.0, 134291.0, 134380.0, 874.6807415293372, 1031.9071283584362, 1047.5914393386586, 1062.4209805655937, 1063.4895250279908, 18805.529861753017, 18872.622547549247, 18873.0, 19034.33379831699, 19232.0, 51646.74176629093, 52302.738486307324, 52867.77332569998, 53870.0, 53893.92212155656, 69984.0, 76940.0, 78514.4297114066, 79027.0, 79613.20386796058, 8284.295834853863, 8346.624401901807, 8390.580470976549, 8518.275946544365, 8650.0, 11896.345700986529, 12618.305993170463, 12766.234025958473, 12788.744225115632, 12859.16415432994, 10867.29362591429, 11195.2723073, 11197.44012799373, 11287.153463490107, 11424.200305978502, 7147.392471639969, 10753.784924301313, 10908.945455272673, 11187.160962927976, 11232.045276151619, 11655.53377864876, 11662.88337116652, 11788.410579471163, 11808.645740627795, 11881.800629611858, 8307.750767476744, 8379.413441059067, 8380.20388063133, 8568.35737319691, 8591.140885911358, 10519.526621301906, 11103.72240693989, 11319.320840749582, 11360.886391136313, 11364.920332568392], "value": 9607.232678839258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.6213446638342, 1515.3484001879187, 1737.0, 1823.3618233618226, 1937.7674679038516, 7859.410544209193, 8497.447665901713, 8630.18013288738, 8842.027376988533, 8904.0, 8629.956850215756, 8655.69705060323, 8669.349798765086, 8734.781630459242, 8773.517456539903, 2108.1988844239245, 2353.635186546084, 2434.172381390327, 2446.3394883381566, 2471.542764588557, 2431.4043059450373, 2432.8053755699502, 2462.642916777066, 2469.086438017936, 2487.589547724623, 2461.4953934443397, 2481.7270100289043, 2488.365466805971, 2501.199616122832, 2502.8248022638422, 2420.818438617102, 2430.258771074839, 2430.6718592989896, 2449.9142530011454, 2470.542949554338, 2075.5122546201633, 2447.7919376852988, 2454.2882564056404, 2472.443700167466, 2473.9257822265363, 8745.825083498357, 8827.646894124227, 8853.822923541558, 8899.644014239422, 8920.598573064228, 5357.571394288448, 5358.705271210082, 5429.6742195468005, 5506.091494903336, 5506.724663766796, 3402.1834759657504, 3507.754457187998, 3512.6487351264923, 3566.0, 3584.0, 922.7324076018014, 1039.77644806367, 1054.7626783973622, 1071.571371451418, 1072.9302595331278, 11131.777364452666, 11334.093272538177, 11408.657740267723, 11455.599054033151, 11954.282743035359, 4535.365048893158, 4588.151192029485, 4630.166570017429, 4636.39726835516, 4651.906961860744, 7347.63261836906, 7698.884516732253, 9282.793236879297, 9303.720888373224, 9338.346315757968, 5257.342832145981, 5261.184516399964, 5273.709945952933, 5277.261183434322, 5294.285271488377, 4391.363252328394, 4812.1578723723205, 4907.043126590352, 4916.901661966741, 4984.476629953802, 3888.300105980951, 3897.5322961244265, 3974.6621537169085, 3980.24375368679, 4010.6590939770444, 1098.6703988803326, 1231.8090695942144, 1236.8082947143207, 1237.0969192489533, 1245.339969815999, 813.2639960835453, 839.3327304792705, 921.3090182363228, 937.9343445958717, 943.1841457139662, 5866.648001119861, 5980.162777211107, 6021.458068773743, 6071.089336599545, 6132.0, 457.80085662736815, 461.24586301397454, 473.2309996256084, 476.2522839142582, 490.43844797706424, 3932.3511620582285, 3974.364101743707, 4015.9598404015587, 4033.1731994940965, 4068.06434520062, 10542.262041657164, 10887.0, 10927.344359338465, 10959.726006849893, 11012.17408694351, 10575.788484230272, 10576.576936922436, 10604.045635892806, 10633.946830265799, 10701.0, 7862.646180921873, 8099.87850182236, 8269.62786674601, 8330.166983301742, 8451.323894088458, 5848.53211743068, 5871.089981052944, 5921.3190483094995, 6013.9097913532205, 6049.18336024631, 9126.954365228132, 9439.103285187895, 9451.905480945103, 9658.323917325719, 9665.806683866424, 9619.18236949867, 9849.901500984899, 9877.802443951225, 9888.011198880055, 9901.009899010041, 6831.146106736658, 7249.05762250904, 7480.438967077382, 7574.242575742382, 7703.922960770545, 8224.424290299621, 8266.586670666564, 8272.627731752205, 8279.0, 8310.501369917582, 7225.24134965842, 7366.189719130784, 7382.9630851845395, 7473.51422157558, 7480.438967077382, 7195.0, 7205.927940720526, 7237.095363079615, 7251.601161935933, 7334.706611735471, 7046.577205367695, 7077.6461176941975, 7137.429005679637, 7141.535800172972, 7160.355567998905, 4773.069251495925, 4881.463039065771, 4948.331975183304, 4997.475265097258, 5020.297158397901, 4967.883487049205, 4996.875078123076, 5007.649464537448, 5089.745512724423, 5244.265802787537], "value": 4494.360053859324, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.50988252797015, 326.8578168496704, 334.5867853201296, 334.84597085340744, 337.6269222509129, 6657.0, 6744.08954791103, 6753.561018533792, 6785.525013249075, 6807.0, 6769.424598909086, 6791.660416979156, 6834.179898412198, 6870.82822929427, 6898.620575868338, 4594.72431654101, 5046.571041461461, 5059.519345662175, 5069.073751974244, 5073.974630126844, 5055.646104772667, 5056.696598204119, 5062.392512898457, 5068.341115654978, 5085.745712714368, 4567.497575266734, 5002.474740152286, 5007.649464537484, 5015.22264049073, 5030.346055012861, 4847.975760121194, 5009.148444764399, 5014.84955451337, 5017.949820501784, 5024.547790698818, 4255.5744425557195, 4278.272693642089, 4293.527711951683, 4300.075483771005, 4325.762083085429, 6502.967485162591, 6507.837304067436, 6515.0, 6543.836404089889, 6658.334166583351, 5945.910811337833, 5955.464008239279, 5963.701814909237, 5965.313988891289, 5998.1002849572915, 6892.172939247273, 7263.709451621929, 7321.194668586451, 7337.0, 7355.705771769123, 3879.495665563487, 4465.37484752135, 4634.073185362907, 4778.211595086841, 4779.474257831635, 7732.845343093163, 7787.415943804237, 7792.805179870492, 7809.758950035785, 7826.647800848976, 4846.660733748674, 4851.587615052689, 4859.416869975555, 4860.513948605182, 4881.170201065827, 4934.481879402611, 4937.7777999990085, 4941.407031156285, 4945.060438516671, 4965.0069986002945, 5921.585489015728, 5924.14099955504, 5930.318013428425, 5930.7924222652, 5973.402659734079, 6964.4080253179045, 7330.0, 7337.559746415232, 7340.853182936311, 7395.85208295831, 1259.4017841525201, 1371.835379754436, 1654.586353411647, 1658.4112640012863, 1658.8175300716912, 956.3592393096642, 991.0535438656066, 1010.7271036820165, 1020.0360659177155, 1039.5374058544026, 5466.480684334982, 5691.662459322056, 5734.684592347461, 6727.966360168168, 6847.383735463832, 6182.218001899074, 6687.465002799861, 6842.73409419259, 7531.171571127172, 7695.422843286776, 6805.455563554904, 6854.931450685429, 6894.517383783087, 6917.9308206918295, 6922.826929326807, 3999.060220848098, 4043.8180281887385, 4055.371417430303, 4059.7970101494807, 4061.878143655695, 7149.9285007149265, 7845.1762564931005, 7937.563434011185, 7966.681332746741, 8104.230098140667, 6425.935740642627, 7935.64289606969, 7949.7217597383815, 7960.721374751856, 7980.960095199487, 8052.758417247492, 8052.959735201286, 8055.798605034921, 8084.0, 8114.350851931831, 7347.963260183665, 7619.885701714368, 7636.732714354971, 7664.616769161408, 7683.500572462772, 6114.57197996136, 7343.41252699772, 7408.851822963403, 7431.851362972819, 7447.702091916262, 8002.999625046869, 8040.517568945882, 8055.637496312797, 8075.353971682134, 8078.3133433658795, 4680.742559159279, 4723.716577005391, 4724.503927087744, 4741.0, 4742.52574742523, 7261.854762904818, 7569.243075692607, 7639.121501027231, 7640.8471830564185, 7668.884966725615, 7316.561006339637, 7354.963225184054, 7381.188069312264, 7386.593737344498, 7391.556506609621, 7310.561366318038, 7378.262173782578, 7378.29906158914, 7383.261673832574, 7387.4459415545125, 5913.645181289136, 7192.352688258082, 7196.3163499469565, 7236.20401755817, 7237.986681864649, 7091.0, 7358.926410735824, 7435.0, 7437.107547094383, 7442.106947166375, 7199.1361036675935, 7233.421326293989, 7237.240089790496, 7247.347738703542, 7258.3104605062435], "value": 5294.264841176049, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.3264767879799, 690.6684791300178, 740.829609189886, 759.9924000759994, 782.9177936316687, 14801.037932534391, 14902.627434314147, 14980.925095374509, 15032.248387580617, 15094.0, 12102.697432564168, 13629.863701362983, 13692.0, 13697.246651434167, 13731.725365492684, 732.3591857125016, 795.5624406576388, 897.9146981036791, 912.0560220172123, 930.8836395450569, 914.9862752058724, 918.7335672654956, 927.2489283680206, 927.7726956895536, 928.6517555916531, 927.3323207290773, 986.57577241786, 990.9157721593673, 990.9990909181706, 993.4784238274927, 921.216965579259, 922.3359181389388, 923.1783712495884, 925.2967744514184, 929.6420877962033, 685.1880521581942, 687.1204857782047, 717.9533330333512, 722.9132504099489, 730.8611363840906, 13891.583252502442, 14172.078814877103, 14270.857291427057, 14274.571762847027, 14336.0, 12489.0, 12578.056645751514, 12651.0, 12716.491340346467, 12741.36293185337, 7883.724069657592, 7894.486858354246, 7894.605269736548, 10044.799104017879, 10107.0, 3510.947335789965, 3539.8938031859084, 3540.5751309842726, 3812.866549670748, 4274.658027357804, 73179.0, 73697.5260494787, 74190.62904685442, 75757.10607234808, 75898.62050689712, 9113.81772364549, 9860.260480463994, 9866.30935834499, 10061.39631622105, 10086.697399078039, 18163.36428225032, 22465.775342246696, 22654.66018009731, 22755.31734047981, 22802.543949120925, 6298.338674439209, 6483.740650374027, 7570.5836179010685, 7615.428842836809, 7677.385809135256, 4023.657989070903, 4100.979495102505, 4107.486564179478, 4151.066010147753, 4163.2298024865495, 3083.7378822799865, 3624.1845584743223, 3682.263547290499, 3700.16746232101, 3705.9073523162137, 659.1266571792394, 659.8185498987817, 674.4873895839197, 675.0279597379757, 683.9213490448562, 555.8665920179128, 576.0178894984042, 602.8251806976016, 607.7477846693573, 608.7473698415108, 8161.428699991063, 8270.669173233124, 8353.749387518385, 8551.273141782895, 8554.657813687507, 552.4889477233543, 596.4352590332277, 602.5601311042875, 611.3763960760089, 615.6613862375675, 3857.267119247334, 3919.0, 3919.510061242345, 4017.9769918367333, 4173.499180098408, 85572.57213714016, 99450.00549994552, 101277.49361253147, 101614.0, 103185.0, 57261.0, 73942.26057739461, 79514.0, 79796.6010169957, 80036.19963800404, 71283.6435817828, 71476.28523714696, 71880.64059679773, 71908.64045679843, 72595.91106133412, 8345.791355216168, 8567.871481927652, 8587.828243434971, 8627.91372086271, 8651.826963460822, 37939.620603793606, 49102.0, 49173.80370275921, 49941.0, 50110.0, 67769.98345024927, 70244.29755702378, 70732.0, 71847.0, 72704.63647681728, 11243.381614011309, 11272.83090753623, 11444.885551144715, 11663.24188927717, 11708.531658733555, 11940.402979850798, 11985.340806255392, 12096.637100886988, 12295.077869160028, 12519.687007824878, 11192.552297907992, 11303.378314192469, 11330.433478325886, 11549.14268904964, 11919.642410727693, 11367.550809507367, 11528.654140375802, 11774.705632359259, 11996.160268781101, 12295.086062604898, 9672.0, 11034.282771619819, 11231.606893758679, 11332.490037948148, 11339.0, 9702.805943881223, 9792.412455252708, 9838.996424362267, 9992.750181245236, 10180.643677471253, 8217.342612591097, 9629.0, 9995.150412215044, 10058.647947321808, 10061.295709300572], "value": 6910.132810035736, "unit": "score"}], "name": "dromaeo_css", "value": 7419.643022238749, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 109.0, 117.0, 119.0, 118.0, 110.0, 117.0, 117.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 157.0, 176.0, 172.0, 145.0, 171.0, 136.0, 158.0, 181.0, 142.0], "value": 161.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 204.0, 200.0, 199.0, 197.0, 197.0, 195.0, 192.0, 196.0, 193.0], "value": 196.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 92.0, 108.0, 171.0, 57.0, 54.0, 57.0, 63.0, 158.0, 76.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 127.0, 76.0, 79.0, 98.0, 119.0, 82.0, 78.0, 119.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 128.0, 88.0, 85.0, 87.0, 85.0, 92.0, 85.0, 88.0, 120.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 134.0, 94.0, 104.0, 146.0, 95.0, 95.0, 95.0, 95.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 93.0, 90.0, 97.0, 91.0, 96.0, 92.0, 92.0, 92.0, 92.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 64.0, 64.0, 68.0, 66.0, 66.0, 83.0, 63.0, 61.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 76.0, 77.0, 70.0, 67.0, 68.0, 68.0, 68.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 82.0, 82.0, 82.0, 90.0, 113.0, 110.0, 108.0, 102.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 148.0, 138.0, 140.0, 127.0, 143.0, 143.0, 152.0, 147.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 166.0, 172.0, 224.0, 163.0, 228.0, 216.0, 222.0, 164.0], "value": 189.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 72.0, 68.0, 67.0, 69.0, 68.0, 69.0, 65.0, 70.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1583.3999999999999, "alertThreshold": 2.0}]} 06:57:55 INFO - Return code: 0 06:57:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:57:55 ERROR - # TBPL SUCCESS # 06:57:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:57:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:57:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:57:55 INFO - 2016-06-06 06:57:55.106 screenresolution[1695:10433] starting screenresolution argv=screenresolution get 06:57:55 INFO - 2016-06-06 06:57:55.109 screenresolution[1695:10433] Display 0: 1600x1200x32@60 06:57:55 INFO - 2016-06-06 06:57:55.115 screenresolution[1696:10436] starting screenresolution argv=screenresolution list 06:57:55 INFO - Available Modes on Display 0 06:57:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:57:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:57:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:57:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:57:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:57:55 INFO - Intel Iris: 06:57:55 INFO - Chipset Model: Intel Iris 06:57:55 INFO - Type: GPU 06:57:55 INFO - Bus: Built-In 06:57:55 INFO - VRAM (Dynamic, Max): 1536 MB 06:57:55 INFO - Vendor: Intel (0x8086) 06:57:55 INFO - Device ID: 0x0a2e 06:57:55 INFO - Revision ID: 0x0009 06:57:55 INFO - Displays: 06:57:55 INFO - Display: 06:57:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:57:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:57:55 INFO - Display Serial Number: 1600x1200 60 06:57:55 INFO - Main Display: Yes 06:57:55 INFO - Mirror: Off 06:57:55 INFO - Online: Yes 06:57:55 INFO - Rotation: Supported 06:57:55 INFO - Return code: 0 06:57:55 INFO - Running post-action listener: _resource_record_post_action 06:57:55 INFO - Running post-run listener: _resource_record_post_run 06:57:56 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 36804096; Write bytes: 655217664; Read time: 237; Write time: 1808 06:57:56 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 353403392; Write bytes: 348456960; Read time: 28069; Write time: 674 06:57:56 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 34969088; Write bytes: 297012224; Read time: 221; Write time: 1100 06:57:56 INFO - Running post-run listener: _upload_blobber_files 06:57:56 INFO - Blob upload gear active. 06:57:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:57:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:57:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:57:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:57:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:57:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:57 INFO - (blobuploader) - INFO - Done attempting. 06:57:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:57:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:57:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:58 INFO - (blobuploader) - INFO - Done attempting. 06:57:58 INFO - (blobuploader) - INFO - Iteration through files over. 06:57:58 INFO - Return code: 0 06:57:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:57:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:57:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/242ccd93a5decef9059c4237731b11bb3dfe2c8c1ddc8e5de93fa59219756c79bee9cedefeb955aa2c0b6fa9caedd13a9d531a81e89c8811a9f7697fbc8e05eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3409cc2a3721ef8d67165f688bb256181cf2bfc7e7a84f8b1846be0e6df23f7caf88775ce81a2d8ac56641bdd1ec38f3a1e27152e698b5361b1a8ebeb212221f"} 06:57:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:57:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:57:58 INFO - Contents: 06:57:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/242ccd93a5decef9059c4237731b11bb3dfe2c8c1ddc8e5de93fa59219756c79bee9cedefeb955aa2c0b6fa9caedd13a9d531a81e89c8811a9f7697fbc8e05eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3409cc2a3721ef8d67165f688bb256181cf2bfc7e7a84f8b1846be0e6df23f7caf88775ce81a2d8ac56641bdd1ec38f3a1e27152e698b5361b1a8ebeb212221f"} 06:57:58 INFO - Running post-run listener: copy_logs_to_upload_dir 06:57:58 INFO - Copying logs to upload dir... 06:57:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:57:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.667380 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-06 06:57:58.658772) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:57:58.662295) ========= 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.o7jxJXToAw/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.u5W6XL06sB/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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/242ccd93a5decef9059c4237731b11bb3dfe2c8c1ddc8e5de93fa59219756c79bee9cedefeb955aa2c0b6fa9caedd13a9d531a81e89c8811a9f7697fbc8e05eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3409cc2a3721ef8d67165f688bb256181cf2bfc7e7a84f8b1846be0e6df23f7caf88775ce81a2d8ac56641bdd1ec38f3a1e27152e698b5361b1a8ebeb212221f"} build_url:https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/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/242ccd93a5decef9059c4237731b11bb3dfe2c8c1ddc8e5de93fa59219756c79bee9cedefeb955aa2c0b6fa9caedd13a9d531a81e89c8811a9f7697fbc8e05eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3409cc2a3721ef8d67165f688bb256181cf2bfc7e7a84f8b1846be0e6df23f7caf88775ce81a2d8ac56641bdd1ec38f3a1e27152e698b5361b1a8ebeb212221f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:57:58.693717) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:57:58.694045) ========= 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.o7jxJXToAw/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.u5W6XL06sB/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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.005084 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:57:58.742709) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:57:58.743040) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:57:58.743370) ========= ========= Total master_lag: 0.64 =========