builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0153 starttime: 1460653156.47 results: success (0) buildid: 20160414074538 builduid: e44f1848eee34552bfde55587b277c28 revision: 995e7890dd613843c3914a1d9d46676f400152c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:16.471165) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:16.471671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:16.471969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:16.489547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:16.489811) ========= 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.OfabJ29BuP/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.FLhDrp1So8/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-14 09:59:16-- 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% 50.3M=0s 2016-04-14 09:59:16 (50.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191420 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:16.697562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:16.697893) ========= 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.OfabJ29BuP/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.FLhDrp1So8/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.020499 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:16.747924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 09:59:16.748289) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 995e7890dd613843c3914a1d9d46676f400152c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 995e7890dd613843c3914a1d9d46676f400152c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OfabJ29BuP/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.FLhDrp1So8/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-14 09:59:16,781 truncating revision to first 12 chars 2016-04-14 09:59:16,781 Setting DEBUG logging. 2016-04-14 09:59:16,781 attempt 1/10 2016-04-14 09:59:16,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/995e7890dd61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 09:59:18,143 unpacking tar archive at: fx-team-995e7890dd61/testing/mozharness/ program finished with exit code 0 elapsedTime=1.611536 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 09:59:18.376414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:18.376735) ========= script_repo_revision: 995e7890dd613843c3914a1d9d46676f400152c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:18.377147) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:18.377408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 09:59:18.392383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-14 09:59:18.392768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OfabJ29BuP/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.FLhDrp1So8/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:59:18 INFO - MultiFileLogger online at 20160414 09:59:18 in /builds/slave/test 09:59:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:59:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:18 INFO - {'append_to_log': False, 09:59:18 INFO - 'base_work_dir': '/builds/slave/test', 09:59:18 INFO - 'blob_upload_branch': 'Fx-Team', 09:59:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:18 INFO - 'branch': 'Fx-Team', 09:59:18 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:18 INFO - 'config_files': ('talos/mac_config.py',), 09:59:18 INFO - 'default_actions': ('clobber', 09:59:18 INFO - 'read-buildbot-config', 09:59:18 INFO - 'download-and-extract', 09:59:18 INFO - 'populate-webroot', 09:59:18 INFO - 'create-virtualenv', 09:59:18 INFO - 'install', 09:59:18 INFO - 'run-tests'), 09:59:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:18 INFO - 'download_minidump_stackwalk': True, 09:59:18 INFO - 'download_symbols': 'ondemand', 09:59:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:18 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:18 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:18 INFO - 'installer_path': 'installer.exe', 09:59:18 INFO - 'log_level': 'info', 09:59:18 INFO - 'log_name': 'talos', 09:59:18 INFO - 'log_to_console': True, 09:59:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:59:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:59:18 INFO - 'opt_config_files': (), 09:59:18 INFO - 'pip_index': False, 09:59:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:59:18 INFO - 'cmd': ('bash', 09:59:18 INFO - '-c', 09:59:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:59:18 INFO - 'enabled': True, 09:59:18 INFO - 'halt_on_failure': False, 09:59:18 INFO - 'name': 'check_screen_resolution'},), 09:59:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:59:18 INFO - 'cmd': ('bash', 09:59:18 INFO - '-c', 09:59:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:59:18 INFO - 'enabled': True, 09:59:18 INFO - 'halt_on_failure': False, 09:59:18 INFO - 'name': 'check_screen_resolution'},), 09:59:18 INFO - 'run_cmd_checks_enabled': True, 09:59:18 INFO - 'sps_profile': False, 09:59:18 INFO - 'sps_profile_interval': 0, 09:59:18 INFO - 'suite': 'dromaeojs-e10s', 09:59:18 INFO - 'system_bits': '32', 09:59:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:18 INFO - 'title': 't-yosemite-r7-0153', 09:59:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:18 INFO - 'use_talos_json': True, 09:59:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:18 INFO - 'work_dir': 'build'} 09:59:18 INFO - ##### 09:59:18 INFO - ##### Running clobber step. 09:59:18 INFO - ##### 09:59:18 INFO - Running pre-action listener: _resource_record_pre_action 09:59:18 INFO - Running main action method: clobber 09:59:18 INFO - rmtree: /builds/slave/test/build 09:59:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:20 INFO - Running post-action listener: _resource_record_post_action 09:59:20 INFO - ##### 09:59:20 INFO - ##### Running read-buildbot-config step. 09:59:20 INFO - ##### 09:59:20 INFO - Running pre-action listener: _resource_record_pre_action 09:59:20 INFO - Running main action method: read_buildbot_config 09:59:20 INFO - Using buildbot properties: 09:59:20 INFO - { 09:59:20 INFO - "project": "", 09:59:20 INFO - "product": "firefox", 09:59:20 INFO - "script_repo_revision": "production", 09:59:20 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:59:20 INFO - "repository": "", 09:59:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:59:20 INFO - "buildid": "20160414074538", 09:59:20 INFO - "pgo_build": "False", 09:59:20 INFO - "basedir": "/builds/slave/test", 09:59:20 INFO - "buildnumber": 603, 09:59:20 INFO - "slavename": "t-yosemite-r7-0153", 09:59:20 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:59:20 INFO - "platform": "yosemite_r7", 09:59:20 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:59:20 INFO - "branch": "fx-team", 09:59:20 INFO - "repo_path": "integration/fx-team", 09:59:20 INFO - "revision": "995e7890dd613843c3914a1d9d46676f400152c1", 09:59:20 INFO - "stage_platform": "macosx64", 09:59:20 INFO - "builduid": "e44f1848eee34552bfde55587b277c28", 09:59:20 INFO - "slavebuilddir": "test" 09:59:20 INFO - } 09:59:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:59:20 INFO - Running post-action listener: _resource_record_post_action 09:59:20 INFO - ##### 09:59:20 INFO - ##### Running download-and-extract step. 09:59:20 INFO - ##### 09:59:20 INFO - Running pre-action listener: _resource_record_pre_action 09:59:20 INFO - Running main action method: download_and_extract 09:59:20 INFO - mkdir: /builds/slave/test/build/tests 09:59:20 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')]} 09:59:20 INFO - https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 09:59:22 INFO - Downloaded 1199 bytes. 09:59:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:59:22 INFO - Using the following test package requirements: 09:59:22 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:59:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:59:22 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:59:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:59:22 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:59:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:59:22 INFO - u'jsshell-mac.zip'], 09:59:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:59:22 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:59:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:59:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:59:22 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:59:22 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:59:22 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:59:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:59:22 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:59:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:59:22 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:59:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:22 INFO - https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:59:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:59:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:59:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:59:23 INFO - Downloaded 18031162 bytes. 09:59:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:59:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:59:26 INFO - Return code: 0 09:59:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:59: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')]} 09:59:26 INFO - https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:59:29 INFO - Downloaded 18031162 bytes. 09:59:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:59:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:59:32 INFO - Return code: 0 09:59:32 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')]} 09:59:32 INFO - https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:59:33 INFO - Downloaded 10841076 bytes. 09:59:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:59:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:59:34 INFO - Return code: 0 09:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:34 INFO - https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:59:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:59:37 INFO - Downloaded 109831870 bytes. 09:59:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:59:37 INFO - mkdir: /builds/slave/test/properties 09:59:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:59:37 INFO - Writing to file /builds/slave/test/properties/build_url 09:59:37 INFO - Contents: 09:59:37 INFO - build_url:https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:59:38 INFO - Running post-action listener: _resource_record_post_action 09:59:38 INFO - Running post-action listener: set_extra_try_arguments 09:59:38 INFO - ##### 09:59:38 INFO - ##### Running populate-webroot step. 09:59:38 INFO - ##### 09:59:38 INFO - Running pre-action listener: _resource_record_pre_action 09:59:38 INFO - Running main action method: populate_webroot 09:59:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:59:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:59:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:59:38 INFO - '--tppagecycles', 09:59:38 INFO - '7'], 09:59:38 INFO - 'tests': ['tsvgm']}}, 09:59:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:59:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:59:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:59:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:59:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['damp', 'tps']}, 09:59:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'tests': ['damp', 'tps']}, 09:59:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['dromaeo_dom']}, 09:59:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other-e10s': {'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['tsvgx', 09:59:38 INFO - 'tsvgr_opacity', 09:59:38 INFO - 'tart', 09:59:38 INFO - 'tscrollx', 09:59:38 INFO - 'cart']}, 09:59:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:59:38 INFO - 'tsvgr_opacity', 09:59:38 INFO - 'tart', 09:59:38 INFO - 'tscrollx', 09:59:38 INFO - 'cart']}, 09:59:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['tp5o']}, 09:59:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'tests': ['tp5o']}, 09:59:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--disable-e10s', 09:59:38 INFO - '--xperf_path', 09:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:38 INFO - 'tests': ['tp5n']}, 09:59:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--xperf_path', 09:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:38 INFO - 'tests': ['tp5n']}}, 09:59:38 INFO - 'talos.zip': {'path': '', 09:59:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:59:38 INFO - Running post-action listener: _resource_record_post_action 09:59:38 INFO - ##### 09:59:38 INFO - ##### Running create-virtualenv step. 09:59:38 INFO - ##### 09:59:38 INFO - Running pre-action listener: _resource_record_pre_action 09:59:38 INFO - Running main action method: create_virtualenv 09:59:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:59:38 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 09:59:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:59:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:38 INFO - Using real prefix '/tools/python27' 09:59:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:59:39 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:42 INFO - Installing pip.................done. 09:59:42 INFO - Return code: 0 09:59:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59:42 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')]} 09:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:42 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')]} 09:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:42 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 0x105054a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105064420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad80599cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, '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.OfabJ29BuP/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.FLhDrp1So8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:59:42 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 09:59:42 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 09:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 09:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:42 INFO - 'HOME': '/Users/cltbld', 09:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:42 INFO - 'LOGNAME': 'cltbld', 09:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:42 INFO - 'MOZ_NO_REMOTE': '1', 09:59:42 INFO - 'NO_EM_RESTART': '1', 09:59:42 INFO - 'PAGER': '/bin/cat', 09:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:42 INFO - 'PWD': '/builds/slave/test', 09:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:42 INFO - 'SHELL': '/bin/bash', 09:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 09:59:42 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:42 INFO - 'USER': 'cltbld', 09:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:42 INFO - 'XPC_FLAGS': '0x0', 09:59:42 INFO - 'XPC_SERVICE_NAME': '0', 09:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:42 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 09:59:42 INFO - Cleaning up... 09:59:42 INFO - Return code: 0 09:59:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:59:42 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')]} 09:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:42 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')]} 09:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:42 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 0x105054a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105064420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad80599cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, '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.OfabJ29BuP/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.FLhDrp1So8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:59:42 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 09:59:42 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 09:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 09:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:42 INFO - 'HOME': '/Users/cltbld', 09:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:42 INFO - 'LOGNAME': 'cltbld', 09:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:42 INFO - 'MOZ_NO_REMOTE': '1', 09:59:42 INFO - 'NO_EM_RESTART': '1', 09:59:42 INFO - 'PAGER': '/bin/cat', 09:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:42 INFO - 'PWD': '/builds/slave/test', 09:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:42 INFO - 'SHELL': '/bin/bash', 09:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 09:59:42 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:42 INFO - 'USER': 'cltbld', 09:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:42 INFO - 'XPC_FLAGS': '0x0', 09:59:42 INFO - 'XPC_SERVICE_NAME': '0', 09:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:42 INFO - Downloading/unpacking psutil>=0.7.1 09:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:45 INFO - Installing collected packages: psutil 09:59:45 INFO - Running setup.py install for psutil 09:59:45 INFO - building 'psutil._psutil_osx' extension 09:59:45 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 09:59:45 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 09:59:46 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 09:59:46 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 09:59:46 INFO - building 'psutil._psutil_posix' extension 09:59:46 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 09:59:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:59:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:59:46 INFO - ^ 09:59:46 INFO - 1 warning generated. 09:59:46 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 09:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:46 INFO - Successfully installed psutil 09:59:46 INFO - Cleaning up... 09:59:46 INFO - Return code: 0 09:59:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59: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')]} 09:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:46 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 0x105054a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105064420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad80599cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, '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.OfabJ29BuP/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.FLhDrp1So8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:59:46 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 09:59:46 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 09:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 09:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:46 INFO - 'HOME': '/Users/cltbld', 09:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:46 INFO - 'LOGNAME': 'cltbld', 09:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:46 INFO - 'MOZ_NO_REMOTE': '1', 09:59:46 INFO - 'NO_EM_RESTART': '1', 09:59:46 INFO - 'PAGER': '/bin/cat', 09:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:46 INFO - 'PWD': '/builds/slave/test', 09:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:46 INFO - 'SHELL': '/bin/bash', 09:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 09:59:46 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:46 INFO - 'USER': 'cltbld', 09:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:46 INFO - 'XPC_FLAGS': '0x0', 09:59:46 INFO - 'XPC_SERVICE_NAME': '0', 09:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:59:46 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 09:59:46 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 09:59:46 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 09:59:46 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 09:59:46 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 09:59:46 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 09:59:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:59:49 INFO - Installing collected packages: mozsystemmonitor 09:59:49 INFO - Running setup.py install for mozsystemmonitor 09:59:49 INFO - Successfully installed mozsystemmonitor 09:59:49 INFO - Cleaning up... 09:59:49 INFO - Return code: 0 09:59:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59:49 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')]} 09:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:49 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')]} 09:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:49 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 0x105054a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105064420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad80599cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, '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.OfabJ29BuP/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.FLhDrp1So8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:59:49 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 09:59:49 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 09:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 09:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:49 INFO - 'HOME': '/Users/cltbld', 09:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:49 INFO - 'LOGNAME': 'cltbld', 09:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:49 INFO - 'MOZ_NO_REMOTE': '1', 09:59:49 INFO - 'NO_EM_RESTART': '1', 09:59:49 INFO - 'PAGER': '/bin/cat', 09:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:49 INFO - 'PWD': '/builds/slave/test', 09:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:49 INFO - 'SHELL': '/bin/bash', 09:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 09:59:49 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:49 INFO - 'USER': 'cltbld', 09:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:49 INFO - 'XPC_FLAGS': '0x0', 09:59:49 INFO - 'XPC_SERVICE_NAME': '0', 09:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:49 INFO - Downloading/unpacking blobuploader==1.2.4 09:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:49 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 09:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:52 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:52 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 09:59:52 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 09:59:52 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 09:59:52 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 09:59:52 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 09:59:52 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 09:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:52 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 09:59:52 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 09:59:52 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 09:59:52 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 09:59:52 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 09:59:52 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 09:59:53 INFO - Downloading docopt-0.6.1.tar.gz 09:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:53 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:53 INFO - Running setup.py install for blobuploader 09:59:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:53 INFO - Running setup.py install for requests 09:59:53 INFO - Running setup.py install for docopt 09:59:54 INFO - Successfully installed blobuploader requests docopt 09:59:54 INFO - Cleaning up... 09:59:54 INFO - Return code: 0 09:59:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:54 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 0x105054a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105064420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad80599cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, '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.OfabJ29BuP/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.FLhDrp1So8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:59:54 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 09:59:54 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 09:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 09:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:54 INFO - 'HOME': '/Users/cltbld', 09:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:54 INFO - 'LOGNAME': 'cltbld', 09:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:54 INFO - 'MOZ_NO_REMOTE': '1', 09:59:54 INFO - 'NO_EM_RESTART': '1', 09:59:54 INFO - 'PAGER': '/bin/cat', 09:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:54 INFO - 'PWD': '/builds/slave/test', 09:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:54 INFO - 'SHELL': '/bin/bash', 09:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 09:59:54 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:54 INFO - 'USER': 'cltbld', 09:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:54 INFO - 'XPC_FLAGS': '0x0', 09:59:54 INFO - 'XPC_SERVICE_NAME': '0', 09:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:54 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-0zaNHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:54 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Bo83Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:54 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-v3zR3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:54 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ftRoiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:54 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-1T67b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7CiiXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-LM6vLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-EFFpqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-9mRYoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-6SKNN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-qTMOMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-usYZx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-O1onbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-WL4At4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:55 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-8Ncu3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:56 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-K_X52N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:56 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-QXvC44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:56 INFO - Running setup.py install for manifestparser 09:59:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:59:56 INFO - Running setup.py install for mozcrash 09:59:56 INFO - Running setup.py install for mozdebug 09:59:56 INFO - Running setup.py install for mozdevice 09:59:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:59:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:59:56 INFO - Running setup.py install for mozfile 09:59:57 INFO - Running setup.py install for mozhttpd 09:59:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:59:57 INFO - Running setup.py install for mozinfo 09:59:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:59:57 INFO - Running setup.py install for mozInstall 09:59:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:59:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:59:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:59:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:59:57 INFO - Running setup.py install for mozleak 09:59:57 INFO - Running setup.py install for mozlog 09:59:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:59:57 INFO - Running setup.py install for moznetwork 09:59:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:59:57 INFO - Running setup.py install for mozprocess 09:59:58 INFO - Running setup.py install for mozprofile 09:59:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:59:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:59:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:59:58 INFO - Running setup.py install for mozrunner 09:59:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:59:58 INFO - Running setup.py install for mozscreenshot 09:59:58 INFO - Running setup.py install for moztest 09:59:58 INFO - Running setup.py install for mozversion 09:59:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:59:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:58 INFO - Cleaning up... 09:59:58 INFO - Return code: 0 09:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:59 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 0x105054a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105064420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad80599cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, '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.OfabJ29BuP/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.FLhDrp1So8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:59:59 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 09:59:59 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 09:59:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 09:59:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:59 INFO - 'HOME': '/Users/cltbld', 09:59:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:59 INFO - 'LOGNAME': 'cltbld', 09:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:59 INFO - 'MOZ_NO_REMOTE': '1', 09:59:59 INFO - 'NO_EM_RESTART': '1', 09:59:59 INFO - 'PAGER': '/bin/cat', 09:59:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:59 INFO - 'PWD': '/builds/slave/test', 09:59:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:59 INFO - 'SHELL': '/bin/bash', 09:59:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 09:59:59 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:59:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:59 INFO - 'USER': 'cltbld', 09:59:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:59 INFO - 'XPC_FLAGS': '0x0', 09:59:59 INFO - 'XPC_SERVICE_NAME': '0', 09:59:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:59 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7nMMRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:59 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)) 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:59 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-4aJMMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:59 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)) 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:59 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-giy6wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:59 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)) 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:59 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-wHEmlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:59 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)) 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:59 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-R_YKuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-TNg_AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-xLn5U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-eFemcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-PPowqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7hGNuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-nhd9c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-vFbAa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-jX2Vt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Plv_4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:00 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)) 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Tn7cmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:01 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)) 10:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-DVdkTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:01 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)) 10:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-BbbH4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:01 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)) 10:00:01 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)) 10:00:01 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)) 10:00:01 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)) 10:00:01 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)) 10:00:01 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)) 10:00:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:01 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 10:00:01 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 10:00:01 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 10:00:01 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 10:00:01 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 10:00:01 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 10:00:04 INFO - Downloading blessings-1.6.tar.gz 10:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:04 INFO - Installing collected packages: blessings 10:00:04 INFO - Running setup.py install for blessings 10:00:04 INFO - Successfully installed blessings 10:00:04 INFO - Cleaning up... 10:00:04 INFO - Return code: 0 10:00:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:04 INFO - Reading from file tmpfile_stdout 10:00:04 INFO - Current package versions: 10:00:04 INFO - blessings == 1.6 10:00:04 INFO - blobuploader == 1.2.4 10:00:04 INFO - docopt == 0.6.1 10:00:04 INFO - manifestparser == 1.1 10:00:04 INFO - mozInstall == 1.12 10:00:04 INFO - mozcrash == 0.17 10:00:04 INFO - mozdebug == 0.1 10:00:04 INFO - mozdevice == 0.48 10:00:04 INFO - mozfile == 1.2 10:00:04 INFO - mozhttpd == 0.7 10:00:04 INFO - mozinfo == 0.9 10:00:04 INFO - mozleak == 0.1 10:00:04 INFO - mozlog == 3.1 10:00:04 INFO - moznetwork == 0.27 10:00:04 INFO - mozprocess == 0.22 10:00:04 INFO - mozprofile == 0.28 10:00:04 INFO - mozrunner == 6.11 10:00:04 INFO - mozscreenshot == 0.1 10:00:04 INFO - mozsystemmonitor == 0.0 10:00:04 INFO - moztest == 0.7 10:00:04 INFO - mozversion == 1.4 10:00:04 INFO - psutil == 3.1.1 10:00:04 INFO - requests == 1.2.3 10:00:04 INFO - wsgiref == 0.1.2 10:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:04 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 0x105054a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105064420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad80599cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, '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.OfabJ29BuP/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.FLhDrp1So8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 10:00:04 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 10:00:04 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 10:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 10:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:04 INFO - 'HOME': '/Users/cltbld', 10:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:04 INFO - 'LOGNAME': 'cltbld', 10:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:04 INFO - 'MOZ_NO_REMOTE': '1', 10:00:04 INFO - 'NO_EM_RESTART': '1', 10:00:04 INFO - 'PAGER': '/bin/cat', 10:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:04 INFO - 'PWD': '/builds/slave/test', 10:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:04 INFO - 'SHELL': '/bin/bash', 10:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 10:00:04 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 10:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:04 INFO - 'USER': 'cltbld', 10:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:04 INFO - 'XPC_FLAGS': '0x0', 10:00:04 INFO - 'XPC_SERVICE_NAME': '0', 10:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 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)) 10:00:04 INFO - Cleaning up... 10:00:04 INFO - Return code: 0 10:00:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105054a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105064420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad80599cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, '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.OfabJ29BuP/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.FLhDrp1So8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 10:00: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', 'jsonschema'] in /builds/slave/test/build 10:00: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 jsonschema 10:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 10:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:04 INFO - 'HOME': '/Users/cltbld', 10:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:04 INFO - 'LOGNAME': 'cltbld', 10:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:04 INFO - 'MOZ_NO_REMOTE': '1', 10:00:04 INFO - 'NO_EM_RESTART': '1', 10:00:04 INFO - 'PAGER': '/bin/cat', 10:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:04 INFO - 'PWD': '/builds/slave/test', 10:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:04 INFO - 'SHELL': '/bin/bash', 10:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 10:00:04 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 10:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:04 INFO - 'USER': 'cltbld', 10:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:04 INFO - 'XPC_FLAGS': '0x0', 10:00:04 INFO - 'XPC_SERVICE_NAME': '0', 10:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:05 INFO - Downloading/unpacking jsonschema 10:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:00:07 INFO - Downloading/unpacking functools32 (from jsonschema) 10:00:07 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 10:00:07 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 10:00:07 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 10:00:07 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 10:00:07 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 10:00:07 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 10:00:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:00:08 INFO - warning: no files found matching '*.txt' 10:00:08 INFO - no previously-included directories found matching 'build' 10:00:08 INFO - no previously-included directories found matching 'dist' 10:00:08 INFO - no previously-included directories found matching '.git*' 10:00:08 INFO - Installing collected packages: jsonschema, functools32 10:00:08 INFO - Running setup.py install for functools32 10:00:08 INFO - warning: no files found matching '*.txt' 10:00:08 INFO - no previously-included directories found matching 'build' 10:00:08 INFO - no previously-included directories found matching 'dist' 10:00:08 INFO - no previously-included directories found matching '.git*' 10:00:08 INFO - Successfully installed jsonschema functools32 10:00:08 INFO - Cleaning up... 10:00:08 INFO - Return code: 0 10:00:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105054a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105064420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad80599cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, '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.OfabJ29BuP/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.FLhDrp1So8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 10:00: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', 'flake8'] in /builds/slave/test/build 10:00: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 flake8 10:00:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 10:00:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:08 INFO - 'HOME': '/Users/cltbld', 10:00:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:08 INFO - 'LOGNAME': 'cltbld', 10:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:08 INFO - 'MOZ_NO_REMOTE': '1', 10:00:08 INFO - 'NO_EM_RESTART': '1', 10:00:08 INFO - 'PAGER': '/bin/cat', 10:00:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:08 INFO - 'PWD': '/builds/slave/test', 10:00:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:08 INFO - 'SHELL': '/bin/bash', 10:00:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 10:00:08 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 10:00:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:08 INFO - 'USER': 'cltbld', 10:00:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:08 INFO - 'XPC_FLAGS': '0x0', 10:00:08 INFO - 'XPC_SERVICE_NAME': '0', 10:00:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:08 INFO - Downloading/unpacking flake8 10:00:08 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 10:00:08 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 10:00:08 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 10:00:08 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 10:00:08 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 10:00:08 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 10:00:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:00:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:00:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:00:12 INFO - no previously-included directories found matching 'docs/_build' 10:00:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:00:12 INFO - Running setup.py install for pep8 10:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:00:12 INFO - no previously-included directories found matching 'docs/_build' 10:00:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:00:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:00:12 INFO - Cleaning up... 10:00:12 INFO - Return code: 0 10:00:12 INFO - Running post-action listener: _resource_record_post_action 10:00:12 INFO - Running post-action listener: _start_resource_monitoring 10:00:12 INFO - Starting resource monitoring. 10:00:12 INFO - ##### 10:00:12 INFO - ##### Running install step. 10:00:12 INFO - ##### 10:00:12 INFO - Running pre-action listener: _resource_record_pre_action 10:00:12 INFO - Running main action method: install 10:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:13 INFO - Reading from file tmpfile_stdout 10:00:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:13 INFO - Reading from file tmpfile_stdout 10:00:13 INFO - Output received: 10:00:13 INFO - Usage: mozinstall [options] installer 10:00:13 INFO - Options: 10:00:13 INFO - -h, --help show this help message and exit 10:00:13 INFO - -d DEST, --destination=DEST 10:00:13 INFO - Directory to install application into. [default: 10:00:13 INFO - "/builds/slave/test"] 10:00:13 INFO - --app=APP Application being installed. [default: firefox] 10:00:13 INFO - mkdir: /builds/slave/test/build/application 10:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:00:47 INFO - Reading from file tmpfile_stdout 10:00:47 INFO - Output received: 10:00:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:00:47 INFO - Running post-action listener: _resource_record_post_action 10:00:47 INFO - ##### 10:00:47 INFO - ##### Running run-tests step. 10:00:47 INFO - ##### 10:00:47 INFO - Running pre-action listener: _resource_record_pre_action 10:00:47 INFO - Running main action method: run_tests 10:00:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:00:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:00:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:00:47 INFO - 2016-04-14 10:00:47.146 screenresolution[1942:18252] starting screenresolution argv=screenresolution get 10:00:47 INFO - 2016-04-14 10:00:47.149 screenresolution[1942:18252] Display 0: 1600x1200x32@60 10:00:47 INFO - 2016-04-14 10:00:47.155 screenresolution[1943:18254] starting screenresolution argv=screenresolution list 10:00:47 INFO - Available Modes on Display 0 10:00:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:00:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:00:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:00:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:00:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:00:47 INFO - Intel Iris: 10:00:47 INFO - Chipset Model: Intel Iris 10:00:47 INFO - Type: GPU 10:00:47 INFO - Bus: Built-In 10:00:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:00:47 INFO - Vendor: Intel (0x8086) 10:00:47 INFO - Device ID: 0x0a2e 10:00:47 INFO - Revision ID: 0x0009 10:00:47 INFO - Displays: 10:00:47 INFO - Display: 10:00:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:00:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:00:47 INFO - Display Serial Number: 1600x1200 60 10:00:47 INFO - Main Display: Yes 10:00:47 INFO - Mirror: Off 10:00:47 INFO - Online: Yes 10:00:47 INFO - Rotation: Supported 10:00:47 INFO - Return code: 0 10:00:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:47 INFO - Python 2.7.3 10:00:47 INFO - Return code: 0 10:00:47 INFO - grabbing minidump binary from tooltool 10:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:47 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 0x104ef3e00>, '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 0x104d5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104eeeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:47 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 10:00:47 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 10:00:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:47 INFO - Return code: 0 10:00:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:00:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:00:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:00:48 INFO - Return code: 0 10:00:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 10:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --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 10:00:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfabJ29BuP/Render', 10:00:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:48 INFO - 'HOME': '/Users/cltbld', 10:00:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:48 INFO - 'LOGNAME': 'cltbld', 10:00:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:48 INFO - 'MOZ_NO_REMOTE': '1', 10:00:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:48 INFO - 'NO_EM_RESTART': '1', 10:00:48 INFO - 'PAGER': '/bin/cat', 10:00:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:48 INFO - 'PWD': '/builds/slave/test', 10:00:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:48 INFO - 'SHELL': '/bin/bash', 10:00:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FLhDrp1So8/Listeners', 10:00:48 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 10:00:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:48 INFO - 'USER': 'cltbld', 10:00:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:48 INFO - 'XPC_FLAGS': '0x0', 10:00:48 INFO - 'XPC_SERVICE_NAME': '0', 10:00:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 10:00:48 INFO - mozversion application_buildid: 20160414074538 10:00:48 INFO - mozversion application_changeset: 995e7890dd613843c3914a1d9d46676f400152c1 10:00:48 INFO - mozversion application_display_name: Nightly 10:00:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:48 INFO - mozversion application_name: Firefox 10:00:48 INFO - mozversion application_remotingname: firefox 10:00:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:00:48 INFO - mozversion application_vendor: Mozilla 10:00:48 INFO - mozversion application_version: 48.0a1 10:00:48 INFO - mozversion platform_buildid: 20160414074538 10:00:48 INFO - mozversion platform_changeset: 995e7890dd613843c3914a1d9d46676f400152c1 10:00:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:00:48 INFO - mozversion platform_version: 48.0a1 10:00:48 INFO - using testdate: 1460653248 10:00:48 INFO - actual date: 1460653248 10:00:48 INFO - starting webserver on 'localhost:57175' 10:00:48 INFO - SUITE-START | Running 2 tests 10:00:48 INFO - TEST-START | dromaeo_css 10:00:48 INFO - operating with platform_type : mac_ 10:00:48 INFO - Initialising browser for dromaeo_css test... 10:00:48 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpa1jfpH/profile http://localhost:57175/getInfo.html) 10:00:51 INFO - PROCESS | 1961 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 10:00:51 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 10:00:51 INFO - PROCESS | 1961 | colorDepth:24 10:00:51 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 10:00:51 INFO - PROCESS | 1961 | __metrics 10:00:51 ERROR - PROCESS | 1961 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:00:52 INFO - TEST-INFO | 1961: exit 0 10:00:52 INFO - Browser initialized. 10:00:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:52 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpa1jfpH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:04 INFO - PROCESS | 1964 | RSS: Main: 248295424 10:01:04 INFO - PROCESS | 1964 | 10:01:54 INFO - PROCESS | 1964 | 1460653314283 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] 10:04:04 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57175/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57175/tests/dromaeo/cssquery-ext.html) 10:04:06 INFO - PROCESS | 1964 | RSS: Main: 263974912 10:04:06 INFO - PROCESS | 1964 | 10:07:08 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57175/tests/dromaeo/cssquery-ext.html (next: http://localhost:57175/tests/dromaeo/cssquery-jquery.html) 10:07:08 INFO - PROCESS | 1964 | RSS: Main: 275349504 10:07:08 INFO - PROCESS | 1964 | 10:10:10 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57175/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57175/tests/dromaeo/cssquery-mootools.html) 10:10:11 INFO - PROCESS | 1964 | RSS: Main: 277254144 10:10:11 INFO - PROCESS | 1964 | 10:13:13 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57175/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57175/tests/dromaeo/cssquery-prototype.html) 10:13:13 INFO - PROCESS | 1964 | RSS: Main: 278757376 10:13:13 INFO - PROCESS | 1964 | 10:16:16 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57175/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57175/tests/dromaeo/cssquery-yui.html) 10:16:16 INFO - PROCESS | 1964 | RSS: Main: 281632768 10:16:16 INFO - PROCESS | 1964 | 10:19:19 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57175/tests/dromaeo/cssquery-yui.html (next: http://localhost:57175/tests/dromaeo/cssquery-dojo.html) 10:19:19 INFO - PROCESS | 1964 | RSS: Main: 282923008 10:19:19 INFO - PROCESS | 1964 | 10:19:19 INFO - PROCESS | 1964 | __start_tp_report 10:19:19 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 10:19:19 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 10:19:19 INFO - PROCESS | 1964 | |i|pagename|runs| 10:19:19 INFO - PROCESS | 1964 | |0;dojo.html;2910.9272268193295;3416.624171341152;3444.328355970585;3504.2465869837997;3557.039599308185;5765.740541675625;5766.279215098113;5791.8262452126455;5799.420057994198;5805.680687562182;4725.362076119723;5658.547316214704;5802.187693722883;5867.823965281038;5885.352611212763;4315.762633055181;5223.164293713006;5238.895222095556;5297.390800057985;5340.385855626594;241.0320994498442;5185.222216667511;5273.1826566882;5279.788808447657;5290.1800220965815;4540.27355623102;4608.677392582521;5235.345581802275;5281.339832520935;5311.282976798141;5113.769880355356;5281.181416880351;5305.283786688825;5313.495217954288;5372.7313634318125;5114.079465696173;5194.298769666085;5213.6089793265655;5261.710605916673;5309.230161626581;5607.299087614048;5725.198472213893;5751.252337196138;5759.65442073477;5790.565707571949;6119.5104391648565;6122.96938515309;6175.5985860919345;6176.969115154396;6202.937970620281;6138.32709113608;6206.317305096436;6240.31356550779;6245.968770156165;6247.5939063960695;5051.52010559;5874.441928016831;5937.020391635375;5986.431289027535;5993.430624090704;6233.781817636361;6297.559170857996;6373.553851230462;6389.552731308764;6398.392152745481;6101.731934812992;6126.914660831478;6166.321704612489;6171.290301615282;6173.32093469718;6194.225721784777;6220.813375598739;6227.470664993526;6268.717907694074;6287.654179020198;6135.04893764628;6143.511877689543;6167.537434692416;6202.379762023762;6218.906716399167;6140.017597184429;6146.7233974471255;6172.506199504029;6178.227721534809;6179.474744646665;4951.72765497901;4979.875503112451;4980.875478113004;5000.599952003831;5009.323741294951;4339.934900976488;4422.071365013383;4443.4445694288215;4485.416895803524;4591.242444996538;5673.971630141906;5827.533797296206;5854.414558544111;5925.792597259161;5944.970275148683;6247.312795592481;6262.436380725757;6272.466840318532;6276.811695649138;6296.6851657417865;5735.426457354231;5828.125781132864;5887.293524776968;5924.6149000314845;5984.700764961822;5430.619856609999;5447.863803404867;5448.891022179534;5450.127979523258;5456.727163641802;6398.808035758934;6412.487001039813;6419.422251997343;6439.871202575922;6445.16212892321;6063.151158837678;6150.415710507495;6209.844753881189;6234.625922444668;6256.624602523863;5414.891702166014;5596.944030559643;6416.390442907917;6452.35476452351;6481.8703625928165;6119.571629985859;6180.066617468195;6193.473554747897;6252.406021427957;6258.468030217483;6179.474744646575;6181.752729890754;6275.560710750204;6301.779437719658;6332.366763323815;6043.244594425697;6098.75604975796;6104.053871649901;6104.511639068953;6125.9693701531205;6023.337432882292;6050.30421501533;6074.3318234994995;6101.389861013863;6120.60216085953;5923.229980102731;6085.756569737161;6086.72609732572;6106.236720409949;6118.938810612015;6128.509719222362;6136.907946380718;6165.938340616716;6176.3514830943905;6186.907196391968;5008.373953255843;5942.64344139353;6039.607425517327;6061.878762424639;6113.327533971171 10:19:19 INFO - PROCESS | 1964 | |1;ext.html;469.60083928660634;471.1683877955409;475.8834085649015;501.32071043735715;526.5866294958458;38661.420078698844;39231.21537569254;39660.60339396605;39687.80156099219;39747.80126099373;40545;40990.770276891664;41598.376024359655;41769.79115104428;41953.74138775834;9412.81174376512;9534.284928630346;9639.518024098803;9656.951715241414;9689.273304502156;9569.234461243119;9595.472249026301;9596.808063838718;9682.273829462783;9696.612135514571;9616.759581010496;9617.038296170396;9656.034396560322;9710.854337184948;9749.658761943334;9568.56941437637;9576.808463830685;9581.808363832719;9637.662681806174;9667.323287369853;9521.714348569554;9581.664641737505;9643.855342169873;9644.373115747454;9669.951650241774;37196.25607487862;37676.43485347722;37684.86945391643;37744.245115097816;38304.61695383038;2786.70739572344;2982;3001.264690150905;3346.2303670155757;3387.4072037393603;25863.965441382323;26769.73230267692;27290.5906411404;27445;27554.5866811998;2642.3129986203726;2755.779537636984;2761.240658818841;2855.072101566999;2871.454423659498;291205;293702.99999999785;345649;348172;351753;32357.029289121365;35000;36005.93949514268;57452.71273643605;58327.4167258322;34862.9541113767;35251.82374088113;35376.46935295973;35496.645033549335;35513.8224308882;12836.48654053846;14984.775228371584;15042.548723538312;15339.386424543116;15402.922985385001;12628.558000469939;12871.871281287255;12961.22232666043;12976.740465190644;12993.610191694264;7915.802104947307;8096.51420914747;8123.878141827878;8198.221168988937;8219.301359384399;3358.6641335866216;3382.8308584570673;3402.7788193767324;3406.9659303407143;3409.403354412968;1039.991208527742;1068.2682362581656;1068.7915856407926;1085.9900292727839;1089.934603923767;29210.41579168447;29281.09113453193;29455.821767129073;29557.26106847303;29858.850705746765;1075.473018221066;1089.6022951622758;1091.5633746501462;1096.3476731344838;1122.3826895207603;15231;15248.161351125573;15275;15766.527004189893;15790.21048947571;623125;698337;717200;725502;725638;57788;60131;61491.770164596455;61734.0739888902;61875.38124618786;1477.4828809916658;1487.7874532256176;1492.7089217602681;1494.9327280272196;1618.4901755947074;29732.554011689408;29828.552571711007;29929.850350748977;30397.544036839023;30536.389272214874;51151;51168;51854.740726297634;52037.47962520326;52068.21897671462;456903;458727;460129;460418;463967;26608;26760;27029.053983111284;27064;27076.864615676797;44771.55228447674;45364;45589.54410455853;46056;47514.52485475101;29071.27321816887;36033.81983090068;37320.253594928494;37616.05031471656;38208.42687359636;27768.750406231364;36736.26527469382;37005.07487312839;37114;37586.43620345752;36192.27615447729;36469.635303646624;36753.26493470169;36873.81563092167;37129.071773205884;29091;31709;32566.674333256364;32678.856240031484;32793.67206328001;22517.662235066815;24192.637110443004;24687.876560617082;25177.118800841883;25235.11677091293 10:19:19 INFO - PROCESS | 1964 | |2;jquery.html;349.67480243373666;388.9552701439334;395.36149119172535;402.40042336918003;410.7556004177517;18544.629107417844;21336.57326853462;21558.706477611315;21987.780122198772;22048.89755512224;20111;20394.184232630712;20822.687659685118;21208.681869771965;21369.893150534266;5181.818636347729;5690.317161940563;5909.497692696126;5931.169636250928;5937.287525496947;5090.116656836975;5132.28148059272;5812.883742325151;5841;5842.123681447774;5028.597712183035;5558.916616250759;5719.59962802604;5768;5860.179574859523;5096.8277296221895;5511.283533140666;5644.181593668936;5696.2594862668;5810.506106980912;5084.9321642455125;5096.541311282002;5111.361079865017;5119.462456442095;5124.333836601218;22152.667709984362;24586.385340366454;25859.0949316773;25947.481050379076;26706.46587068267;2251.9887400562893;2263.981208456185;2339.9649005264932;2431.5866302728577;2521.646969424282;14657.633559161;14960.62598435037;14979.101253924691;15050.172240526766;15284.159371234578;1722.3024675006643;1754.359658724569;1776.3960253513737;1803.9007854567994;1826.6711991841464;94679.99999999932;115797.84202157955;119504.40247798705;119637.80362196354;120461.5561521654;11047.83428248577;11111.00000999914;11543.595974141033;11631.47658355376;11803.645890623295;13855;14135.43458261658;14193.929030354782;14253.64365890861;14309.21299328526;7491.513051651626;8493.235608795238;8698.391112622056;8851.778705532284;8949.418287811272;8841.115888411108;8880.71229671694;8890.33322500802;8971.50656713874;8997.145271199226;6749.730010799612;6761.830954226184;6835.829104272433;6857.725690972405;6865.656717164122;1749.6238308763677;1751.3782607174523;1937.7190307405629;1950.2881448271562;1968;931.4504442379028;942.7218970403748;998.7403275148514;1024.788120823415;1051.0540513537724;19921.402357929284;20483.283085092247;21299.68050479244;21422.46443838885;21534.676979845313;986.2800155886243;993.7465946183677;1020.9336393134422;1028.3675539543276;1092.1317552545745;11129.276597021168;11326.37704926237;11410.030147437561;11451.656450306504;11718.531258749554;596053;597927;612898;619542.9022854947;621058;107577.38633920497;109217;109886;111865;112039.87960120295;1063.2875973098044;1072.860528131338;1093.005365117755;1097.1935627313917;1101.6474728086935;18589.44231673052;18793.248270069045;18985.860848349144;18994;19009.42971710851;46553.76723116363;48203.75898120627;48690.5130948686;48993.02013959772;49754.502454976435;67409;68276;70086.64956675185;70357;71199;7533.322001019935;7923.6830526778285;7959.08470525897;8135.593220338841;8409.285210757154;11600.245984011011;12780.61658150257;12968.157069790434;13154;13171.07802453819;7773.961130194313;7846.882296765439;7929.444938854225;8464.957675211585;11262.887371126184;5979.671118088547;7561.017067781153;7737.613119344122;7859.371250299848;7903.853941178612;8086;8152.3478121751305;8169.428140030141;8346.165383461605;8466.576671166295;10528.578856845641;11961.222520536485;12374;12659.746805063663;12739.93630031881;11814.291142531476;11842.407879606157;11969.820452693042;12052.216605920587;12152.635420937386 10:19:19 INFO - PROCESS | 1964 | |3;mootools.html;1601.87185025198;1641.7701521786953;1829.9569245530035;1893.3941138835569;1964.1063316191135;8047.91952080479;8494.40539162259;8534.378468091058;8811.295096392289;8827.955860220698;8521.78695532612;8547.230749232567;8636.784080397993;8645.049044605104;8663.870041949376;2426.563218620652;2435.2694191742494;2447.963280550793;2452.717937437191;2460.483298507316;2428.2715185444385;2429.647701083342;2457.508498300338;2460.4709987352717;2460.753924607534;2434.45224824414;2441.084593277521;2454.4232105455203;2458.373114855718;2461.963070553943;2425;2429.7327293997646;2435.659007738918;2448.6082226843796;2452.546278938384;2354.187805207218;2370.78662920338;2413.6017557103055;2426.126594426023;2437.6465412515263;8663.176998185163;8710.608022638997;8747.737567872973;8796.780080498038;8836.955815220947;5166.741662916839;5294.7617357219015;5345.412004679482;5360.624756267063;5383.946160538423;3490.371733088043;3527.523784289114;3542.8759993400363;3584.4085725855202;3617.2584620152807;1015.8882522922546;1020.8468729690532;1029.5212726082332;1036.7097212780434;1039.5841663334652;11368.488418021208;11379.886201137966;11454.427278636118;11465.656030319104;11492.770144597145;4070.4708387909973;4625.537446255347;4631.745254011062;4882.292067650171;4933.0380575788095;9708.466034368037;9713.417194968184;9733.124018838338;9744;9753.658621948198;5237.8428647140645;5240.109181439165;5261.842144735664;5278.287431196739;5328.733563321818;4386.583274588909;4754;4813.4945830687275;4815.686980346266;4891.486393928586;3635.4910312556262;3687.7049836013052;3880.8447662093763;3934.960650393459;4099.569545197771;1173.495396979307;1335.9893360492397;1350.6623344163959;1356.7150898311465;1358.1647286918474;800.6797281087495;877.6138499060393;878.7100256915203;923.9722808315761;934.5655459478128;5571.387147413781;5623.690697011703;5650.97174514133;5805.680687562224;5859.589828711949;436.9643943853025;438.77403137383635;441.39528845481897;446.7319608235033;447.6038705745374;3820.560635526894;3888.6889048876023;3907.8241479133508;3926.2932672118723;3948.407738839197;9160.625906114003;9974.900250997542;10277.691669249934;10587.523561439753;10664.253502254767;9033.548322583845;9230.400023998418;10666.520006599721;10672.78654426907;10690.305130166515;7763.1848655891445;8075.959620201979;8115.8782618260775;8182.795430114175;8185.590720463953;5635.830925072254;5833.970830145992;5842.941570584239;5907.379725128972;5953.28560572734;9804;9811.607535698779;9897.703068907944;9949.502524873582;10058.748531286776;8643.783905402415;9923.057309555581;9946;9984.850227246452;9996;6761.3238676132;7108.395786358011;7186.496945213785;7310.415166786751;7509.5869727163345;7395.18652948186;8142.104368519576;8175.7138500152205;8237.83524329522;8275.296599789086;6086.878262434638;7267.927320726936;7310.378617817545;7339.009233753375;7489.700411983677;5970.820875373745;7101.254368291255;7186.24544422849;7220.241874603091;7327.230640782641;6857.794266172023;6967.268436814062;6993.440524757905;6994.090768200102;6996.160460744743;4726.220173671443;4761.214399624023;4784.545468180518;4816.710997340171;4827.275908613736;4690.179218636793;4728.219843725747;4761.166795810788;4775;4778.450478195052 10:19:19 INFO - PROCESS | 1964 | |4;prototype.html;307.87684926029584;318.06330357098346;324.5845317992969;326.3375348043473;326.9771116021878;5945.167676525279;5968.373320801318;6126.20359353284;6227.657478838668;6244.625322480654;5366.517013468787;5855.824325270238;6064.241969753781;6133.50931925446;6138.508919286458;4559.817607295704;4583.839565615204;4585.908281834353;4595.149897269016;4598.264277715566;3797.841658294219;4162.605527148409;4444.444444444444;4584.564466375689;4608.769561521927;3530.5763308402898;4170.520390155126;4459.955400446002;4528.501864794886;4565.908681826361;3750.9624903750887;4534.093181363724;4556.749378784166;4562.041971186055;4582.587567118942;3811.123441608446;3842.2507611015862;3913.5695073541888;3937.3897045957924;3938.6455219030427;5057.721825299607;5733.971330143323;5802.274715660543;5827.125931110325;5845.181674565564;4215.768132752697;5287.762050707727;5312.043832110218;5326.840194794162;5329.2006199070065;4945.315739773856;5062.443131255559;6290.874182516324;6442.259140198843;6553.377429144271;4345.717528360647;4392.363107349448;4412;4419;4458.621017213541;6548.9017664735065;6851.383375496229;6887.2079710833395;6912.997615345797;6955.374016338554;3862.0344913771555;4200.978995105005;4431.003024319567;4473.329000649928;4486.66350023743;4451.532589078165;4523.208438523246;4533.38799262102;4555.703879247838;4571.9085618287445;5320.787168513216;5338.733063346817;5366.141417373279;5377.8117765878005;5378.058839703036;5884.057391790916;6147.877042459126;6293.653849038255;6533.738650453929;6546.869062618816;1359.9800149887585;1406.4936622815778;1471.529110684592;1582.7625856121674;1589.841015898424;977.2182254196756;1009.9040591143829;1021.5085974477346;1039.4854546999134;1053.1732589916878;5908.852278693067;5999.670018148957;6007.879842403127;6018.849528761816;6046.879062418727;6365.809025729235;6714.4749006771835;6714.832129196711;6721.596704197764;6782.118324617768;5014.323066386064;5579.163125531121;5793.362730099686;5851.941480585225;5999.700014999233;3055.251463391439;3511.8068506231893;3547.403668349253;3566.1619519412916;3573.535440392732;6825.215100263434;6896.586204827727;7028.0863487746265;7030.402415794715;7079.362857342864;5826.970865145647;6660.134182556237;6875.037494750739;6910.654467276616;6986.825329366807;6802.591844489248;6873.656317184121;6990.09128813251;7035.788926332219;7045.195594378978;6602.273749887412;6619.867602647823;6641.568298060611;6646.235682896336;6657.53397262187;5399.83800485986;6272.310045895039;6484.5460817742305;6579.2104947406615;6640.236372816995;6961.721531138698;7001.859962800613;7011.368976792113;7052.753153639598;7060.8940865886025;4429.844955426544;4433.802873224147;4437.911241775211;4461.910761784811;4462.732236065846;6326.06566877836;6465.967670161619;6666.200055993312;6714.160729908762;6805.183377994672;5777.653340799566;6582.539222254396;6586.835329116619;6591.571547849375;6605.405513503808;5457.045017122067;6152.07776306251;6194;6337.7781777637565;6600.768973085919;6436.581622194542;6447.290798012121;6454.870902581828;6466.838329041811;6480.773172938924;5493.917591236214;6546.672666366758;6597.27429982692;6603.108580341593;6625.469962403093;5196.870078248074;5914.19617016814;6353.14232578596;6404.007378856285;6456.967715161394 10:19:19 INFO - PROCESS | 1964 | |5;yui.html;662.9668516574174;668.1214203322631;703.2440126863623;719.5035425556366;735.5990984913221;14915.552533423988;15373.308201130949;15396.538103856888;15404;16399.427059502257;16055.197240137975;16083.919580402082;16105.677886442265;16139.094962906673;16201.83798162018;908.5048648486575;910.6311943662827;916.9174774270315;917.6100157433098;919.237033262394;601.681109012222;813.5525460996429;882.1663527966075;913.4154141349542;913.9131782480654;938.8310104181245;957.4016239850093;960.9759756006085;965.75856035991;966.6085235479642;948.1892981500821;954.5275088831038;955.049725523102;959.1559427703576;960.4573416019927;705.3757424679145;714.8963400306978;715.3597530210485;719.126261592168;724.5000949344935;15160.620984475367;15403.768943465857;15507.069575825486;15657.921710391374;15766.975146615549;12662.55681051168;12684;12699;12701.301428421433;12829.486820527167;10014.59941602335;10027.899721002843;10182.18542516597;10508.159347252202;10586.36481811086;2971.9598140650814;3440.36353274645;3465.203003309253;3582.408902531079;3599.31612993533;81252.59373703094;82065.35869282641;82195;82248.17751822465;82659.58670206611;9399.718008459757;9412.105849944244;9424;9607.087326703951;9662.661806836726;21098.367048988246;21117.366479005654;21233.36299911005;21392;21580.352589422342;6526.543141980016;7311.707531698778;7458.589777562286;7515.323620874038;7516.098068231847;4088.6115818997146;4097.221527909687;4170.624643782075;4210.85262015828;4246;3581.3374525712825;3656.451532270181;3660.066682995819;3695.519582454264;3695.5565332160313;590.271015296109;614.714157916562;641.563736659067;642.6176425027102;660.131926516629;507.5406756884951;529.317180836724;542.1055258822895;602.0475577831522;608.0726891490513;7763.4953728007495;7832.373410127176;7872.252136047066;8120.269175774209;8213.54825484604;518.199381954873;533.8318429694634;552.8037546670954;570.6021040952635;591.3642833953517;3758.3972356572317;3788.5453745550712;3790.3935370340614;3900.0249937515623;3907.2185562886966;86478.56760716156;87709.12290877009;89160.5541972299;90081;90847.09152908518;71211.57576848434;72256.277437226;72617.54764904673;73420.16449588804;73747.63126184442;39511;64996.186839862494;66371;68405.97391039139;68589.65705171443;7481.289277518627;7599.1261004982925;7611.961940190264;7672.808179795326;7750.612469376621;42517.787411062745;42997;43393.566064340215;43608;43811;50094;56037;56070.71964640151;57030.7148464255;57288;10645.159692257354;10647.574097036342;10768.569257229623;10839.349639021684;10923.890761092605;11764.470598823245;11863.76272474563;11867.58463453775;11926.284422934652;11976.221545599508;9316.48759318244;11154.219204655596;11463.885361146282;11619.5352185915;11799.646010619696;10965.122790176927;11366.715832104264;11434.970852622972;11504.827427588425;11746.482251359308;10841.566337346734;11532.135089868461;11574.6527604172;11878.762424751629;12256.754864902474;9464.858027129736;9465.574049167666;9858.457784821903;9940.850887236553;9944.254180936603;9519.143277105093;9614.326997110134;9719.708408747749;9844.803103938024;9887.653932112342 10:19:19 INFO - PROCESS | 1964 | __end_tp_report 10:19:19 INFO - PROCESS | 1964 | __start_cc_report 10:19:19 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,378 10:19:19 INFO - PROCESS | 1964 | __end_cc_report 10:19:19 INFO - PROCESS | 1964 | __startTimestamp1460654359601__endTimestamp 10:19:19 INFO - PROCESS | 1964 | 10:19:19 INFO - PROCESS | 1964 | ------- Summary: start ------- 10:19:19 INFO - PROCESS | 1964 | Number of tests: 6 10:19:19 INFO - PROCESS | 1964 | 10:19:19 INFO - PROCESS | 1964 | [#0] dojo.html Cycles:165 Average:5719.32 Median:6043.24 stddev:788.53 (13.0%) stddev-sans-first:759.55 10:19:19 INFO - PROCESS | 1964 | Values: 2910.9 3416.6 3444.3 3504.2 3557.0 5765.7 5766.3 5791.8 5799.4 5805.7 4725.4 5658.5 5802.2 5867.8 5885.4 4315.8 5223.2 5238.9 5297.4 5340.4 241.0 5185.2 5273.2 5279.8 5290.2 4540.3 4608.7 5235.3 5281.3 5311.3 5113.8 5281.2 5305.3 5313.5 5372.7 5114.1 5194.3 5213.6 5261.7 5309.2 5607.3 5725.2 5751.3 5759.7 5790.6 6119.5 6123.0 6175.6 6177.0 6202.9 6138.3 6206.3 6240.3 6246.0 6247.6 5051.5 5874.4 5937.0 5986.4 5993.4 6233.8 6297.6 6373.6 6389.6 6398.4 6101.7 6126.9 6166.3 6171.3 6173.3 6194.2 6220.8 6227.5 6268.7 6287.7 6135.0 6143.5 6167.5 6202.4 6218.9 6140.0 6146.7 6172.5 6178.2 6179.5 4951.7 4979.9 4980.9 5000.6 5009.3 4339.9 4422.1 4443.4 4485.4 4591.2 5674.0 5827.5 5854.4 5925.8 5945.0 6247.3 6262.4 6272.5 6276.8 6296.7 5735.4 5828.1 5887.3 5924.6 5984.7 5430.6 5447.9 5448.9 5450.1 5456.7 6398.8 6412.5 6419.4 6439.9 6445.2 6063.2 6150.4 6209.8 6234.6 6256.6 5414.9 5596.9 6416.4 6452.4 6481.9 6119.6 6180.1 6193.5 6252.4 6258.5 6179.5 6181.8 6275.6 6301.8 6332.4 6043.2 6098.8 6104.1 6104.5 6126.0 6023.3 6050.3 6074.3 6101.4 6120.6 5923.2 6085.8 6086.7 6106.2 6118.9 6128.5 6136.9 6165.9 6176.4 6186.9 5008.4 5942.6 6039.6 6061.9 6113.3 10:19:19 INFO - PROCESS | 1964 | 10:19:19 INFO - PROCESS | 1964 | [#1] ext.html Cycles:180 Average:61936.19 Median:36113.05 stddev:139393.64 (386.0%) stddev-sans-first:139708.28 10:19:19 INFO - PROCESS | 1964 | Values: 469.6 471.2 475.9 501.3 526.6 38661.4 39231.2 39660.6 39687.8 39747.8 40545.0 40990.8 41598.4 41769.8 41953.7 9412.8 9534.3 9639.5 9657.0 9689.3 9569.2 9595.5 9596.8 9682.3 9696.6 9616.8 9617.0 9656.0 9710.9 9749.7 9568.6 9576.8 9581.8 9637.7 9667.3 9521.7 9581.7 9643.9 9644.4 9670.0 37196.3 37676.4 37684.9 37744.2 38304.6 2786.7 2982.0 3001.3 3346.2 3387.4 25864.0 26769.7 27290.6 27445.0 27554.6 2642.3 2755.8 2761.2 2855.1 2871.5 291205.0 293703.0 345649.0 348172.0 351753.0 32357.0 35000.0 36005.9 57452.7 58327.4 34863.0 35251.8 35376.5 35496.6 35513.8 12836.5 14984.8 15042.5 15339.4 15402.9 12628.6 12871.9 12961.2 12976.7 12993.6 7915.8 8096.5 8123.9 8198.2 8219.3 3358.7 3382.8 3402.8 3407.0 3409.4 1040.0 1068.3 1068.8 1086.0 1089.9 29210.4 29281.1 29455.8 29557.3 29858.9 1075.5 1089.6 1091.6 1096.3 1122.4 15231.0 15248.2 15275.0 15766.5 15790.2 623125.0 698337.0 717200.0 725502.0 725638.0 57788.0 60131.0 61491.8 61734.1 61875.4 1477.5 1487.8 1492.7 1494.9 1618.5 29732.6 29828.6 29929.9 30397.5 30536.4 51151.0 51168.0 51854.7 52037.5 52068.2 456903.0 458727.0 460129.0 460418.0 463967.0 26608.0 26760.0 27029.1 27064.0 27076.9 44771.6 45364.0 45589.5 46056.0 47514.5 29071.3 36033.8 37320.3 37616.1 38208.4 27768.8 36736.3 37005.1 37114.0 37586.4 36192.3 36469.6 36753.3 36873.8 37129.1 29091.0 31709.0 32566.7 32678.9 32793.7 22517.7 24192.6 24687.9 25177.1 25235.1 10:19:19 INFO - PROCESS | 1964 | 10:19:19 INFO - PROCESS | 1964 | [#2] jquery.html Cycles:180 Average:34459.39 Median:13554.02 stddev:101017.10 (745.3%) stddev-sans-first:101268.02 10:19:19 INFO - PROCESS | 1964 | Values: 349.7 389.0 395.4 402.4 410.8 18544.6 21336.6 21558.7 21987.8 22048.9 20111.0 20394.2 20822.7 21208.7 21369.9 5181.8 5690.3 5909.5 5931.2 5937.3 5090.1 5132.3 5812.9 5841.0 5842.1 5028.6 5558.9 5719.6 5768.0 5860.2 5096.8 5511.3 5644.2 5696.3 5810.5 5084.9 5096.5 5111.4 5119.5 5124.3 22152.7 24586.4 25859.1 25947.5 26706.5 2252.0 2264.0 2340.0 2431.6 2521.6 14657.6 14960.6 14979.1 15050.2 15284.2 1722.3 1754.4 1776.4 1803.9 1826.7 94680.0 115797.8 119504.4 119637.8 120461.6 11047.8 11111.0 11543.6 11631.5 11803.6 13855.0 14135.4 14193.9 14253.6 14309.2 7491.5 8493.2 8698.4 8851.8 8949.4 8841.1 8880.7 8890.3 8971.5 8997.1 6749.7 6761.8 6835.8 6857.7 6865.7 1749.6 1751.4 1937.7 1950.3 1968.0 931.5 942.7 998.7 1024.8 1051.1 19921.4 20483.3 21299.7 21422.5 21534.7 986.3 993.7 1020.9 1028.4 1092.1 11129.3 11326.4 11410.0 11451.7 11718.5 596053.0 597927.0 612898.0 619542.9 621058.0 107577.4 109217.0 109886.0 111865.0 112039.9 1063.3 1072.9 1093.0 1097.2 1101.6 18589.4 18793.2 18985.9 18994.0 19009.4 46553.8 48203.8 48690.5 48993.0 49754.5 67409.0 68276.0 70086.6 70357.0 71199.0 7533.3 7923.7 7959.1 8135.6 8409.3 11600.2 12780.6 12968.2 13154.0 13171.1 7774.0 7846.9 7929.4 8465.0 11262.9 5979.7 7561.0 7737.6 7859.4 7903.9 8086.0 8152.3 8169.4 8346.2 8466.6 10528.6 11961.2 12374.0 12659.7 12739.9 11814.3 11842.4 11969.8 12052.2 12152.6 10:19:19 INFO - PROCESS | 1964 | 10:19:19 INFO - PROCESS | 1964 | [#3] mootools.html Cycles:180 Average:5586.20 Median:4912.26 stddev:3096.75 (63.0%) stddev-sans-first:3090.97 10:19:19 INFO - PROCESS | 1964 | Values: 1601.9 1641.8 1830.0 1893.4 1964.1 8047.9 8494.4 8534.4 8811.3 8828.0 8521.8 8547.2 8636.8 8645.0 8663.9 2426.6 2435.3 2448.0 2452.7 2460.5 2428.3 2429.6 2457.5 2460.5 2460.8 2434.5 2441.1 2454.4 2458.4 2462.0 2425.0 2429.7 2435.7 2448.6 2452.5 2354.2 2370.8 2413.6 2426.1 2437.6 8663.2 8710.6 8747.7 8796.8 8837.0 5166.7 5294.8 5345.4 5360.6 5383.9 3490.4 3527.5 3542.9 3584.4 3617.3 1015.9 1020.8 1029.5 1036.7 1039.6 11368.5 11379.9 11454.4 11465.7 11492.8 4070.5 4625.5 4631.7 4882.3 4933.0 9708.5 9713.4 9733.1 9744.0 9753.7 5237.8 5240.1 5261.8 5278.3 5328.7 4386.6 4754.0 4813.5 4815.7 4891.5 3635.5 3687.7 3880.8 3935.0 4099.6 1173.5 1336.0 1350.7 1356.7 1358.2 800.7 877.6 878.7 924.0 934.6 5571.4 5623.7 5651.0 5805.7 5859.6 437.0 438.8 441.4 446.7 447.6 3820.6 3888.7 3907.8 3926.3 3948.4 9160.6 9974.9 10277.7 10587.5 10664.3 9033.5 9230.4 10666.5 10672.8 10690.3 7763.2 8076.0 8115.9 8182.8 8185.6 5635.8 5834.0 5842.9 5907.4 5953.3 9804.0 9811.6 9897.7 9949.5 10058.7 8643.8 9923.1 9946.0 9984.9 9996.0 6761.3 7108.4 7186.5 7310.4 7509.6 7395.2 8142.1 8175.7 8237.8 8275.3 6086.9 7267.9 7310.4 7339.0 7489.7 5970.8 7101.3 7186.2 7220.2 7327.2 6857.8 6967.3 6993.4 6994.1 6996.2 4726.2 4761.2 4784.5 4816.7 4827.3 4690.2 4728.2 4761.2 4775.0 4778.5 10:19:19 INFO - PROCESS | 1964 | 10:19:19 INFO - PROCESS | 1964 | [#4] prototype.html Cycles:180 Average:5259.59 Median:5848.56 stddev:1665.30 (28.5%) stddev-sans-first:1627.97 10:19:19 INFO - PROCESS | 1964 | Values: 307.9 318.1 324.6 326.3 327.0 5945.2 5968.4 6126.2 6227.7 6244.6 5366.5 5855.8 6064.2 6133.5 6138.5 4559.8 4583.8 4585.9 4595.1 4598.3 3797.8 4162.6 4444.4 4584.6 4608.8 3530.6 4170.5 4460.0 4528.5 4565.9 3751.0 4534.1 4556.7 4562.0 4582.6 3811.1 3842.3 3913.6 3937.4 3938.6 5057.7 5734.0 5802.3 5827.1 5845.2 4215.8 5287.8 5312.0 5326.8 5329.2 4945.3 5062.4 6290.9 6442.3 6553.4 4345.7 4392.4 4412.0 4419.0 4458.6 6548.9 6851.4 6887.2 6913.0 6955.4 3862.0 4201.0 4431.0 4473.3 4486.7 4451.5 4523.2 4533.4 4555.7 4571.9 5320.8 5338.7 5366.1 5377.8 5378.1 5884.1 6147.9 6293.7 6533.7 6546.9 1360.0 1406.5 1471.5 1582.8 1589.8 977.2 1009.9 1021.5 1039.5 1053.2 5908.9 5999.7 6007.9 6018.8 6046.9 6365.8 6714.5 6714.8 6721.6 6782.1 5014.3 5579.2 5793.4 5851.9 5999.7 3055.3 3511.8 3547.4 3566.2 3573.5 6825.2 6896.6 7028.1 7030.4 7079.4 5827.0 6660.1 6875.0 6910.7 6986.8 6802.6 6873.7 6990.1 7035.8 7045.2 6602.3 6619.9 6641.6 6646.2 6657.5 5399.8 6272.3 6484.5 6579.2 6640.2 6961.7 7001.9 7011.4 7052.8 7060.9 4429.8 4433.8 4437.9 4461.9 4462.7 6326.1 6466.0 6666.2 6714.2 6805.2 5777.7 6582.5 6586.8 6591.6 6605.4 5457.0 6152.1 6194.0 6337.8 6600.8 6436.6 6447.3 6454.9 6466.8 6480.8 5493.9 6546.7 6597.3 6603.1 6625.5 5196.9 5914.2 6353.1 6404.0 6457.0 10:19:19 INFO - PROCESS | 1964 | 10:19:19 INFO - PROCESS | 1964 | [#5] yui.html Cycles:180 Average:17375.52 Median:57159.36 stddev:23942.04 (41.9%) stddev-sans-first:23976.31 10:19:19 INFO - PROCESS | 1964 | Values: 663.0 668.1 703.2 719.5 735.6 14915.6 15373.3 15396.5 15404.0 16399.4 16055.2 16083.9 16105.7 16139.1 16201.8 908.5 910.6 916.9 917.6 919.2 601.7 813.6 882.2 913.4 913.9 938.8 957.4 961.0 965.8 966.6 948.2 954.5 955.0 959.2 960.5 705.4 714.9 715.4 719.1 724.5 15160.6 15403.8 15507.1 15657.9 15767.0 12662.6 12684.0 12699.0 12701.3 12829.5 10014.6 10027.9 10182.2 10508.2 10586.4 2972.0 3440.4 3465.2 3582.4 3599.3 81252.6 82065.4 82195.0 82248.2 82659.6 9399.7 9412.1 9424.0 9607.1 9662.7 21098.4 21117.4 21233.4 21392.0 21580.4 6526.5 7311.7 7458.6 7515.3 7516.1 4088.6 4097.2 4170.6 4210.9 4246.0 3581.3 3656.5 3660.1 3695.5 3695.6 590.3 614.7 641.6 642.6 660.1 507.5 529.3 542.1 602.0 608.1 7763.5 7832.4 7872.3 8120.3 8213.5 518.2 533.8 552.8 570.6 591.4 3758.4 3788.5 3790.4 3900.0 3907.2 86478.6 87709.1 89160.6 90081.0 90847.1 71211.6 72256.3 72617.5 73420.2 73747.6 39511.0 64996.2 66371.0 68406.0 68589.7 7481.3 7599.1 7612.0 7672.8 7750.6 42517.8 42997.0 43393.6 43608.0 43811.0 50094.0 56037.0 56070.7 57030.7 57288.0 10645.2 10647.6 10768.6 10839.3 10923.9 11764.5 11863.8 11867.6 11926.3 11976.2 9316.5 11154.2 11463.9 11619.5 11799.6 10965.1 11366.7 11435.0 11504.8 11746.5 10841.6 11532.1 11574.7 11878.8 12256.8 9464.9 9465.6 9858.5 9940.9 9944.3 9519.1 9614.3 9719.7 9844.8 9887.7 10:19:19 INFO - PROCESS | 1964 | -------- Summary: end -------- 10:19:19 INFO - PROCESS | 1964 | 10:19:20 INFO - TEST-INFO | 1964: exit 0 10:19:20 INFO - TEST-OK | dromaeo_css | took 1111175ms 10:19:20 INFO - TEST-START | kraken 10:19:20 INFO - operating with platform_type : mac_ 10:19:20 INFO - Initialising browser for kraken test... 10:19:20 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpWq0J17/profile http://localhost:57175/getInfo.html) 10:19:22 INFO - PROCESS | 1969 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 10:19:22 INFO - PROCESS | 1969 | __metrics Screen width/height:1600/1200 10:19:22 INFO - PROCESS | 1969 | colorDepth:24 10:19:22 INFO - PROCESS | 1969 | Browser inner width/height: 1024/689 10:19:22 INFO - PROCESS | 1969 | __metrics 10:19:23 ERROR - PROCESS | 1969 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:19:23 INFO - TEST-INFO | 1969: exit 0 10:19:23 INFO - Browser initialized. 10:19:23 INFO - Running cycle 1/1 for kraken test... 10:19:23 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpWq0J17/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:35 INFO - PROCESS | 1972 | RSS: Main: 247754752 10:19:35 INFO - PROCESS | 1972 | 10:19:38 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57175/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:39 INFO - PROCESS | 1972 | RSS: Main: 260063232 10:19:39 INFO - PROCESS | 1972 | 10:19:41 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57175/tests/kraken/driver.html?testName=audio-dft) 10:19:42 INFO - PROCESS | 1972 | RSS: Main: 269021184 10:19:42 INFO - PROCESS | 1972 | 10:19:46 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57175/tests/kraken/driver.html?testName=audio-fft) 10:19:46 INFO - PROCESS | 1972 | RSS: Main: 272019456 10:19:46 INFO - PROCESS | 1972 | 10:19:48 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57175/tests/kraken/driver.html?testName=audio-oscillator) 10:19:49 INFO - PROCESS | 1972 | RSS: Main: 273993728 10:19:49 INFO - PROCESS | 1972 | 10:19:51 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57175/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:51 INFO - PROCESS | 1972 | RSS: Main: 274468864 10:19:51 INFO - PROCESS | 1972 | 10:19:54 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57175/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:55 INFO - PROCESS | 1972 | RSS: Main: 274710528 10:19:55 INFO - PROCESS | 1972 | 10:19:58 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57175/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:59 INFO - PROCESS | 1972 | RSS: Main: 274812928 10:19:59 INFO - PROCESS | 1972 | 10:20:02 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57175/tests/kraken/driver.html?testName=json-parse-financial) 10:20:02 INFO - PROCESS | 1972 | RSS: Main: 275214336 10:20:02 INFO - PROCESS | 1972 | 10:20:04 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57175/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:04 INFO - PROCESS | 1972 | RSS: Main: 274759680 10:20:04 INFO - PROCESS | 1972 | 10:20:06 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57175/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:07 INFO - PROCESS | 1972 | RSS: Main: 274903040 10:20:07 INFO - PROCESS | 1972 | 10:20:09 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57175/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:10 INFO - PROCESS | 1972 | RSS: Main: 275177472 10:20:10 INFO - PROCESS | 1972 | 10:20:13 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:13 INFO - PROCESS | 1972 | RSS: Main: 275439616 10:20:13 INFO - PROCESS | 1972 | 10:20:16 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:17 INFO - PROCESS | 1972 | RSS: Main: 275505152 10:20:17 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:57175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57175/tests/kraken/driver.html?testName=ai-astar) 10:20:19 INFO - PROCESS | 1972 | RSS: Main: 277098496 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | __start_tp_report 10:20:19 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 10:20:19 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 10:20:19 INFO - PROCESS | 1972 | |i|pagename|runs| 10:20:19 INFO - PROCESS | 1972 | |0;ai-astar;116;113;130;170;106;176;168;154;117;118 10:20:19 INFO - PROCESS | 1972 | |1;audio-beat-detection;155;124;145;166;126;143;143;117;171;127 10:20:19 INFO - PROCESS | 1972 | |2;audio-dft;199;234;189;234;251;274;201;200;200;196 10:20:19 INFO - PROCESS | 1972 | |3;audio-fft;69;83;73;132;56;56;62;65;73;56 10:20:19 INFO - PROCESS | 1972 | |4;audio-oscillator;77;82;128;77;79;84;120;78;77;121 10:20:19 INFO - PROCESS | 1972 | |5;imaging-gaussian-blur;118;128;93;88;127;86;111;88;90;90 10:20:19 INFO - PROCESS | 1972 | |6;imaging-darkroom;95;96;100;141;150;111;108;150;129;95 10:20:19 INFO - PROCESS | 1972 | |7;imaging-desaturate;92;95;92;94;92;93;92;96;93;134 10:20:19 INFO - PROCESS | 1972 | |8;json-parse-financial;60;62;61;61;62;63;62;76;65;60 10:20:19 INFO - PROCESS | 1972 | |9;json-stringify-tinderbox;66;70;84;73;74;74;75;65;67;71 10:20:19 INFO - PROCESS | 1972 | |10;stanford-crypto-aes;90;88;96;114;112;84;89;84;96;115 10:20:19 INFO - PROCESS | 1972 | |11;stanford-crypto-ccm;146;143;158;170;175;150;168;159;180;148 10:20:19 INFO - PROCESS | 1972 | |12;stanford-crypto-pbkdf2;171;173;169;174;173;170;175;178;169;169 10:20:19 INFO - PROCESS | 1972 | |13;stanford-crypto-sha256-iterative;68;68;70;69;67;70;69;66;70;69 10:20:19 INFO - PROCESS | 1972 | __end_tp_report 10:20:19 INFO - PROCESS | 1972 | __start_cc_report 10:20:19 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,971 10:20:19 INFO - PROCESS | 1972 | __end_cc_report 10:20:19 INFO - PROCESS | 1972 | __startTimestamp1460654419322__endTimestamp 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | ------- Summary: start ------- 10:20:19 INFO - PROCESS | 1972 | Number of tests: 14 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#0] ai-astar Cycles:10 Average:136.80 Median:142.00 stddev:27.18 (19.1%) stddev-sans-first:27.76 10:20:19 INFO - PROCESS | 1972 | Values: 116.0 113.0 130.0 170.0 106.0 176.0 168.0 154.0 117.0 118.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:144.00 stddev:18.34 (12.7%) stddev-sans-first:18.81 10:20:19 INFO - PROCESS | 1972 | Values: 155.0 124.0 145.0 166.0 126.0 143.0 143.0 117.0 171.0 127.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#2] audio-dft Cycles:10 Average:217.80 Median:217.50 stddev:28.60 (13.1%) stddev-sans-first:29.51 10:20:19 INFO - PROCESS | 1972 | Values: 199.0 234.0 189.0 234.0 251.0 274.0 201.0 200.0 200.0 196.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#3] audio-fft Cycles:10 Average:72.50 Median:67.00 stddev:22.72 (33.9%) stddev-sans-first:24.06 10:20:19 INFO - PROCESS | 1972 | Values: 69.0 83.0 73.0 132.0 56.0 56.0 62.0 65.0 73.0 56.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:77.50 stddev:21.41 (27.6%) stddev-sans-first:21.98 10:20:19 INFO - PROCESS | 1972 | Values: 77.0 82.0 128.0 77.0 79.0 84.0 120.0 78.0 77.0 121.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#5] imaging-gaussian-blur Cycles:10 Average:101.90 Median:88.00 stddev:17.18 (19.5%) stddev-sans-first:17.20 10:20:19 INFO - PROCESS | 1972 | Values: 118.0 128.0 93.0 88.0 127.0 86.0 111.0 88.0 90.0 90.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#6] imaging-darkroom Cycles:10 Average:117.50 Median:150.00 stddev:22.88 (15.3%) stddev-sans-first:22.77 10:20:19 INFO - PROCESS | 1972 | Values: 95.0 96.0 100.0 141.0 150.0 111.0 108.0 150.0 129.0 95.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:93.00 stddev:12.97 (13.9%) stddev-sans-first:13.61 10:20:19 INFO - PROCESS | 1972 | Values: 92.0 95.0 92.0 94.0 92.0 93.0 92.0 96.0 93.0 134.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:62.00 stddev:4.73 (7.6%) stddev-sans-first:4.88 10:20:19 INFO - PROCESS | 1972 | Values: 60.0 62.0 61.0 61.0 62.0 63.0 62.0 76.0 65.0 60.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:73.50 stddev:5.55 (7.5%) stddev-sans-first:5.46 10:20:19 INFO - PROCESS | 1972 | Values: 66.0 70.0 84.0 73.0 74.0 74.0 75.0 65.0 67.0 71.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:88.50 stddev:12.35 (13.9%) stddev-sans-first:12.85 10:20:19 INFO - PROCESS | 1972 | Values: 90.0 88.0 96.0 114.0 112.0 84.0 89.0 84.0 96.0 115.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#11] stanford-crypto-ccm Cycles:10 Average:159.70 Median:163.50 stddev:13.00 (8.0%) stddev-sans-first:12.81 10:20:19 INFO - PROCESS | 1972 | Values: 146.0 143.0 158.0 170.0 175.0 150.0 168.0 159.0 180.0 148.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.00 stddev:3.03 (1.8%) stddev-sans-first:3.19 10:20:19 INFO - PROCESS | 1972 | Values: 171.0 173.0 169.0 174.0 173.0 170.0 175.0 178.0 169.0 169.0 10:20:19 INFO - PROCESS | 1972 | 10:20:19 INFO - PROCESS | 1972 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.35 (2.0%) stddev-sans-first:1.41 10:20:19 INFO - PROCESS | 1972 | Values: 68.0 68.0 70.0 69.0 67.0 70.0 69.0 66.0 70.0 69.0 10:20:19 INFO - PROCESS | 1972 | -------- Summary: end -------- 10:20:19 INFO - PROCESS | 1972 | 10:20:20 INFO - TEST-INFO | 1972: exit 0 10:20:20 INFO - TEST-OK | kraken | took 60003ms 10:20:20 INFO - SUITE-END | took 1171s 10:20:20 INFO - Completed test suite (00:19:31) 10:20:20 INFO - javascript benchmark 10:20:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2910.9272268193295, 3416.624171341152, 3444.328355970585, 3504.2465869837997, 3557.039599308185, 5765.740541675625, 5766.279215098113, 5791.8262452126455, 5799.420057994198, 5805.680687562182, 4725.362076119723, 5658.547316214704, 5802.187693722883, 5867.823965281038, 5885.352611212763, 4315.762633055181, 5223.164293713006, 5238.895222095556, 5297.390800057985, 5340.385855626594, 241.0320994498442, 5185.222216667511, 5273.1826566882, 5279.788808447657, 5290.1800220965815, 4540.27355623102, 4608.677392582521, 5235.345581802275, 5281.339832520935, 5311.282976798141, 5113.769880355356, 5281.181416880351, 5305.283786688825, 5313.495217954288, 5372.7313634318125, 5114.079465696173, 5194.298769666085, 5213.6089793265655, 5261.710605916673, 5309.230161626581, 5607.299087614048, 5725.198472213893, 5751.252337196138, 5759.65442073477, 5790.565707571949, 6119.5104391648565, 6122.96938515309, 6175.5985860919345, 6176.969115154396, 6202.937970620281, 6138.32709113608, 6206.317305096436, 6240.31356550779, 6245.968770156165, 6247.5939063960695, 5051.52010559, 5874.441928016831, 5937.020391635375, 5986.431289027535, 5993.430624090704, 6233.781817636361, 6297.559170857996, 6373.553851230462, 6389.552731308764, 6398.392152745481, 6101.731934812992, 6126.914660831478, 6166.321704612489, 6171.290301615282, 6173.32093469718, 6194.225721784777, 6220.813375598739, 6227.470664993526, 6268.717907694074, 6287.654179020198, 6135.04893764628, 6143.511877689543, 6167.537434692416, 6202.379762023762, 6218.906716399167, 6140.017597184429, 6146.7233974471255, 6172.506199504029, 6178.227721534809, 6179.474744646665, 4951.72765497901, 4979.875503112451, 4980.875478113004, 5000.599952003831, 5009.323741294951, 4339.934900976488, 4422.071365013383, 4443.4445694288215, 4485.416895803524, 4591.242444996538, 5673.971630141906, 5827.533797296206, 5854.414558544111, 5925.792597259161, 5944.970275148683, 6247.312795592481, 6262.436380725757, 6272.466840318532, 6276.811695649138, 6296.6851657417865, 5735.426457354231, 5828.125781132864, 5887.293524776968, 5924.6149000314845, 5984.700764961822, 5430.619856609999, 5447.863803404867, 5448.891022179534, 5450.127979523258, 5456.727163641802, 6398.808035758934, 6412.487001039813, 6419.422251997343, 6439.871202575922, 6445.16212892321, 6063.151158837678, 6150.415710507495, 6209.844753881189, 6234.625922444668, 6256.624602523863, 5414.891702166014, 5596.944030559643, 6416.390442907917, 6452.35476452351, 6481.8703625928165, 6119.571629985859, 6180.066617468195, 6193.473554747897, 6252.406021427957, 6258.468030217483, 6179.474744646575, 6181.752729890754, 6275.560710750204, 6301.779437719658, 6332.366763323815, 6043.244594425697, 6098.75604975796, 6104.053871649901, 6104.511639068953, 6125.9693701531205, 6023.337432882292, 6050.30421501533, 6074.3318234994995, 6101.389861013863, 6120.60216085953, 5923.229980102731, 6085.756569737161, 6086.72609732572, 6106.236720409949, 6118.938810612015, 6128.509719222362, 6136.907946380718, 6165.938340616716, 6176.3514830943905, 6186.907196391968, 5008.373953255843, 5942.64344139353, 6039.607425517327, 6061.878762424639, 6113.327533971171], "value": 5671.413127245726, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.60083928660634, 471.1683877955409, 475.8834085649015, 501.32071043735715, 526.5866294958458, 38661.420078698844, 39231.21537569254, 39660.60339396605, 39687.80156099219, 39747.80126099373, 40545.0, 40990.770276891664, 41598.376024359655, 41769.79115104428, 41953.74138775834, 9412.81174376512, 9534.284928630346, 9639.518024098803, 9656.951715241414, 9689.273304502156, 9569.234461243119, 9595.472249026301, 9596.808063838718, 9682.273829462783, 9696.612135514571, 9616.759581010496, 9617.038296170396, 9656.034396560322, 9710.854337184948, 9749.658761943334, 9568.56941437637, 9576.808463830685, 9581.808363832719, 9637.662681806174, 9667.323287369853, 9521.714348569554, 9581.664641737505, 9643.855342169873, 9644.373115747454, 9669.951650241774, 37196.25607487862, 37676.43485347722, 37684.86945391643, 37744.245115097816, 38304.61695383038, 2786.70739572344, 2982.0, 3001.264690150905, 3346.2303670155757, 3387.4072037393603, 25863.965441382323, 26769.73230267692, 27290.5906411404, 27445.0, 27554.5866811998, 2642.3129986203726, 2755.779537636984, 2761.240658818841, 2855.072101566999, 2871.454423659498, 291205.0, 293702.99999999785, 345649.0, 348172.0, 351753.0, 32357.029289121365, 35000.0, 36005.93949514268, 57452.71273643605, 58327.4167258322, 34862.9541113767, 35251.82374088113, 35376.46935295973, 35496.645033549335, 35513.8224308882, 12836.48654053846, 14984.775228371584, 15042.548723538312, 15339.386424543116, 15402.922985385001, 12628.558000469939, 12871.871281287255, 12961.22232666043, 12976.740465190644, 12993.610191694264, 7915.802104947307, 8096.51420914747, 8123.878141827878, 8198.221168988937, 8219.301359384399, 3358.6641335866216, 3382.8308584570673, 3402.7788193767324, 3406.9659303407143, 3409.403354412968, 1039.991208527742, 1068.2682362581656, 1068.7915856407926, 1085.9900292727839, 1089.934603923767, 29210.41579168447, 29281.09113453193, 29455.821767129073, 29557.26106847303, 29858.850705746765, 1075.473018221066, 1089.6022951622758, 1091.5633746501462, 1096.3476731344838, 1122.3826895207603, 15231.0, 15248.161351125573, 15275.0, 15766.527004189893, 15790.21048947571, 623125.0, 698337.0, 717200.0, 725502.0, 725638.0, 57788.0, 60131.0, 61491.770164596455, 61734.0739888902, 61875.38124618786, 1477.4828809916658, 1487.7874532256176, 1492.7089217602681, 1494.9327280272196, 1618.4901755947074, 29732.554011689408, 29828.552571711007, 29929.850350748977, 30397.544036839023, 30536.389272214874, 51151.0, 51168.0, 51854.740726297634, 52037.47962520326, 52068.21897671462, 456903.0, 458727.0, 460129.0, 460418.0, 463967.0, 26608.0, 26760.0, 27029.053983111284, 27064.0, 27076.864615676797, 44771.55228447674, 45364.0, 45589.54410455853, 46056.0, 47514.52485475101, 29071.27321816887, 36033.81983090068, 37320.253594928494, 37616.05031471656, 38208.42687359636, 27768.750406231364, 36736.26527469382, 37005.07487312839, 37114.0, 37586.43620345752, 36192.27615447729, 36469.635303646624, 36753.26493470169, 36873.81563092167, 37129.071773205884, 29091.0, 31709.0, 32566.674333256364, 32678.856240031484, 32793.67206328001, 22517.662235066815, 24192.637110443004, 24687.876560617082, 25177.118800841883, 25235.11677091293], "value": 18028.969683910855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.67480243373666, 388.9552701439334, 395.36149119172535, 402.40042336918003, 410.7556004177517, 18544.629107417844, 21336.57326853462, 21558.706477611315, 21987.780122198772, 22048.89755512224, 20111.0, 20394.184232630712, 20822.687659685118, 21208.681869771965, 21369.893150534266, 5181.818636347729, 5690.317161940563, 5909.497692696126, 5931.169636250928, 5937.287525496947, 5090.116656836975, 5132.28148059272, 5812.883742325151, 5841.0, 5842.123681447774, 5028.597712183035, 5558.916616250759, 5719.59962802604, 5768.0, 5860.179574859523, 5096.8277296221895, 5511.283533140666, 5644.181593668936, 5696.2594862668, 5810.506106980912, 5084.9321642455125, 5096.541311282002, 5111.361079865017, 5119.462456442095, 5124.333836601218, 22152.667709984362, 24586.385340366454, 25859.0949316773, 25947.481050379076, 26706.46587068267, 2251.9887400562893, 2263.981208456185, 2339.9649005264932, 2431.5866302728577, 2521.646969424282, 14657.633559161, 14960.62598435037, 14979.101253924691, 15050.172240526766, 15284.159371234578, 1722.3024675006643, 1754.359658724569, 1776.3960253513737, 1803.9007854567994, 1826.6711991841464, 94679.99999999932, 115797.84202157955, 119504.40247798705, 119637.80362196354, 120461.5561521654, 11047.83428248577, 11111.00000999914, 11543.595974141033, 11631.47658355376, 11803.645890623295, 13855.0, 14135.43458261658, 14193.929030354782, 14253.64365890861, 14309.21299328526, 7491.513051651626, 8493.235608795238, 8698.391112622056, 8851.778705532284, 8949.418287811272, 8841.115888411108, 8880.71229671694, 8890.33322500802, 8971.50656713874, 8997.145271199226, 6749.730010799612, 6761.830954226184, 6835.829104272433, 6857.725690972405, 6865.656717164122, 1749.6238308763677, 1751.3782607174523, 1937.7190307405629, 1950.2881448271562, 1968.0, 931.4504442379028, 942.7218970403748, 998.7403275148514, 1024.788120823415, 1051.0540513537724, 19921.402357929284, 20483.283085092247, 21299.68050479244, 21422.46443838885, 21534.676979845313, 986.2800155886243, 993.7465946183677, 1020.9336393134422, 1028.3675539543276, 1092.1317552545745, 11129.276597021168, 11326.37704926237, 11410.030147437561, 11451.656450306504, 11718.531258749554, 596053.0, 597927.0, 612898.0, 619542.9022854947, 621058.0, 107577.38633920497, 109217.0, 109886.0, 111865.0, 112039.87960120295, 1063.2875973098044, 1072.860528131338, 1093.005365117755, 1097.1935627313917, 1101.6474728086935, 18589.44231673052, 18793.248270069045, 18985.860848349144, 18994.0, 19009.42971710851, 46553.76723116363, 48203.75898120627, 48690.5130948686, 48993.02013959772, 49754.502454976435, 67409.0, 68276.0, 70086.64956675185, 70357.0, 71199.0, 7533.322001019935, 7923.6830526778285, 7959.08470525897, 8135.593220338841, 8409.285210757154, 11600.245984011011, 12780.61658150257, 12968.157069790434, 13154.0, 13171.07802453819, 7773.961130194313, 7846.882296765439, 7929.444938854225, 8464.957675211585, 11262.887371126184, 5979.671118088547, 7561.017067781153, 7737.613119344122, 7859.371250299848, 7903.853941178612, 8086.0, 8152.3478121751305, 8169.428140030141, 8346.165383461605, 8466.576671166295, 10528.578856845641, 11961.222520536485, 12374.0, 12659.746805063663, 12739.93630031881, 11814.291142531476, 11842.407879606157, 11969.820452693042, 12052.216605920587, 12152.635420937386], "value": 9576.714117094234, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1601.87185025198, 1641.7701521786953, 1829.9569245530035, 1893.3941138835569, 1964.1063316191135, 8047.91952080479, 8494.40539162259, 8534.378468091058, 8811.295096392289, 8827.955860220698, 8521.78695532612, 8547.230749232567, 8636.784080397993, 8645.049044605104, 8663.870041949376, 2426.563218620652, 2435.2694191742494, 2447.963280550793, 2452.717937437191, 2460.483298507316, 2428.2715185444385, 2429.647701083342, 2457.508498300338, 2460.4709987352717, 2460.753924607534, 2434.45224824414, 2441.084593277521, 2454.4232105455203, 2458.373114855718, 2461.963070553943, 2425.0, 2429.7327293997646, 2435.659007738918, 2448.6082226843796, 2452.546278938384, 2354.187805207218, 2370.78662920338, 2413.6017557103055, 2426.126594426023, 2437.6465412515263, 8663.176998185163, 8710.608022638997, 8747.737567872973, 8796.780080498038, 8836.955815220947, 5166.741662916839, 5294.7617357219015, 5345.412004679482, 5360.624756267063, 5383.946160538423, 3490.371733088043, 3527.523784289114, 3542.8759993400363, 3584.4085725855202, 3617.2584620152807, 1015.8882522922546, 1020.8468729690532, 1029.5212726082332, 1036.7097212780434, 1039.5841663334652, 11368.488418021208, 11379.886201137966, 11454.427278636118, 11465.656030319104, 11492.770144597145, 4070.4708387909973, 4625.537446255347, 4631.745254011062, 4882.292067650171, 4933.0380575788095, 9708.466034368037, 9713.417194968184, 9733.124018838338, 9744.0, 9753.658621948198, 5237.8428647140645, 5240.109181439165, 5261.842144735664, 5278.287431196739, 5328.733563321818, 4386.583274588909, 4754.0, 4813.4945830687275, 4815.686980346266, 4891.486393928586, 3635.4910312556262, 3687.7049836013052, 3880.8447662093763, 3934.960650393459, 4099.569545197771, 1173.495396979307, 1335.9893360492397, 1350.6623344163959, 1356.7150898311465, 1358.1647286918474, 800.6797281087495, 877.6138499060393, 878.7100256915203, 923.9722808315761, 934.5655459478128, 5571.387147413781, 5623.690697011703, 5650.97174514133, 5805.680687562224, 5859.589828711949, 436.9643943853025, 438.77403137383635, 441.39528845481897, 446.7319608235033, 447.6038705745374, 3820.560635526894, 3888.6889048876023, 3907.8241479133508, 3926.2932672118723, 3948.407738839197, 9160.625906114003, 9974.900250997542, 10277.691669249934, 10587.523561439753, 10664.253502254767, 9033.548322583845, 9230.400023998418, 10666.520006599721, 10672.78654426907, 10690.305130166515, 7763.1848655891445, 8075.959620201979, 8115.8782618260775, 8182.795430114175, 8185.590720463953, 5635.830925072254, 5833.970830145992, 5842.941570584239, 5907.379725128972, 5953.28560572734, 9804.0, 9811.607535698779, 9897.703068907944, 9949.502524873582, 10058.748531286776, 8643.783905402415, 9923.057309555581, 9946.0, 9984.850227246452, 9996.0, 6761.3238676132, 7108.395786358011, 7186.496945213785, 7310.415166786751, 7509.5869727163345, 7395.18652948186, 8142.104368519576, 8175.7138500152205, 8237.83524329522, 8275.296599789086, 6086.878262434638, 7267.927320726936, 7310.378617817545, 7339.009233753375, 7489.700411983677, 5970.820875373745, 7101.254368291255, 7186.24544422849, 7220.241874603091, 7327.230640782641, 6857.794266172023, 6967.268436814062, 6993.440524757905, 6994.090768200102, 6996.160460744743, 4726.220173671443, 4761.214399624023, 4784.545468180518, 4816.710997340171, 4827.275908613736, 4690.179218636793, 4728.219843725747, 4761.166795810788, 4775.0, 4778.450478195052], "value": 4453.15385483722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.87684926029584, 318.06330357098346, 324.5845317992969, 326.3375348043473, 326.9771116021878, 5945.167676525279, 5968.373320801318, 6126.20359353284, 6227.657478838668, 6244.625322480654, 5366.517013468787, 5855.824325270238, 6064.241969753781, 6133.50931925446, 6138.508919286458, 4559.817607295704, 4583.839565615204, 4585.908281834353, 4595.149897269016, 4598.264277715566, 3797.841658294219, 4162.605527148409, 4444.444444444444, 4584.564466375689, 4608.769561521927, 3530.5763308402898, 4170.520390155126, 4459.955400446002, 4528.501864794886, 4565.908681826361, 3750.9624903750887, 4534.093181363724, 4556.749378784166, 4562.041971186055, 4582.587567118942, 3811.123441608446, 3842.2507611015862, 3913.5695073541888, 3937.3897045957924, 3938.6455219030427, 5057.721825299607, 5733.971330143323, 5802.274715660543, 5827.125931110325, 5845.181674565564, 4215.768132752697, 5287.762050707727, 5312.043832110218, 5326.840194794162, 5329.2006199070065, 4945.315739773856, 5062.443131255559, 6290.874182516324, 6442.259140198843, 6553.377429144271, 4345.717528360647, 4392.363107349448, 4412.0, 4419.0, 4458.621017213541, 6548.9017664735065, 6851.383375496229, 6887.2079710833395, 6912.997615345797, 6955.374016338554, 3862.0344913771555, 4200.978995105005, 4431.003024319567, 4473.329000649928, 4486.66350023743, 4451.532589078165, 4523.208438523246, 4533.38799262102, 4555.703879247838, 4571.9085618287445, 5320.787168513216, 5338.733063346817, 5366.141417373279, 5377.8117765878005, 5378.058839703036, 5884.057391790916, 6147.877042459126, 6293.653849038255, 6533.738650453929, 6546.869062618816, 1359.9800149887585, 1406.4936622815778, 1471.529110684592, 1582.7625856121674, 1589.841015898424, 977.2182254196756, 1009.9040591143829, 1021.5085974477346, 1039.4854546999134, 1053.1732589916878, 5908.852278693067, 5999.670018148957, 6007.879842403127, 6018.849528761816, 6046.879062418727, 6365.809025729235, 6714.4749006771835, 6714.832129196711, 6721.596704197764, 6782.118324617768, 5014.323066386064, 5579.163125531121, 5793.362730099686, 5851.941480585225, 5999.700014999233, 3055.251463391439, 3511.8068506231893, 3547.403668349253, 3566.1619519412916, 3573.535440392732, 6825.215100263434, 6896.586204827727, 7028.0863487746265, 7030.402415794715, 7079.362857342864, 5826.970865145647, 6660.134182556237, 6875.037494750739, 6910.654467276616, 6986.825329366807, 6802.591844489248, 6873.656317184121, 6990.09128813251, 7035.788926332219, 7045.195594378978, 6602.273749887412, 6619.867602647823, 6641.568298060611, 6646.235682896336, 6657.53397262187, 5399.83800485986, 6272.310045895039, 6484.5460817742305, 6579.2104947406615, 6640.236372816995, 6961.721531138698, 7001.859962800613, 7011.368976792113, 7052.753153639598, 7060.8940865886025, 4429.844955426544, 4433.802873224147, 4437.911241775211, 4461.910761784811, 4462.732236065846, 6326.06566877836, 6465.967670161619, 6666.200055993312, 6714.160729908762, 6805.183377994672, 5777.653340799566, 6582.539222254396, 6586.835329116619, 6591.571547849375, 6605.405513503808, 5457.045017122067, 6152.07776306251, 6194.0, 6337.7781777637565, 6600.768973085919, 6436.581622194542, 6447.290798012121, 6454.870902581828, 6466.838329041811, 6480.773172938924, 5493.917591236214, 6546.672666366758, 6597.27429982692, 6603.108580341593, 6625.469962403093, 5196.870078248074, 5914.19617016814, 6353.14232578596, 6404.007378856285, 6456.967715161394], "value": 4716.352779621811, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.9668516574174, 668.1214203322631, 703.2440126863623, 719.5035425556366, 735.5990984913221, 14915.552533423988, 15373.308201130949, 15396.538103856888, 15404.0, 16399.427059502257, 16055.197240137975, 16083.919580402082, 16105.677886442265, 16139.094962906673, 16201.83798162018, 908.5048648486575, 910.6311943662827, 916.9174774270315, 917.6100157433098, 919.237033262394, 601.681109012222, 813.5525460996429, 882.1663527966075, 913.4154141349542, 913.9131782480654, 938.8310104181245, 957.4016239850093, 960.9759756006085, 965.75856035991, 966.6085235479642, 948.1892981500821, 954.5275088831038, 955.049725523102, 959.1559427703576, 960.4573416019927, 705.3757424679145, 714.8963400306978, 715.3597530210485, 719.126261592168, 724.5000949344935, 15160.620984475367, 15403.768943465857, 15507.069575825486, 15657.921710391374, 15766.975146615549, 12662.55681051168, 12684.0, 12699.0, 12701.301428421433, 12829.486820527167, 10014.59941602335, 10027.899721002843, 10182.18542516597, 10508.159347252202, 10586.36481811086, 2971.9598140650814, 3440.36353274645, 3465.203003309253, 3582.408902531079, 3599.31612993533, 81252.59373703094, 82065.35869282641, 82195.0, 82248.17751822465, 82659.58670206611, 9399.718008459757, 9412.105849944244, 9424.0, 9607.087326703951, 9662.661806836726, 21098.367048988246, 21117.366479005654, 21233.36299911005, 21392.0, 21580.352589422342, 6526.543141980016, 7311.707531698778, 7458.589777562286, 7515.323620874038, 7516.098068231847, 4088.6115818997146, 4097.221527909687, 4170.624643782075, 4210.85262015828, 4246.0, 3581.3374525712825, 3656.451532270181, 3660.066682995819, 3695.519582454264, 3695.5565332160313, 590.271015296109, 614.714157916562, 641.563736659067, 642.6176425027102, 660.131926516629, 507.5406756884951, 529.317180836724, 542.1055258822895, 602.0475577831522, 608.0726891490513, 7763.4953728007495, 7832.373410127176, 7872.252136047066, 8120.269175774209, 8213.54825484604, 518.199381954873, 533.8318429694634, 552.8037546670954, 570.6021040952635, 591.3642833953517, 3758.3972356572317, 3788.5453745550712, 3790.3935370340614, 3900.0249937515623, 3907.2185562886966, 86478.56760716156, 87709.12290877009, 89160.5541972299, 90081.0, 90847.09152908518, 71211.57576848434, 72256.277437226, 72617.54764904673, 73420.16449588804, 73747.63126184442, 39511.0, 64996.186839862494, 66371.0, 68405.97391039139, 68589.65705171443, 7481.289277518627, 7599.1261004982925, 7611.961940190264, 7672.808179795326, 7750.612469376621, 42517.787411062745, 42997.0, 43393.566064340215, 43608.0, 43811.0, 50094.0, 56037.0, 56070.71964640151, 57030.7148464255, 57288.0, 10645.159692257354, 10647.574097036342, 10768.569257229623, 10839.349639021684, 10923.890761092605, 11764.470598823245, 11863.76272474563, 11867.58463453775, 11926.284422934652, 11976.221545599508, 9316.48759318244, 11154.219204655596, 11463.885361146282, 11619.5352185915, 11799.646010619696, 10965.122790176927, 11366.715832104264, 11434.970852622972, 11504.827427588425, 11746.482251359308, 10841.566337346734, 11532.135089868461, 11574.6527604172, 11878.762424751629, 12256.754864902474, 9464.858027129736, 9465.574049167666, 9858.457784821903, 9940.850887236553, 9944.254180936603, 9519.143277105093, 9614.326997110134, 9719.708408747749, 9844.803103938024, 9887.653932112342], "value": 6780.149887759653, "unit": "score"}], "name": "dromaeo_css", "value": 7201.201575036203, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 130.0, 170.0, 106.0, 176.0, 168.0, 154.0, 117.0, 118.0], "value": 136.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 145.0, 166.0, 126.0, 143.0, 143.0, 117.0, 171.0, 127.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 234.0, 189.0, 234.0, 251.0, 274.0, 201.0, 200.0, 200.0, 196.0], "value": 217.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 83.0, 73.0, 132.0, 56.0, 56.0, 62.0, 65.0, 73.0, 56.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 128.0, 77.0, 79.0, 84.0, 120.0, 78.0, 77.0, 121.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 128.0, 93.0, 88.0, 127.0, 86.0, 111.0, 88.0, 90.0, 90.0], "value": 101.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 100.0, 141.0, 150.0, 111.0, 108.0, 150.0, 129.0, 95.0], "value": 117.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 92.0, 94.0, 92.0, 93.0, 92.0, 96.0, 93.0, 134.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 62.0, 63.0, 62.0, 76.0, 65.0, 60.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 84.0, 73.0, 74.0, 74.0, 75.0, 65.0, 67.0, 71.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 96.0, 114.0, 112.0, 84.0, 89.0, 84.0, 96.0, 115.0], "value": 96.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 158.0, 170.0, 175.0, 150.0, 168.0, 159.0, 180.0, 148.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 169.0, 174.0, 173.0, 170.0, 175.0, 178.0, 169.0, 169.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 69.0, 67.0, 70.0, 69.0, 66.0, 70.0, 69.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1610.0999999999997, "alertThreshold": 2.0}]} 10:20:20 INFO - Return code: 0 10:20:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:20:20 ERROR - # TBPL SUCCESS # 10:20:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:20:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:20:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:20:20 INFO - 2016-04-14 10:20:20.664 screenresolution[1977:21106] starting screenresolution argv=screenresolution get 10:20:20 INFO - 2016-04-14 10:20:20.667 screenresolution[1977:21106] Display 0: 1600x1200x32@60 10:20:20 INFO - 2016-04-14 10:20:20.673 screenresolution[1978:21109] starting screenresolution argv=screenresolution list 10:20:20 INFO - Available Modes on Display 0 10:20:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:20:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:20:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:20:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:20:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:20:20 INFO - Intel Iris: 10:20:20 INFO - Chipset Model: Intel Iris 10:20:20 INFO - Type: GPU 10:20:20 INFO - Bus: Built-In 10:20:20 INFO - VRAM (Dynamic, Max): 1536 MB 10:20:20 INFO - Vendor: Intel (0x8086) 10:20:20 INFO - Device ID: 0x0a2e 10:20:20 INFO - Revision ID: 0x0009 10:20:20 INFO - Displays: 10:20:20 INFO - Display: 10:20:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:20:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:20:20 INFO - Display Serial Number: 1600x1200 60 10:20:20 INFO - Main Display: Yes 10:20:20 INFO - Mirror: Off 10:20:20 INFO - Online: Yes 10:20:20 INFO - Rotation: Supported 10:20:20 INFO - Return code: 0 10:20:20 INFO - Running post-action listener: _resource_record_post_action 10:20:20 INFO - Running post-run listener: _resource_record_post_run 10:20:21 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 266240; Write bytes: 696771072; Read time: 8; Write time: 1918 10:20:21 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 394678784; Write bytes: 389608448; Read time: 29738; Write time: 736 10:20:21 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 245760; Write bytes: 298040832; Read time: 7; Write time: 1154 10:20:21 INFO - Running post-run listener: _upload_blobber_files 10:20:21 INFO - Blob upload gear active. 10:20:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:21 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 10:20:21 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:20:21 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:20:22 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:20:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:23 INFO - (blobuploader) - INFO - Done attempting. 10:20:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:20:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:20:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:24 INFO - (blobuploader) - INFO - Done attempting. 10:20:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:24 INFO - Return code: 0 10:20:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c123d4b21a15c7a3eada6059e1a67b842079c5f1e1ea18cb486a64702dce34fcd91d4fc63ce73c75af5708cb7e5ceb0ead98e4e6bbfe742e56547d29f1f6958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c16aa4370da3cf2b60f674c5ba03f2cadce11dba11da670ed45636724faa55100e302c35c7b21e74f1132ed65746ddacdd1d2b21268aac9762b0591d3082a335"} 10:20:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:24 INFO - Contents: 10:20:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c123d4b21a15c7a3eada6059e1a67b842079c5f1e1ea18cb486a64702dce34fcd91d4fc63ce73c75af5708cb7e5ceb0ead98e4e6bbfe742e56547d29f1f6958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c16aa4370da3cf2b60f674c5ba03f2cadce11dba11da670ed45636724faa55100e302c35c7b21e74f1132ed65746ddacdd1d2b21268aac9762b0591d3082a335"} 10:20:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:24 INFO - Copying logs to upload dir... 10:20:24 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.409950 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-14 10:20:25.007038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-04-14 10:20:25.014339) ========= 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.OfabJ29BuP/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.FLhDrp1So8/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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/Fx-Team/sha512/1c123d4b21a15c7a3eada6059e1a67b842079c5f1e1ea18cb486a64702dce34fcd91d4fc63ce73c75af5708cb7e5ceb0ead98e4e6bbfe742e56547d29f1f6958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c16aa4370da3cf2b60f674c5ba03f2cadce11dba11da670ed45636724faa55100e302c35c7b21e74f1132ed65746ddacdd1d2b21268aac9762b0591d3082a335"} build_url:https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010998 build_url: 'https://queue.taskcluster.net/v1/task/XQeK8fMOTH-FksCmB8fHRA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c123d4b21a15c7a3eada6059e1a67b842079c5f1e1ea18cb486a64702dce34fcd91d4fc63ce73c75af5708cb7e5ceb0ead98e4e6bbfe742e56547d29f1f6958", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c16aa4370da3cf2b60f674c5ba03f2cadce11dba11da670ed45636724faa55100e302c35c7b21e74f1132ed65746ddacdd1d2b21268aac9762b0591d3082a335"}' ========= master_lag: 4.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-04-14 10:20:29.082087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-14 10:20:29.082369) ========= 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.OfabJ29BuP/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.FLhDrp1So8/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005373 ========= master_lag: 6.91 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-14 10:20:35.997890) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-14 10:20:35.998194) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-14 10:20:41.671769) ========= ========= Total master_lag: 11.23 =========