builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0057 starttime: 1461754061.42 results: success (0) buildid: 20160425042155 builduid: 3cafbae6ee4445cbb07d61c2d398d690 revision: f328ac32af6a3d0ce1593c41fd18edf7216a1652 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:41.422629) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:41.423118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:41.423469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:41.444043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:41.444678) ========= 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.NE3j596isx/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.mSib5WxkXO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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-27 03:47:41-- 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% 8.32M=0.001s 2016-04-27 03:47:41 (8.32 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113440 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:41.575819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:41.576142) ========= 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.NE3j596isx/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.mSib5WxkXO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.020229 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:41.624747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 03:47:41.625172) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f328ac32af6a3d0ce1593c41fd18edf7216a1652 --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 f328ac32af6a3d0ce1593c41fd18edf7216a1652 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NE3j596isx/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.mSib5WxkXO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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-27 03:47:41,699 truncating revision to first 12 chars 2016-04-27 03:47:41,699 Setting DEBUG logging. 2016-04-27 03:47:41,699 attempt 1/10 2016-04-27 03:47:41,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f328ac32af6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 03:47:43,004 unpacking tar archive at: mozilla-aurora-f328ac32af6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.553721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 03:47:43.196260) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:43.196586) ========= script_repo_revision: f328ac32af6a3d0ce1593c41fd18edf7216a1652 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:43.197082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:43.197355) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:47:43.209056) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-27 03:47:43.209334) ========= /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.NE3j596isx/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.mSib5WxkXO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:47:43 INFO - MultiFileLogger online at 20160427 03:47:43 in /builds/slave/test 03:47:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:47:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:47:43 INFO - {'append_to_log': False, 03:47:43 INFO - 'base_work_dir': '/builds/slave/test', 03:47:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:47:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:47:43 INFO - 'branch': 'Mozilla-Aurora', 03:47:43 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:43 INFO - 'config_files': ('talos/mac_config.py',), 03:47:43 INFO - 'default_actions': ('clobber', 03:47:43 INFO - 'read-buildbot-config', 03:47:43 INFO - 'download-and-extract', 03:47:43 INFO - 'populate-webroot', 03:47:43 INFO - 'create-virtualenv', 03:47:43 INFO - 'install', 03:47:43 INFO - 'run-tests'), 03:47:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:43 INFO - 'download_minidump_stackwalk': True, 03:47:43 INFO - 'download_symbols': 'ondemand', 03:47:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:43 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:43 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:43 INFO - 'installer_path': 'installer.exe', 03:47:43 INFO - 'log_level': 'info', 03:47:43 INFO - 'log_name': 'talos', 03:47:43 INFO - 'log_to_console': True, 03:47:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:47:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:47:43 INFO - 'opt_config_files': (), 03:47:43 INFO - 'pip_index': False, 03:47:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:47:43 INFO - 'cmd': ('bash', 03:47:43 INFO - '-c', 03:47:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:47:43 INFO - 'enabled': True, 03:47:43 INFO - 'halt_on_failure': False, 03:47:43 INFO - 'name': 'check_screen_resolution'},), 03:47:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:47:43 INFO - 'cmd': ('bash', 03:47:43 INFO - '-c', 03:47:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:47:43 INFO - 'enabled': True, 03:47:43 INFO - 'halt_on_failure': False, 03:47:43 INFO - 'name': 'check_screen_resolution'},), 03:47:43 INFO - 'run_cmd_checks_enabled': True, 03:47:43 INFO - 'sps_profile': False, 03:47:43 INFO - 'sps_profile_interval': 0, 03:47:43 INFO - 'suite': 'dromaeojs-e10s', 03:47:43 INFO - 'system_bits': '32', 03:47:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:43 INFO - 'title': 't-yosemite-r7-0057', 03:47:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:43 INFO - 'use_talos_json': True, 03:47:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:47:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:43 INFO - 'work_dir': 'build'} 03:47:43 INFO - ##### 03:47:43 INFO - ##### Running clobber step. 03:47:43 INFO - ##### 03:47:43 INFO - Running pre-action listener: _resource_record_pre_action 03:47:43 INFO - Running main action method: clobber 03:47:43 INFO - rmtree: /builds/slave/test/build 03:47:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:47:44 INFO - Running post-action listener: _resource_record_post_action 03:47:44 INFO - ##### 03:47:44 INFO - ##### Running read-buildbot-config step. 03:47:44 INFO - ##### 03:47:44 INFO - Running pre-action listener: _resource_record_pre_action 03:47:44 INFO - Running main action method: read_buildbot_config 03:47:44 INFO - Using buildbot properties: 03:47:44 INFO - { 03:47:44 INFO - "project": "", 03:47:44 INFO - "product": "firefox", 03:47:44 INFO - "script_repo_revision": "production", 03:47:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:47:44 INFO - "repository": "", 03:47:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:47:44 INFO - "buildid": "20160425042155", 03:47:44 INFO - "pgo_build": "False", 03:47:44 INFO - "basedir": "/builds/slave/test", 03:47:44 INFO - "buildnumber": 304, 03:47:44 INFO - "slavename": "t-yosemite-r7-0057", 03:47:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:47:44 INFO - "platform": "yosemite_r7", 03:47:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:47:44 INFO - "branch": "mozilla-aurora", 03:47:44 INFO - "repo_path": "releases/mozilla-aurora", 03:47:44 INFO - "revision": "f328ac32af6a3d0ce1593c41fd18edf7216a1652", 03:47:44 INFO - "stage_platform": "macosx64", 03:47:44 INFO - "builduid": "3cafbae6ee4445cbb07d61c2d398d690", 03:47:44 INFO - "slavebuilddir": "test" 03:47:44 INFO - } 03:47:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 03:47:44 INFO - Running post-action listener: _resource_record_post_action 03:47:44 INFO - ##### 03:47:44 INFO - ##### Running download-and-extract step. 03:47:44 INFO - ##### 03:47:44 INFO - Running pre-action listener: _resource_record_pre_action 03:47:44 INFO - Running main action method: download_and_extract 03:47:44 INFO - mkdir: /builds/slave/test/build/tests 03:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:44 INFO - https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 03:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 03:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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 03:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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 03:47:46 INFO - Downloaded 1277 bytes. 03:47:46 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 03:47:46 INFO - Using the following test package requirements: 03:47:46 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:47:46 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:47:46 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 03:47:46 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:47:46 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 03:47:46 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:47:46 INFO - u'jsshell-mac.zip'], 03:47:46 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:47:46 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 03:47:46 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:47:46 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:47:46 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 03:47:46 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:47:46 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 03:47:46 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:47:46 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 03:47:46 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:47:46 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:47:46 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 03:47:46 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:47: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')]} 03:47:46 INFO - https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:47:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:47:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:47:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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 03:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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 03:47:47 INFO - Downloaded 17919003 bytes. 03:47:47 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'] 03:47:47 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 03:47:50 INFO - Return code: 0 03:47:50 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 03:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:50 INFO - https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:47:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:47:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:47:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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 03:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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 03:47:51 INFO - Downloaded 17919003 bytes. 03:47:51 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'] 03:47:51 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 03:47:55 INFO - Return code: 0 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:55 INFO - https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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 03:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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 03:47:56 INFO - Downloaded 10845194 bytes. 03:47:56 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'] 03:47:56 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 03:47:56 INFO - Return code: 0 03:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:56 INFO - https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 03:47:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:47:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:47:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 03:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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 03:47:59 INFO - Downloaded 115766844 bytes. 03:47:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:47:59 INFO - mkdir: /builds/slave/test/properties 03:47:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:47:59 INFO - Writing to file /builds/slave/test/properties/build_url 03:47:59 INFO - Contents: 03:47:59 INFO - build_url:https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:48:00 INFO - Running post-action listener: _resource_record_post_action 03:48:00 INFO - Running post-action listener: set_extra_try_arguments 03:48:00 INFO - ##### 03:48:00 INFO - ##### Running populate-webroot step. 03:48:00 INFO - ##### 03:48:00 INFO - Running pre-action listener: _resource_record_pre_action 03:48:00 INFO - Running main action method: populate_webroot 03:48:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:48:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:48:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:48:00 INFO - '--tppagecycles', 03:48:00 INFO - '7'], 03:48:00 INFO - 'tests': ['tsvgm']}}, 03:48:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:48:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:48:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:48:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:48:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:48:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:48:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:00 INFO - 'talos_options': ['--e10s'], 03:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:00 INFO - 'tests': ['damp', 'tps']}, 03:48:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:00 INFO - 'talos_options': ['--e10s'], 03:48:00 INFO - 'tests': ['damp', 'tps']}, 03:48:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:48:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:00 INFO - 'other': {'tests': ['a11yr', 03:48:00 INFO - 'ts_paint', 03:48:00 INFO - 'tpaint', 03:48:00 INFO - 'sessionrestore', 03:48:00 INFO - 'sessionrestore_no_auto_restore', 03:48:00 INFO - 'tabpaint']}, 03:48:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:48:00 INFO - 'tests': ['a11yr', 03:48:00 INFO - 'ts_paint', 03:48:00 INFO - 'tpaint', 03:48:00 INFO - 'sessionrestore', 03:48:00 INFO - 'sessionrestore_no_auto_restore', 03:48:00 INFO - 'tabpaint']}, 03:48:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:48:00 INFO - 'tests': ['a11yr', 03:48:00 INFO - 'ts_paint', 03:48:00 INFO - 'tpaint', 03:48:00 INFO - 'sessionrestore', 03:48:00 INFO - 'sessionrestore_no_auto_restore', 03:48:00 INFO - 'tabpaint']}, 03:48:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:48:00 INFO - 'tests': ['a11yr', 03:48:00 INFO - 'ts_paint', 03:48:00 INFO - 'tpaint', 03:48:00 INFO - 'sessionrestore', 03:48:00 INFO - 'sessionrestore_no_auto_restore', 03:48:00 INFO - 'tabpaint']}, 03:48:00 INFO - 'other_l64': {'tests': ['a11yr', 03:48:00 INFO - 'ts_paint', 03:48:00 INFO - 'tpaint', 03:48:00 INFO - 'sessionrestore', 03:48:00 INFO - 'sessionrestore_no_auto_restore', 03:48:00 INFO - 'tabpaint']}, 03:48:00 INFO - 'other_nol64': {'tests': ['a11yr', 03:48:00 INFO - 'ts_paint', 03:48:00 INFO - 'tpaint', 03:48:00 INFO - 'sessionrestore', 03:48:00 INFO - 'sessionrestore_no_auto_restore', 03:48:00 INFO - 'tabpaint']}, 03:48:00 INFO - 'svgr': {'tests': ['tsvgx', 03:48:00 INFO - 'tsvgr_opacity', 03:48:00 INFO - 'tart', 03:48:00 INFO - 'tscrollx', 03:48:00 INFO - 'cart']}, 03:48:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:48:00 INFO - 'tests': ['tsvgx', 03:48:00 INFO - 'tsvgr_opacity', 03:48:00 INFO - 'tart', 03:48:00 INFO - 'tscrollx', 03:48:00 INFO - 'cart']}, 03:48:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:00 INFO - 'tests': ['tp5o']}, 03:48:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:00 INFO - 'talos_options': ['--e10s'], 03:48:00 INFO - 'tests': ['tp5o']}, 03:48:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:00 INFO - 'talos_options': ['--xperf_path', 03:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:00 INFO - 'tests': ['tp5n']}, 03:48:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:00 INFO - 'talos_options': ['--e10s', 03:48:00 INFO - '--xperf_path', 03:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:00 INFO - 'tests': ['tp5n']}}, 03:48:00 INFO - 'talos.zip': {'path': '', 03:48:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:48:00 INFO - Running post-action listener: _resource_record_post_action 03:48:00 INFO - ##### 03:48:00 INFO - ##### Running create-virtualenv step. 03:48:00 INFO - ##### 03:48:00 INFO - Running pre-action listener: _resource_record_pre_action 03:48:00 INFO - Running main action method: create_virtualenv 03:48:00 INFO - Creating virtualenv /builds/slave/test/build/venv 03:48: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 03:48:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:48:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:00 INFO - Using real prefix '/tools/python27' 03:48:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:48:01 INFO - Installing distribute.............................................................................................................................................................................................done. 03:48:04 INFO - Installing pip.................done. 03:48:04 INFO - Return code: 0 03:48:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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 0x104ea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eac4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981b485280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, '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.NE3j596isx/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.mSib5WxkXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48: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 03:48: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 03:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:04 INFO - 'HOME': '/Users/cltbld', 03:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:04 INFO - 'LOGNAME': 'cltbld', 03:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:04 INFO - 'MOZ_NO_REMOTE': '1', 03:48:04 INFO - 'NO_EM_RESTART': '1', 03:48:04 INFO - 'PAGER': '/bin/cat', 03:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:04 INFO - 'PWD': '/builds/slave/test', 03:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:04 INFO - 'SHELL': '/bin/bash', 03:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:48:04 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:04 INFO - 'USER': 'cltbld', 03:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:04 INFO - 'XPC_FLAGS': '0x0', 03:48:04 INFO - 'XPC_SERVICE_NAME': '0', 03:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48: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 03:48:04 INFO - Cleaning up... 03:48:04 INFO - Return code: 0 03:48:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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 0x104ea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eac4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981b485280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, '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.NE3j596isx/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.mSib5WxkXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48: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 03:48: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 03:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:04 INFO - 'HOME': '/Users/cltbld', 03:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:04 INFO - 'LOGNAME': 'cltbld', 03:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:04 INFO - 'MOZ_NO_REMOTE': '1', 03:48:04 INFO - 'NO_EM_RESTART': '1', 03:48:04 INFO - 'PAGER': '/bin/cat', 03:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:04 INFO - 'PWD': '/builds/slave/test', 03:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:04 INFO - 'SHELL': '/bin/bash', 03:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:48:04 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:04 INFO - 'USER': 'cltbld', 03:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:04 INFO - 'XPC_FLAGS': '0x0', 03:48:04 INFO - 'XPC_SERVICE_NAME': '0', 03:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:04 INFO - Downloading/unpacking psutil>=0.7.1 03:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:07 INFO - Installing collected packages: psutil 03:48:07 INFO - Running setup.py install for psutil 03:48:08 INFO - building 'psutil._psutil_osx' extension 03:48: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:48: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 03:48: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 03:48: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 03:48:08 INFO - building 'psutil._psutil_posix' extension 03:48: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 03:48:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:48:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:48:08 INFO - ^ 03:48:08 INFO - 1 warning generated. 03:48: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 03:48:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:08 INFO - Successfully installed psutil 03:48:08 INFO - Cleaning up... 03:48:08 INFO - Return code: 0 03:48:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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 0x104ea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eac4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981b485280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, '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.NE3j596isx/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.mSib5WxkXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48: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 03:48: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 03:48:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:48:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:08 INFO - 'HOME': '/Users/cltbld', 03:48:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:08 INFO - 'LOGNAME': 'cltbld', 03:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:08 INFO - 'MOZ_NO_REMOTE': '1', 03:48:08 INFO - 'NO_EM_RESTART': '1', 03:48:08 INFO - 'PAGER': '/bin/cat', 03:48:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:08 INFO - 'PWD': '/builds/slave/test', 03:48:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:08 INFO - 'SHELL': '/bin/bash', 03:48:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:48:08 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:48:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:08 INFO - 'USER': 'cltbld', 03:48:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:08 INFO - 'XPC_FLAGS': '0x0', 03:48:08 INFO - 'XPC_SERVICE_NAME': '0', 03:48:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48: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) 03:48:11 INFO - Installing collected packages: mozsystemmonitor 03:48:11 INFO - Running setup.py install for mozsystemmonitor 03:48:11 INFO - Successfully installed mozsystemmonitor 03:48:11 INFO - Cleaning up... 03:48:11 INFO - Return code: 0 03:48:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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 0x104ea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eac4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981b485280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, '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.NE3j596isx/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.mSib5WxkXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48: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 03:48: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 03:48:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:48:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:11 INFO - 'HOME': '/Users/cltbld', 03:48:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:11 INFO - 'LOGNAME': 'cltbld', 03:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:11 INFO - 'MOZ_NO_REMOTE': '1', 03:48:11 INFO - 'NO_EM_RESTART': '1', 03:48:11 INFO - 'PAGER': '/bin/cat', 03:48:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:11 INFO - 'PWD': '/builds/slave/test', 03:48:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:11 INFO - 'SHELL': '/bin/bash', 03:48:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:48:11 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:48:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:11 INFO - 'USER': 'cltbld', 03:48:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:11 INFO - 'XPC_FLAGS': '0x0', 03:48:11 INFO - 'XPC_SERVICE_NAME': '0', 03:48:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:48:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:15 INFO - Downloading docopt-0.6.1.tar.gz 03:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:15 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:15 INFO - Running setup.py install for blobuploader 03:48:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:48:15 INFO - Running setup.py install for requests 03:48:16 INFO - Running setup.py install for docopt 03:48:16 INFO - Successfully installed blobuploader requests docopt 03:48:16 INFO - Cleaning up... 03:48:16 INFO - Return code: 0 03:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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 0x104ea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eac4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981b485280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, '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.NE3j596isx/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.mSib5WxkXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48: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 03:48: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 03:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:16 INFO - 'HOME': '/Users/cltbld', 03:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:16 INFO - 'LOGNAME': 'cltbld', 03:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:16 INFO - 'MOZ_NO_REMOTE': '1', 03:48:16 INFO - 'NO_EM_RESTART': '1', 03:48:16 INFO - 'PAGER': '/bin/cat', 03:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:16 INFO - 'PWD': '/builds/slave/test', 03:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:16 INFO - 'SHELL': '/bin/bash', 03:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:48:16 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:16 INFO - 'USER': 'cltbld', 03:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:16 INFO - 'XPC_FLAGS': '0x0', 03:48:16 INFO - 'XPC_SERVICE_NAME': '0', 03:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:16 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-kOFEnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-wzsdZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-1cxTEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-Cdiygq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-G8urqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-30eigX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-mgmf_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-C8V8e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-Mpc7ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-H3z9Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:17 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-gJQMhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:18 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-xK5WON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:18 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-YKyveA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:18 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-WBYRUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:18 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-DiAILe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:18 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-ZJI5xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:18 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-WS6LkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:18 INFO - Running setup.py install for manifestparser 03:48:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:18 INFO - Running setup.py install for mozcrash 03:48:18 INFO - Running setup.py install for mozdebug 03:48:19 INFO - Running setup.py install for mozdevice 03:48:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozfile 03:48:19 INFO - Running setup.py install for mozhttpd 03:48:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozinfo 03:48:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozInstall 03:48:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:48:19 INFO - Running setup.py install for mozleak 03:48:19 INFO - Running setup.py install for mozlog 03:48:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:48:20 INFO - Running setup.py install for moznetwork 03:48:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:48:20 INFO - Running setup.py install for mozprocess 03:48:20 INFO - Running setup.py install for mozprofile 03:48:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:48:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:48:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:48:20 INFO - Running setup.py install for mozrunner 03:48:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:48:20 INFO - Running setup.py install for mozscreenshot 03:48:20 INFO - Running setup.py install for moztest 03:48:21 INFO - Running setup.py install for mozversion 03:48:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:48:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:21 INFO - Cleaning up... 03:48:21 INFO - Return code: 0 03:48:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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 0x104ea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eac4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981b485280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, '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.NE3j596isx/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.mSib5WxkXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48: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 03:48: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 03:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:21 INFO - 'HOME': '/Users/cltbld', 03:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:21 INFO - 'LOGNAME': 'cltbld', 03:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:21 INFO - 'MOZ_NO_REMOTE': '1', 03:48:21 INFO - 'NO_EM_RESTART': '1', 03:48:21 INFO - 'PAGER': '/bin/cat', 03:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:21 INFO - 'PWD': '/builds/slave/test', 03:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:21 INFO - 'SHELL': '/bin/bash', 03:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:48:21 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:21 INFO - 'USER': 'cltbld', 03:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:21 INFO - 'XPC_FLAGS': '0x0', 03:48:21 INFO - 'XPC_SERVICE_NAME': '0', 03:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:21 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-zqgLAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48: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)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:21 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-E1DaA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:21 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-ymQonj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:21 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-khUfOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:21 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-LTu4tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48: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)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-Q1Wnqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48: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)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-KMdG2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48: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)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-pJWHil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48: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)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-MEXUte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48: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)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-FAwBMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48: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)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-JDoVL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-2ABF98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-r4e65o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-J8Heya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:22 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-Z02Z3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48: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)) 03:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:23 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-pbQvgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48: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)) 03:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:23 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-nyROco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48: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)) 03:48: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)) 03:48: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)) 03:48: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)) 03:48: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)) 03:48: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)) 03:48:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:25 INFO - Downloading blessings-1.6.tar.gz 03:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:25 INFO - Installing collected packages: blessings 03:48:25 INFO - Running setup.py install for blessings 03:48:25 INFO - Successfully installed blessings 03:48:25 INFO - Cleaning up... 03:48:26 INFO - Return code: 0 03:48:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:26 INFO - Reading from file tmpfile_stdout 03:48:26 INFO - Current package versions: 03:48:26 INFO - blessings == 1.6 03:48:26 INFO - blobuploader == 1.2.4 03:48:26 INFO - docopt == 0.6.1 03:48:26 INFO - manifestparser == 1.1 03:48:26 INFO - mozInstall == 1.12 03:48:26 INFO - mozcrash == 0.17 03:48:26 INFO - mozdebug == 0.1 03:48:26 INFO - mozdevice == 0.48 03:48:26 INFO - mozfile == 1.2 03:48:26 INFO - mozhttpd == 0.7 03:48:26 INFO - mozinfo == 0.9 03:48:26 INFO - mozleak == 0.1 03:48:26 INFO - mozlog == 3.1 03:48:26 INFO - moznetwork == 0.27 03:48:26 INFO - mozprocess == 0.22 03:48:26 INFO - mozprofile == 0.28 03:48:26 INFO - mozrunner == 6.11 03:48:26 INFO - mozscreenshot == 0.1 03:48:26 INFO - mozsystemmonitor == 0.0 03:48:26 INFO - moztest == 0.7 03:48:26 INFO - mozversion == 1.4 03:48:26 INFO - psutil == 3.1.1 03:48:26 INFO - requests == 1.2.3 03:48:26 INFO - wsgiref == 0.1.2 03:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:26 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 0x104ea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eac4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981b485280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, '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.NE3j596isx/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.mSib5WxkXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:26 INFO - 'HOME': '/Users/cltbld', 03:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:26 INFO - 'LOGNAME': 'cltbld', 03:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:26 INFO - 'MOZ_NO_REMOTE': '1', 03:48:26 INFO - 'NO_EM_RESTART': '1', 03:48:26 INFO - 'PAGER': '/bin/cat', 03:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:26 INFO - 'PWD': '/builds/slave/test', 03:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:26 INFO - 'SHELL': '/bin/bash', 03:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:48:26 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:26 INFO - 'USER': 'cltbld', 03:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:26 INFO - 'XPC_FLAGS': '0x0', 03:48:26 INFO - 'XPC_SERVICE_NAME': '0', 03:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:48:26 INFO - Cleaning up... 03:48:26 INFO - Return code: 0 03:48:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eac4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981b485280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, '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.NE3j596isx/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.mSib5WxkXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:26 INFO - 'HOME': '/Users/cltbld', 03:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:26 INFO - 'LOGNAME': 'cltbld', 03:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:26 INFO - 'MOZ_NO_REMOTE': '1', 03:48:26 INFO - 'NO_EM_RESTART': '1', 03:48:26 INFO - 'PAGER': '/bin/cat', 03:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:26 INFO - 'PWD': '/builds/slave/test', 03:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:26 INFO - 'SHELL': '/bin/bash', 03:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:48:26 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:26 INFO - 'USER': 'cltbld', 03:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:26 INFO - 'XPC_FLAGS': '0x0', 03:48:26 INFO - 'XPC_SERVICE_NAME': '0', 03:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:26 INFO - Downloading/unpacking jsonschema 03:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:29 INFO - Downloading/unpacking functools32 (from jsonschema) 03:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:29 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:29 INFO - warning: no files found matching '*.txt' 03:48:29 INFO - no previously-included directories found matching 'build' 03:48:29 INFO - no previously-included directories found matching 'dist' 03:48:29 INFO - no previously-included directories found matching '.git*' 03:48:29 INFO - Installing collected packages: jsonschema, functools32 03:48:29 INFO - Running setup.py install for functools32 03:48:29 INFO - warning: no files found matching '*.txt' 03:48:29 INFO - no previously-included directories found matching 'build' 03:48:29 INFO - no previously-included directories found matching 'dist' 03:48:29 INFO - no previously-included directories found matching '.git*' 03:48:29 INFO - Successfully installed jsonschema functools32 03:48:29 INFO - Cleaning up... 03:48:30 INFO - Return code: 0 03:48:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:48: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')]} 03:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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 0x104ea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eac4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981b485280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, '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.NE3j596isx/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.mSib5WxkXO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:48: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 03:48: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 03:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:30 INFO - 'HOME': '/Users/cltbld', 03:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:30 INFO - 'LOGNAME': 'cltbld', 03:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:30 INFO - 'MOZ_NO_REMOTE': '1', 03:48:30 INFO - 'NO_EM_RESTART': '1', 03:48:30 INFO - 'PAGER': '/bin/cat', 03:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:30 INFO - 'PWD': '/builds/slave/test', 03:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:30 INFO - 'SHELL': '/bin/bash', 03:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:48:30 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:30 INFO - 'USER': 'cltbld', 03:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:30 INFO - 'XPC_FLAGS': '0x0', 03:48:30 INFO - 'XPC_SERVICE_NAME': '0', 03:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:30 INFO - Downloading/unpacking flake8 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:48:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:48:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:48:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:34 INFO - no previously-included directories found matching 'docs/_build' 03:48:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:48:34 INFO - Running setup.py install for pep8 03:48:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:34 INFO - no previously-included directories found matching 'docs/_build' 03:48:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:48:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:48:34 INFO - Cleaning up... 03:48:34 INFO - Return code: 0 03:48:34 INFO - Running post-action listener: _resource_record_post_action 03:48:34 INFO - Running post-action listener: _start_resource_monitoring 03:48:34 INFO - Starting resource monitoring. 03:48:34 INFO - ##### 03:48:34 INFO - ##### Running install step. 03:48:34 INFO - ##### 03:48:34 INFO - Running pre-action listener: _resource_record_pre_action 03:48:34 INFO - Running main action method: install 03:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:34 INFO - Reading from file tmpfile_stdout 03:48:34 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:48:34 INFO - Reading from file tmpfile_stdout 03:48:34 INFO - Output received: 03:48:34 INFO - Usage: mozinstall [options] installer 03:48:34 INFO - Options: 03:48:34 INFO - -h, --help show this help message and exit 03:48:34 INFO - -d DEST, --destination=DEST 03:48:34 INFO - Directory to install application into. [default: 03:48:34 INFO - "/builds/slave/test"] 03:48:34 INFO - --app=APP Application being installed. [default: firefox] 03:48:34 INFO - mkdir: /builds/slave/test/build/application 03:48:34 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'] 03:48:34 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 03:49:07 INFO - Reading from file tmpfile_stdout 03:49:07 INFO - Output received: 03:49:07 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:49:07 INFO - Running post-action listener: _resource_record_post_action 03:49:07 INFO - ##### 03:49:07 INFO - ##### Running run-tests step. 03:49:07 INFO - ##### 03:49:07 INFO - Running pre-action listener: _resource_record_pre_action 03:49:07 INFO - Running main action method: run_tests 03:49:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:49:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:49:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:49:07 INFO - 2016-04-27 03:49:07.636 screenresolution[1945:15524] starting screenresolution argv=screenresolution get 03:49:07 INFO - 2016-04-27 03:49:07.639 screenresolution[1945:15524] Display 0: 1600x1200x32@60 03:49:07 INFO - 2016-04-27 03:49:07.644 screenresolution[1946:15528] starting screenresolution argv=screenresolution list 03:49:07 INFO - Available Modes on Display 0 03:49:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:49:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:49:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:49:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:49:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:49:07 INFO - Intel Iris: 03:49:07 INFO - Chipset Model: Intel Iris 03:49:07 INFO - Type: GPU 03:49:07 INFO - Bus: Built-In 03:49:07 INFO - VRAM (Dynamic, Max): 1536 MB 03:49:07 INFO - Vendor: Intel (0x8086) 03:49:07 INFO - Device ID: 0x0a2e 03:49:07 INFO - Revision ID: 0x0009 03:49:07 INFO - Displays: 03:49:07 INFO - Display: 03:49:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:49:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:49:07 INFO - Display Serial Number: 1600x1200 60 03:49:07 INFO - Main Display: Yes 03:49:07 INFO - Mirror: Off 03:49:07 INFO - Online: Yes 03:49:07 INFO - Rotation: Supported 03:49:07 INFO - Return code: 0 03:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:49:07 INFO - Python 2.7.3 03:49:07 INFO - Return code: 0 03:49:07 INFO - grabbing minidump binary from tooltool 03:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49: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 0x104d49d30>, '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 0x104baddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d40b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:49: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 03:49: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 03:49:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:07 INFO - Return code: 0 03:49:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:49:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:49:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:49:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:49:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:49:09 INFO - Return code: 0 03:49: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/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:49: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/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:49:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE3j596isx/Render', 03:49:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:49:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:49:09 INFO - 'HOME': '/Users/cltbld', 03:49:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:49:09 INFO - 'LOGNAME': 'cltbld', 03:49:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:09 INFO - 'MOZ_NO_REMOTE': '1', 03:49:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:09 INFO - 'NO_EM_RESTART': '1', 03:49:09 INFO - 'PAGER': '/bin/cat', 03:49:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:09 INFO - 'PWD': '/builds/slave/test', 03:49:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:49:09 INFO - 'SHELL': '/bin/bash', 03:49:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mSib5WxkXO/Listeners', 03:49:09 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 03:49:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:49:09 INFO - 'USER': 'cltbld', 03:49:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:49:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:09 INFO - 'XPC_FLAGS': '0x0', 03:49:09 INFO - 'XPC_SERVICE_NAME': '0', 03:49:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:49: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/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:49:09 INFO - mozversion application_buildid: 20160425042155 03:49:09 INFO - mozversion application_changeset: f328ac32af6a3d0ce1593c41fd18edf7216a1652 03:49:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:49:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:09 INFO - mozversion application_name: Firefox 03:49:09 INFO - mozversion application_remotingname: firefox-dev 03:49:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:49:09 INFO - mozversion application_vendor: Mozilla 03:49:09 INFO - mozversion application_version: 47.0a2 03:49:09 INFO - mozversion platform_buildid: 20160425042155 03:49:09 INFO - mozversion platform_changeset: f328ac32af6a3d0ce1593c41fd18edf7216a1652 03:49:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:49:09 INFO - mozversion platform_version: 47.0a2 03:49:09 INFO - using testdate: 1461754149 03:49:09 INFO - actual date: 1461754149 03:49:09 INFO - starting webserver on 'localhost:52289' 03:49:09 INFO - SUITE-START | Running 2 tests 03:49:09 INFO - TEST-START | dromaeo_css 03:49:09 INFO - operating with platform_type : mac_ 03:49:09 INFO - Initialising browser for dromaeo_css test... 03:49:09 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpUdNKYT/profile http://localhost:52289/getInfo.html) 03:49:12 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 03:49:12 INFO - PROCESS | 1964 | colorDepth:24 03:49:12 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 03:49:12 INFO - PROCESS | 1964 | __metrics 03:49:12 ERROR - PROCESS | 1964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:49:12 INFO - TEST-INFO | 1964: exit 0 03:49:12 INFO - Browser initialized. 03:49:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:49:12 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpUdNKYT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:24 INFO - PROCESS | 1967 | RSS: Main: 217939968 03:49:24 INFO - PROCESS | 1967 | 03:50:14 INFO - PROCESS | 1967 | 1461754214300 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:52:25 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52289/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52289/tests/dromaeo/cssquery-ext.html) 03:52:27 INFO - PROCESS | 1967 | RSS: Main: 230838272 03:52:27 INFO - PROCESS | 1967 | 03:55:29 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52289/tests/dromaeo/cssquery-ext.html (next: http://localhost:52289/tests/dromaeo/cssquery-jquery.html) 03:55:29 INFO - PROCESS | 1967 | RSS: Main: 242647040 03:55:29 INFO - PROCESS | 1967 | 03:58:31 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52289/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52289/tests/dromaeo/cssquery-mootools.html) 03:58:31 INFO - PROCESS | 1967 | RSS: Main: 244699136 03:58:31 INFO - PROCESS | 1967 | 04:01:33 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52289/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52289/tests/dromaeo/cssquery-prototype.html) 04:01:34 INFO - PROCESS | 1967 | RSS: Main: 246276096 04:01:34 INFO - PROCESS | 1967 | 04:04:36 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52289/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52289/tests/dromaeo/cssquery-yui.html) 04:04:37 INFO - PROCESS | 1967 | RSS: Main: 249114624 04:04:37 INFO - PROCESS | 1967 | 04:07:39 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52289/tests/dromaeo/cssquery-yui.html (next: http://localhost:52289/tests/dromaeo/cssquery-dojo.html) 04:07:39 INFO - PROCESS | 1967 | RSS: Main: 250589184 04:07:39 INFO - PROCESS | 1967 | 04:07:39 INFO - PROCESS | 1967 | __start_tp_report 04:07:39 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 04:07:39 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 04:07:39 INFO - PROCESS | 1967 | |i|pagename|runs| 04:07:39 INFO - PROCESS | 1967 | |0;dojo.html;3505.6669616386444;3578.8747393841213;3592.497050412941;3593.8499680102364;3610.963890361097;5883.441073098049;5989.101634754789;5996.340402555716;6007.339192688801;6019.488343490798;5132.922086361868;5139.383274007115;5214.139666954948;6020.0367941129425;6047.395260473951;4764.35681183041;5312.548433383147;5370.248165256867;5378.78484860607;5401.675899446026;4566.817327306904;5226.895462090756;5248.737563121828;5377.381601115863;5400.135978243482;5340.172273297626;5346.705931173784;5367;5370.301860758096;5414;4787.257975013878;5135.024345374404;5309.575233981292;5377.569794416438;5406.135018397038;5268.209768534751;5350.785968561253;5354.303940487751;5379.784808607651;5394.298741163623;5783.479486846204;5939;5962.105684147369;5982.551308651869;6037.63774173551;6117.766507567588;6180.351063138351;6230.06549017651;6247.750089996394;6251.937480625181;6296.401841825019;6305.558610897239;6306.873862522724;6308.968455157741;6311.116443697886;5913.852153696149;6030.095485677183;6079.05774604937;6087.847803804896;6089.725962331706;6465.903011454832;6490.513211509156;6497.382748638872;6499.992501162327;6501.512386571026;6216.7824126155365;6245.781397651152;6249.187605611241;6264.655443950626;6280.528960327993;6195.566310358322;6291.559590828598;6310.747570097236;6320.367963203643;6336.366363363627;6161.383861613893;6177.722002509898;6221.9377806222265;6226.6575338355915;6235.657038862815;6171.321154672983;6181.072839074175;6201.627902325875;6222.782202622887;6238.719257633417;4941.530554597308;5001.924971125436;5042.344495215599;5076.035553244872;5083.440821509631;3821.2739579479808;4513.255312873339;4521.186186486464;4555.339475775994;4567.794449249792;5801;6011.1884895539415;6040.667763272974;6042.637441753509;6050.2437195350585;6190.535709821781;6270.811875643647;6280.120783090371;6283;6335.936640633535;6022.69886505673;6040.36576159497;6040.546958978094;6044.546659000593;6055.333913269536;5552.250446189793;5560.388357280696;5560.582956278296;5565.666060036411;5568.220449137124;6320.399562041599;6400.55196136266;6454.096426500388;6489.5781774184525;6499.415052645285;6345.777897773556;6354.936450635434;6358.554901156875;6362.840928976812;6383.265924418752;6321.683915804099;6476.12572302752;6525;6541.0188471729625;6553.574017688835;5271.314729085195;6190.133381326528;6218.81343559694;6264.561480696308;6282.811515654537;6265.8120256392385;6304.936950630435;6306.117143599808;6314.494840412664;6322.778702745381;5685.715714214355;5776.815752770588;6049.032154855202;6139.185504090546;6240.875182496416;6135.630783975068;6162.383761623981;6168.19813424252;6193.163922870535;6236.968815155895;5696.8006119785605;6157.722902469489;6210.472109870711;6227.1282020516255;6231.2522497300615;5923.289205295392;6098.115773212948;6120.2947619997085;6170.753169873335;6206.937930620817;6069.575129740876;6182.721777519932;6194.566380353513;6206.441420272197;6212.4408803207925 04:07:39 INFO - PROCESS | 1967 | |1;ext.html;570.9172170035345;624.9062640603906;674.9493787965903;680.8357708318774;695.782380833541;36997.630023699756;38894.61105388945;38943.80528097359;39171;39256.60743392565;40640.187196256134;40689.38965915514;41093.58906410935;41108.58891411085;41218.7939060305;9517.904820951771;9695.757606059835;9727.90272097277;9775.022497750204;9789.02109789019;8862.24670902974;9573.904260957406;9768.755781105458;9792.16766574842;9811.411315321067;9772;9853.852192217122;9858.507074646239;9862.852057219148;9865.556049977768;9788.510574471284;9810;9815.06756858101;9824.852627210597;9855.408675479459;9534.284928630312;9589.664361747375;9668;9679.225661947028;9689.176420004309;34622;40074.198516029515;40491.987700307436;40639;40639.984000399934;3257.6090869095624;3464.0473869685784;3469.6703813137965;3499.3526197653514;3930.3711406174875;28007.0197543085;28069.438611227662;28332.716672833212;28372.574411383845;28577;2758.4207316463567;2771.5704065869822;2817.1548535439288;2822.4919514487383;2833.0367674990603;271913;316145;319519;320292.39853800816;321982;55105;65053;65568;65613.67193164004;65676.67161664256;75544.24455755482;75996;76279;76519.61740191263;77378.4524309522;15142.54572362831;15153.924230378998;18342.908285458754;18446.446606601825;18579.814201857807;13751.106178098391;13956.09285396446;14030.158190508602;14055.156690598596;14066.578002659937;22195.889020555118;22447;22625.660615090786;22641.2075577354;23141.84290785454;9352.532373381304;9557.569909354095;9612.423254604746;9625.71122866315;9625.855612165824;1014.5688082564881;1084.8969347912093;1092.546593163844;1122.9157813163881;1165.8659254185707;30522.54216186759;30641.69358306433;30861.84318626555;30908;31098.84450577778;1034.4724190662816;1052.678932925465;1066.4561073852392;1092.039005675001;1113.8886111388797;13803.51687690926;13999.440022399194;15445.691086178214;15468.613284667974;15634.296456659478;515600;519270;523216;523259;524022.3798880981;60500.39499605036;60718.69640651769;60892;60945;61042.38957610456;1322.7566087877365;1506.0963421946963;1538.8845836562302;1543.5446543269538;1556.8053993250844;23662.763372366055;29959.251018723833;30237;30834.845825770728;30903.845480772452;47744.522554774005;54305;59344;59568.404315956286;59738.70130649319;419567;423905;424048;428456;429452;41926.861623140765;42426.1514769709;43250.78374608107;43573.346399804665;43971;44434.33348499711;48373.75813120912;48405;49172.770680733265;49179.26231106608;39016.41475377815;39732.404013940395;40140;40177;41543.58456415518;29850.85074574613;35950.64049359473;39406.802965984985;39933.00167495836;40667.7966610165;37490.62509374871;38689;40225.396619051324;40992;41158.588414115475;27287.59068614012;31132.688673113884;33476.665233347354;34363.65636343604;34413;21771.673424898956;25752.356191095372;26159;26247.21258362252;26597 04:07:39 INFO - PROCESS | 1967 | |2;jquery.html;377.74313466842534;382.6747264824899;384.87491565241294;388.828915277278;390.32668646584625;19656.21375144994;20463;20941.581168376622;21069.367918962438;21248.787512124873;11932.463039163236;12398;20738.859362735042;20994.89502552485;21041.684374734392;4834;5360.812371566996;5485.259489968863;5537;5559.388467268597;4135.255653982282;5836.445537673914;6009.06859436788;6082.118092876531;6082.1180928765525;5977.671228082454;6048.123022161784;6056.666883321415;6074.362191969846;6102.664353460558;6554.049662798891;6560.278369379364;6571.835704107388;6579.374959378852;6591.307912669148;5677.40387259336;5711.228984087136;5831.504322132624;5839.211706419622;5892.941070589282;26134;26201.73798262031;26693.332666683487;26718.33204169892;26909.865450672816;1802.531341851115;2180.3458962311242;2205.9669104963436;2229.4649284171846;2269.4326418395403;9824.607015719363;10800.621978230723;13975.09161904473;15346.002509836937;15429.614259643486;1652.4133932453926;1692.815029479357;1827.0864567716142;1874.71879218117;1876.3714155757837;107798;108069.37895931567;112792.43603782011;114799;118161;11674.299542027506;11738.94130529342;11809.940950295366;11827.940860295643;11828;14602.050866693631;14694.971352005257;14741.41034358635;14744;14787.704245915236;8930.598123084477;9054.185123338932;9056.320775941831;9061.54692265384;9079.954600227089;9134.680286189952;9189.218916392181;9220.5850736717;9279.304052196112;9307.674231401868;3960.2475529649273;4431.113777244564;4566.908661826745;4647.279671650899;4652.674312798072;1839.1700258242865;1914.985057919305;1954.7263383126374;1977.5550501137416;2028.9188432462831;965.5510187762584;965.6909788867636;981.288565789811;985.3447457440722;1049.9422531760827;17016.91491542559;21022.579548408947;21361.35915922525;21992.89003554972;22433.887830560743;838.4508147163617;1029.4492446541215;1034.6378767431338;1042.702829693549;1053.3416614615865;11350.09199264057;11597.594084207012;11632.825507617392;11655.184137110491;11723.824142637868;638641;645186;645427;655374;659589;102862;130879;131270.34364828115;131281.34359328143;131839;912.7170577121113;1001.5242759689235;1058.872935247775;1127.0476447401932;1127.937963412004;16746.748798767785;17228.483145505656;18998.525036873634;19461.026948652227;19781.010949452757;45894.541054590365;55843.441565583824;55879.99999999837;57346.139807903746;58080.70959645175;71879.20301992283;76676.61661691879;85076.14923850683;85384.14615853762;85451.57274213589;7551.848963020819;8249.463784853966;8374.911261536205;8456.788580285296;8546.23083922425;11955.64133076009;13247.403866825824;13477.595672129852;13500.054996150175;13707.588772336845;11602.303861768321;11704.824427633423;11886.465109069939;11914.10644201671;11962.76074478523;11253.549858005916;11379.260348077349;11439.08487321029;11616.883831161918;11685.883141168479;10380.844287335847;11852.940735296268;11934.940325298317;12108.455119519467;12237.75524489523;8140.877886831584;8312.977976252945;8359.247667709935;8466.026406963032;8771.210591046836;10739.785204296026;11676.88323116758;11698;11853.762924741284;11855 04:07:39 INFO - PROCESS | 1967 | |3;mootools.html;1639.721247387944;1678.0854434333287;2019.1216820683003;2041.540653352995;2106.062802053085;8362.996440427158;8975.147361000694;9140.862887056699;9326.72019839405;9337.25301975842;8989.190972812445;9028.458292502455;9131.99548049714;9136.90863091369;9151.633934642607;2542.186500319903;2555.3739333863227;2556.27146263315;2563.628273900283;2572.006694811527;2236.7250667119747;2261.649444336122;2489.4647650755173;2491.9252422427357;2501.7248102708686;2162.7512836023902;2525.2676723750183;2533.2526904563106;2546.5925451927696;2547.5796493578537;2131.2540610786255;2522.2811498722867;2532.1643857526974;2547.5669136246884;2572.742725727431;2474.715407728116;2508.234988328559;2526.166365099513;2537.099329737953;2581.7547333003336;9132.315076369232;9285.396449230846;9306.348555601111;9340.112689294507;9353.251739860794;5667.518260947824;5737.770489180428;5829.125631155318;5856.853578660568;5873.324567674729;3691.907702307437;3736.645018723217;3761.22894806564;3782.7541209821275;3828.0812604974885;1037.5797801890246;1046.2937517175876;1047.8218702820539;1054.1040115901499;1054.4727636181908;11335.093192544658;11738.471768770425;12559.497620095186;12596.433160507799;12646.557370491988;5053.317802096743;5069.670471419419;5114.002769459919;5168.302279192336;5193.324867767166;10513.211509136845;10593.364398135982;10597.364158150536;10601.787964240671;10644.627438039632;5717.599768016199;5719.8570035749435;5750.1949727038245;5778.855528611818;5820.35976042635;3942.9802850986134;5001.924971125436;5076.796928122908;5177;5191.8182863599595;4065.715399921977;4078.653314468244;4088.5707000765087;4128.1330920506425;4161.812718427678;1365.590322903125;1367.453018792471;1369.0621923982103;1371.6502291915497;1381.302442266649;1389.6178550898383;1404.248726931087;1422.566117334223;1436.8203974503188;1465.6848777512887;8336.208060234268;8428.241458268785;8453.788655283544;8478.364122690822;8515.74452766418;532.9760160792696;544.4637032522962;544.6840832317325;545.2148905575958;549.574080087935;6276;6309.842253943688;6311.495080393557;6371.936280637227;6382.680865956683;10943.56225750977;11244.044256238149;11377.43112844371;11405.258658187191;11412.144089193343;10747.570097196181;11013;11036.11711063113;11118.499667514981;11182.217244792786;8622;8746.256568191648;8819.559022049;8845.42504737203;8895.688650897187;8018;8080.070791858776;8157.8776318354085;8231.876521852057;8242;9552.57013434411;9819.36174148678;9855.605775768889;9955.850662240216;10081.69754907354;10067.597296108073;10249.692509224735;10296.279260451696;10354.5340459678;10371.014753598396;7064.929350706633;7249.891251631124;7446.962765186356;7632.80917977055;7769.805754856174;7959.801004974922;8089.757307280791;8107.513549187068;8131.7967050821835;8139.226773456512;7099.964500177673;7255.709771609077;7285.890711639224;7347.228541003117;7392.445566582635;7137.10786151731;7182.604956727221;7276.636168191463;7471.775846724607;7559.659815308214;7838.216178382117;7951.125376208497;7958.522488650699;7970.960145199237;8016.997875265592;7090.07828982229;7156.284371562802;7198.100237470317;7228.566286022856;7264.200937896721;6427.003814408774;6761.526693131434;7007;7347;7401.555906645403 04:07:39 INFO - PROCESS | 1967 | |4;prototype.html;330.9073459431359;339.76725942729234;340.168288534533;342.65563109075407;348.07238708840924;6614.900776488351;6661.16735408074;6674.86650266995;6702.899456508157;6703.128593282872;5094.898102037957;5235.685858848472;6598.736050557972;6620.602763834161;6631.701573429195;4101.954001729562;4576.794044267999;4760.8333708320215;4932.8520144395725;4941.283513890484;3940.783256920868;4884.096442158194;4907.2393778964315;4917.164082106051;4922.852314430573;4848.490908454614;4855.295982082596;4880.389951256093;4883.365162528867;4904.5340692634145;4194.3498757692605;4694.812207511695;4874.463808981027;4883;4887.3402090717655;4241.660667146621;4244.236037513247;4253.851115210984;4259.297215959363;4261;5066.82266120684;6035.698215089228;6285.842853928642;6323.588966717149;6344.809655710336;5693.943060569424;5772.509336706343;5796.739146738407;5804.912926306109;5839.9124013139835;7146.964265178693;7162.247963963813;7164.605946672931;7169.498135130543;7197.676104575306;4635.745034023127;4664.883377915546;4665.276882083249;4674.439067311944;4689.554492323224;7502.249775022508;7541.8114547135665;7559.244075592452;7569.659365328574;7594.468387212897;4403.757793321334;4544.931826022612;4609.907801843944;4679.578837904605;4684.625229981593;4751.263554149113;4773.284007398848;4775.450823155312;4779.972305954237;4827.131116399011;5746.396628354046;5750.30996280449;5773.451522105393;5780.88438231233;5792.247007889032;7115.679794409264;7119.715211391486;7128.607926564089;7133.964330178316;7141.071660684078;1635.582926353772;1656.7017936771256;1660.609756707173;1665.533650577816;1667.933282668704;1037.6886933919793;1059.7721489879714;1064.0423618743039;1067.0983019348637;1086.8858769829212;6553.180852393451;6588.40704336612;6598;6606.306337834458;6608.140941677551;7371.262873712586;7388.445866559922;7408.592527410937;7416.443766717518;7428.702851885864;6594.769183078569;6610.933890661128;6617.371349721769;6618.86762264752;6649.833754156088;3759.342115129841;3884.436756670267;3884.6503814656817;3910.9608903911167;3931.331673615492;6487.0269459580495;7405.037345145097;7686.846263074707;7703.1911649277135;7786.026746656668;6523.18460192476;7695.461317707706;7723;7736.342410895137;7765.961170194113;7662.310392064741;7698.345640620386;7723.497972631761;7725.381969442431;7735.1491335953;7073.575585464889;7428.851422971402;7430.071241094864;7441.8139546511775;7448.776536703907;7200.567965922061;7248.818779530554;7262.876962906001;7286.599237042014;7300.671469783979;6805.9659701701175;7140.714371425085;7704.576248306397;7746.845063098819;7765.53406795594;4642.767861606839;4685.99251161002;4687.437507499122;4699.741514216614;4725;7173.928260717326;7411.295926886937;7424.443166762622;7443.734565123834;7468.5145465544565;5662.7734890603915;7152.427805775422;7158.749443769443;7165.713371465083;7169.068021157216;7048.436125109876;7125.608091554807;7136.607486588287;7154.105736782903;7176.174739904769;6025.096235564701;6518.413342799171;6978.860422791618;6994.370506654425;7008.859822803617;6882.552634078769;7166.498345116001;7183.245759195418;7189.568625882254;7222.349988501061;5838.065909454467;6433.581817181868;6606.942889137715;6832.214295355899;7070.575765454089 04:07:39 INFO - PROCESS | 1967 | |5;yui.html;650.4276236911517;687.9931200687995;707.2891743797485;745.355267693445;786.3826895886726;15053.397864085451;15345.616359591017;15583.454579089734;15584.376624935017;15602.985805922606;14862.108273503598;14878.181700006522;14913.92543037286;14954.102753834777;14959.626009349771;790.8497385496737;946.8579713043047;973.7614284500272;975.2246963663869;983.2871168402922;972.0765272990652;972.610955617755;973.2408721197477;973.6397532912797;976.3360914578084;1006.3659894266639;1020.607066279484;1028.8096702110097;1028.93311934724;1030.3817709374352;1018.5620183321168;1024.549198352726;1024.605526872152;1024.7284469615558;1027.2090490322485;760.4106817216646;769.4690663442207;774.5430196184278;775.0931410249965;775.1899265267808;12938.87061129386;15309;15319.846801531954;15492.612684682861;15679.843201567952;13412.195268283935;13446;13479.460821567125;13566.525171618947;13588.320583970763;10345.431001294926;10398.480075996245;10419.583216671324;10449.164066874631;10529.526171322232;3599;3607.765495242827;3612.060864175307;3635.054885729703;3637.613924586786;65636.6872662544;83023;83323.16676833275;83516.58241708753;83905;9934;9974.700758977242;9996.900030999597;10018.499075046218;10108.29241953071;23645.7635423647;23782;23856.64215036776;23879.641805372932;23946;7742.341900938371;7757.146713861471;7791.220877912277;7810.687572497037;7896.131425543185;4135.751854888656;4141.8436887734;4209.705320627527;4257.212415703105;4303.655707543389;3648.21563363878;3654.2326111516877;3676.9888280723017;3689.4281386385155;3715.071232191952;572.4418691775569;647.5143642268299;648.2933602373436;650.9023646452976;662.2417332154656;613.2120225510198;613.414189449084;614.8739508400768;628.8270725550419;636.0491065856575;8413.411061225655;8434;8763.25512331459;8872.822543549093;9145.222656074307;524.9474803019921;580.2862479150668;593.3858456497504;619.6994457688018;637.4581605635173;3922.646961773454;4071.063655359225;4116.732412393185;4126.484189476316;4242.130363275521;93430.59854102194;93905;95298.52350738202;97444;99796.00203997867;61758.69120654368;68350.63298734097;86825;87450.56274718586;88273;58670.7066464665;74963.87554186692;75652;75704.24295757082;77004.61497692476;7793.98678171834;8076.798080048045;8781.990071141901;8932.46405215689;9057.456552606865;52364.47635523596;52828;52880.73559632177;55132.72433637806;55362.16956745571;71563;72652.63673681598;74260.62869685618;74341.25658743344;77923.83114253178;11205.103591712481;11246.493907774333;11344.546218151181;11736.0611151106;11737.823932640846;11973;12040.157188996685;12074.818877717016;12267.815982760445;13070.607881763563;11749.823752643546;11835.230710003822;11880.76238475243;11953.103517236068;11958.58144964922;11602.419879006186;11934.462949167482;11958.701032474257;12085.818712719492;12248.816267756169;11403;11537.192396532499;11772.411379431165;11787.233829801036;11917.761644766882;7969.641366138653;9834.901650983686;10066.094051535398;10132.746681333025;10259.538320775433;9815.85276220843;10134.898651013396;10158.441285729356;10269.74325641865;10281.383117013003 04:07:39 INFO - PROCESS | 1967 | __end_tp_report 04:07:39 INFO - PROCESS | 1967 | __start_cc_report 04:07:39 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,355 04:07:39 INFO - PROCESS | 1967 | __end_cc_report 04:07:39 INFO - PROCESS | 1967 | __startTimestamp1461755259747__endTimestamp 04:07:39 INFO - PROCESS | 1967 | 04:07:39 INFO - PROCESS | 1967 | ------- Summary: start ------- 04:07:39 INFO - PROCESS | 1967 | Number of tests: 6 04:07:39 INFO - PROCESS | 1967 | 04:07:39 INFO - PROCESS | 1967 | [#0] dojo.html Cycles:165 Average:5841.90 Median:6098.12 stddev:651.37 (10.7%) stddev-sans-first:627.05 04:07:39 INFO - PROCESS | 1967 | Values: 3505.7 3578.9 3592.5 3593.8 3611.0 5883.4 5989.1 5996.3 6007.3 6019.5 5132.9 5139.4 5214.1 6020.0 6047.4 4764.4 5312.5 5370.2 5378.8 5401.7 4566.8 5226.9 5248.7 5377.4 5400.1 5340.2 5346.7 5367.0 5370.3 5414.0 4787.3 5135.0 5309.6 5377.6 5406.1 5268.2 5350.8 5354.3 5379.8 5394.3 5783.5 5939.0 5962.1 5982.6 6037.6 6117.8 6180.4 6230.1 6247.8 6251.9 6296.4 6305.6 6306.9 6309.0 6311.1 5913.9 6030.1 6079.1 6087.8 6089.7 6465.9 6490.5 6497.4 6500.0 6501.5 6216.8 6245.8 6249.2 6264.7 6280.5 6195.6 6291.6 6310.7 6320.4 6336.4 6161.4 6177.7 6221.9 6226.7 6235.7 6171.3 6181.1 6201.6 6222.8 6238.7 4941.5 5001.9 5042.3 5076.0 5083.4 3821.3 4513.3 4521.2 4555.3 4567.8 5801.0 6011.2 6040.7 6042.6 6050.2 6190.5 6270.8 6280.1 6283.0 6335.9 6022.7 6040.4 6040.5 6044.5 6055.3 5552.3 5560.4 5560.6 5565.7 5568.2 6320.4 6400.6 6454.1 6489.6 6499.4 6345.8 6354.9 6358.6 6362.8 6383.3 6321.7 6476.1 6525.0 6541.0 6553.6 5271.3 6190.1 6218.8 6264.6 6282.8 6265.8 6304.9 6306.1 6314.5 6322.8 5685.7 5776.8 6049.0 6139.2 6240.9 6135.6 6162.4 6168.2 6193.2 6237.0 5696.8 6157.7 6210.5 6227.1 6231.3 5923.3 6098.1 6120.3 6170.8 6206.9 6069.6 6182.7 6194.6 6206.4 6212.4 04:07:39 INFO - PROCESS | 1967 | 04:07:39 INFO - PROCESS | 1967 | [#1] ext.html Cycles:180 Average:58962.23 Median:40158.50 stddev:113332.85 (282.2%) stddev-sans-first:113565.99 04:07:39 INFO - PROCESS | 1967 | Values: 570.9 624.9 674.9 680.8 695.8 36997.6 38894.6 38943.8 39171.0 39256.6 40640.2 40689.4 41093.6 41108.6 41218.8 9517.9 9695.8 9727.9 9775.0 9789.0 8862.2 9573.9 9768.8 9792.2 9811.4 9772.0 9853.9 9858.5 9862.9 9865.6 9788.5 9810.0 9815.1 9824.9 9855.4 9534.3 9589.7 9668.0 9679.2 9689.2 34622.0 40074.2 40492.0 40639.0 40640.0 3257.6 3464.0 3469.7 3499.4 3930.4 28007.0 28069.4 28332.7 28372.6 28577.0 2758.4 2771.6 2817.2 2822.5 2833.0 271913.0 316145.0 319519.0 320292.4 321982.0 55105.0 65053.0 65568.0 65613.7 65676.7 75544.2 75996.0 76279.0 76519.6 77378.5 15142.5 15153.9 18342.9 18446.4 18579.8 13751.1 13956.1 14030.2 14055.2 14066.6 22195.9 22447.0 22625.7 22641.2 23141.8 9352.5 9557.6 9612.4 9625.7 9625.9 1014.6 1084.9 1092.5 1122.9 1165.9 30522.5 30641.7 30861.8 30908.0 31098.8 1034.5 1052.7 1066.5 1092.0 1113.9 13803.5 13999.4 15445.7 15468.6 15634.3 515600.0 519270.0 523216.0 523259.0 524022.4 60500.4 60718.7 60892.0 60945.0 61042.4 1322.8 1506.1 1538.9 1543.5 1556.8 23662.8 29959.3 30237.0 30834.8 30903.8 47744.5 54305.0 59344.0 59568.4 59738.7 419567.0 423905.0 424048.0 428456.0 429452.0 41926.9 42426.2 43250.8 43573.3 43971.0 44434.3 48373.8 48405.0 49172.8 49179.3 39016.4 39732.4 40140.0 40177.0 41543.6 29850.9 35950.6 39406.8 39933.0 40667.8 37490.6 38689.0 40225.4 40992.0 41158.6 27287.6 31132.7 33476.7 34363.7 34413.0 21771.7 25752.4 26159.0 26247.2 26597.0 04:07:39 INFO - PROCESS | 1967 | 04:07:39 INFO - PROCESS | 1967 | [#2] jquery.html Cycles:180 Average:36529.67 Median:21305.07 stddev:107701.35 (505.5%) stddev-sans-first:107969.27 04:07:39 INFO - PROCESS | 1967 | Values: 377.7 382.7 384.9 388.8 390.3 19656.2 20463.0 20941.6 21069.4 21248.8 11932.5 12398.0 20738.9 20994.9 21041.7 4834.0 5360.8 5485.3 5537.0 5559.4 4135.3 5836.4 6009.1 6082.1 6082.1 5977.7 6048.1 6056.7 6074.4 6102.7 6554.0 6560.3 6571.8 6579.4 6591.3 5677.4 5711.2 5831.5 5839.2 5892.9 26134.0 26201.7 26693.3 26718.3 26909.9 1802.5 2180.3 2206.0 2229.5 2269.4 9824.6 10800.6 13975.1 15346.0 15429.6 1652.4 1692.8 1827.1 1874.7 1876.4 107798.0 108069.4 112792.4 114799.0 118161.0 11674.3 11738.9 11809.9 11827.9 11828.0 14602.1 14695.0 14741.4 14744.0 14787.7 8930.6 9054.2 9056.3 9061.5 9080.0 9134.7 9189.2 9220.6 9279.3 9307.7 3960.2 4431.1 4566.9 4647.3 4652.7 1839.2 1915.0 1954.7 1977.6 2028.9 965.6 965.7 981.3 985.3 1049.9 17016.9 21022.6 21361.4 21992.9 22433.9 838.5 1029.4 1034.6 1042.7 1053.3 11350.1 11597.6 11632.8 11655.2 11723.8 638641.0 645186.0 645427.0 655374.0 659589.0 102862.0 130879.0 131270.3 131281.3 131839.0 912.7 1001.5 1058.9 1127.0 1127.9 16746.7 17228.5 18998.5 19461.0 19781.0 45894.5 55843.4 55880.0 57346.1 58080.7 71879.2 76676.6 85076.1 85384.1 85451.6 7551.8 8249.5 8374.9 8456.8 8546.2 11955.6 13247.4 13477.6 13500.1 13707.6 11602.3 11704.8 11886.5 11914.1 11962.8 11253.5 11379.3 11439.1 11616.9 11685.9 10380.8 11852.9 11934.9 12108.5 12237.8 8140.9 8313.0 8359.2 8466.0 8771.2 10739.8 11676.9 11698.0 11853.8 11855.0 04:07:39 INFO - PROCESS | 1967 | 04:07:39 INFO - PROCESS | 1967 | [#3] mootools.html Cycles:180 Average:6239.73 Median:2863.15 stddev:3319.35 (115.9%) stddev-sans-first:3310.66 04:07:39 INFO - PROCESS | 1967 | Values: 1639.7 1678.1 2019.1 2041.5 2106.1 8363.0 8975.1 9140.9 9326.7 9337.3 8989.2 9028.5 9132.0 9136.9 9151.6 2542.2 2555.4 2556.3 2563.6 2572.0 2236.7 2261.6 2489.5 2491.9 2501.7 2162.8 2525.3 2533.3 2546.6 2547.6 2131.3 2522.3 2532.2 2547.6 2572.7 2474.7 2508.2 2526.2 2537.1 2581.8 9132.3 9285.4 9306.3 9340.1 9353.3 5667.5 5737.8 5829.1 5856.9 5873.3 3691.9 3736.6 3761.2 3782.8 3828.1 1037.6 1046.3 1047.8 1054.1 1054.5 11335.1 11738.5 12559.5 12596.4 12646.6 5053.3 5069.7 5114.0 5168.3 5193.3 10513.2 10593.4 10597.4 10601.8 10644.6 5717.6 5719.9 5750.2 5778.9 5820.4 3943.0 5001.9 5076.8 5177.0 5191.8 4065.7 4078.7 4088.6 4128.1 4161.8 1365.6 1367.5 1369.1 1371.7 1381.3 1389.6 1404.2 1422.6 1436.8 1465.7 8336.2 8428.2 8453.8 8478.4 8515.7 533.0 544.5 544.7 545.2 549.6 6276.0 6309.8 6311.5 6371.9 6382.7 10943.6 11244.0 11377.4 11405.3 11412.1 10747.6 11013.0 11036.1 11118.5 11182.2 8622.0 8746.3 8819.6 8845.4 8895.7 8018.0 8080.1 8157.9 8231.9 8242.0 9552.6 9819.4 9855.6 9955.9 10081.7 10067.6 10249.7 10296.3 10354.5 10371.0 7064.9 7249.9 7447.0 7632.8 7769.8 7959.8 8089.8 8107.5 8131.8 8139.2 7100.0 7255.7 7285.9 7347.2 7392.4 7137.1 7182.6 7276.6 7471.8 7559.7 7838.2 7951.1 7958.5 7971.0 8017.0 7090.1 7156.3 7198.1 7228.6 7264.2 6427.0 6761.5 7007.0 7347.0 7401.6 04:07:39 INFO - PROCESS | 1967 | 04:07:39 INFO - PROCESS | 1967 | [#4] prototype.html Cycles:180 Average:5778.59 Median:6591.59 stddev:1859.84 (28.2%) stddev-sans-first:1819.56 04:07:39 INFO - PROCESS | 1967 | Values: 330.9 339.8 340.2 342.7 348.1 6614.9 6661.2 6674.9 6702.9 6703.1 5094.9 5235.7 6598.7 6620.6 6631.7 4102.0 4576.8 4760.8 4932.9 4941.3 3940.8 4884.1 4907.2 4917.2 4922.9 4848.5 4855.3 4880.4 4883.4 4904.5 4194.3 4694.8 4874.5 4883.0 4887.3 4241.7 4244.2 4253.9 4259.3 4261.0 5066.8 6035.7 6285.8 6323.6 6344.8 5693.9 5772.5 5796.7 5804.9 5839.9 7147.0 7162.2 7164.6 7169.5 7197.7 4635.7 4664.9 4665.3 4674.4 4689.6 7502.2 7541.8 7559.2 7569.7 7594.5 4403.8 4544.9 4609.9 4679.6 4684.6 4751.3 4773.3 4775.5 4780.0 4827.1 5746.4 5750.3 5773.5 5780.9 5792.2 7115.7 7119.7 7128.6 7134.0 7141.1 1635.6 1656.7 1660.6 1665.5 1667.9 1037.7 1059.8 1064.0 1067.1 1086.9 6553.2 6588.4 6598.0 6606.3 6608.1 7371.3 7388.4 7408.6 7416.4 7428.7 6594.8 6610.9 6617.4 6618.9 6649.8 3759.3 3884.4 3884.7 3911.0 3931.3 6487.0 7405.0 7686.8 7703.2 7786.0 6523.2 7695.5 7723.0 7736.3 7766.0 7662.3 7698.3 7723.5 7725.4 7735.1 7073.6 7428.9 7430.1 7441.8 7448.8 7200.6 7248.8 7262.9 7286.6 7300.7 6806.0 7140.7 7704.6 7746.8 7765.5 4642.8 4686.0 4687.4 4699.7 4725.0 7173.9 7411.3 7424.4 7443.7 7468.5 5662.8 7152.4 7158.7 7165.7 7169.1 7048.4 7125.6 7136.6 7154.1 7176.2 6025.1 6518.4 6978.9 6994.4 7008.9 6882.6 7166.5 7183.2 7189.6 7222.3 5838.1 6433.6 6606.9 6832.2 7070.6 04:07:39 INFO - PROCESS | 1967 | 04:07:39 INFO - PROCESS | 1967 | [#5] yui.html Cycles:180 Average:19019.23 Median:4225.92 stddev:26646.04 (630.5%) stddev-sans-first:26685.09 04:07:39 INFO - PROCESS | 1967 | Values: 650.4 688.0 707.3 745.4 786.4 15053.4 15345.6 15583.5 15584.4 15603.0 14862.1 14878.2 14913.9 14954.1 14959.6 790.8 946.9 973.8 975.2 983.3 972.1 972.6 973.2 973.6 976.3 1006.4 1020.6 1028.8 1028.9 1030.4 1018.6 1024.5 1024.6 1024.7 1027.2 760.4 769.5 774.5 775.1 775.2 12938.9 15309.0 15319.8 15492.6 15679.8 13412.2 13446.0 13479.5 13566.5 13588.3 10345.4 10398.5 10419.6 10449.2 10529.5 3599.0 3607.8 3612.1 3635.1 3637.6 65636.7 83023.0 83323.2 83516.6 83905.0 9934.0 9974.7 9996.9 10018.5 10108.3 23645.8 23782.0 23856.6 23879.6 23946.0 7742.3 7757.1 7791.2 7810.7 7896.1 4135.8 4141.8 4209.7 4257.2 4303.7 3648.2 3654.2 3677.0 3689.4 3715.1 572.4 647.5 648.3 650.9 662.2 613.2 613.4 614.9 628.8 636.0 8413.4 8434.0 8763.3 8872.8 9145.2 524.9 580.3 593.4 619.7 637.5 3922.6 4071.1 4116.7 4126.5 4242.1 93430.6 93905.0 95298.5 97444.0 99796.0 61758.7 68350.6 86825.0 87450.6 88273.0 58670.7 74963.9 75652.0 75704.2 77004.6 7794.0 8076.8 8782.0 8932.5 9057.5 52364.5 52828.0 52880.7 55132.7 55362.2 71563.0 72652.6 74260.6 74341.3 77923.8 11205.1 11246.5 11344.5 11736.1 11737.8 11973.0 12040.2 12074.8 12267.8 13070.6 11749.8 11835.2 11880.8 11953.1 11958.6 11602.4 11934.5 11958.7 12085.8 12248.8 11403.0 11537.2 11772.4 11787.2 11917.8 7969.6 9834.9 10066.1 10132.7 10259.5 9815.9 10134.9 10158.4 10269.7 10281.4 04:07:39 INFO - PROCESS | 1967 | -------- Summary: end -------- 04:07:39 INFO - PROCESS | 1967 | 04:07:40 INFO - TEST-INFO | 1967: exit 0 04:07:40 INFO - TEST-OK | dromaeo_css | took 1110856ms 04:07:40 INFO - TEST-START | kraken 04:07:40 INFO - operating with platform_type : mac_ 04:07:40 INFO - Initialising browser for kraken test... 04:07:40 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpoozell/profile http://localhost:52289/getInfo.html) 04:07:42 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 04:07:42 INFO - PROCESS | 1977 | colorDepth:24 04:07:42 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 04:07:42 INFO - PROCESS | 1977 | __metrics 04:07:43 ERROR - PROCESS | 1977 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:07:43 INFO - TEST-INFO | 1977: exit 0 04:07:43 INFO - Browser initialized. 04:07:43 INFO - Running cycle 1/1 for kraken test... 04:07:43 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpoozell/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:55 INFO - PROCESS | 1980 | RSS: Main: 218333184 04:07:55 INFO - PROCESS | 1980 | 04:07:58 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52289/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:58 INFO - PROCESS | 1980 | RSS: Main: 230285312 04:07:58 INFO - PROCESS | 1980 | 04:08:01 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52289/tests/kraken/driver.html?testName=audio-dft) 04:08:02 INFO - PROCESS | 1980 | RSS: Main: 239603712 04:08:02 INFO - PROCESS | 1980 | 04:08:05 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52289/tests/kraken/driver.html?testName=audio-fft) 04:08:06 INFO - PROCESS | 1980 | RSS: Main: 242708480 04:08:06 INFO - PROCESS | 1980 | 04:08:08 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52289/tests/kraken/driver.html?testName=audio-oscillator) 04:08:08 INFO - PROCESS | 1980 | RSS: Main: 243273728 04:08:08 INFO - PROCESS | 1980 | 04:08:10 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52289/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:11 INFO - PROCESS | 1980 | RSS: Main: 243482624 04:08:11 INFO - PROCESS | 1980 | 04:08:14 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52289/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:14 INFO - PROCESS | 1980 | RSS: Main: 243556352 04:08:14 INFO - PROCESS | 1980 | 04:08:17 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52289/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:18 INFO - PROCESS | 1980 | RSS: Main: 243437568 04:08:18 INFO - PROCESS | 1980 | 04:08:20 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52289/tests/kraken/driver.html?testName=json-parse-financial) 04:08:21 INFO - PROCESS | 1980 | RSS: Main: 244756480 04:08:21 INFO - PROCESS | 1980 | 04:08:23 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52289/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:23 INFO - PROCESS | 1980 | RSS: Main: 244727808 04:08:23 INFO - PROCESS | 1980 | 04:08:25 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52289/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:26 INFO - PROCESS | 1980 | RSS: Main: 245342208 04:08:26 INFO - PROCESS | 1980 | 04:08:28 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52289/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:28 INFO - PROCESS | 1980 | RSS: Main: 245592064 04:08:28 INFO - PROCESS | 1980 | 04:08:31 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52289/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:32 INFO - PROCESS | 1980 | RSS: Main: 245075968 04:08:32 INFO - PROCESS | 1980 | 04:08:34 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52289/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:35 INFO - PROCESS | 1980 | RSS: Main: 245219328 04:08:35 INFO - PROCESS | 1980 | 04:08:36 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:52289/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52289/tests/kraken/driver.html?testName=ai-astar) 04:08:37 INFO - PROCESS | 1980 | RSS: Main: 246812672 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | __start_tp_report 04:08:37 INFO - PROCESS | 1980 | _x_x_mozilla_page_load 04:08:37 INFO - PROCESS | 1980 | _x_x_mozilla_page_load_details 04:08:37 INFO - PROCESS | 1980 | |i|pagename|runs| 04:08:37 INFO - PROCESS | 1980 | |0;ai-astar;117;110;115;113;116;130;115;115;103;165 04:08:37 INFO - PROCESS | 1980 | |1;audio-beat-detection;177;151;162;144;120;138;118;148;146;121 04:08:37 INFO - PROCESS | 1980 | |2;audio-dft;193;197;197;201;196;234;274;242;196;194 04:08:37 INFO - PROCESS | 1980 | |3;audio-fft;67;68;72;112;81;82;83;89;135;56 04:08:37 INFO - PROCESS | 1980 | |4;audio-oscillator;83;78;123;78;77;81;118;78;79;117 04:08:37 INFO - PROCESS | 1980 | |5;imaging-gaussian-blur;91;90;104;128;92;89;92;94;76;126 04:08:37 INFO - PROCESS | 1980 | |6;imaging-darkroom;95;97;96;96;97;95;94;96;93;136 04:08:37 INFO - PROCESS | 1980 | |7;imaging-desaturate;90;92;89;92;93;90;119;147;86;144 04:08:37 INFO - PROCESS | 1980 | |8;json-parse-financial;54;60;59;59;57;60;60;68;56;55 04:08:37 INFO - PROCESS | 1980 | |9;json-stringify-tinderbox;64;65;78;101;77;64;74;65;65;75 04:08:37 INFO - PROCESS | 1980 | |10;stanford-crypto-aes;84;82;81;82;82;82;80;81;80;78 04:08:37 INFO - PROCESS | 1980 | |11;stanford-crypto-ccm;130;138;131;107;138;136;129;136;122;136 04:08:37 INFO - PROCESS | 1980 | |12;stanford-crypto-pbkdf2;137;135;136;136;153;172;141;133;138;123 04:08:37 INFO - PROCESS | 1980 | |13;stanford-crypto-sha256-iterative;67;66;68;67;65;61;66;69;70;64 04:08:37 INFO - PROCESS | 1980 | __end_tp_report 04:08:37 INFO - PROCESS | 1980 | __start_cc_report 04:08:37 INFO - PROCESS | 1980 | _x_x_mozilla_cycle_collect,946 04:08:37 INFO - PROCESS | 1980 | __end_cc_report 04:08:37 INFO - PROCESS | 1980 | __startTimestamp1461755317095__endTimestamp 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | ------- Summary: start ------- 04:08:37 INFO - PROCESS | 1980 | Number of tests: 14 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#0] ai-astar Cycles:10 Average:119.90 Median:115.50 stddev:17.20 (14.9%) stddev-sans-first:18.21 04:08:37 INFO - PROCESS | 1980 | Values: 117.0 110.0 115.0 113.0 116.0 130.0 115.0 115.0 103.0 165.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:147.00 stddev:19.08 (13.0%) stddev-sans-first:15.63 04:08:37 INFO - PROCESS | 1980 | Values: 177.0 151.0 162.0 144.0 120.0 138.0 118.0 148.0 146.0 121.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#2] audio-dft Cycles:10 Average:212.40 Median:199.00 stddev:27.88 (14.0%) stddev-sans-first:28.67 04:08:37 INFO - PROCESS | 1980 | Values: 193.0 197.0 197.0 201.0 196.0 234.0 274.0 242.0 196.0 194.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.50 stddev:23.32 (30.5%) stddev-sans-first:23.86 04:08:37 INFO - PROCESS | 1980 | Values: 67.0 68.0 72.0 112.0 81.0 82.0 83.0 89.0 135.0 56.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:78.00 stddev:19.55 (25.1%) stddev-sans-first:20.51 04:08:37 INFO - PROCESS | 1980 | Values: 83.0 78.0 123.0 78.0 77.0 81.0 118.0 78.0 79.0 117.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#5] imaging-gaussian-blur Cycles:10 Average:98.20 Median:90.50 stddev:16.62 (18.4%) stddev-sans-first:17.42 04:08:37 INFO - PROCESS | 1980 | Values: 91.0 90.0 104.0 128.0 92.0 89.0 92.0 94.0 76.0 126.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:96.00 stddev:12.89 (13.4%) stddev-sans-first:13.56 04:08:37 INFO - PROCESS | 1980 | Values: 95.0 97.0 96.0 96.0 97.0 95.0 94.0 96.0 93.0 136.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#7] imaging-desaturate Cycles:10 Average:104.20 Median:90.00 stddev:23.63 (26.3%) stddev-sans-first:24.49 04:08:37 INFO - PROCESS | 1980 | Values: 90.0 92.0 89.0 92.0 93.0 90.0 119.0 147.0 86.0 144.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.50 stddev:3.91 (6.6%) stddev-sans-first:3.74 04:08:37 INFO - PROCESS | 1980 | Values: 54.0 60.0 59.0 59.0 57.0 60.0 60.0 68.0 56.0 55.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:69.50 stddev:11.47 (16.5%) stddev-sans-first:11.71 04:08:37 INFO - PROCESS | 1980 | Values: 64.0 65.0 78.0 101.0 77.0 64.0 74.0 65.0 65.0 75.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:82.00 stddev:1.62 (2.0%) stddev-sans-first:1.36 04:08:37 INFO - PROCESS | 1980 | Values: 84.0 82.0 81.0 82.0 82.0 82.0 80.0 81.0 80.0 78.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:136.00 stddev:9.60 (7.1%) stddev-sans-first:10.19 04:08:37 INFO - PROCESS | 1980 | Values: 130.0 138.0 131.0 107.0 138.0 136.0 129.0 136.0 122.0 136.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.40 Median:137.50 stddev:13.33 (9.7%) stddev-sans-first:14.09 04:08:37 INFO - PROCESS | 1980 | Values: 137.0 135.0 136.0 136.0 153.0 172.0 141.0 133.0 138.0 123.0 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - PROCESS | 1980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:2.58 (3.9%) stddev-sans-first:2.73 04:08:37 INFO - PROCESS | 1980 | Values: 67.0 66.0 68.0 67.0 65.0 61.0 66.0 69.0 70.0 64.0 04:08:37 INFO - PROCESS | 1980 | -------- Summary: end -------- 04:08:37 INFO - PROCESS | 1980 | 04:08:37 INFO - TEST-INFO | 1980: exit 0 04:08:37 INFO - TEST-OK | kraken | took 57686ms 04:08:37 INFO - SUITE-END | took 1168s 04:08:38 INFO - Completed test suite (00:19:28) 04:08:38 INFO - javascript benchmark 04:08:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3505.6669616386444, 3578.8747393841213, 3592.497050412941, 3593.8499680102364, 3610.963890361097, 5883.441073098049, 5989.101634754789, 5996.340402555716, 6007.339192688801, 6019.488343490798, 5132.922086361868, 5139.383274007115, 5214.139666954948, 6020.0367941129425, 6047.395260473951, 4764.35681183041, 5312.548433383147, 5370.248165256867, 5378.78484860607, 5401.675899446026, 4566.817327306904, 5226.895462090756, 5248.737563121828, 5377.381601115863, 5400.135978243482, 5340.172273297626, 5346.705931173784, 5367.0, 5370.301860758096, 5414.0, 4787.257975013878, 5135.024345374404, 5309.575233981292, 5377.569794416438, 5406.135018397038, 5268.209768534751, 5350.785968561253, 5354.303940487751, 5379.784808607651, 5394.298741163623, 5783.479486846204, 5939.0, 5962.105684147369, 5982.551308651869, 6037.63774173551, 6117.766507567588, 6180.351063138351, 6230.06549017651, 6247.750089996394, 6251.937480625181, 6296.401841825019, 6305.558610897239, 6306.873862522724, 6308.968455157741, 6311.116443697886, 5913.852153696149, 6030.095485677183, 6079.05774604937, 6087.847803804896, 6089.725962331706, 6465.903011454832, 6490.513211509156, 6497.382748638872, 6499.992501162327, 6501.512386571026, 6216.7824126155365, 6245.781397651152, 6249.187605611241, 6264.655443950626, 6280.528960327993, 6195.566310358322, 6291.559590828598, 6310.747570097236, 6320.367963203643, 6336.366363363627, 6161.383861613893, 6177.722002509898, 6221.9377806222265, 6226.6575338355915, 6235.657038862815, 6171.321154672983, 6181.072839074175, 6201.627902325875, 6222.782202622887, 6238.719257633417, 4941.530554597308, 5001.924971125436, 5042.344495215599, 5076.035553244872, 5083.440821509631, 3821.2739579479808, 4513.255312873339, 4521.186186486464, 4555.339475775994, 4567.794449249792, 5801.0, 6011.1884895539415, 6040.667763272974, 6042.637441753509, 6050.2437195350585, 6190.535709821781, 6270.811875643647, 6280.120783090371, 6283.0, 6335.936640633535, 6022.69886505673, 6040.36576159497, 6040.546958978094, 6044.546659000593, 6055.333913269536, 5552.250446189793, 5560.388357280696, 5560.582956278296, 5565.666060036411, 5568.220449137124, 6320.399562041599, 6400.55196136266, 6454.096426500388, 6489.5781774184525, 6499.415052645285, 6345.777897773556, 6354.936450635434, 6358.554901156875, 6362.840928976812, 6383.265924418752, 6321.683915804099, 6476.12572302752, 6525.0, 6541.0188471729625, 6553.574017688835, 5271.314729085195, 6190.133381326528, 6218.81343559694, 6264.561480696308, 6282.811515654537, 6265.8120256392385, 6304.936950630435, 6306.117143599808, 6314.494840412664, 6322.778702745381, 5685.715714214355, 5776.815752770588, 6049.032154855202, 6139.185504090546, 6240.875182496416, 6135.630783975068, 6162.383761623981, 6168.19813424252, 6193.163922870535, 6236.968815155895, 5696.8006119785605, 6157.722902469489, 6210.472109870711, 6227.1282020516255, 6231.2522497300615, 5923.289205295392, 6098.115773212948, 6120.2947619997085, 6170.753169873335, 6206.937930620817, 6069.575129740876, 6182.721777519932, 6194.566380353513, 6206.441420272197, 6212.4408803207925], "unit": "score", "name": "dojo.html", "value": 5801.8826879428225}, {"lowerIsBetter": false, "replicates": [570.9172170035345, 624.9062640603906, 674.9493787965903, 680.8357708318774, 695.782380833541, 36997.630023699756, 38894.61105388945, 38943.80528097359, 39171.0, 39256.60743392565, 40640.187196256134, 40689.38965915514, 41093.58906410935, 41108.58891411085, 41218.7939060305, 9517.904820951771, 9695.757606059835, 9727.90272097277, 9775.022497750204, 9789.02109789019, 8862.24670902974, 9573.904260957406, 9768.755781105458, 9792.16766574842, 9811.411315321067, 9772.0, 9853.852192217122, 9858.507074646239, 9862.852057219148, 9865.556049977768, 9788.510574471284, 9810.0, 9815.06756858101, 9824.852627210597, 9855.408675479459, 9534.284928630312, 9589.664361747375, 9668.0, 9679.225661947028, 9689.176420004309, 34622.0, 40074.198516029515, 40491.987700307436, 40639.0, 40639.984000399934, 3257.6090869095624, 3464.0473869685784, 3469.6703813137965, 3499.3526197653514, 3930.3711406174875, 28007.0197543085, 28069.438611227662, 28332.716672833212, 28372.574411383845, 28577.0, 2758.4207316463567, 2771.5704065869822, 2817.1548535439288, 2822.4919514487383, 2833.0367674990603, 271913.0, 316145.0, 319519.0, 320292.39853800816, 321982.0, 55105.0, 65053.0, 65568.0, 65613.67193164004, 65676.67161664256, 75544.24455755482, 75996.0, 76279.0, 76519.61740191263, 77378.4524309522, 15142.54572362831, 15153.924230378998, 18342.908285458754, 18446.446606601825, 18579.814201857807, 13751.106178098391, 13956.09285396446, 14030.158190508602, 14055.156690598596, 14066.578002659937, 22195.889020555118, 22447.0, 22625.660615090786, 22641.2075577354, 23141.84290785454, 9352.532373381304, 9557.569909354095, 9612.423254604746, 9625.71122866315, 9625.855612165824, 1014.5688082564881, 1084.8969347912093, 1092.546593163844, 1122.9157813163881, 1165.8659254185707, 30522.54216186759, 30641.69358306433, 30861.84318626555, 30908.0, 31098.84450577778, 1034.4724190662816, 1052.678932925465, 1066.4561073852392, 1092.039005675001, 1113.8886111388797, 13803.51687690926, 13999.440022399194, 15445.691086178214, 15468.613284667974, 15634.296456659478, 515600.0, 519270.0, 523216.0, 523259.0, 524022.3798880981, 60500.39499605036, 60718.69640651769, 60892.0, 60945.0, 61042.38957610456, 1322.7566087877365, 1506.0963421946963, 1538.8845836562302, 1543.5446543269538, 1556.8053993250844, 23662.763372366055, 29959.251018723833, 30237.0, 30834.845825770728, 30903.845480772452, 47744.522554774005, 54305.0, 59344.0, 59568.404315956286, 59738.70130649319, 419567.0, 423905.0, 424048.0, 428456.0, 429452.0, 41926.861623140765, 42426.1514769709, 43250.78374608107, 43573.346399804665, 43971.0, 44434.33348499711, 48373.75813120912, 48405.0, 49172.770680733265, 49179.26231106608, 39016.41475377815, 39732.404013940395, 40140.0, 40177.0, 41543.58456415518, 29850.85074574613, 35950.64049359473, 39406.802965984985, 39933.00167495836, 40667.7966610165, 37490.62509374871, 38689.0, 40225.396619051324, 40992.0, 41158.588414115475, 27287.59068614012, 31132.688673113884, 33476.665233347354, 34363.65636343604, 34413.0, 21771.673424898956, 25752.356191095372, 26159.0, 26247.21258362252, 26597.0], "unit": "score", "name": "ext.html", "value": 20371.444862844728}, {"lowerIsBetter": false, "replicates": [377.74313466842534, 382.6747264824899, 384.87491565241294, 388.828915277278, 390.32668646584625, 19656.21375144994, 20463.0, 20941.581168376622, 21069.367918962438, 21248.787512124873, 11932.463039163236, 12398.0, 20738.859362735042, 20994.89502552485, 21041.684374734392, 4834.0, 5360.812371566996, 5485.259489968863, 5537.0, 5559.388467268597, 4135.255653982282, 5836.445537673914, 6009.06859436788, 6082.118092876531, 6082.1180928765525, 5977.671228082454, 6048.123022161784, 6056.666883321415, 6074.362191969846, 6102.664353460558, 6554.049662798891, 6560.278369379364, 6571.835704107388, 6579.374959378852, 6591.307912669148, 5677.40387259336, 5711.228984087136, 5831.504322132624, 5839.211706419622, 5892.941070589282, 26134.0, 26201.73798262031, 26693.332666683487, 26718.33204169892, 26909.865450672816, 1802.531341851115, 2180.3458962311242, 2205.9669104963436, 2229.4649284171846, 2269.4326418395403, 9824.607015719363, 10800.621978230723, 13975.09161904473, 15346.002509836937, 15429.614259643486, 1652.4133932453926, 1692.815029479357, 1827.0864567716142, 1874.71879218117, 1876.3714155757837, 107798.0, 108069.37895931567, 112792.43603782011, 114799.0, 118161.0, 11674.299542027506, 11738.94130529342, 11809.940950295366, 11827.940860295643, 11828.0, 14602.050866693631, 14694.971352005257, 14741.41034358635, 14744.0, 14787.704245915236, 8930.598123084477, 9054.185123338932, 9056.320775941831, 9061.54692265384, 9079.954600227089, 9134.680286189952, 9189.218916392181, 9220.5850736717, 9279.304052196112, 9307.674231401868, 3960.2475529649273, 4431.113777244564, 4566.908661826745, 4647.279671650899, 4652.674312798072, 1839.1700258242865, 1914.985057919305, 1954.7263383126374, 1977.5550501137416, 2028.9188432462831, 965.5510187762584, 965.6909788867636, 981.288565789811, 985.3447457440722, 1049.9422531760827, 17016.91491542559, 21022.579548408947, 21361.35915922525, 21992.89003554972, 22433.887830560743, 838.4508147163617, 1029.4492446541215, 1034.6378767431338, 1042.702829693549, 1053.3416614615865, 11350.09199264057, 11597.594084207012, 11632.825507617392, 11655.184137110491, 11723.824142637868, 638641.0, 645186.0, 645427.0, 655374.0, 659589.0, 102862.0, 130879.0, 131270.34364828115, 131281.34359328143, 131839.0, 912.7170577121113, 1001.5242759689235, 1058.872935247775, 1127.0476447401932, 1127.937963412004, 16746.748798767785, 17228.483145505656, 18998.525036873634, 19461.026948652227, 19781.010949452757, 45894.541054590365, 55843.441565583824, 55879.99999999837, 57346.139807903746, 58080.70959645175, 71879.20301992283, 76676.61661691879, 85076.14923850683, 85384.14615853762, 85451.57274213589, 7551.848963020819, 8249.463784853966, 8374.911261536205, 8456.788580285296, 8546.23083922425, 11955.64133076009, 13247.403866825824, 13477.595672129852, 13500.054996150175, 13707.588772336845, 11602.303861768321, 11704.824427633423, 11886.465109069939, 11914.10644201671, 11962.76074478523, 11253.549858005916, 11379.260348077349, 11439.08487321029, 11616.883831161918, 11685.883141168479, 10380.844287335847, 11852.940735296268, 11934.940325298317, 12108.455119519467, 12237.75524489523, 8140.877886831584, 8312.977976252945, 8359.247667709935, 8466.026406963032, 8771.210591046836, 10739.785204296026, 11676.88323116758, 11698.0, 11853.762924741284, 11855.0], "unit": "score", "name": "jquery.html", "value": 9808.208320904145}, {"lowerIsBetter": false, "replicates": [1639.721247387944, 1678.0854434333287, 2019.1216820683003, 2041.540653352995, 2106.062802053085, 8362.996440427158, 8975.147361000694, 9140.862887056699, 9326.72019839405, 9337.25301975842, 8989.190972812445, 9028.458292502455, 9131.99548049714, 9136.90863091369, 9151.633934642607, 2542.186500319903, 2555.3739333863227, 2556.27146263315, 2563.628273900283, 2572.006694811527, 2236.7250667119747, 2261.649444336122, 2489.4647650755173, 2491.9252422427357, 2501.7248102708686, 2162.7512836023902, 2525.2676723750183, 2533.2526904563106, 2546.5925451927696, 2547.5796493578537, 2131.2540610786255, 2522.2811498722867, 2532.1643857526974, 2547.5669136246884, 2572.742725727431, 2474.715407728116, 2508.234988328559, 2526.166365099513, 2537.099329737953, 2581.7547333003336, 9132.315076369232, 9285.396449230846, 9306.348555601111, 9340.112689294507, 9353.251739860794, 5667.518260947824, 5737.770489180428, 5829.125631155318, 5856.853578660568, 5873.324567674729, 3691.907702307437, 3736.645018723217, 3761.22894806564, 3782.7541209821275, 3828.0812604974885, 1037.5797801890246, 1046.2937517175876, 1047.8218702820539, 1054.1040115901499, 1054.4727636181908, 11335.093192544658, 11738.471768770425, 12559.497620095186, 12596.433160507799, 12646.557370491988, 5053.317802096743, 5069.670471419419, 5114.002769459919, 5168.302279192336, 5193.324867767166, 10513.211509136845, 10593.364398135982, 10597.364158150536, 10601.787964240671, 10644.627438039632, 5717.599768016199, 5719.8570035749435, 5750.1949727038245, 5778.855528611818, 5820.35976042635, 3942.9802850986134, 5001.924971125436, 5076.796928122908, 5177.0, 5191.8182863599595, 4065.715399921977, 4078.653314468244, 4088.5707000765087, 4128.1330920506425, 4161.812718427678, 1365.590322903125, 1367.453018792471, 1369.0621923982103, 1371.6502291915497, 1381.302442266649, 1389.6178550898383, 1404.248726931087, 1422.566117334223, 1436.8203974503188, 1465.6848777512887, 8336.208060234268, 8428.241458268785, 8453.788655283544, 8478.364122690822, 8515.74452766418, 532.9760160792696, 544.4637032522962, 544.6840832317325, 545.2148905575958, 549.574080087935, 6276.0, 6309.842253943688, 6311.495080393557, 6371.936280637227, 6382.680865956683, 10943.56225750977, 11244.044256238149, 11377.43112844371, 11405.258658187191, 11412.144089193343, 10747.570097196181, 11013.0, 11036.11711063113, 11118.499667514981, 11182.217244792786, 8622.0, 8746.256568191648, 8819.559022049, 8845.42504737203, 8895.688650897187, 8018.0, 8080.070791858776, 8157.8776318354085, 8231.876521852057, 8242.0, 9552.57013434411, 9819.36174148678, 9855.605775768889, 9955.850662240216, 10081.69754907354, 10067.597296108073, 10249.692509224735, 10296.279260451696, 10354.5340459678, 10371.014753598396, 7064.929350706633, 7249.891251631124, 7446.962765186356, 7632.80917977055, 7769.805754856174, 7959.801004974922, 8089.757307280791, 8107.513549187068, 8131.7967050821835, 8139.226773456512, 7099.964500177673, 7255.709771609077, 7285.890711639224, 7347.228541003117, 7392.445566582635, 7137.10786151731, 7182.604956727221, 7276.636168191463, 7471.775846724607, 7559.659815308214, 7838.216178382117, 7951.125376208497, 7958.522488650699, 7970.960145199237, 8016.997875265592, 7090.07828982229, 7156.284371562802, 7198.100237470317, 7228.566286022856, 7264.200937896721, 6427.003814408774, 6761.526693131434, 7007.0, 7347.0, 7401.555906645403], "unit": "score", "name": "mootools.html", "value": 5007.987184021099}, {"lowerIsBetter": false, "replicates": [330.9073459431359, 339.76725942729234, 340.168288534533, 342.65563109075407, 348.07238708840924, 6614.900776488351, 6661.16735408074, 6674.86650266995, 6702.899456508157, 6703.128593282872, 5094.898102037957, 5235.685858848472, 6598.736050557972, 6620.602763834161, 6631.701573429195, 4101.954001729562, 4576.794044267999, 4760.8333708320215, 4932.8520144395725, 4941.283513890484, 3940.783256920868, 4884.096442158194, 4907.2393778964315, 4917.164082106051, 4922.852314430573, 4848.490908454614, 4855.295982082596, 4880.389951256093, 4883.365162528867, 4904.5340692634145, 4194.3498757692605, 4694.812207511695, 4874.463808981027, 4883.0, 4887.3402090717655, 4241.660667146621, 4244.236037513247, 4253.851115210984, 4259.297215959363, 4261.0, 5066.82266120684, 6035.698215089228, 6285.842853928642, 6323.588966717149, 6344.809655710336, 5693.943060569424, 5772.509336706343, 5796.739146738407, 5804.912926306109, 5839.9124013139835, 7146.964265178693, 7162.247963963813, 7164.605946672931, 7169.498135130543, 7197.676104575306, 4635.745034023127, 4664.883377915546, 4665.276882083249, 4674.439067311944, 4689.554492323224, 7502.249775022508, 7541.8114547135665, 7559.244075592452, 7569.659365328574, 7594.468387212897, 4403.757793321334, 4544.931826022612, 4609.907801843944, 4679.578837904605, 4684.625229981593, 4751.263554149113, 4773.284007398848, 4775.450823155312, 4779.972305954237, 4827.131116399011, 5746.396628354046, 5750.30996280449, 5773.451522105393, 5780.88438231233, 5792.247007889032, 7115.679794409264, 7119.715211391486, 7128.607926564089, 7133.964330178316, 7141.071660684078, 1635.582926353772, 1656.7017936771256, 1660.609756707173, 1665.533650577816, 1667.933282668704, 1037.6886933919793, 1059.7721489879714, 1064.0423618743039, 1067.0983019348637, 1086.8858769829212, 6553.180852393451, 6588.40704336612, 6598.0, 6606.306337834458, 6608.140941677551, 7371.262873712586, 7388.445866559922, 7408.592527410937, 7416.443766717518, 7428.702851885864, 6594.769183078569, 6610.933890661128, 6617.371349721769, 6618.86762264752, 6649.833754156088, 3759.342115129841, 3884.436756670267, 3884.6503814656817, 3910.9608903911167, 3931.331673615492, 6487.0269459580495, 7405.037345145097, 7686.846263074707, 7703.1911649277135, 7786.026746656668, 6523.18460192476, 7695.461317707706, 7723.0, 7736.342410895137, 7765.961170194113, 7662.310392064741, 7698.345640620386, 7723.497972631761, 7725.381969442431, 7735.1491335953, 7073.575585464889, 7428.851422971402, 7430.071241094864, 7441.8139546511775, 7448.776536703907, 7200.567965922061, 7248.818779530554, 7262.876962906001, 7286.599237042014, 7300.671469783979, 6805.9659701701175, 7140.714371425085, 7704.576248306397, 7746.845063098819, 7765.53406795594, 4642.767861606839, 4685.99251161002, 4687.437507499122, 4699.741514216614, 4725.0, 7173.928260717326, 7411.295926886937, 7424.443166762622, 7443.734565123834, 7468.5145465544565, 5662.7734890603915, 7152.427805775422, 7158.749443769443, 7165.713371465083, 7169.068021157216, 7048.436125109876, 7125.608091554807, 7136.607486588287, 7154.105736782903, 7176.174739904769, 6025.096235564701, 6518.413342799171, 6978.860422791618, 6994.370506654425, 7008.859822803617, 6882.552634078769, 7166.498345116001, 7183.245759195418, 7189.568625882254, 7222.349988501061, 5838.065909454467, 6433.581817181868, 6606.942889137715, 6832.214295355899, 7070.575765454089], "unit": "score", "name": "prototype.html", "value": 5163.705787343326}, {"lowerIsBetter": false, "replicates": [650.4276236911517, 687.9931200687995, 707.2891743797485, 745.355267693445, 786.3826895886726, 15053.397864085451, 15345.616359591017, 15583.454579089734, 15584.376624935017, 15602.985805922606, 14862.108273503598, 14878.181700006522, 14913.92543037286, 14954.102753834777, 14959.626009349771, 790.8497385496737, 946.8579713043047, 973.7614284500272, 975.2246963663869, 983.2871168402922, 972.0765272990652, 972.610955617755, 973.2408721197477, 973.6397532912797, 976.3360914578084, 1006.3659894266639, 1020.607066279484, 1028.8096702110097, 1028.93311934724, 1030.3817709374352, 1018.5620183321168, 1024.549198352726, 1024.605526872152, 1024.7284469615558, 1027.2090490322485, 760.4106817216646, 769.4690663442207, 774.5430196184278, 775.0931410249965, 775.1899265267808, 12938.87061129386, 15309.0, 15319.846801531954, 15492.612684682861, 15679.843201567952, 13412.195268283935, 13446.0, 13479.460821567125, 13566.525171618947, 13588.320583970763, 10345.431001294926, 10398.480075996245, 10419.583216671324, 10449.164066874631, 10529.526171322232, 3599.0, 3607.765495242827, 3612.060864175307, 3635.054885729703, 3637.613924586786, 65636.6872662544, 83023.0, 83323.16676833275, 83516.58241708753, 83905.0, 9934.0, 9974.700758977242, 9996.900030999597, 10018.499075046218, 10108.29241953071, 23645.7635423647, 23782.0, 23856.64215036776, 23879.641805372932, 23946.0, 7742.341900938371, 7757.146713861471, 7791.220877912277, 7810.687572497037, 7896.131425543185, 4135.751854888656, 4141.8436887734, 4209.705320627527, 4257.212415703105, 4303.655707543389, 3648.21563363878, 3654.2326111516877, 3676.9888280723017, 3689.4281386385155, 3715.071232191952, 572.4418691775569, 647.5143642268299, 648.2933602373436, 650.9023646452976, 662.2417332154656, 613.2120225510198, 613.414189449084, 614.8739508400768, 628.8270725550419, 636.0491065856575, 8413.411061225655, 8434.0, 8763.25512331459, 8872.822543549093, 9145.222656074307, 524.9474803019921, 580.2862479150668, 593.3858456497504, 619.6994457688018, 637.4581605635173, 3922.646961773454, 4071.063655359225, 4116.732412393185, 4126.484189476316, 4242.130363275521, 93430.59854102194, 93905.0, 95298.52350738202, 97444.0, 99796.00203997867, 61758.69120654368, 68350.63298734097, 86825.0, 87450.56274718586, 88273.0, 58670.7066464665, 74963.87554186692, 75652.0, 75704.24295757082, 77004.61497692476, 7793.98678171834, 8076.798080048045, 8781.990071141901, 8932.46405215689, 9057.456552606865, 52364.47635523596, 52828.0, 52880.73559632177, 55132.72433637806, 55362.16956745571, 71563.0, 72652.63673681598, 74260.62869685618, 74341.25658743344, 77923.83114253178, 11205.103591712481, 11246.493907774333, 11344.546218151181, 11736.0611151106, 11737.823932640846, 11973.0, 12040.157188996685, 12074.818877717016, 12267.815982760445, 13070.607881763563, 11749.823752643546, 11835.230710003822, 11880.76238475243, 11953.103517236068, 11958.58144964922, 11602.419879006186, 11934.462949167482, 11958.701032474257, 12085.818712719492, 12248.816267756169, 11403.0, 11537.192396532499, 11772.411379431165, 11787.233829801036, 11917.761644766882, 7969.641366138653, 9834.901650983686, 10066.094051535398, 10132.746681333025, 10259.538320775433, 9815.85276220843, 10134.898651013396, 10158.441285729356, 10269.74325641865, 10281.383117013003], "unit": "score", "name": "yui.html", "value": 7206.58743127482}], "name": "dromaeo_css", "value": 7746.312144817252}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 110.0, 115.0, 113.0, 116.0, 130.0, 115.0, 115.0, 103.0, 165.0], "unit": "score", "name": "ai-astar", "value": 119.9}, {"lowerIsBetter": true, "replicates": [177.0, 151.0, 162.0, 144.0, 120.0, 138.0, 118.0, 148.0, 146.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [193.0, 197.0, 197.0, 201.0, 196.0, 234.0, 274.0, 242.0, 196.0, 194.0], "unit": "score", "name": "audio-dft", "value": 212.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 72.0, 112.0, 81.0, 82.0, 83.0, 89.0, 135.0, 56.0], "unit": "score", "name": "audio-fft", "value": 84.5}, {"lowerIsBetter": true, "replicates": [83.0, 78.0, 123.0, 78.0, 77.0, 81.0, 118.0, 78.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 91.2}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 104.0, 128.0, 92.0, 89.0, 92.0, 94.0, 76.0, 126.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.2}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 96.0, 97.0, 95.0, 94.0, 96.0, 93.0, 136.0], "unit": "score", "name": "imaging-darkroom", "value": 99.5}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 89.0, 92.0, 93.0, 90.0, 119.0, 147.0, 86.0, 144.0], "unit": "score", "name": "imaging-desaturate", "value": 104.2}, {"lowerIsBetter": true, "replicates": [54.0, 60.0, 59.0, 59.0, 57.0, 60.0, 60.0, 68.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 78.0, 101.0, 77.0, 64.0, 74.0, 65.0, 65.0, 75.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.8}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 81.0, 82.0, 82.0, 82.0, 80.0, 81.0, 80.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [130.0, 138.0, 131.0, 107.0, 138.0, 136.0, 129.0, 136.0, 122.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [137.0, 135.0, 136.0, 136.0, 153.0, 172.0, 141.0, 133.0, 138.0, 123.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.4}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 67.0, 65.0, 61.0, 66.0, 69.0, 70.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1502.2}]} 04:08:38 INFO - Return code: 0 04:08:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:08:38 ERROR - # TBPL SUCCESS # 04:08:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:08:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:08:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:08:38 INFO - 2016-04-27 04:08:38.414 screenresolution[1985:18190] starting screenresolution argv=screenresolution get 04:08:38 INFO - 2016-04-27 04:08:38.416 screenresolution[1985:18190] Display 0: 1600x1200x32@60 04:08:38 INFO - 2016-04-27 04:08:38.422 screenresolution[1986:18193] starting screenresolution argv=screenresolution list 04:08:38 INFO - Available Modes on Display 0 04:08:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:08:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:08:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:08:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:08:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:08:38 INFO - Intel Iris: 04:08:38 INFO - Chipset Model: Intel Iris 04:08:38 INFO - Type: GPU 04:08:38 INFO - Bus: Built-In 04:08:38 INFO - VRAM (Dynamic, Max): 1536 MB 04:08:38 INFO - Vendor: Intel (0x8086) 04:08:38 INFO - Device ID: 0x0a2e 04:08:38 INFO - Revision ID: 0x0009 04:08:38 INFO - Displays: 04:08:38 INFO - Display: 04:08:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:08:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:08:38 INFO - Display Serial Number: 1600x1200 60 04:08:38 INFO - Main Display: Yes 04:08:38 INFO - Mirror: Off 04:08:38 INFO - Online: Yes 04:08:38 INFO - Rotation: Supported 04:08:38 INFO - Return code: 0 04:08:38 INFO - Running post-action listener: _resource_record_post_action 04:08:38 INFO - Running post-run listener: _resource_record_post_run 04:08:39 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 999424; Write bytes: 668409856; Read time: 13; Write time: 2106 04:08:39 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 362414592; Write bytes: 363681280; Read time: 29407; Write time: 793 04:08:39 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 999424; Write bytes: 301494784; Read time: 13; Write time: 1255 04:08:39 INFO - Running post-run listener: _upload_blobber_files 04:08:39 INFO - Blob upload gear active. 04:08:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:08: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 04:08: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'] 04:08: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 04:08:40 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:40 INFO - (blobuploader) - INFO - Done attempting. 04:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:41 INFO - (blobuploader) - INFO - Done attempting. 04:08:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:08:41 INFO - Return code: 0 04:08:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:08:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:08:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c453a669d4fa368b7d362a63e16d9535575a5b425829918af9ba32d2e6689990a6654e005f1f3427a9973d51bd98b5455c369360c776caf988f20034d9447ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/102c8eaa082c84cdf757d01feea7aa27b9eb642f8e104d4cc3cbbd01a944ce38fdbb6bfd0e49466b775db6a1a7806b43e2282f84d8795202605c509c6c6d4515"} 04:08:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:08:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:08:41 INFO - Contents: 04:08:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c453a669d4fa368b7d362a63e16d9535575a5b425829918af9ba32d2e6689990a6654e005f1f3427a9973d51bd98b5455c369360c776caf988f20034d9447ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/102c8eaa082c84cdf757d01feea7aa27b9eb642f8e104d4cc3cbbd01a944ce38fdbb6bfd0e49466b775db6a1a7806b43e2282f84d8795202605c509c6c6d4515"} 04:08:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:08:41 INFO - Copying logs to upload dir... 04:08:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:08:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.792768 ========= master_lag: 0.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-27 04:08:42.684181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:08:42.691267) ========= 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.NE3j596isx/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.mSib5WxkXO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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/8c453a669d4fa368b7d362a63e16d9535575a5b425829918af9ba32d2e6689990a6654e005f1f3427a9973d51bd98b5455c369360c776caf988f20034d9447ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/102c8eaa082c84cdf757d01feea7aa27b9eb642f8e104d4cc3cbbd01a944ce38fdbb6bfd0e49466b775db6a1a7806b43e2282f84d8795202605c509c6c6d4515"} build_url:https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/Og0VB9dDR6qRbf5zAwFhyg/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/8c453a669d4fa368b7d362a63e16d9535575a5b425829918af9ba32d2e6689990a6654e005f1f3427a9973d51bd98b5455c369360c776caf988f20034d9447ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/102c8eaa082c84cdf757d01feea7aa27b9eb642f8e104d4cc3cbbd01a944ce38fdbb6bfd0e49466b775db6a1a7806b43e2282f84d8795202605c509c6c6d4515"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:08:42.729743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:08:42.733110) ========= 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.NE3j596isx/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.mSib5WxkXO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005171 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:08:42.781447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:08:42.781749) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:08:42.785153) ========= ========= Total master_lag: 0.82 =========