builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0073 starttime: 1461479953.28 results: success (0) buildid: 20160423225058 builduid: e1d4c5cb78d24f88b6389002f64d0523 revision: 08791c3d6f713f4032f704e44bae22353bbdae77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:13.277322) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:13.277794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:13.278701) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:13.380273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:13.380685) ========= 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.61YMbngFKb/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.4Lxzwr5qy5/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-04-23 23:39:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.34M=0.002s 2016-04-23 23:39:13 (7.34 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131765 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:13.532760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:13.533245) ========= 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.61YMbngFKb/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.4Lxzwr5qy5/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.019695 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:13.588546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 23:39:13.588900) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08791c3d6f713f4032f704e44bae22353bbdae77 --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 08791c3d6f713f4032f704e44bae22353bbdae77 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.61YMbngFKb/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.4Lxzwr5qy5/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-04-23 23:39:13,663 truncating revision to first 12 chars 2016-04-23 23:39:13,663 Setting DEBUG logging. 2016-04-23 23:39:13,664 attempt 1/10 2016-04-23 23:39:13,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/08791c3d6f71?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 23:39:14,425 unpacking tar archive at: mozilla-aurora-08791c3d6f71/testing/mozharness/ program finished with exit code 0 elapsedTime=1.013690 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 23:39:14.802159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:14.802722) ========= script_repo_revision: 08791c3d6f713f4032f704e44bae22353bbdae77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:14.803571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:14.804261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 23:39:14.872134) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-04-23 23:39:14.872452) ========= /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.61YMbngFKb/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.4Lxzwr5qy5/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:39:15 INFO - MultiFileLogger online at 20160423 23:39:15 in /builds/slave/test 23:39:15 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 23:39:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:39:15 INFO - {'append_to_log': False, 23:39:15 INFO - 'base_work_dir': '/builds/slave/test', 23:39:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:39:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:39:15 INFO - 'branch': 'Mozilla-Aurora', 23:39:15 INFO - 'buildbot_json_path': 'buildprops.json', 23:39:15 INFO - 'config_files': ('talos/mac_config.py',), 23:39:15 INFO - 'default_actions': ('clobber', 23:39:15 INFO - 'read-buildbot-config', 23:39:15 INFO - 'download-and-extract', 23:39:15 INFO - 'populate-webroot', 23:39:15 INFO - 'create-virtualenv', 23:39:15 INFO - 'install', 23:39:15 INFO - 'run-tests'), 23:39:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:39:15 INFO - 'download_minidump_stackwalk': True, 23:39:15 INFO - 'download_symbols': 'ondemand', 23:39:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:39:15 INFO - 'tooltool.py': '/tools/tooltool.py', 23:39:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:39:15 INFO - '/tools/misc-python/virtualenv.py')}, 23:39:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:39:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:39:15 INFO - 'installer_path': 'installer.exe', 23:39:15 INFO - 'log_level': 'info', 23:39:15 INFO - 'log_name': 'talos', 23:39:15 INFO - 'log_to_console': True, 23:39:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:39:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:39:15 INFO - 'opt_config_files': (), 23:39:15 INFO - 'pip_index': False, 23:39:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:39:15 INFO - 'cmd': ('bash', 23:39:15 INFO - '-c', 23:39:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:39:15 INFO - 'enabled': True, 23:39:15 INFO - 'halt_on_failure': False, 23:39:15 INFO - 'name': 'check_screen_resolution'},), 23:39:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:39:15 INFO - 'cmd': ('bash', 23:39:15 INFO - '-c', 23:39:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:39:15 INFO - 'enabled': True, 23:39:15 INFO - 'halt_on_failure': False, 23:39:15 INFO - 'name': 'check_screen_resolution'},), 23:39:15 INFO - 'run_cmd_checks_enabled': True, 23:39:15 INFO - 'sps_profile': False, 23:39:15 INFO - 'sps_profile_interval': 0, 23:39:15 INFO - 'suite': 'dromaeojs-e10s', 23:39:15 INFO - 'system_bits': '32', 23:39:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:39:15 INFO - 'title': 't-yosemite-r7-0073', 23:39:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:39:15 INFO - 'use_talos_json': True, 23:39:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:39:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:39:15 INFO - 'work_dir': 'build'} 23:39:15 INFO - ##### 23:39:15 INFO - ##### Running clobber step. 23:39:15 INFO - ##### 23:39:15 INFO - Running pre-action listener: _resource_record_pre_action 23:39:15 INFO - Running main action method: clobber 23:39:15 INFO - rmtree: /builds/slave/test/build 23:39:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:39:16 INFO - Running post-action listener: _resource_record_post_action 23:39:16 INFO - ##### 23:39:16 INFO - ##### Running read-buildbot-config step. 23:39:16 INFO - ##### 23:39:16 INFO - Running pre-action listener: _resource_record_pre_action 23:39:16 INFO - Running main action method: read_buildbot_config 23:39:16 INFO - Using buildbot properties: 23:39:16 INFO - { 23:39:16 INFO - "project": "", 23:39:16 INFO - "product": "firefox", 23:39:16 INFO - "script_repo_revision": "production", 23:39:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 23:39:16 INFO - "repository": "", 23:39:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 23:39:16 INFO - "buildid": "20160423225058", 23:39:16 INFO - "pgo_build": "False", 23:39:16 INFO - "basedir": "/builds/slave/test", 23:39:16 INFO - "buildnumber": 291, 23:39:16 INFO - "slavename": "t-yosemite-r7-0073", 23:39:16 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 23:39:16 INFO - "platform": "yosemite_r7", 23:39:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 23:39:16 INFO - "branch": "mozilla-aurora", 23:39:16 INFO - "repo_path": "releases/mozilla-aurora", 23:39:16 INFO - "revision": "08791c3d6f713f4032f704e44bae22353bbdae77", 23:39:16 INFO - "stage_platform": "macosx64", 23:39:16 INFO - "builduid": "e1d4c5cb78d24f88b6389002f64d0523", 23:39:16 INFO - "slavebuilddir": "test" 23:39:16 INFO - } 23:39:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 23:39:16 INFO - Running post-action listener: _resource_record_post_action 23:39:16 INFO - ##### 23:39:16 INFO - ##### Running download-and-extract step. 23:39:16 INFO - ##### 23:39:16 INFO - Running pre-action listener: _resource_record_pre_action 23:39:16 INFO - Running main action method: download_and_extract 23:39:16 INFO - mkdir: /builds/slave/test/build/tests 23:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:39:16 INFO - https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 23:39:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 23:39:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 23:39:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 23:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 23:39:40 INFO - Downloaded 1277 bytes. 23:39:40 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 23:39:40 INFO - Using the following test package requirements: 23:39:40 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 23:39:40 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 23:39:40 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 23:39:40 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 23:39:40 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 23:39:40 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 23:39:40 INFO - u'jsshell-mac.zip'], 23:39:40 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 23:39:40 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 23:39:40 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 23:39:40 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 23:39:40 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 23:39:40 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 23:39:40 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 23:39:40 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 23:39:40 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 23:39:40 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 23:39:40 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 23:39:40 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 23:39:40 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 23:39:40 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')]} 23:39:40 INFO - https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 23:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 23:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 23:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 23:39:42 INFO - Downloaded 17917528 bytes. 23:39:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:39:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:39:46 INFO - Return code: 0 23:39:46 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 23:39:46 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')]} 23:39:46 INFO - https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 23:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 23:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 23:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 23:39:48 INFO - Downloaded 17917528 bytes. 23:39:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:39:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:39:52 INFO - Return code: 0 23:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:39:52 INFO - https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:39:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 23:39:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 23:39:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 23:39:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 23:39:53 INFO - Downloaded 10845194 bytes. 23:39:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:39:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 23:39:53 INFO - Return code: 0 23:39:53 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')]} 23:39:53 INFO - https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 23:39:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 23:39:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 23:39:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 23:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 23:40:00 INFO - Downloaded 115760089 bytes. 23:40:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 23:40:00 INFO - mkdir: /builds/slave/test/properties 23:40:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:40:00 INFO - Writing to file /builds/slave/test/properties/build_url 23:40:00 INFO - Contents: 23:40:00 INFO - build_url:https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 23:40:00 INFO - Running post-action listener: _resource_record_post_action 23:40:00 INFO - Running post-action listener: set_extra_try_arguments 23:40:00 INFO - ##### 23:40:00 INFO - ##### Running populate-webroot step. 23:40:00 INFO - ##### 23:40:00 INFO - Running pre-action listener: _resource_record_pre_action 23:40:00 INFO - Running main action method: populate_webroot 23:40:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:40:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:40:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:40:00 INFO - '--tppagecycles', 23:40:00 INFO - '7'], 23:40:00 INFO - 'tests': ['tsvgm']}}, 23:40:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:40:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:40:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:40:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:40:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:40:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:40:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:40:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:00 INFO - 'talos_options': ['--e10s'], 23:40:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:40:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:00 INFO - 'tests': ['damp', 'tps']}, 23:40:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:00 INFO - 'talos_options': ['--e10s'], 23:40:00 INFO - 'tests': ['damp', 'tps']}, 23:40:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:40:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:40:00 INFO - 'other': {'tests': ['a11yr', 23:40:00 INFO - 'ts_paint', 23:40:00 INFO - 'tpaint', 23:40:00 INFO - 'sessionrestore', 23:40:00 INFO - 'sessionrestore_no_auto_restore', 23:40:00 INFO - 'tabpaint']}, 23:40:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:40:00 INFO - 'tests': ['a11yr', 23:40:00 INFO - 'ts_paint', 23:40:00 INFO - 'tpaint', 23:40:00 INFO - 'sessionrestore', 23:40:00 INFO - 'sessionrestore_no_auto_restore', 23:40:00 INFO - 'tabpaint']}, 23:40:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:40:00 INFO - 'tests': ['a11yr', 23:40:00 INFO - 'ts_paint', 23:40:00 INFO - 'tpaint', 23:40:00 INFO - 'sessionrestore', 23:40:00 INFO - 'sessionrestore_no_auto_restore', 23:40:00 INFO - 'tabpaint']}, 23:40:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:40:00 INFO - 'tests': ['a11yr', 23:40:00 INFO - 'ts_paint', 23:40:00 INFO - 'tpaint', 23:40:00 INFO - 'sessionrestore', 23:40:00 INFO - 'sessionrestore_no_auto_restore', 23:40:00 INFO - 'tabpaint']}, 23:40:00 INFO - 'other_l64': {'tests': ['a11yr', 23:40:00 INFO - 'ts_paint', 23:40:00 INFO - 'tpaint', 23:40:00 INFO - 'sessionrestore', 23:40:00 INFO - 'sessionrestore_no_auto_restore', 23:40:00 INFO - 'tabpaint']}, 23:40:00 INFO - 'other_nol64': {'tests': ['a11yr', 23:40:00 INFO - 'ts_paint', 23:40:00 INFO - 'tpaint', 23:40:00 INFO - 'sessionrestore', 23:40:00 INFO - 'sessionrestore_no_auto_restore', 23:40:00 INFO - 'tabpaint']}, 23:40:00 INFO - 'svgr': {'tests': ['tsvgx', 23:40:00 INFO - 'tsvgr_opacity', 23:40:00 INFO - 'tart', 23:40:00 INFO - 'tscrollx', 23:40:00 INFO - 'cart']}, 23:40:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:40:00 INFO - 'tests': ['tsvgx', 23:40:00 INFO - 'tsvgr_opacity', 23:40:00 INFO - 'tart', 23:40:00 INFO - 'tscrollx', 23:40:00 INFO - 'cart']}, 23:40:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:00 INFO - 'tests': ['tp5o']}, 23:40:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:00 INFO - 'talos_options': ['--e10s'], 23:40:00 INFO - 'tests': ['tp5o']}, 23:40:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:00 INFO - 'talos_options': ['--xperf_path', 23:40:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:40:00 INFO - 'tests': ['tp5n']}, 23:40:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:00 INFO - 'talos_options': ['--e10s', 23:40:00 INFO - '--xperf_path', 23:40:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:40:00 INFO - 'tests': ['tp5n']}}, 23:40:00 INFO - 'talos.zip': {'path': '', 23:40:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:40:00 INFO - Running post-action listener: _resource_record_post_action 23:40:00 INFO - ##### 23:40:00 INFO - ##### Running create-virtualenv step. 23:40:00 INFO - ##### 23:40:00 INFO - Running pre-action listener: _resource_record_pre_action 23:40:00 INFO - Running main action method: create_virtualenv 23:40:00 INFO - Creating virtualenv /builds/slave/test/build/venv 23:40:00 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 23:40:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:40:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:40:00 INFO - Using real prefix '/tools/python27' 23:40:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:40:01 INFO - Installing distribute.............................................................................................................................................................................................done. 23:40:04 INFO - Installing pip.................done. 23:40:04 INFO - Return code: 0 23:40:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:40: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')]} 23:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40: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')]} 23:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:04 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 0x1051a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051ae4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb513c674a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, '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.61YMbngFKb/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.4Lxzwr5qy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:40:04 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 23:40:04 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 23:40:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:40:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:40:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:40:04 INFO - 'HOME': '/Users/cltbld', 23:40:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:40:04 INFO - 'LOGNAME': 'cltbld', 23:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:04 INFO - 'MOZ_NO_REMOTE': '1', 23:40:04 INFO - 'NO_EM_RESTART': '1', 23:40:04 INFO - 'PAGER': '/bin/cat', 23:40:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:04 INFO - 'PWD': '/builds/slave/test', 23:40:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:40:04 INFO - 'SHELL': '/bin/bash', 23:40:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:40:04 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:40:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:40:04 INFO - 'USER': 'cltbld', 23:40:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:40:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:04 INFO - 'XPC_FLAGS': '0x0', 23:40:04 INFO - 'XPC_SERVICE_NAME': '0', 23:40:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:04 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 23:40:04 INFO - Cleaning up... 23:40:04 INFO - Return code: 0 23:40:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:40: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')]} 23:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40: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')]} 23:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:04 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 0x1051a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051ae4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb513c674a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, '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.61YMbngFKb/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.4Lxzwr5qy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:40:04 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 23:40:04 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 23:40:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:40:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:40:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:40:04 INFO - 'HOME': '/Users/cltbld', 23:40:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:40:04 INFO - 'LOGNAME': 'cltbld', 23:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:04 INFO - 'MOZ_NO_REMOTE': '1', 23:40:04 INFO - 'NO_EM_RESTART': '1', 23:40:04 INFO - 'PAGER': '/bin/cat', 23:40:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:04 INFO - 'PWD': '/builds/slave/test', 23:40:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:40:04 INFO - 'SHELL': '/bin/bash', 23:40:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:40:04 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:40:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:40:04 INFO - 'USER': 'cltbld', 23:40:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:40:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:04 INFO - 'XPC_FLAGS': '0x0', 23:40:04 INFO - 'XPC_SERVICE_NAME': '0', 23:40:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:05 INFO - Downloading/unpacking psutil>=0.7.1 23:40:05 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 23:40:05 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 23:40:05 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 23:40:05 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 23:40:05 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 23:40:05 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 23:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:40:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:40:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:40:07 INFO - Installing collected packages: psutil 23:40:07 INFO - Running setup.py install for psutil 23:40:07 INFO - building 'psutil._psutil_osx' extension 23:40:07 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 23:40:08 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 23:40:08 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 23:40:08 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 23:40:08 INFO - building 'psutil._psutil_posix' extension 23:40:08 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 23:40:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:40:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:40:08 INFO - ^ 23:40:08 INFO - 1 warning generated. 23:40:08 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 23:40:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:40:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:40:08 INFO - Successfully installed psutil 23:40:08 INFO - Cleaning up... 23:40:08 INFO - Return code: 0 23:40:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1051a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051ae4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb513c674a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, '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.61YMbngFKb/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.4Lxzwr5qy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:40:08 INFO - 'HOME': '/Users/cltbld', 23:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:40:08 INFO - 'LOGNAME': 'cltbld', 23:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:08 INFO - 'MOZ_NO_REMOTE': '1', 23:40:08 INFO - 'NO_EM_RESTART': '1', 23:40:08 INFO - 'PAGER': '/bin/cat', 23:40:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:08 INFO - 'PWD': '/builds/slave/test', 23:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:40:08 INFO - 'SHELL': '/bin/bash', 23:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:40:08 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:40:08 INFO - 'USER': 'cltbld', 23:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:08 INFO - 'XPC_FLAGS': '0x0', 23:40:08 INFO - 'XPC_SERVICE_NAME': '0', 23:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:40:09 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 23:40:09 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 23:40:09 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 23:40:09 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 23:40:09 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 23:40:09 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 23:40:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:40:11 INFO - Installing collected packages: mozsystemmonitor 23:40:11 INFO - Running setup.py install for mozsystemmonitor 23:40:11 INFO - Successfully installed mozsystemmonitor 23:40:11 INFO - Cleaning up... 23:40:11 INFO - Return code: 0 23:40:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:40:11 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')]} 23:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:11 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')]} 23:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:11 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 0x1051a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051ae4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb513c674a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, '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.61YMbngFKb/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.4Lxzwr5qy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:40:11 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 23:40:11 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 23:40:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:40:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:40:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:40:11 INFO - 'HOME': '/Users/cltbld', 23:40:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:40:11 INFO - 'LOGNAME': 'cltbld', 23:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:11 INFO - 'MOZ_NO_REMOTE': '1', 23:40:11 INFO - 'NO_EM_RESTART': '1', 23:40:11 INFO - 'PAGER': '/bin/cat', 23:40:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:11 INFO - 'PWD': '/builds/slave/test', 23:40:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:40:11 INFO - 'SHELL': '/bin/bash', 23:40:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:40:11 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:40:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:40:11 INFO - 'USER': 'cltbld', 23:40:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:40:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:11 INFO - 'XPC_FLAGS': '0x0', 23:40:11 INFO - 'XPC_SERVICE_NAME': '0', 23:40:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:11 INFO - Downloading/unpacking blobuploader==1.2.4 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 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 23:40:11 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 23:40:14 INFO - Downloading blobuploader-1.2.4.tar.gz 23:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:40:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:40:14 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 23:40:14 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 23:40:14 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 23:40:14 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 23:40:14 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 23:40:14 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 23:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:40:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 INFO - Downloading docopt-0.6.1.tar.gz 23:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:40:15 INFO - Installing collected packages: blobuploader, requests, docopt 23:40:15 INFO - Running setup.py install for blobuploader 23:40:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:40:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:40:15 INFO - Running setup.py install for requests 23:40:16 INFO - Running setup.py install for docopt 23:40:16 INFO - Successfully installed blobuploader requests docopt 23:40:16 INFO - Cleaning up... 23:40:16 INFO - Return code: 0 23:40:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:16 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 0x1051a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051ae4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb513c674a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, '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.61YMbngFKb/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.4Lxzwr5qy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:40:16 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 23:40:16 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 23:40:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:40:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:40:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:40:16 INFO - 'HOME': '/Users/cltbld', 23:40:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:40:16 INFO - 'LOGNAME': 'cltbld', 23:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:16 INFO - 'MOZ_NO_REMOTE': '1', 23:40:16 INFO - 'NO_EM_RESTART': '1', 23:40:16 INFO - 'PAGER': '/bin/cat', 23:40:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:16 INFO - 'PWD': '/builds/slave/test', 23:40:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:40:16 INFO - 'SHELL': '/bin/bash', 23:40:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:40:16 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:40:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:40:16 INFO - 'USER': 'cltbld', 23:40:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:40:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:16 INFO - 'XPC_FLAGS': '0x0', 23:40:16 INFO - 'XPC_SERVICE_NAME': '0', 23:40:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:40:17 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-3heJxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:40:17 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-R66oBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:40:17 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-kmDv8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:40:17 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-0KBceo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:40:17 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-RbIClJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:40:17 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-cEnjEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:40:17 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-nPaLP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:40:17 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-hDbNyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:40:18 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-fv_VFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:40:18 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-wIZDyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:40:18 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-4HVnDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:40:18 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ebljdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:40:18 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-fK0OBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:40:18 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-dE_pvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:18 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-dG62G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:40:18 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-YLmos7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:40:18 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-4_eYzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:40:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:40:19 INFO - Running setup.py install for manifestparser 23:40:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Running setup.py install for mozcrash 23:40:19 INFO - Running setup.py install for mozdebug 23:40:19 INFO - Running setup.py install for mozdevice 23:40:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Running setup.py install for mozfile 23:40:19 INFO - Running setup.py install for mozhttpd 23:40:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Running setup.py install for mozinfo 23:40:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Running setup.py install for mozInstall 23:40:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Running setup.py install for mozleak 23:40:20 INFO - Running setup.py install for mozlog 23:40:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Running setup.py install for moznetwork 23:40:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Running setup.py install for mozprocess 23:40:20 INFO - Running setup.py install for mozprofile 23:40:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:40:20 INFO - Running setup.py install for mozrunner 23:40:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:40:21 INFO - Running setup.py install for mozscreenshot 23:40:21 INFO - Running setup.py install for moztest 23:40:21 INFO - Running setup.py install for mozversion 23:40:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:40:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:40:21 INFO - Cleaning up... 23:40:21 INFO - Return code: 0 23:40:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:21 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 0x1051a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051ae4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb513c674a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, '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.61YMbngFKb/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.4Lxzwr5qy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:40:21 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 23:40:21 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 23:40:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:40:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:40:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:40:21 INFO - 'HOME': '/Users/cltbld', 23:40:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:40:21 INFO - 'LOGNAME': 'cltbld', 23:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:21 INFO - 'MOZ_NO_REMOTE': '1', 23:40:21 INFO - 'NO_EM_RESTART': '1', 23:40:21 INFO - 'PAGER': '/bin/cat', 23:40:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:21 INFO - 'PWD': '/builds/slave/test', 23:40:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:40:21 INFO - 'SHELL': '/bin/bash', 23:40:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:40:21 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:40:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:40:21 INFO - 'USER': 'cltbld', 23:40:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:40:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:21 INFO - 'XPC_FLAGS': '0x0', 23:40:21 INFO - 'XPC_SERVICE_NAME': '0', 23:40:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:40:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-h3EPTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:40:21 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)) 23:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:40:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Hw22L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:40:22 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)) 23:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:40:22 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-DC5gZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:40:22 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)) 23:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:40:22 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ud_i83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:40:22 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)) 23:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:40:22 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-EbZsL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:40:22 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)) 23:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:40:22 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-zjXN0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:40:22 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)) 23:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:40:22 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-uc99C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:40:22 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)) 23:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:40:22 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-XELKwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:40:22 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)) 23:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:40:22 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-iBKiRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:40:22 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)) 23:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:40:22 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-71PVM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:40:22 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)) 23:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:40:22 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-QG4H5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:40:23 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)) 23:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:40:23 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-CFXjV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:40:23 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)) 23:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:40:23 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-0Skqsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:40:23 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)) 23:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:40:23 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-MNlZ1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:40:23 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)) 23:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:23 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-dp_mym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:23 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)) 23:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:40:23 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-JxW4co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:40:23 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)) 23:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:40:23 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ZexYjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:26 INFO - Downloading blessings-1.6.tar.gz 23:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:40:26 INFO - Installing collected packages: blessings 23:40:26 INFO - Running setup.py install for blessings 23:40:26 INFO - Successfully installed blessings 23:40:26 INFO - Cleaning up... 23:40:26 INFO - Return code: 0 23:40:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:40:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:40:27 INFO - Reading from file tmpfile_stdout 23:40:27 INFO - Current package versions: 23:40:27 INFO - blessings == 1.6 23:40:27 INFO - blobuploader == 1.2.4 23:40:27 INFO - docopt == 0.6.1 23:40:27 INFO - manifestparser == 1.1 23:40:27 INFO - mozInstall == 1.12 23:40:27 INFO - mozcrash == 0.17 23:40:27 INFO - mozdebug == 0.1 23:40:27 INFO - mozdevice == 0.48 23:40:27 INFO - mozfile == 1.2 23:40:27 INFO - mozhttpd == 0.7 23:40:27 INFO - mozinfo == 0.9 23:40:27 INFO - mozleak == 0.1 23:40:27 INFO - mozlog == 3.1 23:40:27 INFO - moznetwork == 0.27 23:40:27 INFO - mozprocess == 0.22 23:40:27 INFO - mozprofile == 0.28 23:40:27 INFO - mozrunner == 6.11 23:40:27 INFO - mozscreenshot == 0.1 23:40:27 INFO - mozsystemmonitor == 0.0 23:40:27 INFO - moztest == 0.7 23:40:27 INFO - mozversion == 1.4 23:40:27 INFO - psutil == 3.1.1 23:40:27 INFO - requests == 1.2.3 23:40:27 INFO - wsgiref == 0.1.2 23:40:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:27 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 0x1051a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051ae4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb513c674a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, '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.61YMbngFKb/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.4Lxzwr5qy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:40:27 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 23:40:27 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 23:40:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:40:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:40:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:40:27 INFO - 'HOME': '/Users/cltbld', 23:40:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:40:27 INFO - 'LOGNAME': 'cltbld', 23:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:27 INFO - 'MOZ_NO_REMOTE': '1', 23:40:27 INFO - 'NO_EM_RESTART': '1', 23:40:27 INFO - 'PAGER': '/bin/cat', 23:40:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:27 INFO - 'PWD': '/builds/slave/test', 23:40:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:40:27 INFO - 'SHELL': '/bin/bash', 23:40:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:40:27 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:40:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:40:27 INFO - 'USER': 'cltbld', 23:40:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:40:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:27 INFO - 'XPC_FLAGS': '0x0', 23:40:27 INFO - 'XPC_SERVICE_NAME': '0', 23:40:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:27 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)) 23:40:27 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)) 23:40:27 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)) 23:40:27 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)) 23:40:27 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)) 23:40:27 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)) 23:40:27 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)) 23:40:27 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)) 23:40:27 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)) 23:40:27 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)) 23:40:27 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)) 23:40:27 INFO - Cleaning up... 23:40:27 INFO - Return code: 0 23:40:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1051a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051ae4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb513c674a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, '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.61YMbngFKb/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.4Lxzwr5qy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:40:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:40:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:40:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:40:27 INFO - 'HOME': '/Users/cltbld', 23:40:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:40:27 INFO - 'LOGNAME': 'cltbld', 23:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:27 INFO - 'MOZ_NO_REMOTE': '1', 23:40:27 INFO - 'NO_EM_RESTART': '1', 23:40:27 INFO - 'PAGER': '/bin/cat', 23:40:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:27 INFO - 'PWD': '/builds/slave/test', 23:40:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:40:27 INFO - 'SHELL': '/bin/bash', 23:40:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:40:27 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:40:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:40:27 INFO - 'USER': 'cltbld', 23:40:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:40:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:27 INFO - 'XPC_FLAGS': '0x0', 23:40:27 INFO - 'XPC_SERVICE_NAME': '0', 23:40:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:27 INFO - Downloading/unpacking jsonschema 23:40: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 23:40: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 23:40: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 23:40: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 23:40: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 23:40: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 23:40:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:40:30 INFO - Downloading/unpacking functools32 (from jsonschema) 23:40: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 23:40: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 23:40: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 23:40: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 23:40: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 23:40: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 23:40:30 INFO - Downloading functools32-3.2.3-2.tar.gz 23:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:40:30 INFO - warning: no files found matching '*.txt' 23:40:30 INFO - no previously-included directories found matching 'build' 23:40:30 INFO - no previously-included directories found matching 'dist' 23:40:30 INFO - no previously-included directories found matching '.git*' 23:40:30 INFO - Installing collected packages: jsonschema, functools32 23:40:30 INFO - Running setup.py install for functools32 23:40:30 INFO - warning: no files found matching '*.txt' 23:40:30 INFO - no previously-included directories found matching 'build' 23:40:30 INFO - no previously-included directories found matching 'dist' 23:40:30 INFO - no previously-included directories found matching '.git*' 23:40:30 INFO - Successfully installed jsonschema functools32 23:40:30 INFO - Cleaning up... 23:40:30 INFO - Return code: 0 23:40:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:40:30 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')]} 23:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:30 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')]} 23:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:30 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 0x1051a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051ae4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb513c674a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, '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.61YMbngFKb/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.4Lxzwr5qy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 23:40:30 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 23:40:30 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 23:40:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:40:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:40:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:40:30 INFO - 'HOME': '/Users/cltbld', 23:40:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:40:30 INFO - 'LOGNAME': 'cltbld', 23:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:30 INFO - 'MOZ_NO_REMOTE': '1', 23:40:30 INFO - 'NO_EM_RESTART': '1', 23:40:30 INFO - 'PAGER': '/bin/cat', 23:40:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:30 INFO - 'PWD': '/builds/slave/test', 23:40:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:40:30 INFO - 'SHELL': '/bin/bash', 23:40:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:40:30 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:40:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:40:30 INFO - 'USER': 'cltbld', 23:40:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:40:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:30 INFO - 'XPC_FLAGS': '0x0', 23:40:30 INFO - 'XPC_SERVICE_NAME': '0', 23:40:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:31 INFO - Downloading/unpacking flake8 23:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:40:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:40:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:40:34 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 23:40:34 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 23:40:34 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 23:40:34 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 23:40:34 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 23:40:34 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 23:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:40:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:40:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:40:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:40:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:40:34 INFO - no previously-included directories found matching 'docs/_build' 23:40:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:40:34 INFO - Running setup.py install for pep8 23:40:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:40:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:40:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:40:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:40:35 INFO - no previously-included directories found matching 'docs/_build' 23:40:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:40:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:40:35 INFO - Cleaning up... 23:40:35 INFO - Return code: 0 23:40:35 INFO - Running post-action listener: _resource_record_post_action 23:40:35 INFO - Running post-action listener: _start_resource_monitoring 23:40:35 INFO - Starting resource monitoring. 23:40:35 INFO - ##### 23:40:35 INFO - ##### Running install step. 23:40:35 INFO - ##### 23:40:35 INFO - Running pre-action listener: _resource_record_pre_action 23:40:35 INFO - Running main action method: install 23:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:40:35 INFO - Reading from file tmpfile_stdout 23:40:35 INFO - Detecting whether we're running mozinstall >=1.0... 23:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:40:35 INFO - Reading from file tmpfile_stdout 23:40:35 INFO - Output received: 23:40:35 INFO - Usage: mozinstall [options] installer 23:40:35 INFO - Options: 23:40:35 INFO - -h, --help show this help message and exit 23:40:35 INFO - -d DEST, --destination=DEST 23:40:35 INFO - Directory to install application into. [default: 23:40:35 INFO - "/builds/slave/test"] 23:40:35 INFO - --app=APP Application being installed. [default: firefox] 23:40:35 INFO - mkdir: /builds/slave/test/build/application 23:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 23:41:07 INFO - Reading from file tmpfile_stdout 23:41:07 INFO - Output received: 23:41:07 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 23:41:07 INFO - Running post-action listener: _resource_record_post_action 23:41:07 INFO - ##### 23:41:07 INFO - ##### Running run-tests step. 23:41:07 INFO - ##### 23:41:07 INFO - Running pre-action listener: _resource_record_pre_action 23:41:07 INFO - Running main action method: run_tests 23:41:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:41:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:41:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:41:07 INFO - 2016-04-23 23:41:07.711 screenresolution[2194:21106] starting screenresolution argv=screenresolution get 23:41:07 INFO - 2016-04-23 23:41:07.714 screenresolution[2194:21106] Display 0: 1600x1200x32@60 23:41:07 INFO - 2016-04-23 23:41:07.720 screenresolution[2195:21108] starting screenresolution argv=screenresolution list 23:41:07 INFO - Available Modes on Display 0 23:41:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:41:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:41:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:41:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:41:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:41:07 INFO - Intel Iris: 23:41:07 INFO - Chipset Model: Intel Iris 23:41:07 INFO - Type: GPU 23:41:07 INFO - Bus: Built-In 23:41:07 INFO - VRAM (Dynamic, Max): 1536 MB 23:41:07 INFO - Vendor: Intel (0x8086) 23:41:07 INFO - Device ID: 0x0a2e 23:41:07 INFO - Revision ID: 0x0009 23:41:07 INFO - Displays: 23:41:07 INFO - Display: 23:41:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:41:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:41:07 INFO - Display Serial Number: 1600x1200 60 23:41:07 INFO - Main Display: Yes 23:41:07 INFO - Mirror: Off 23:41:07 INFO - Online: Yes 23:41:07 INFO - Rotation: Supported 23:41:07 INFO - Return code: 0 23:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:41:07 INFO - Python 2.7.3 23:41:07 INFO - Return code: 0 23:41:07 INFO - grabbing minidump binary from tooltool 23:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:41:07 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 0x10504bd30>, '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 0x104eafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105042b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:41:07 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 23:41:07 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 23:41:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:41:08 INFO - Return code: 0 23:41:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:41:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:41:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:41:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:41:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:41:09 INFO - Return code: 0 23:41:09 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/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 23:41:09 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/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --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 23:41:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.61YMbngFKb/Render', 23:41:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:41:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:41:09 INFO - 'HOME': '/Users/cltbld', 23:41:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:41:09 INFO - 'LOGNAME': 'cltbld', 23:41:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:41:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:41:09 INFO - 'MOZ_NO_REMOTE': '1', 23:41:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:41:09 INFO - 'NO_EM_RESTART': '1', 23:41:09 INFO - 'PAGER': '/bin/cat', 23:41:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:41:09 INFO - 'PWD': '/builds/slave/test', 23:41:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:41:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:41:09 INFO - 'SHELL': '/bin/bash', 23:41:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4Lxzwr5qy5/Listeners', 23:41:09 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 23:41:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:41:09 INFO - 'USER': 'cltbld', 23:41:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:41:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:41:09 INFO - 'XPC_FLAGS': '0x0', 23:41:09 INFO - 'XPC_SERVICE_NAME': '0', 23:41:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:41:09 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/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 23:41:09 INFO - mozversion application_buildid: 20160423225058 23:41:09 INFO - mozversion application_changeset: 08791c3d6f713f4032f704e44bae22353bbdae77 23:41:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:41:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:41:09 INFO - mozversion application_name: Firefox 23:41:09 INFO - mozversion application_remotingname: firefox-dev 23:41:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:41:09 INFO - mozversion application_vendor: Mozilla 23:41:09 INFO - mozversion application_version: 47.0a2 23:41:09 INFO - mozversion platform_buildid: 20160423225058 23:41:09 INFO - mozversion platform_changeset: 08791c3d6f713f4032f704e44bae22353bbdae77 23:41:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:41:09 INFO - mozversion platform_version: 47.0a2 23:41:09 INFO - using testdate: 1461480069 23:41:09 INFO - actual date: 1461480069 23:41:09 INFO - starting webserver on 'localhost:52516' 23:41:09 INFO - SUITE-START | Running 2 tests 23:41:09 INFO - TEST-START | dromaeo_css 23:41:09 INFO - operating with platform_type : mac_ 23:41:09 INFO - Initialising browser for dromaeo_css test... 23:41:09 INFO - TEST-INFO | started process 2213 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpqzY4_0/profile http://localhost:52516/getInfo.html) 23:41:12 INFO - PROCESS | 2213 | __metrics Screen width/height:1600/1200 23:41:12 INFO - PROCESS | 2213 | colorDepth:24 23:41:12 INFO - PROCESS | 2213 | Browser inner width/height: 1024/689 23:41:12 INFO - PROCESS | 2213 | __metrics 23:41:12 ERROR - PROCESS | 2213 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:41:12 INFO - TEST-INFO | 2213: exit 0 23:41:12 INFO - Browser initialized. 23:41:12 INFO - Running cycle 1/1 for dromaeo_css test... 23:41:12 INFO - TEST-INFO | started process 2216 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpqzY4_0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:41:24 INFO - PROCESS | 2216 | RSS: Main: 218013696 23:41:24 INFO - PROCESS | 2216 | 23:42:14 INFO - PROCESS | 2216 | 1461480134477 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] 23:44:25 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:52516/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52516/tests/dromaeo/cssquery-ext.html) 23:44:26 INFO - PROCESS | 2216 | RSS: Main: 228392960 23:44:26 INFO - PROCESS | 2216 | 23:47:28 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:52516/tests/dromaeo/cssquery-ext.html (next: http://localhost:52516/tests/dromaeo/cssquery-jquery.html) 23:47:29 INFO - PROCESS | 2216 | RSS: Main: 240123904 23:47:29 INFO - PROCESS | 2216 | 23:50:30 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:52516/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52516/tests/dromaeo/cssquery-mootools.html) 23:50:31 INFO - PROCESS | 2216 | RSS: Main: 242122752 23:50:31 INFO - PROCESS | 2216 | 23:53:32 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:52516/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52516/tests/dromaeo/cssquery-prototype.html) 23:53:33 INFO - PROCESS | 2216 | RSS: Main: 243765248 23:53:33 INFO - PROCESS | 2216 | 23:56:36 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:52516/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52516/tests/dromaeo/cssquery-yui.html) 23:56:36 INFO - PROCESS | 2216 | RSS: Main: 246575104 23:56:36 INFO - PROCESS | 2216 | 23:59:39 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:52516/tests/dromaeo/cssquery-yui.html (next: http://localhost:52516/tests/dromaeo/cssquery-dojo.html) 23:59:39 INFO - PROCESS | 2216 | RSS: Main: 248139776 23:59:39 INFO - PROCESS | 2216 | 23:59:39 INFO - PROCESS | 2216 | __start_tp_report 23:59:39 INFO - PROCESS | 2216 | _x_x_mozilla_page_load 23:59:39 INFO - PROCESS | 2216 | _x_x_mozilla_page_load_details 23:59:39 INFO - PROCESS | 2216 | |i|pagename|runs| 23:59:39 INFO - PROCESS | 2216 | |0;dojo.html;3016.6380034395875;3217.163537480255;3568.072301201687;3606.585242697089;3616.8914932552034;5869.471747542721;5876.11858221267;5915.14230436587;5922.970385148068;5936.050231962881;5847;5864.941350586493;5869.853253668661;5889.234399528066;5957.52339812815;5311.707856067915;5353.411124776271;5415.13357862742;5424.457554244584;5490.094134467808;5262.842114736545;5376.623636345457;5402.459754024605;5404.972975135119;5421.322334708161;5373.462653734615;5410.513053825155;5442.537384322337;5446.863828404302;5457;4352.586504282088;5183;5382.0043291991105;5428.75570599324;5491.450854914517;4260.360945858115;5132.897342053138;5200.765965531522;5359.169328754049;5371.221172929903;5569.136783798518;5724.856878578027;5764.308283006066;5779;5781.392953739839;6145.477634401082;6158.784442544489;6160.907586386208;6210.068489726532;6212.565120441571;5251.422343542207;6139.706800529493;6202.945499265091;6233.501319894398;6248.875022499525;5076.578558003765;5117.771734783662;5831.212786273841;6031.314906534576;6040.516758659297;6276.968615156895;6388.7125079371535;6409.262934762469;6415;6431.549791514549;6133.172021777003;6143.082036032849;6153.353897840662;6195.659238741912;6259.593126446766;6244.875102497925;6275.309715931244;6283.3088360280335;6291.339409362043;6299.874002519924;6021.488173505213;6162.952298109332;6185.165002724664;6186.133941248228;6193.752249909953;6128.992047069329;6131.743695907034;6141.355157708465;6199.752009919553;6209.348018458088;4186.392973018956;4945.060438516671;4976.875578110504;5011;5036.546710796046;4391.956080439219;4424.623906967944;4494.505604383515;4501.257292546693;4513.774311284423;5748.9425105748405;5950;5972.134040564094;6030.939690603038;6049.364816694272;6216.409441103088;6240.812775616739;6260.40526150015;6269.937300627026;6271.090691849657;5858.941410585925;5892;5969.283685957626;5984.251968503937;6026.758929642853;5445.673259604437;5466.617336786387;5498.092814685532;5508.338999320027;5541.27963364768;6409.03864420322;6417.679116044179;6430.356964303533;6437.452816510556;6439.839004024843;6125.388069147376;6162.907556386568;6214.316425193135;6227;6270.968645156745;6417.839554011187;6431.839204019937;6434.903476447764;6461.321561236003;6480.351964803482;6194.473469754941;6213.751449941951;6236.438720514994;6246.219222597176;6271.372862713874;5162.561182299396;6131;6161.106639537153;6211.068339748893;6250.124982502362;4697;5995;6161.537884658758;6186.969065154645;6194.163787888578;6088.238970128734;6120.7857724981195;6121.204243448323;6126.509879209563;6135.1717518136265;5839.270091238595;5981.7607295707685;6025.276966764016;6072.757089716539;6114.57197996136;5238.795077132205;5709.685967271674;6044.667543285162;6199.535034872312;6208.348123446973;5052.065367906949;5232.03207406631;5896.882062358814;6115.235595550556;6116.052011938156 23:59:39 INFO - PROCESS | 2216 | |1;ext.html;470.7904982282885;543.0605053257862;561.9971900140499;619.6034537895747;678.7420780103562;40336;41016.79491602538;41074.79462602683;41081;41099.38350924738;43788;43881.90295242621;44410.555894441044;44432.111357772825;44500;9724.708258752213;9901.158401535879;9935.602575896955;9939.304248702594;9956.402615843073;9739.074787895139;9806.509674516246;9829.164521015686;9886.653967111153;9909.653162139326;9961.053699898497;10004.349717268391;10050.246231532628;10070.848937265946;10078.546465409037;9959.75100622483;9968.601255949754;10025.398476091457;10034.849477257847;10043.548040338203;9947.651832185838;10085.49572521371;10087.848682269772;10100.949495252551;10117.291789574732;43758.781206093765;43812.3428148578;44033.339499907524;44295.557044429785;45113.54886451159;3279.6556361582166;3437.9312413751586;3533.664301891342;3566.001519574523;3859.749116307459;27228.45543089147;29493.115206543836;29645.555316670267;29760.70239297601;29951;2610.5562054450597;2629.474105178953;2637.0638423359815;2673.25148958292;2701.8243814152015;392392.03803981084;398076;400665;400690;401036.9999999971;77910.61044694853;78167.21832781713;78179.26372576933;78811.8178227327;78863;68411;81210.18789812144;86993.56503217443;87442.56278718566;87666;18054;18126.365577204997;18258.908705456386;18306;18325.7251141233;13471.98960077998;13590.04869659134;13656.931715341558;13732.313384330744;13739.381727822272;20122.496937576387;24703.87648061748;25101.4979700405;25239.74760252411;25250.116245931305;7796.908432819409;10143.289969702199;10477;10631.97992381445;10732.517036733365;942.3026960049514;1070.796548655753;1080.9405482698369;1141.0643272516456;1166.6733314671735;22444.32667019992;27388.315292117855;31123.221919452193;31134.532982005287;31725;1062.6493257225097;1067.685032915292;1116.8608019819737;1167.427960299464;1188.6909403555137;12908.548200812926;15429.459968901034;15851.603709907115;16080.115593642227;16119;525783;529804;530489;534221;536315;62158;62860.68569657122;63275.36724632787;63322.05016924658;63646.72706545843;1546.6597348583293;1570.7879436276185;1584.5721655153045;1590.9522714318357;1591.4748133116043;30130.397392052473;30695.693043070176;30991.69008309888;31058;31223.531647025768;52720;54663.72668136793;56297;56469.71765141148;57827;492696;496338;499235;501870;512029;34581.82709086438;35336.46995295124;35585.93242202738;35588.28823423465;36310.636893630726;49181.75409122931;49587;50106.248406274666;50806;51022.48977510177;38128;38240.61759382482;38255.42616860694;38339.80830095831;38416;34632.480512792834;34775.30449391049;35147.94556163319;35221;35278.64721352753;34436.139096522784;38112;39770.657003151995;40758;42043.57956420519;32841.67158328482;33619.15952101217;33620.327593448485;33730;33787;26190.69046547703;26302.34244143835;26332.815023323612;26347.946082157265;26740.465190696465 23:59:39 INFO - PROCESS | 2216 | |2;jquery.html;301.3686327144631;383.20676200265444;385.5681636567045;390.43192155413874;391.7923500544712;20106.89946550267;21372.14511419543;21378.57242855142;22474.999999999978;22561.98471068802;20693.896530517362;20983.055762490687;21138.260160894373;21370.89314553425;21616.135354585836;5508.779648814043;5698.202251684767;5847.853803654911;6011.248593925759;6071.78748743794;4402.60376566109;5788.82633520995;6369.172007639;6644.302348253436;6659.4672426206025;6492.870142597145;6536.379043990813;6577.342265773408;6601.471882249432;6602.679464107174;5578.553715702755;5680.659160450345;5723.141528770676;5832.183494310779;5839.941600584004;5410;5596.832095037155;5597.972010139964;5623.353314368859;5673.149027645845;13627.727445451035;13640.931795340959;13883.4446622135;13887.02790804644;13888.23614701191;2063.8555301128927;2172.4134483689472;2346.3312955807514;2395.904163833462;2806.424682939992;7988.480748751371;9741.805163896754;10337.121344685711;10591.894081059168;15213.771793422997;1747.1788259518132;1772.9024903630295;1777.7777777777778;1790.3644206306833;1790.8298711622374;69803.65098174528;101615.98384016212;104215;115000;119805;11443;11680.474378652982;11749.149227069063;11894.643160705193;12001.339926303963;14213.78679319811;14405.85594144066;14409.279536023367;14506.854931450762;14528.491502797351;8876.822463550821;8927.687530936386;9010.774730631787;9014.63941442348;9056.411333263448;9164.312676549285;9240.214581760625;9257.722268331961;9303.023182565868;9323.673671421468;4607.193741095295;4611.9077618447445;4636.095961287584;4641.280601506772;4665.883352916137;1752.2202619834306;1808.2315016118098;1821.3898344054626;1947.1821834829407;1957.696557033662;876.2639382918379;957.9616815327308;976.2677991506371;988.5699720621552;1042.3224903812431;14686.485972990895;17593.38423155209;17799.555011124565;21040.36878893605;22201.44496387603;992.5483904823288;1033.2302434686208;1049.30745707834;1117.1677100559973;1128.9830652540218;11352.94323528377;11714.765704685859;11737.941310293394;11771.117166212398;11781.587644432404;561800;596627;652959;673092;675195;102530.97469025363;126145;132853.007204892;134460;135261;1006.642641862143;1040.8490768838476;1060.04066319979;1107.3909349857547;1119.8824123467082;17082.29177082282;17183.656326873144;17550.648987020442;19516.82899026063;19690.704639430707;52399.21401179062;54407.45592544024;54979.175312369545;57247.713761430925;57975;60169;80285;81067.59466202631;82081;82263.5886820562;6755.831104222434;8089.786532020009;8311.792205194919;8410.663573456994;8447.366447516339;9546.85679714791;12117;12752.6811829705;13598;13762.724745505235;11319.547218111513;11591.6522504325;11710.824337635113;12007.339596322287;12175.452104655134;10274;11662.416879156179;11686.532538698697;11785.351805650771;12075.57735479254;11656.592019279624;11801.82297265559;12014.819777703517;12099.153059285765;12355.814662780245;8148.348132149295;8218.342532597497;8283;8345.41582089248;8579.970403551364;8793.988691300583;11549.6535103947;11890.583829565923;11941.582044628396;12021 23:59:39 INFO - PROCESS | 2216 | |3;mootools.html;1639.0165900459722;1687.1395588249989;2032.176968327827;2062.8143467087966;2109.5886302171066;8365.12166222547;9088.681896133636;9114.772130696727;9316.720498385042;9321.813563728721;9250.722478325644;9286.02496737843;9335.62657493701;9376.343655944087;9389.436633801959;2268.852524585905;2568.4092658688464;2594.3384436968545;2596.72734362892;2614;2192.8465007449486;2538.657281267033;2543.6518645118117;2582.4835032993383;2592.987035064822;2572.65269188659;2585.818992670514;2596.6494523239403;2597.8830952607177;2605.1533251693277;2544;2549.1078122657013;2554.0422341621984;2614.7254538273587;2617;2225.94267722832;2232.910683572655;2510.7112682041616;2519.9496010079697;2609.9869500652567;9414.717558473258;9433.622655093788;9490.335676502647;9504.382215155993;9613.711588652352;5769.105788602773;5836.095405212199;5863.648181109104;5911.083782013795;5941.049432090845;3256.4925007743905;3742.7380083394173;3817;3862.575116737157;3877.243937432202;1076.978460430787;1080.2154462851397;1082.5940272397852;1095.6439157273837;1098.7088421568292;12379.195352302071;12589.559365422258;12613.747725045449;12627.305498197595;12670.429830657642;4503.099380123988;5027.84916452507;5054.166062599704;5106.259592359087;5140.460251673595;10396.22028347877;10574.471276436147;10637.095846853104;10698.144148468104;10745.14038876888;5690.857728556736;5725.8568535786935;5756.65460072397;5760.942390576124;5767.192593036978;4637.25803871379;5044.596432285409;5109.616778741609;5137.383513978347;5163.638545301793;4088.448059511987;4138.985948442591;4143.129942712004;4170;4177.3316269396755;1160.9071274298205;1352.452256835983;1371.060823336018;1380.942395830226;1382.5506710318984;1393.6655202751267;1414.2363123913178;1433.2905211919958;1440.9639759006109;1462.8902832287622;8537.74386768398;8611.612477438404;8658.350623703247;8715.084916083846;8718.564071796385;530.5144218229369;538.3862396867496;539.0620320642055;540.8674874655735;541.3611937913222;5503.422140675251;6274.905876411857;6396;6407.231132264158;6426.839329016719;10607.416592087355;10855.402952837512;10921.39932303715;10927.945360273148;10981.560737570568;10421.062104410488;10811.621593244356;10848.349099054081;10868.510917008596;10908.127349811995;8459.407841451162;8460;8469.195426434479;8508.702195423131;8572.957135214408;7765.378769698297;7858.017747781528;7921.089074756477;7979.760607181794;7989.840203195788;9588.993155718548;9620.615175392906;9636.132748052709;9724.75688107803;9761.023897610183;9967.352122112039;10108.1408080314;10148.23888208402;10152.644657436955;10282.948585257025;6902.275261097713;7502.924970750222;7531.133919599316;7683.538987660758;7722.575258360844;8557.957210213908;8579;8617.95691021541;8646.956765216133;8681.348898832486;7500.737474188377;7569.1673915868105;7647;7741.341985931259;7761.9611901940125;7548.094228692592;7555.13115991646;7576.583287919218;7650.693972241048;7692.307692307719;8016.959915200387;8031.879521807061;8119.147489513516;8180.795480112807;8183.427160098736;7165.713371465083;7307.707691692272;7323.487355885037;7362.926370736224;7384.040074790458;7387.704491820267;7406.814829629302;7445.106587209353;7453.403727701662;7457.664405101675 23:59:39 INFO - PROCESS | 2216 | |4;prototype.html;284.99857500712505;336.570872138024;337.3623850921758;339.99700882396905;343.44019248624744;6853.143357080365;6907.516473846833;6918.273581273969;6920.723171073158;6955.513114082017;6729.384947612574;6865.519413641047;6874.796910540648;6906.96546517268;6908.240093589714;4855.4901735317635;4940.555350018498;5052.9747351263195;5071.822486212984;5140.871478213037;5048.217526283432;5075.898482030358;5084.186530155176;5108.64239503235;5129.897402051956;4944.728039957801;5057.924131138036;5063.189889617662;5098.337216161894;5106.974465127688;5075.365579302587;5076.771545280471;5087.236914462823;5095.668781529207;5108.208227724672;4333.133373325348;4336.479622445295;4339.5443478434945;4341;4343.978280108579;6505.93494065058;6596.604203747743;6664.366885145903;6682.966585167043;6717.764878229287;5908.084246941731;5981.850453738648;5986.521078313768;5996.4902983246475;5999.940000599981;7338.633068346561;7365.153007404164;7372.483926125174;7374.705011799521;7379.409647228209;4813.253945638432;4824.445188803297;4826.34844296019;4827.879303017417;4832.613390928717;7033.402160816337;7839.37285017203;7846.686132554691;7856.450048496607;7857.253560911704;4834.20235661119;4878.95121048792;4921.311016457699;4949;4961.280614310905;5081.339425874613;5081.8475445736685;5090.389153301628;5098.847034588968;5103.5661968733075;5977;5989.9101513477335;6010;6018.21763170785;6021.789237376671;7376.299251571092;7412.444066694911;7418.221086785918;7424.368928641126;7436.905719582103;1661.0781016535939;1706.1469265367316;1716.262007336832;1737.5829800847957;1750.754894314797;933.5192375926404;1011.22135955314;1111.855458790352;1112.3159257056852;1120;5777.815547812688;5878.882422351529;6952.756653517103;6955.791326260221;6992.895106573405;7551.848963020819;7612.961935190288;7615.124260709978;7632.351250143689;7646.197149299243;6153.876922461525;6474.967625161844;6936.895946560705;6937.68780404883;6978.511504194759;2789.4421115776927;4012.518497780285;4056.452378928807;4057.857974970921;4067.613576710208;6496.252930913006;6887.724491020404;8051.4637889065925;8151.551664658501;8164.265216130577;8051.355891528664;8053.436259461899;8060.8387832243025;8068.47554908929;8069.991251093613;8130.756077317572;8130.959345203236;8150.144234855255;8165.673373065011;8180.181981801772;7404.518706284074;7680.039995000625;7712.730054448068;7784.377249819888;7802.72690455854;7546.245375462629;7598.278163574451;7603.543787372775;7616.885746713914;7631.732889348847;8114.634841432032;8115.675372985251;8121.187881211831;8124.22819832115;8155.347572194329;4720.221163507983;4778.116048531033;4789.3294938709305;4791.041791641616;4797.376341075777;7482.139553951365;7707.88438173439;7716.074071111502;7718.498297610638;7749.7675069748;7347.485676002629;7404.888926666212;7419.629018549159;7440.069991251094;7458.21688722698;7376.668049937873;7382.520136191345;7391.519551229153;7422.4433167513735;7430.442716796154;5833.649981001154;6971.024056632177;7218.386437152691;7246.96376518114;7257.564546127249;7368.447366447431;7394.852102957803;7408.148062972827;7409.110906691231;7419.629018549159;7173.42612590981;7217.855642887008;7241.203467618452;7248.60132692707;7265.600391978281 23:59:39 INFO - PROCESS | 2216 | |5;yui.html;706.1702499563013;735.4226931858491;775.3874439193038;777.8988731464913;799.6601444386138;15232.31454584545;15249.23753812309;15286.082835029878;15391.153486558234;15448.304826282816;14253.643658908533;14259.3583288752;14272.50046248379;14298.428062877472;14359.569212923603;785.8114052627385;963.4941655630797;964.5273815830228;977.0180968127022;984.3896783993933;971.5773638467253;985.8816941966974;986.2455221755363;989.8267803134459;997.997013001932;838.3754103193099;988.8170688422665;993.438707130469;1016.9847452288221;1026.2200727447157;985.7437066362761;1002.9247806414512;1005.7485628592851;1009.3439264478149;1020.7244044108087;722.0901663903467;726.963651817407;735.4888352594949;766.6894907562446;767.1714548287836;15243.695126097417;15317.693646127014;15479.303431345505;15524.76712849297;15530.145841978687;9896.950515247378;12457.128001039931;12888.742225155538;12929.48282068716;13138.474461021548;9709.805803883954;10190.949045254727;10199.150899311007;10480.633177838816;10538.736531586695;3214.5821043264227;3514.437689969618;3530.3998320285614;3572.910677233064;3727.6086010969;74901.50196996084;79315.60342198309;84528;87717.56141219253;88242;7859.257968994926;9469.47917864524;9776.804463910681;9832.508374581243;10044.19646428284;22285.331440056823;22803.429914252276;22848.885755571115;23069;23142.884285578464;7611.923880761232;7669.846603067907;7729.613519324012;7751.1861254568585;7787.221277872281;4091.8363265469047;4135.462389889295;4138.358554424069;4145.440365550672;4162.542120366757;3452.879149229815;3504.456809194579;3505.5267538882435;3519.7184225261917;3529.8058606776362;617.7590739611466;618.5206464989669;624.0327492386873;624.8437890527368;651.5374084400034;498.8852563910321;593.2228780297824;621.6177051113623;623.3512359808282;635.5233574818886;8080;8384.958075209584;8386.496810191407;8610.65557377698;8672.696455624024;531.8032328038651;546.4207939584054;550.9338879334506;556.7839996812708;602.9427204415573;3845.7501312073127;3915.47141135943;3942.3889297158985;3998.782198132399;4102.384642303678;98539.01460985442;98606.50696746471;98674.50662746784;99459;99880.500597498;80820.59589702013;81968.18031819725;82386.58806705927;83145;83240;67576;67606.66196669084;67620.32379676239;71354;71819.69081855105;7739.380849532136;7807.876849260341;7923.603819808871;8124.715634952985;8228.25945664893;47076.058478829545;47493.76253118712;50356.24465632945;51048;51055;68602;71043.64478177576;71249.64375178091;71281.28718712747;72751;10251.38491690501;10488.947555262175;10615.416152111398;10665.733356666145;10736.73158171052;10574.312669676447;10889.782204356026;10935.781284374109;11181.888181118085;11466.541338346373;10313.535890884777;10389.272750907365;10431.217658675781;10557.841632375366;10922.617708380169;10378.325408848401;10484.21368397358;10589.152867770406;10832.566697332333;10935.945320273348;10271.126954208976;10278.434686092038;10406.843897341698;10441.63454279127;10824.593667677194;8717.564121794012;8873.290136788912;8932.28541716648;9154.450732956044;9256.799619379864;8723.25852302536;8804.207621314112;8889.377743557889;8968.282537396863;9023.39416911644 23:59:39 INFO - PROCESS | 2216 | __end_tp_report 23:59:39 INFO - PROCESS | 2216 | __start_cc_report 23:59:39 INFO - PROCESS | 2216 | _x_x_mozilla_cycle_collect,363 23:59:39 INFO - PROCESS | 2216 | __end_cc_report 23:59:39 INFO - PROCESS | 2216 | __startTimestamp1461481179268__endTimestamp 23:59:39 INFO - PROCESS | 2216 | 23:59:39 INFO - PROCESS | 2216 | ------- Summary: start ------- 23:59:39 INFO - PROCESS | 2216 | Number of tests: 6 23:59:39 INFO - PROCESS | 2216 | 23:59:39 INFO - PROCESS | 2216 | [#0] dojo.html Cycles:165 Average:5759.80 Median:6025.28 stddev:664.64 (11.0%) stddev-sans-first:630.88 23:59:39 INFO - PROCESS | 2216 | Values: 3016.6 3217.2 3568.1 3606.6 3616.9 5869.5 5876.1 5915.1 5923.0 5936.1 5847.0 5864.9 5869.9 5889.2 5957.5 5311.7 5353.4 5415.1 5424.5 5490.1 5262.8 5376.6 5402.5 5405.0 5421.3 5373.5 5410.5 5442.5 5446.9 5457.0 4352.6 5183.0 5382.0 5428.8 5491.5 4260.4 5132.9 5200.8 5359.2 5371.2 5569.1 5724.9 5764.3 5779.0 5781.4 6145.5 6158.8 6160.9 6210.1 6212.6 5251.4 6139.7 6202.9 6233.5 6248.9 5076.6 5117.8 5831.2 6031.3 6040.5 6277.0 6388.7 6409.3 6415.0 6431.5 6133.2 6143.1 6153.4 6195.7 6259.6 6244.9 6275.3 6283.3 6291.3 6299.9 6021.5 6163.0 6185.2 6186.1 6193.8 6129.0 6131.7 6141.4 6199.8 6209.3 4186.4 4945.1 4976.9 5011.0 5036.5 4392.0 4424.6 4494.5 4501.3 4513.8 5748.9 5950.0 5972.1 6030.9 6049.4 6216.4 6240.8 6260.4 6269.9 6271.1 5858.9 5892.0 5969.3 5984.3 6026.8 5445.7 5466.6 5498.1 5508.3 5541.3 6409.0 6417.7 6430.4 6437.5 6439.8 6125.4 6162.9 6214.3 6227.0 6271.0 6417.8 6431.8 6434.9 6461.3 6480.4 6194.5 6213.8 6236.4 6246.2 6271.4 5162.6 6131.0 6161.1 6211.1 6250.1 4697.0 5995.0 6161.5 6187.0 6194.2 6088.2 6120.8 6121.2 6126.5 6135.2 5839.3 5981.8 6025.3 6072.8 6114.6 5238.8 5709.7 6044.7 6199.5 6208.3 5052.1 5232.0 5896.9 6115.2 6116.1 23:59:39 INFO - PROCESS | 2216 | 23:59:39 INFO - PROCESS | 2216 | [#1] ext.html Cycles:180 Average:64644.70 Median:35587.11 stddev:127423.02 (358.1%) stddev-sans-first:127689.38 23:59:39 INFO - PROCESS | 2216 | Values: 470.8 543.1 562.0 619.6 678.7 40336.0 41016.8 41074.8 41081.0 41099.4 43788.0 43881.9 44410.6 44432.1 44500.0 9724.7 9901.2 9935.6 9939.3 9956.4 9739.1 9806.5 9829.2 9886.7 9909.7 9961.1 10004.3 10050.2 10070.8 10078.5 9959.8 9968.6 10025.4 10034.8 10043.5 9947.7 10085.5 10087.8 10100.9 10117.3 43758.8 43812.3 44033.3 44295.6 45113.5 3279.7 3437.9 3533.7 3566.0 3859.7 27228.5 29493.1 29645.6 29760.7 29951.0 2610.6 2629.5 2637.1 2673.3 2701.8 392392.0 398076.0 400665.0 400690.0 401037.0 77910.6 78167.2 78179.3 78811.8 78863.0 68411.0 81210.2 86993.6 87442.6 87666.0 18054.0 18126.4 18258.9 18306.0 18325.7 13472.0 13590.0 13656.9 13732.3 13739.4 20122.5 24703.9 25101.5 25239.7 25250.1 7796.9 10143.3 10477.0 10632.0 10732.5 942.3 1070.8 1080.9 1141.1 1166.7 22444.3 27388.3 31123.2 31134.5 31725.0 1062.6 1067.7 1116.9 1167.4 1188.7 12908.5 15429.5 15851.6 16080.1 16119.0 525783.0 529804.0 530489.0 534221.0 536315.0 62158.0 62860.7 63275.4 63322.1 63646.7 1546.7 1570.8 1584.6 1591.0 1591.5 30130.4 30695.7 30991.7 31058.0 31223.5 52720.0 54663.7 56297.0 56469.7 57827.0 492696.0 496338.0 499235.0 501870.0 512029.0 34581.8 35336.5 35585.9 35588.3 36310.6 49181.8 49587.0 50106.2 50806.0 51022.5 38128.0 38240.6 38255.4 38339.8 38416.0 34632.5 34775.3 35147.9 35221.0 35278.6 34436.1 38112.0 39770.7 40758.0 42043.6 32841.7 33619.2 33620.3 33730.0 33787.0 26190.7 26302.3 26332.8 26347.9 26740.5 23:59:39 INFO - PROCESS | 2216 | 23:59:39 INFO - PROCESS | 2216 | [#2] jquery.html Cycles:180 Average:35333.66 Median:21375.36 stddev:105168.01 (492.0%) stddev-sans-first:105430.13 23:59:39 INFO - PROCESS | 2216 | Values: 301.4 383.2 385.6 390.4 391.8 20106.9 21372.1 21378.6 22475.0 22562.0 20693.9 20983.1 21138.3 21370.9 21616.1 5508.8 5698.2 5847.9 6011.2 6071.8 4402.6 5788.8 6369.2 6644.3 6659.5 6492.9 6536.4 6577.3 6601.5 6602.7 5578.6 5680.7 5723.1 5832.2 5839.9 5410.0 5596.8 5598.0 5623.4 5673.1 13627.7 13640.9 13883.4 13887.0 13888.2 2063.9 2172.4 2346.3 2395.9 2806.4 7988.5 9741.8 10337.1 10591.9 15213.8 1747.2 1772.9 1777.8 1790.4 1790.8 69803.7 101616.0 104215.0 115000.0 119805.0 11443.0 11680.5 11749.1 11894.6 12001.3 14213.8 14405.9 14409.3 14506.9 14528.5 8876.8 8927.7 9010.8 9014.6 9056.4 9164.3 9240.2 9257.7 9303.0 9323.7 4607.2 4611.9 4636.1 4641.3 4665.9 1752.2 1808.2 1821.4 1947.2 1957.7 876.3 958.0 976.3 988.6 1042.3 14686.5 17593.4 17799.6 21040.4 22201.4 992.5 1033.2 1049.3 1117.2 1129.0 11352.9 11714.8 11737.9 11771.1 11781.6 561800.0 596627.0 652959.0 673092.0 675195.0 102531.0 126145.0 132853.0 134460.0 135261.0 1006.6 1040.8 1060.0 1107.4 1119.9 17082.3 17183.7 17550.6 19516.8 19690.7 52399.2 54407.5 54979.2 57247.7 57975.0 60169.0 80285.0 81067.6 82081.0 82263.6 6755.8 8089.8 8311.8 8410.7 8447.4 9546.9 12117.0 12752.7 13598.0 13762.7 11319.5 11591.7 11710.8 12007.3 12175.5 10274.0 11662.4 11686.5 11785.4 12075.6 11656.6 11801.8 12014.8 12099.2 12355.8 8148.3 8218.3 8283.0 8345.4 8580.0 8794.0 11549.7 11890.6 11941.6 12021.0 23:59:39 INFO - PROCESS | 2216 | 23:59:39 INFO - PROCESS | 2216 | [#3] mootools.html Cycles:180 Average:6284.46 Median:538.72 stddev:3325.33 (617.3%) stddev-sans-first:3316.32 23:59:39 INFO - PROCESS | 2216 | Values: 1639.0 1687.1 2032.2 2062.8 2109.6 8365.1 9088.7 9114.8 9316.7 9321.8 9250.7 9286.0 9335.6 9376.3 9389.4 2268.9 2568.4 2594.3 2596.7 2614.0 2192.8 2538.7 2543.7 2582.5 2593.0 2572.7 2585.8 2596.6 2597.9 2605.2 2544.0 2549.1 2554.0 2614.7 2617.0 2225.9 2232.9 2510.7 2519.9 2610.0 9414.7 9433.6 9490.3 9504.4 9613.7 5769.1 5836.1 5863.6 5911.1 5941.0 3256.5 3742.7 3817.0 3862.6 3877.2 1077.0 1080.2 1082.6 1095.6 1098.7 12379.2 12589.6 12613.7 12627.3 12670.4 4503.1 5027.8 5054.2 5106.3 5140.5 10396.2 10574.5 10637.1 10698.1 10745.1 5690.9 5725.9 5756.7 5760.9 5767.2 4637.3 5044.6 5109.6 5137.4 5163.6 4088.4 4139.0 4143.1 4170.0 4177.3 1160.9 1352.5 1371.1 1380.9 1382.6 1393.7 1414.2 1433.3 1441.0 1462.9 8537.7 8611.6 8658.4 8715.1 8718.6 530.5 538.4 539.1 540.9 541.4 5503.4 6274.9 6396.0 6407.2 6426.8 10607.4 10855.4 10921.4 10927.9 10981.6 10421.1 10811.6 10848.3 10868.5 10908.1 8459.4 8460.0 8469.2 8508.7 8573.0 7765.4 7858.0 7921.1 7979.8 7989.8 9589.0 9620.6 9636.1 9724.8 9761.0 9967.4 10108.1 10148.2 10152.6 10282.9 6902.3 7502.9 7531.1 7683.5 7722.6 8558.0 8579.0 8618.0 8647.0 8681.3 7500.7 7569.2 7647.0 7741.3 7762.0 7548.1 7555.1 7576.6 7650.7 7692.3 8017.0 8031.9 8119.1 8180.8 8183.4 7165.7 7307.7 7323.5 7362.9 7384.0 7387.7 7406.8 7445.1 7453.4 7457.7 23:59:39 INFO - PROCESS | 2216 | 23:59:39 INFO - PROCESS | 2216 | [#4] prototype.html Cycles:180 Average:6053.78 Median:6907.24 stddev:1954.82 (28.3%) stddev-sans-first:1911.75 23:59:39 INFO - PROCESS | 2216 | Values: 285.0 336.6 337.4 340.0 343.4 6853.1 6907.5 6918.3 6920.7 6955.5 6729.4 6865.5 6874.8 6907.0 6908.2 4855.5 4940.6 5053.0 5071.8 5140.9 5048.2 5075.9 5084.2 5108.6 5129.9 4944.7 5057.9 5063.2 5098.3 5107.0 5075.4 5076.8 5087.2 5095.7 5108.2 4333.1 4336.5 4339.5 4341.0 4344.0 6505.9 6596.6 6664.4 6683.0 6717.8 5908.1 5981.9 5986.5 5996.5 5999.9 7338.6 7365.2 7372.5 7374.7 7379.4 4813.3 4824.4 4826.3 4827.9 4832.6 7033.4 7839.4 7846.7 7856.5 7857.3 4834.2 4879.0 4921.3 4949.0 4961.3 5081.3 5081.8 5090.4 5098.8 5103.6 5977.0 5989.9 6010.0 6018.2 6021.8 7376.3 7412.4 7418.2 7424.4 7436.9 1661.1 1706.1 1716.3 1737.6 1750.8 933.5 1011.2 1111.9 1112.3 1120.0 5777.8 5878.9 6952.8 6955.8 6992.9 7551.8 7613.0 7615.1 7632.4 7646.2 6153.9 6475.0 6936.9 6937.7 6978.5 2789.4 4012.5 4056.5 4057.9 4067.6 6496.3 6887.7 8051.5 8151.6 8164.3 8051.4 8053.4 8060.8 8068.5 8070.0 8130.8 8131.0 8150.1 8165.7 8180.2 7404.5 7680.0 7712.7 7784.4 7802.7 7546.2 7598.3 7603.5 7616.9 7631.7 8114.6 8115.7 8121.2 8124.2 8155.3 4720.2 4778.1 4789.3 4791.0 4797.4 7482.1 7707.9 7716.1 7718.5 7749.8 7347.5 7404.9 7419.6 7440.1 7458.2 7376.7 7382.5 7391.5 7422.4 7430.4 5833.6 6971.0 7218.4 7247.0 7257.6 7368.4 7394.9 7408.1 7409.1 7419.6 7173.4 7217.9 7241.2 7248.6 7265.6 23:59:39 INFO - PROCESS | 2216 | 23:59:39 INFO - PROCESS | 2216 | [#5] yui.html Cycles:180 Average:18640.21 Median:598.08 stddev:26836.75 (4487.1%) stddev-sans-first:26878.25 23:59:39 INFO - PROCESS | 2216 | Values: 706.2 735.4 775.4 777.9 799.7 15232.3 15249.2 15286.1 15391.2 15448.3 14253.6 14259.4 14272.5 14298.4 14359.6 785.8 963.5 964.5 977.0 984.4 971.6 985.9 986.2 989.8 998.0 838.4 988.8 993.4 1017.0 1026.2 985.7 1002.9 1005.7 1009.3 1020.7 722.1 727.0 735.5 766.7 767.2 15243.7 15317.7 15479.3 15524.8 15530.1 9897.0 12457.1 12888.7 12929.5 13138.5 9709.8 10190.9 10199.2 10480.6 10538.7 3214.6 3514.4 3530.4 3572.9 3727.6 74901.5 79315.6 84528.0 87717.6 88242.0 7859.3 9469.5 9776.8 9832.5 10044.2 22285.3 22803.4 22848.9 23069.0 23142.9 7611.9 7669.8 7729.6 7751.2 7787.2 4091.8 4135.5 4138.4 4145.4 4162.5 3452.9 3504.5 3505.5 3519.7 3529.8 617.8 618.5 624.0 624.8 651.5 498.9 593.2 621.6 623.4 635.5 8080.0 8385.0 8386.5 8610.7 8672.7 531.8 546.4 550.9 556.8 602.9 3845.8 3915.5 3942.4 3998.8 4102.4 98539.0 98606.5 98674.5 99459.0 99880.5 80820.6 81968.2 82386.6 83145.0 83240.0 67576.0 67606.7 67620.3 71354.0 71819.7 7739.4 7807.9 7923.6 8124.7 8228.3 47076.1 47493.8 50356.2 51048.0 51055.0 68602.0 71043.6 71249.6 71281.3 72751.0 10251.4 10488.9 10615.4 10665.7 10736.7 10574.3 10889.8 10935.8 11181.9 11466.5 10313.5 10389.3 10431.2 10557.8 10922.6 10378.3 10484.2 10589.2 10832.6 10935.9 10271.1 10278.4 10406.8 10441.6 10824.6 8717.6 8873.3 8932.3 9154.5 9256.8 8723.3 8804.2 8889.4 8968.3 9023.4 23:59:39 INFO - PROCESS | 2216 | -------- Summary: end -------- 23:59:39 INFO - PROCESS | 2216 | 23:59:39 INFO - TEST-INFO | 2216: exit 0 23:59:39 INFO - TEST-OK | dromaeo_css | took 1110352ms 23:59:39 INFO - TEST-START | kraken 23:59:39 INFO - operating with platform_type : mac_ 23:59:39 INFO - Initialising browser for kraken test... 23:59:39 INFO - TEST-INFO | started process 2222 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpACTh7k/profile http://localhost:52516/getInfo.html) 23:59:42 INFO - PROCESS | 2222 | __metrics Screen width/height:1600/1200 23:59:42 INFO - PROCESS | 2222 | colorDepth:24 23:59:42 INFO - PROCESS | 2222 | Browser inner width/height: 1024/689 23:59:42 INFO - PROCESS | 2222 | __metrics 23:59:42 ERROR - PROCESS | 2222 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:59:43 INFO - TEST-INFO | 2222: exit 0 23:59:43 INFO - Browser initialized. 23:59:43 INFO - Running cycle 1/1 for kraken test... 23:59:43 INFO - TEST-INFO | started process 2225 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpACTh7k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:59:55 INFO - PROCESS | 2225 | RSS: Main: 217874432 23:59:55 INFO - PROCESS | 2225 | 23:59:57 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52516/tests/kraken/driver.html?testName=audio-beat-detection) 23:59:58 INFO - PROCESS | 2225 | RSS: Main: 229892096 23:59:58 INFO - PROCESS | 2225 | 00:00:01 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52516/tests/kraken/driver.html?testName=audio-dft) 00:00:01 INFO - PROCESS | 2225 | RSS: Main: 239251456 00:00:01 INFO - PROCESS | 2225 | 00:00:05 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52516/tests/kraken/driver.html?testName=audio-fft) 00:00:05 INFO - PROCESS | 2225 | RSS: Main: 242393088 00:00:05 INFO - PROCESS | 2225 | 00:00:07 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52516/tests/kraken/driver.html?testName=audio-oscillator) 00:00:08 INFO - PROCESS | 2225 | RSS: Main: 244498432 00:00:08 INFO - PROCESS | 2225 | 00:00:10 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52516/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:00:10 INFO - PROCESS | 2225 | RSS: Main: 244768768 00:00:10 INFO - PROCESS | 2225 | 00:00:13 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52516/tests/kraken/driver.html?testName=imaging-darkroom) 00:00:14 INFO - PROCESS | 2225 | RSS: Main: 244772864 00:00:14 INFO - PROCESS | 2225 | 00:00:17 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52516/tests/kraken/driver.html?testName=imaging-desaturate) 00:00:17 INFO - PROCESS | 2225 | RSS: Main: 244981760 00:00:17 INFO - PROCESS | 2225 | 00:00:20 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52516/tests/kraken/driver.html?testName=json-parse-financial) 00:00:21 INFO - PROCESS | 2225 | RSS: Main: 245055488 00:00:21 INFO - PROCESS | 2225 | 00:00:23 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52516/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:00:23 INFO - PROCESS | 2225 | RSS: Main: 244731904 00:00:23 INFO - PROCESS | 2225 | 00:00:25 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52516/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:00:26 INFO - PROCESS | 2225 | RSS: Main: 245129216 00:00:26 INFO - PROCESS | 2225 | 00:00:28 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52516/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:00:28 INFO - PROCESS | 2225 | RSS: Main: 244576256 00:00:28 INFO - PROCESS | 2225 | 00:00:31 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:00:32 INFO - PROCESS | 2225 | RSS: Main: 244756480 00:00:32 INFO - PROCESS | 2225 | 00:00:34 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:00:35 INFO - PROCESS | 2225 | RSS: Main: 245219328 00:00:35 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:52516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52516/tests/kraken/driver.html?testName=ai-astar) 00:00:37 INFO - PROCESS | 2225 | RSS: Main: 246546432 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | __start_tp_report 00:00:37 INFO - PROCESS | 2225 | _x_x_mozilla_page_load 00:00:37 INFO - PROCESS | 2225 | _x_x_mozilla_page_load_details 00:00:37 INFO - PROCESS | 2225 | |i|pagename|runs| 00:00:37 INFO - PROCESS | 2225 | |0;ai-astar;117;113;115;116;116;129;115;122;168;127 00:00:37 INFO - PROCESS | 2225 | |1;audio-beat-detection;188;136;143;155;122;168;148;110;196;113 00:00:37 INFO - PROCESS | 2225 | |2;audio-dft;197;189;216;198;197;200;199;200;247;214 00:00:37 INFO - PROCESS | 2225 | |3;audio-fft;67;76;71;113;59;57;58;58;130;60 00:00:37 INFO - PROCESS | 2225 | |4;audio-oscillator;83;78;118;105;121;116;115;78;75;119 00:00:37 INFO - PROCESS | 2225 | |5;imaging-gaussian-blur;94;88;89;85;89;86;104;87;117;74 00:00:37 INFO - PROCESS | 2225 | |6;imaging-darkroom;104;95;146;151;93;95;95;95;94;103 00:00:37 INFO - PROCESS | 2225 | |7;imaging-desaturate;84;155;148;90;91;98;93;76;144;140 00:00:37 INFO - PROCESS | 2225 | |8;json-parse-financial;57;60;61;57;63;83;93;99;55;54 00:00:37 INFO - PROCESS | 2225 | |9;json-stringify-tinderbox;61;68;105;57;102;111;106;86;64;65 00:00:37 INFO - PROCESS | 2225 | |10;stanford-crypto-aes;84;81;84;96;78;80;85;81;83;82 00:00:37 INFO - PROCESS | 2225 | |11;stanford-crypto-ccm;175;131;118;130;135;110;128;137;125;138 00:00:37 INFO - PROCESS | 2225 | |12;stanford-crypto-pbkdf2;137;135;138;139;177;145;177;180;138;131 00:00:37 INFO - PROCESS | 2225 | |13;stanford-crypto-sha256-iterative;68;69;70;86;97;67;70;73;76;90 00:00:37 INFO - PROCESS | 2225 | __end_tp_report 00:00:37 INFO - PROCESS | 2225 | __start_cc_report 00:00:37 INFO - PROCESS | 2225 | _x_x_mozilla_cycle_collect,926 00:00:37 INFO - PROCESS | 2225 | __end_cc_report 00:00:37 INFO - PROCESS | 2225 | __startTimestamp1461481237387__endTimestamp 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | ------- Summary: start ------- 00:00:37 INFO - PROCESS | 2225 | Number of tests: 14 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#0] ai-astar Cycles:10 Average:123.80 Median:119.50 stddev:16.44 (13.8%) stddev-sans-first:17.26 00:00:37 INFO - PROCESS | 2225 | Values: 117.0 113.0 115.0 116.0 116.0 129.0 115.0 122.0 168.0 127.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:151.50 stddev:29.57 (19.5%) stddev-sans-first:27.57 00:00:37 INFO - PROCESS | 2225 | Values: 188.0 136.0 143.0 155.0 122.0 168.0 148.0 110.0 196.0 113.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#2] audio-dft Cycles:10 Average:205.70 Median:200.00 stddev:16.60 (8.3%) stddev-sans-first:17.31 00:00:37 INFO - PROCESS | 2225 | Values: 197.0 189.0 216.0 198.0 197.0 200.0 199.0 200.0 247.0 214.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#3] audio-fft Cycles:10 Average:74.90 Median:59.50 stddev:25.68 (43.2%) stddev-sans-first:27.07 00:00:37 INFO - PROCESS | 2225 | Values: 67.0 76.0 71.0 113.0 59.0 57.0 58.0 58.0 130.0 60.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:98.00 stddev:19.74 (20.1%) stddev-sans-first:19.86 00:00:37 INFO - PROCESS | 2225 | Values: 83.0 78.0 118.0 105.0 121.0 116.0 115.0 78.0 75.0 119.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:87.50 stddev:11.72 (13.4%) stddev-sans-first:12.39 00:00:37 INFO - PROCESS | 2225 | Values: 94.0 88.0 89.0 85.0 89.0 86.0 104.0 87.0 117.0 74.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#6] imaging-darkroom Cycles:10 Average:107.10 Median:94.50 stddev:22.17 (23.5%) stddev-sans-first:23.48 00:00:37 INFO - PROCESS | 2225 | Values: 104.0 95.0 146.0 151.0 93.0 95.0 95.0 95.0 94.0 103.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#7] imaging-desaturate Cycles:10 Average:111.90 Median:87.00 stddev:30.76 (35.4%) stddev-sans-first:30.92 00:00:37 INFO - PROCESS | 2225 | Values: 84.0 155.0 148.0 90.0 91.0 98.0 93.0 76.0 144.0 140.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:62.00 stddev:16.85 (27.2%) stddev-sans-first:17.38 00:00:37 INFO - PROCESS | 2225 | Values: 57.0 60.0 61.0 57.0 63.0 83.0 93.0 99.0 55.0 54.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#9] json-stringify-tinderbox Cycles:10 Average:82.50 Median:62.50 stddev:21.69 (34.7%) stddev-sans-first:21.57 00:00:37 INFO - PROCESS | 2225 | Values: 61.0 68.0 105.0 57.0 102.0 111.0 106.0 86.0 64.0 65.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:4.90 (5.9%) stddev-sans-first:5.20 00:00:37 INFO - PROCESS | 2225 | Values: 84.0 81.0 84.0 96.0 78.0 80.0 85.0 81.0 83.0 82.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:133.00 stddev:17.20 (12.9%) stddev-sans-first:9.19 00:00:37 INFO - PROCESS | 2225 | Values: 175.0 131.0 118.0 130.0 135.0 110.0 128.0 137.0 125.0 138.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:142.00 stddev:19.85 (14.0%) stddev-sans-first:20.51 00:00:37 INFO - PROCESS | 2225 | Values: 137.0 135.0 138.0 139.0 177.0 145.0 177.0 180.0 138.0 131.0 00:00:37 INFO - PROCESS | 2225 | 00:00:37 INFO - PROCESS | 2225 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:74.50 stddev:10.59 (14.2%) stddev-sans-first:10.76 00:00:37 INFO - PROCESS | 2225 | Values: 68.0 69.0 70.0 86.0 97.0 67.0 70.0 73.0 76.0 90.0 00:00:37 INFO - PROCESS | 2225 | -------- Summary: end -------- 00:00:37 INFO - PROCESS | 2225 | 00:00:38 INFO - TEST-INFO | 2225: exit 0 00:00:38 INFO - TEST-OK | kraken | took 58291ms 00:00:38 INFO - SUITE-END | took 1168s 00:00:38 INFO - Completed test suite (00:19:29) 00:00:38 INFO - javascript benchmark 00:00:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3016.6380034395875, 3217.163537480255, 3568.072301201687, 3606.585242697089, 3616.8914932552034, 5869.471747542721, 5876.11858221267, 5915.14230436587, 5922.970385148068, 5936.050231962881, 5847.0, 5864.941350586493, 5869.853253668661, 5889.234399528066, 5957.52339812815, 5311.707856067915, 5353.411124776271, 5415.13357862742, 5424.457554244584, 5490.094134467808, 5262.842114736545, 5376.623636345457, 5402.459754024605, 5404.972975135119, 5421.322334708161, 5373.462653734615, 5410.513053825155, 5442.537384322337, 5446.863828404302, 5457.0, 4352.586504282088, 5183.0, 5382.0043291991105, 5428.75570599324, 5491.450854914517, 4260.360945858115, 5132.897342053138, 5200.765965531522, 5359.169328754049, 5371.221172929903, 5569.136783798518, 5724.856878578027, 5764.308283006066, 5779.0, 5781.392953739839, 6145.477634401082, 6158.784442544489, 6160.907586386208, 6210.068489726532, 6212.565120441571, 5251.422343542207, 6139.706800529493, 6202.945499265091, 6233.501319894398, 6248.875022499525, 5076.578558003765, 5117.771734783662, 5831.212786273841, 6031.314906534576, 6040.516758659297, 6276.968615156895, 6388.7125079371535, 6409.262934762469, 6415.0, 6431.549791514549, 6133.172021777003, 6143.082036032849, 6153.353897840662, 6195.659238741912, 6259.593126446766, 6244.875102497925, 6275.309715931244, 6283.3088360280335, 6291.339409362043, 6299.874002519924, 6021.488173505213, 6162.952298109332, 6185.165002724664, 6186.133941248228, 6193.752249909953, 6128.992047069329, 6131.743695907034, 6141.355157708465, 6199.752009919553, 6209.348018458088, 4186.392973018956, 4945.060438516671, 4976.875578110504, 5011.0, 5036.546710796046, 4391.956080439219, 4424.623906967944, 4494.505604383515, 4501.257292546693, 4513.774311284423, 5748.9425105748405, 5950.0, 5972.134040564094, 6030.939690603038, 6049.364816694272, 6216.409441103088, 6240.812775616739, 6260.40526150015, 6269.937300627026, 6271.090691849657, 5858.941410585925, 5892.0, 5969.283685957626, 5984.251968503937, 6026.758929642853, 5445.673259604437, 5466.617336786387, 5498.092814685532, 5508.338999320027, 5541.27963364768, 6409.03864420322, 6417.679116044179, 6430.356964303533, 6437.452816510556, 6439.839004024843, 6125.388069147376, 6162.907556386568, 6214.316425193135, 6227.0, 6270.968645156745, 6417.839554011187, 6431.839204019937, 6434.903476447764, 6461.321561236003, 6480.351964803482, 6194.473469754941, 6213.751449941951, 6236.438720514994, 6246.219222597176, 6271.372862713874, 5162.561182299396, 6131.0, 6161.106639537153, 6211.068339748893, 6250.124982502362, 4697.0, 5995.0, 6161.537884658758, 6186.969065154645, 6194.163787888578, 6088.238970128734, 6120.7857724981195, 6121.204243448323, 6126.509879209563, 6135.1717518136265, 5839.270091238595, 5981.7607295707685, 6025.276966764016, 6072.757089716539, 6114.57197996136, 5238.795077132205, 5709.685967271674, 6044.667543285162, 6199.535034872312, 6208.348123446973, 5052.065367906949, 5232.03207406631, 5896.882062358814, 6115.235595550556, 6116.052011938156], "unit": "score", "name": "dojo.html", "value": 5719.816014732197}, {"lowerIsBetter": false, "replicates": [470.7904982282885, 543.0605053257862, 561.9971900140499, 619.6034537895747, 678.7420780103562, 40336.0, 41016.79491602538, 41074.79462602683, 41081.0, 41099.38350924738, 43788.0, 43881.90295242621, 44410.555894441044, 44432.111357772825, 44500.0, 9724.708258752213, 9901.158401535879, 9935.602575896955, 9939.304248702594, 9956.402615843073, 9739.074787895139, 9806.509674516246, 9829.164521015686, 9886.653967111153, 9909.653162139326, 9961.053699898497, 10004.349717268391, 10050.246231532628, 10070.848937265946, 10078.546465409037, 9959.75100622483, 9968.601255949754, 10025.398476091457, 10034.849477257847, 10043.548040338203, 9947.651832185838, 10085.49572521371, 10087.848682269772, 10100.949495252551, 10117.291789574732, 43758.781206093765, 43812.3428148578, 44033.339499907524, 44295.557044429785, 45113.54886451159, 3279.6556361582166, 3437.9312413751586, 3533.664301891342, 3566.001519574523, 3859.749116307459, 27228.45543089147, 29493.115206543836, 29645.555316670267, 29760.70239297601, 29951.0, 2610.5562054450597, 2629.474105178953, 2637.0638423359815, 2673.25148958292, 2701.8243814152015, 392392.03803981084, 398076.0, 400665.0, 400690.0, 401036.9999999971, 77910.61044694853, 78167.21832781713, 78179.26372576933, 78811.8178227327, 78863.0, 68411.0, 81210.18789812144, 86993.56503217443, 87442.56278718566, 87666.0, 18054.0, 18126.365577204997, 18258.908705456386, 18306.0, 18325.7251141233, 13471.98960077998, 13590.04869659134, 13656.931715341558, 13732.313384330744, 13739.381727822272, 20122.496937576387, 24703.87648061748, 25101.4979700405, 25239.74760252411, 25250.116245931305, 7796.908432819409, 10143.289969702199, 10477.0, 10631.97992381445, 10732.517036733365, 942.3026960049514, 1070.796548655753, 1080.9405482698369, 1141.0643272516456, 1166.6733314671735, 22444.32667019992, 27388.315292117855, 31123.221919452193, 31134.532982005287, 31725.0, 1062.6493257225097, 1067.685032915292, 1116.8608019819737, 1167.427960299464, 1188.6909403555137, 12908.548200812926, 15429.459968901034, 15851.603709907115, 16080.115593642227, 16119.0, 525783.0, 529804.0, 530489.0, 534221.0, 536315.0, 62158.0, 62860.68569657122, 63275.36724632787, 63322.05016924658, 63646.72706545843, 1546.6597348583293, 1570.7879436276185, 1584.5721655153045, 1590.9522714318357, 1591.4748133116043, 30130.397392052473, 30695.693043070176, 30991.69008309888, 31058.0, 31223.531647025768, 52720.0, 54663.72668136793, 56297.0, 56469.71765141148, 57827.0, 492696.0, 496338.0, 499235.0, 501870.0, 512029.0, 34581.82709086438, 35336.46995295124, 35585.93242202738, 35588.28823423465, 36310.636893630726, 49181.75409122931, 49587.0, 50106.248406274666, 50806.0, 51022.48977510177, 38128.0, 38240.61759382482, 38255.42616860694, 38339.80830095831, 38416.0, 34632.480512792834, 34775.30449391049, 35147.94556163319, 35221.0, 35278.64721352753, 34436.139096522784, 38112.0, 39770.657003151995, 40758.0, 42043.57956420519, 32841.67158328482, 33619.15952101217, 33620.327593448485, 33730.0, 33787.0, 26190.69046547703, 26302.34244143835, 26332.815023323612, 26347.946082157265, 26740.465190696465], "unit": "score", "name": "ext.html", "value": 20969.23772671184}, {"lowerIsBetter": false, "replicates": [301.3686327144631, 383.20676200265444, 385.5681636567045, 390.43192155413874, 391.7923500544712, 20106.89946550267, 21372.14511419543, 21378.57242855142, 22474.999999999978, 22561.98471068802, 20693.896530517362, 20983.055762490687, 21138.260160894373, 21370.89314553425, 21616.135354585836, 5508.779648814043, 5698.202251684767, 5847.853803654911, 6011.248593925759, 6071.78748743794, 4402.60376566109, 5788.82633520995, 6369.172007639, 6644.302348253436, 6659.4672426206025, 6492.870142597145, 6536.379043990813, 6577.342265773408, 6601.471882249432, 6602.679464107174, 5578.553715702755, 5680.659160450345, 5723.141528770676, 5832.183494310779, 5839.941600584004, 5410.0, 5596.832095037155, 5597.972010139964, 5623.353314368859, 5673.149027645845, 13627.727445451035, 13640.931795340959, 13883.4446622135, 13887.02790804644, 13888.23614701191, 2063.8555301128927, 2172.4134483689472, 2346.3312955807514, 2395.904163833462, 2806.424682939992, 7988.480748751371, 9741.805163896754, 10337.121344685711, 10591.894081059168, 15213.771793422997, 1747.1788259518132, 1772.9024903630295, 1777.7777777777778, 1790.3644206306833, 1790.8298711622374, 69803.65098174528, 101615.98384016212, 104215.0, 115000.0, 119805.0, 11443.0, 11680.474378652982, 11749.149227069063, 11894.643160705193, 12001.339926303963, 14213.78679319811, 14405.85594144066, 14409.279536023367, 14506.854931450762, 14528.491502797351, 8876.822463550821, 8927.687530936386, 9010.774730631787, 9014.63941442348, 9056.411333263448, 9164.312676549285, 9240.214581760625, 9257.722268331961, 9303.023182565868, 9323.673671421468, 4607.193741095295, 4611.9077618447445, 4636.095961287584, 4641.280601506772, 4665.883352916137, 1752.2202619834306, 1808.2315016118098, 1821.3898344054626, 1947.1821834829407, 1957.696557033662, 876.2639382918379, 957.9616815327308, 976.2677991506371, 988.5699720621552, 1042.3224903812431, 14686.485972990895, 17593.38423155209, 17799.555011124565, 21040.36878893605, 22201.44496387603, 992.5483904823288, 1033.2302434686208, 1049.30745707834, 1117.1677100559973, 1128.9830652540218, 11352.94323528377, 11714.765704685859, 11737.941310293394, 11771.117166212398, 11781.587644432404, 561800.0, 596627.0, 652959.0, 673092.0, 675195.0, 102530.97469025363, 126145.0, 132853.007204892, 134460.0, 135261.0, 1006.642641862143, 1040.8490768838476, 1060.04066319979, 1107.3909349857547, 1119.8824123467082, 17082.29177082282, 17183.656326873144, 17550.648987020442, 19516.82899026063, 19690.704639430707, 52399.21401179062, 54407.45592544024, 54979.175312369545, 57247.713761430925, 57975.0, 60169.0, 80285.0, 81067.59466202631, 82081.0, 82263.5886820562, 6755.831104222434, 8089.786532020009, 8311.792205194919, 8410.663573456994, 8447.366447516339, 9546.85679714791, 12117.0, 12752.6811829705, 13598.0, 13762.724745505235, 11319.547218111513, 11591.6522504325, 11710.824337635113, 12007.339596322287, 12175.452104655134, 10274.0, 11662.416879156179, 11686.532538698697, 11785.351805650771, 12075.57735479254, 11656.592019279624, 11801.82297265559, 12014.819777703517, 12099.153059285765, 12355.814662780245, 8148.348132149295, 8218.342532597497, 8283.0, 8345.41582089248, 8579.970403551364, 8793.988691300583, 11549.6535103947, 11890.583829565923, 11941.582044628396, 12021.0], "unit": "score", "name": "jquery.html", "value": 9579.383507269911}, {"lowerIsBetter": false, "replicates": [1639.0165900459722, 1687.1395588249989, 2032.176968327827, 2062.8143467087966, 2109.5886302171066, 8365.12166222547, 9088.681896133636, 9114.772130696727, 9316.720498385042, 9321.813563728721, 9250.722478325644, 9286.02496737843, 9335.62657493701, 9376.343655944087, 9389.436633801959, 2268.852524585905, 2568.4092658688464, 2594.3384436968545, 2596.72734362892, 2614.0, 2192.8465007449486, 2538.657281267033, 2543.6518645118117, 2582.4835032993383, 2592.987035064822, 2572.65269188659, 2585.818992670514, 2596.6494523239403, 2597.8830952607177, 2605.1533251693277, 2544.0, 2549.1078122657013, 2554.0422341621984, 2614.7254538273587, 2617.0, 2225.94267722832, 2232.910683572655, 2510.7112682041616, 2519.9496010079697, 2609.9869500652567, 9414.717558473258, 9433.622655093788, 9490.335676502647, 9504.382215155993, 9613.711588652352, 5769.105788602773, 5836.095405212199, 5863.648181109104, 5911.083782013795, 5941.049432090845, 3256.4925007743905, 3742.7380083394173, 3817.0, 3862.575116737157, 3877.243937432202, 1076.978460430787, 1080.2154462851397, 1082.5940272397852, 1095.6439157273837, 1098.7088421568292, 12379.195352302071, 12589.559365422258, 12613.747725045449, 12627.305498197595, 12670.429830657642, 4503.099380123988, 5027.84916452507, 5054.166062599704, 5106.259592359087, 5140.460251673595, 10396.22028347877, 10574.471276436147, 10637.095846853104, 10698.144148468104, 10745.14038876888, 5690.857728556736, 5725.8568535786935, 5756.65460072397, 5760.942390576124, 5767.192593036978, 4637.25803871379, 5044.596432285409, 5109.616778741609, 5137.383513978347, 5163.638545301793, 4088.448059511987, 4138.985948442591, 4143.129942712004, 4170.0, 4177.3316269396755, 1160.9071274298205, 1352.452256835983, 1371.060823336018, 1380.942395830226, 1382.5506710318984, 1393.6655202751267, 1414.2363123913178, 1433.2905211919958, 1440.9639759006109, 1462.8902832287622, 8537.74386768398, 8611.612477438404, 8658.350623703247, 8715.084916083846, 8718.564071796385, 530.5144218229369, 538.3862396867496, 539.0620320642055, 540.8674874655735, 541.3611937913222, 5503.422140675251, 6274.905876411857, 6396.0, 6407.231132264158, 6426.839329016719, 10607.416592087355, 10855.402952837512, 10921.39932303715, 10927.945360273148, 10981.560737570568, 10421.062104410488, 10811.621593244356, 10848.349099054081, 10868.510917008596, 10908.127349811995, 8459.407841451162, 8460.0, 8469.195426434479, 8508.702195423131, 8572.957135214408, 7765.378769698297, 7858.017747781528, 7921.089074756477, 7979.760607181794, 7989.840203195788, 9588.993155718548, 9620.615175392906, 9636.132748052709, 9724.75688107803, 9761.023897610183, 9967.352122112039, 10108.1408080314, 10148.23888208402, 10152.644657436955, 10282.948585257025, 6902.275261097713, 7502.924970750222, 7531.133919599316, 7683.538987660758, 7722.575258360844, 8557.957210213908, 8579.0, 8617.95691021541, 8646.956765216133, 8681.348898832486, 7500.737474188377, 7569.1673915868105, 7647.0, 7741.341985931259, 7761.9611901940125, 7548.094228692592, 7555.13115991646, 7576.583287919218, 7650.693972241048, 7692.307692307719, 8016.959915200387, 8031.879521807061, 8119.147489513516, 8180.795480112807, 8183.427160098736, 7165.713371465083, 7307.707691692272, 7323.487355885037, 7362.926370736224, 7384.040074790458, 7387.704491820267, 7406.814829629302, 7445.106587209353, 7453.403727701662, 7457.664405101675], "unit": "score", "name": "mootools.html", "value": 5045.918672758946}, {"lowerIsBetter": false, "replicates": [284.99857500712505, 336.570872138024, 337.3623850921758, 339.99700882396905, 343.44019248624744, 6853.143357080365, 6907.516473846833, 6918.273581273969, 6920.723171073158, 6955.513114082017, 6729.384947612574, 6865.519413641047, 6874.796910540648, 6906.96546517268, 6908.240093589714, 4855.4901735317635, 4940.555350018498, 5052.9747351263195, 5071.822486212984, 5140.871478213037, 5048.217526283432, 5075.898482030358, 5084.186530155176, 5108.64239503235, 5129.897402051956, 4944.728039957801, 5057.924131138036, 5063.189889617662, 5098.337216161894, 5106.974465127688, 5075.365579302587, 5076.771545280471, 5087.236914462823, 5095.668781529207, 5108.208227724672, 4333.133373325348, 4336.479622445295, 4339.5443478434945, 4341.0, 4343.978280108579, 6505.93494065058, 6596.604203747743, 6664.366885145903, 6682.966585167043, 6717.764878229287, 5908.084246941731, 5981.850453738648, 5986.521078313768, 5996.4902983246475, 5999.940000599981, 7338.633068346561, 7365.153007404164, 7372.483926125174, 7374.705011799521, 7379.409647228209, 4813.253945638432, 4824.445188803297, 4826.34844296019, 4827.879303017417, 4832.613390928717, 7033.402160816337, 7839.37285017203, 7846.686132554691, 7856.450048496607, 7857.253560911704, 4834.20235661119, 4878.95121048792, 4921.311016457699, 4949.0, 4961.280614310905, 5081.339425874613, 5081.8475445736685, 5090.389153301628, 5098.847034588968, 5103.5661968733075, 5977.0, 5989.9101513477335, 6010.0, 6018.21763170785, 6021.789237376671, 7376.299251571092, 7412.444066694911, 7418.221086785918, 7424.368928641126, 7436.905719582103, 1661.0781016535939, 1706.1469265367316, 1716.262007336832, 1737.5829800847957, 1750.754894314797, 933.5192375926404, 1011.22135955314, 1111.855458790352, 1112.3159257056852, 1120.0, 5777.815547812688, 5878.882422351529, 6952.756653517103, 6955.791326260221, 6992.895106573405, 7551.848963020819, 7612.961935190288, 7615.124260709978, 7632.351250143689, 7646.197149299243, 6153.876922461525, 6474.967625161844, 6936.895946560705, 6937.68780404883, 6978.511504194759, 2789.4421115776927, 4012.518497780285, 4056.452378928807, 4057.857974970921, 4067.613576710208, 6496.252930913006, 6887.724491020404, 8051.4637889065925, 8151.551664658501, 8164.265216130577, 8051.355891528664, 8053.436259461899, 8060.8387832243025, 8068.47554908929, 8069.991251093613, 8130.756077317572, 8130.959345203236, 8150.144234855255, 8165.673373065011, 8180.181981801772, 7404.518706284074, 7680.039995000625, 7712.730054448068, 7784.377249819888, 7802.72690455854, 7546.245375462629, 7598.278163574451, 7603.543787372775, 7616.885746713914, 7631.732889348847, 8114.634841432032, 8115.675372985251, 8121.187881211831, 8124.22819832115, 8155.347572194329, 4720.221163507983, 4778.116048531033, 4789.3294938709305, 4791.041791641616, 4797.376341075777, 7482.139553951365, 7707.88438173439, 7716.074071111502, 7718.498297610638, 7749.7675069748, 7347.485676002629, 7404.888926666212, 7419.629018549159, 7440.069991251094, 7458.21688722698, 7376.668049937873, 7382.520136191345, 7391.519551229153, 7422.4433167513735, 7430.442716796154, 5833.649981001154, 6971.024056632177, 7218.386437152691, 7246.96376518114, 7257.564546127249, 7368.447366447431, 7394.852102957803, 7408.148062972827, 7409.110906691231, 7419.629018549159, 7173.42612590981, 7217.855642887008, 7241.203467618452, 7248.60132692707, 7265.600391978281], "unit": "score", "name": "prototype.html", "value": 5387.492491803935}, {"lowerIsBetter": false, "replicates": [706.1702499563013, 735.4226931858491, 775.3874439193038, 777.8988731464913, 799.6601444386138, 15232.31454584545, 15249.23753812309, 15286.082835029878, 15391.153486558234, 15448.304826282816, 14253.643658908533, 14259.3583288752, 14272.50046248379, 14298.428062877472, 14359.569212923603, 785.8114052627385, 963.4941655630797, 964.5273815830228, 977.0180968127022, 984.3896783993933, 971.5773638467253, 985.8816941966974, 986.2455221755363, 989.8267803134459, 997.997013001932, 838.3754103193099, 988.8170688422665, 993.438707130469, 1016.9847452288221, 1026.2200727447157, 985.7437066362761, 1002.9247806414512, 1005.7485628592851, 1009.3439264478149, 1020.7244044108087, 722.0901663903467, 726.963651817407, 735.4888352594949, 766.6894907562446, 767.1714548287836, 15243.695126097417, 15317.693646127014, 15479.303431345505, 15524.76712849297, 15530.145841978687, 9896.950515247378, 12457.128001039931, 12888.742225155538, 12929.48282068716, 13138.474461021548, 9709.805803883954, 10190.949045254727, 10199.150899311007, 10480.633177838816, 10538.736531586695, 3214.5821043264227, 3514.437689969618, 3530.3998320285614, 3572.910677233064, 3727.6086010969, 74901.50196996084, 79315.60342198309, 84528.0, 87717.56141219253, 88242.0, 7859.257968994926, 9469.47917864524, 9776.804463910681, 9832.508374581243, 10044.19646428284, 22285.331440056823, 22803.429914252276, 22848.885755571115, 23069.0, 23142.884285578464, 7611.923880761232, 7669.846603067907, 7729.613519324012, 7751.1861254568585, 7787.221277872281, 4091.8363265469047, 4135.462389889295, 4138.358554424069, 4145.440365550672, 4162.542120366757, 3452.879149229815, 3504.456809194579, 3505.5267538882435, 3519.7184225261917, 3529.8058606776362, 617.7590739611466, 618.5206464989669, 624.0327492386873, 624.8437890527368, 651.5374084400034, 498.8852563910321, 593.2228780297824, 621.6177051113623, 623.3512359808282, 635.5233574818886, 8080.0, 8384.958075209584, 8386.496810191407, 8610.65557377698, 8672.696455624024, 531.8032328038651, 546.4207939584054, 550.9338879334506, 556.7839996812708, 602.9427204415573, 3845.7501312073127, 3915.47141135943, 3942.3889297158985, 3998.782198132399, 4102.384642303678, 98539.01460985442, 98606.50696746471, 98674.50662746784, 99459.0, 99880.500597498, 80820.59589702013, 81968.18031819725, 82386.58806705927, 83145.0, 83240.0, 67576.0, 67606.66196669084, 67620.32379676239, 71354.0, 71819.69081855105, 7739.380849532136, 7807.876849260341, 7923.603819808871, 8124.715634952985, 8228.25945664893, 47076.058478829545, 47493.76253118712, 50356.24465632945, 51048.0, 51055.0, 68602.0, 71043.64478177576, 71249.64375178091, 71281.28718712747, 72751.0, 10251.38491690501, 10488.947555262175, 10615.416152111398, 10665.733356666145, 10736.73158171052, 10574.312669676447, 10889.782204356026, 10935.781284374109, 11181.888181118085, 11466.541338346373, 10313.535890884777, 10389.272750907365, 10431.217658675781, 10557.841632375366, 10922.617708380169, 10378.325408848401, 10484.21368397358, 10589.152867770406, 10832.566697332333, 10935.945320273348, 10271.126954208976, 10278.434686092038, 10406.843897341698, 10441.63454279127, 10824.593667677194, 8717.564121794012, 8873.290136788912, 8932.28541716648, 9154.450732956044, 9256.799619379864, 8723.25852302536, 8804.207621314112, 8889.377743557889, 8968.282537396863, 9023.39416911644], "unit": "score", "name": "yui.html", "value": 6925.033254201164}], "name": "dromaeo_css", "value": 7747.846627267132}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 113.0, 115.0, 116.0, 116.0, 129.0, 115.0, 122.0, 168.0, 127.0], "unit": "score", "name": "ai-astar", "value": 123.8}, {"lowerIsBetter": true, "replicates": [188.0, 136.0, 143.0, 155.0, 122.0, 168.0, 148.0, 110.0, 196.0, 113.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [197.0, 189.0, 216.0, 198.0, 197.0, 200.0, 199.0, 200.0, 247.0, 214.0], "unit": "score", "name": "audio-dft", "value": 205.7}, {"lowerIsBetter": true, "replicates": [67.0, 76.0, 71.0, 113.0, 59.0, 57.0, 58.0, 58.0, 130.0, 60.0], "unit": "score", "name": "audio-fft", "value": 74.9}, {"lowerIsBetter": true, "replicates": [83.0, 78.0, 118.0, 105.0, 121.0, 116.0, 115.0, 78.0, 75.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 100.8}, {"lowerIsBetter": true, "replicates": [94.0, 88.0, 89.0, 85.0, 89.0, 86.0, 104.0, 87.0, 117.0, 74.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.3}, {"lowerIsBetter": true, "replicates": [104.0, 95.0, 146.0, 151.0, 93.0, 95.0, 95.0, 95.0, 94.0, 103.0], "unit": "score", "name": "imaging-darkroom", "value": 107.1}, {"lowerIsBetter": true, "replicates": [84.0, 155.0, 148.0, 90.0, 91.0, 98.0, 93.0, 76.0, 144.0, 140.0], "unit": "score", "name": "imaging-desaturate", "value": 111.9}, {"lowerIsBetter": true, "replicates": [57.0, 60.0, 61.0, 57.0, 63.0, 83.0, 93.0, 99.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 68.2}, {"lowerIsBetter": true, "replicates": [61.0, 68.0, 105.0, 57.0, 102.0, 111.0, 106.0, 86.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 82.5}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 84.0, 96.0, 78.0, 80.0, 85.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [175.0, 131.0, 118.0, 130.0, 135.0, 110.0, 128.0, 137.0, 125.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.7}, {"lowerIsBetter": true, "replicates": [137.0, 135.0, 138.0, 139.0, 177.0, 145.0, 177.0, 180.0, 138.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 86.0, 97.0, 67.0, 70.0, 73.0, 76.0, 90.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.6}], "name": "kraken", "value": 1556.5}]} 00:00:38 INFO - Return code: 0 00:00:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:00:38 ERROR - # TBPL SUCCESS # 00:00:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:00:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:00:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:00:38 INFO - 2016-04-24 00:00:38.684 screenresolution[2231:24093] starting screenresolution argv=screenresolution get 00:00:38 INFO - 2016-04-24 00:00:38.687 screenresolution[2231:24093] Display 0: 1600x1200x32@60 00:00:38 INFO - 2016-04-24 00:00:38.692 screenresolution[2232:24096] starting screenresolution argv=screenresolution list 00:00:38 INFO - Available Modes on Display 0 00:00:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:00:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:00:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:00:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:00:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:00:38 INFO - Intel Iris: 00:00:38 INFO - Chipset Model: Intel Iris 00:00:38 INFO - Type: GPU 00:00:38 INFO - Bus: Built-In 00:00:38 INFO - VRAM (Dynamic, Max): 1536 MB 00:00:38 INFO - Vendor: Intel (0x8086) 00:00:38 INFO - Device ID: 0x0a2e 00:00:38 INFO - Revision ID: 0x0009 00:00:38 INFO - Displays: 00:00:38 INFO - Display: 00:00:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:00:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:00:38 INFO - Display Serial Number: 1600x1200 60 00:00:38 INFO - Main Display: Yes 00:00:38 INFO - Mirror: Off 00:00:38 INFO - Online: Yes 00:00:38 INFO - Rotation: Supported 00:00:38 INFO - Return code: 0 00:00:38 INFO - Running post-action listener: _resource_record_post_action 00:00:38 INFO - Running post-run listener: _resource_record_post_run 00:00:39 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 3809280; Write bytes: 672349184; Read time: 91; Write time: 2172 00:00:39 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 356919808; Write bytes: 355010560; Read time: 27912; Write time: 678 00:00:39 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 3809280; Write bytes: 306160640; Read time: 91; Write time: 1459 00:00:39 INFO - Running post-run listener: _upload_blobber_files 00:00:39 INFO - Blob upload gear active. 00:00:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:00:39 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 00:00:39 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'] 00:00:39 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 00:00:40 INFO - (blobuploader) - INFO - Open directory for files ... 00:00:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:00:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:00:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:41 INFO - (blobuploader) - INFO - Done attempting. 00:00:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:00:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:00:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:00:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:42 INFO - (blobuploader) - INFO - Done attempting. 00:00:42 INFO - (blobuploader) - INFO - Iteration through files over. 00:00:42 INFO - Return code: 0 00:00:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:00:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:00:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bf6ad90584b59167253bc11ff1a4065e5717f128b93474e7375b5cb9775344d0f64cd9ae8a5e108a80c79f10ab28d9bb7e4d4bc18425966ef9b6667b8cdf456", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fdc962c5b364fb4d8521193fdfc901a5fda9e1a108d5038ab51c72a719626cc6d5532735c941f97ec92c7d9cc0bab251f7f678334e84a2dd86f481ebbe17b1d"} 00:00:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:00:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:00:42 INFO - Contents: 00:00:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bf6ad90584b59167253bc11ff1a4065e5717f128b93474e7375b5cb9775344d0f64cd9ae8a5e108a80c79f10ab28d9bb7e4d4bc18425966ef9b6667b8cdf456", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fdc962c5b364fb4d8521193fdfc901a5fda9e1a108d5038ab51c72a719626cc6d5532735c941f97ec92c7d9cc0bab251f7f678334e84a2dd86f481ebbe17b1d"} 00:00:42 INFO - Running post-run listener: copy_logs_to_upload_dir 00:00:42 INFO - Copying logs to upload dir... 00:00:42 INFO - mkdir: /builds/slave/test/build/upload/logs 00:00:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.912641 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-04-24 00:00:42.843934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 00:00:42.847744) ========= 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.61YMbngFKb/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.4Lxzwr5qy5/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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/9bf6ad90584b59167253bc11ff1a4065e5717f128b93474e7375b5cb9775344d0f64cd9ae8a5e108a80c79f10ab28d9bb7e4d4bc18425966ef9b6667b8cdf456", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fdc962c5b364fb4d8521193fdfc901a5fda9e1a108d5038ab51c72a719626cc6d5532735c941f97ec92c7d9cc0bab251f7f678334e84a2dd86f481ebbe17b1d"} build_url:https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011040 build_url: 'https://queue.taskcluster.net/v1/task/R3I8F4WlTl-knLTJs2lDcg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bf6ad90584b59167253bc11ff1a4065e5717f128b93474e7375b5cb9775344d0f64cd9ae8a5e108a80c79f10ab28d9bb7e4d4bc18425966ef9b6667b8cdf456", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fdc962c5b364fb4d8521193fdfc901a5fda9e1a108d5038ab51c72a719626cc6d5532735c941f97ec92c7d9cc0bab251f7f678334e84a2dd86f481ebbe17b1d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 00:00:42.878904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 00:00:42.879592) ========= 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.61YMbngFKb/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.4Lxzwr5qy5/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005367 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 00:00:42.931283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 00:00:42.931658) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 00:00:42.932133) ========= ========= Total master_lag: 0.38 =========