builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0086 starttime: 1461343275.83 results: success (0) buildid: 20160422070002 builduid: 1f34c23a995f40fc96395e4bd8f08ce1 revision: 0da9dcd298a62e744a069c336797b24135f277a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:15.834952) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:15.835688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:15.836151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:15.858702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:15.859094) ========= 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.0lmtef3AlC/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.E5xf4zuGza/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-22 09:41:15-- 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% 145M=0s 2016-04-22 09:41:15 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:15.971373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:15.971933) ========= 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.0lmtef3AlC/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.E5xf4zuGza/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.026878 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:16.021669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 09:41:16.022033) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0da9dcd298a62e744a069c336797b24135f277a0 --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 0da9dcd298a62e744a069c336797b24135f277a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0lmtef3AlC/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.E5xf4zuGza/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-22 09:41:16,095 truncating revision to first 12 chars 2016-04-22 09:41:16,095 Setting DEBUG logging. 2016-04-22 09:41:16,096 attempt 1/10 2016-04-22 09:41:16,096 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0da9dcd298a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 09:41:17,476 unpacking tar archive at: fx-team-0da9dcd298a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.627451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 09:41:17.666261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:17.666579) ========= script_repo_revision: 0da9dcd298a62e744a069c336797b24135f277a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:17.666976) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:17.667237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 09:41:17.681295) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-04-22 09:41:17.681935) ========= /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.0lmtef3AlC/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.E5xf4zuGza/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:41:17 INFO - MultiFileLogger online at 20160422 09:41:17 in /builds/slave/test 09:41:17 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:41:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:41:17 INFO - {'append_to_log': False, 09:41:17 INFO - 'base_work_dir': '/builds/slave/test', 09:41:17 INFO - 'blob_upload_branch': 'Fx-Team', 09:41:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:41:17 INFO - 'branch': 'Fx-Team', 09:41:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:41:17 INFO - 'config_files': ('talos/mac_config.py',), 09:41:17 INFO - 'default_actions': ('clobber', 09:41:17 INFO - 'read-buildbot-config', 09:41:17 INFO - 'download-and-extract', 09:41:17 INFO - 'populate-webroot', 09:41:17 INFO - 'create-virtualenv', 09:41:17 INFO - 'install', 09:41:17 INFO - 'run-tests'), 09:41:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:41:17 INFO - 'download_minidump_stackwalk': True, 09:41:17 INFO - 'download_symbols': 'ondemand', 09:41:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:41:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:41:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:41:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:41:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:41:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:41:17 INFO - 'installer_path': 'installer.exe', 09:41:17 INFO - 'log_level': 'info', 09:41:17 INFO - 'log_name': 'talos', 09:41:17 INFO - 'log_to_console': True, 09:41:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:41:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:41:17 INFO - 'opt_config_files': (), 09:41:17 INFO - 'pip_index': False, 09:41:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:41:17 INFO - 'cmd': ('bash', 09:41:17 INFO - '-c', 09:41:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:41:17 INFO - 'enabled': True, 09:41:17 INFO - 'halt_on_failure': False, 09:41:17 INFO - 'name': 'check_screen_resolution'},), 09:41:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:41:17 INFO - 'cmd': ('bash', 09:41:17 INFO - '-c', 09:41:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:41:17 INFO - 'enabled': True, 09:41:17 INFO - 'halt_on_failure': False, 09:41:17 INFO - 'name': 'check_screen_resolution'},), 09:41:17 INFO - 'run_cmd_checks_enabled': True, 09:41:17 INFO - 'sps_profile': False, 09:41:17 INFO - 'sps_profile_interval': 0, 09:41:17 INFO - 'suite': 'dromaeojs-e10s', 09:41:17 INFO - 'system_bits': '32', 09:41:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:41:17 INFO - 'title': 't-yosemite-r7-0086', 09:41:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:41:17 INFO - 'use_talos_json': True, 09:41:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:41:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:41:17 INFO - 'work_dir': 'build'} 09:41:17 INFO - ##### 09:41:17 INFO - ##### Running clobber step. 09:41:17 INFO - ##### 09:41:17 INFO - Running pre-action listener: _resource_record_pre_action 09:41:17 INFO - Running main action method: clobber 09:41:17 INFO - rmtree: /builds/slave/test/build 09:41:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:41:19 INFO - Running post-action listener: _resource_record_post_action 09:41:19 INFO - ##### 09:41:19 INFO - ##### Running read-buildbot-config step. 09:41:19 INFO - ##### 09:41:19 INFO - Running pre-action listener: _resource_record_pre_action 09:41:19 INFO - Running main action method: read_buildbot_config 09:41:19 INFO - Using buildbot properties: 09:41:19 INFO - { 09:41:19 INFO - "project": "", 09:41:19 INFO - "product": "firefox", 09:41:19 INFO - "script_repo_revision": "production", 09:41:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:41:19 INFO - "repository": "", 09:41:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:41:19 INFO - "buildid": "20160422070002", 09:41:19 INFO - "pgo_build": "False", 09:41:19 INFO - "basedir": "/builds/slave/test", 09:41:19 INFO - "buildnumber": 626, 09:41:19 INFO - "slavename": "t-yosemite-r7-0086", 09:41:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:41:19 INFO - "platform": "yosemite_r7", 09:41:19 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:41:19 INFO - "branch": "fx-team", 09:41:19 INFO - "repo_path": "integration/fx-team", 09:41:19 INFO - "revision": "0da9dcd298a62e744a069c336797b24135f277a0", 09:41:19 INFO - "stage_platform": "macosx64", 09:41:19 INFO - "builduid": "1f34c23a995f40fc96395e4bd8f08ce1", 09:41:19 INFO - "slavebuilddir": "test" 09:41:19 INFO - } 09:41:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:41:19 INFO - Running post-action listener: _resource_record_post_action 09:41:19 INFO - ##### 09:41:19 INFO - ##### Running download-and-extract step. 09:41:19 INFO - ##### 09:41:19 INFO - Running pre-action listener: _resource_record_pre_action 09:41:19 INFO - Running main action method: download_and_extract 09:41:19 INFO - mkdir: /builds/slave/test/build/tests 09:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:19 INFO - https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:41:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:41:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:41:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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:41:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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:41:20 INFO - Downloaded 1199 bytes. 09:41:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:41:20 INFO - Using the following test package requirements: 09:41:20 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:41:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:41:20 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:41:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:41:20 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:41:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:41:20 INFO - u'jsshell-mac.zip'], 09:41:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:41:20 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:41:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:41:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:41:20 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:41:20 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:41:20 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:41:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:41:20 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:41:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:41:20 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:41:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:41: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:41:20 INFO - https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:41:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:41:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:41:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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:41:22 INFO - Downloaded 18109558 bytes. 09:41:22 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:41:22 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:41:25 INFO - Return code: 0 09:41:25 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:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:25 INFO - https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:41:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:41:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:41:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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:41:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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:41:26 INFO - Downloaded 18109558 bytes. 09:41:26 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:41:26 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:41:29 INFO - Return code: 0 09:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:29 INFO - https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:41:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:41:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:41:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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:41:30 INFO - Downloaded 10840145 bytes. 09:41:30 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:41:30 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:41:31 INFO - Return code: 0 09:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:31 INFO - https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:41:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:41:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:41:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:41:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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:41:34 INFO - Downloaded 110120337 bytes. 09:41:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:41:34 INFO - mkdir: /builds/slave/test/properties 09:41:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:41:34 INFO - Writing to file /builds/slave/test/properties/build_url 09:41:34 INFO - Contents: 09:41:34 INFO - build_url:https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:41:35 INFO - Running post-action listener: _resource_record_post_action 09:41:35 INFO - Running post-action listener: set_extra_try_arguments 09:41:35 INFO - ##### 09:41:35 INFO - ##### Running populate-webroot step. 09:41:35 INFO - ##### 09:41:35 INFO - Running pre-action listener: _resource_record_pre_action 09:41:35 INFO - Running main action method: populate_webroot 09:41:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:41:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:41:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:41:35 INFO - '--tppagecycles', 09:41:35 INFO - '7'], 09:41:35 INFO - 'tests': ['tsvgm']}}, 09:41:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:41:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:41:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:41:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:41:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:35 INFO - 'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:41:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:41:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:35 INFO - 'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['damp', 'tps']}, 09:41:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:35 INFO - 'tests': ['damp', 'tps']}, 09:41:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['dromaeo_dom']}, 09:41:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:41:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['a11yr', 09:41:35 INFO - 'ts_paint', 09:41:35 INFO - 'tpaint', 09:41:35 INFO - 'sessionrestore', 09:41:35 INFO - 'sessionrestore_no_auto_restore', 09:41:35 INFO - 'tabpaint']}, 09:41:35 INFO - 'other-e10s': {'tests': ['a11yr', 09:41:35 INFO - 'ts_paint', 09:41:35 INFO - 'tpaint', 09:41:35 INFO - 'sessionrestore', 09:41:35 INFO - 'sessionrestore_no_auto_restore', 09:41:35 INFO - 'tabpaint']}, 09:41:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:41:35 INFO - 'ts_paint', 09:41:35 INFO - 'tpaint', 09:41:35 INFO - 'sessionrestore', 09:41:35 INFO - 'sessionrestore_no_auto_restore', 09:41:35 INFO - 'tabpaint']}, 09:41:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:41:35 INFO - 'ts_paint', 09:41:35 INFO - 'tpaint', 09:41:35 INFO - 'sessionrestore', 09:41:35 INFO - 'sessionrestore_no_auto_restore', 09:41:35 INFO - 'tabpaint']}, 09:41:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['a11yr', 09:41:35 INFO - 'ts_paint', 09:41:35 INFO - 'tpaint', 09:41:35 INFO - 'sessionrestore', 09:41:35 INFO - 'sessionrestore_no_auto_restore', 09:41:35 INFO - 'tabpaint']}, 09:41:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['a11yr', 09:41:35 INFO - 'ts_paint', 09:41:35 INFO - 'tpaint', 09:41:35 INFO - 'sessionrestore', 09:41:35 INFO - 'sessionrestore_no_auto_restore', 09:41:35 INFO - 'tabpaint']}, 09:41:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['tsvgx', 09:41:35 INFO - 'tsvgr_opacity', 09:41:35 INFO - 'tart', 09:41:35 INFO - 'tscrollx', 09:41:35 INFO - 'cart']}, 09:41:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:41:35 INFO - 'tsvgr_opacity', 09:41:35 INFO - 'tart', 09:41:35 INFO - 'tscrollx', 09:41:35 INFO - 'cart']}, 09:41:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:35 INFO - 'talos_options': ['--disable-e10s'], 09:41:35 INFO - 'tests': ['tp5o']}, 09:41:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:35 INFO - 'tests': ['tp5o']}, 09:41:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:35 INFO - 'talos_options': ['--disable-e10s', 09:41:35 INFO - '--xperf_path', 09:41:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:41:35 INFO - 'tests': ['tp5n']}, 09:41:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:35 INFO - 'talos_options': ['--xperf_path', 09:41:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:41:35 INFO - 'tests': ['tp5n']}}, 09:41:35 INFO - 'talos.zip': {'path': '', 09:41:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:41:35 INFO - Running post-action listener: _resource_record_post_action 09:41:35 INFO - ##### 09:41:35 INFO - ##### Running create-virtualenv step. 09:41:35 INFO - ##### 09:41:35 INFO - Running pre-action listener: _resource_record_pre_action 09:41:35 INFO - Running main action method: create_virtualenv 09:41:35 INFO - Creating virtualenv /builds/slave/test/build/venv 09:41:35 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:41:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:41:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:41:35 INFO - Using real prefix '/tools/python27' 09:41:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:41:36 INFO - Installing distribute.............................................................................................................................................................................................done. 09:41:39 INFO - Installing pip.................done. 09:41:39 INFO - Return code: 0 09:41:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:39 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 0x1056b0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056c0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad42d9d940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, '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.0lmtef3AlC/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.E5xf4zuGza/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:41:39 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:41:39 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:41:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:41:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:39 INFO - 'HOME': '/Users/cltbld', 09:41:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:39 INFO - 'LOGNAME': 'cltbld', 09:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:39 INFO - 'MOZ_NO_REMOTE': '1', 09:41:39 INFO - 'NO_EM_RESTART': '1', 09:41:39 INFO - 'PAGER': '/bin/cat', 09:41:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:39 INFO - 'PWD': '/builds/slave/test', 09:41:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:39 INFO - 'SHELL': '/bin/bash', 09:41:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:41:39 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:41:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:39 INFO - 'USER': 'cltbld', 09:41:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:39 INFO - 'XPC_FLAGS': '0x0', 09:41:39 INFO - 'XPC_SERVICE_NAME': '0', 09:41:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:39 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:41:39 INFO - Cleaning up... 09:41:39 INFO - Return code: 0 09:41:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:39 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 0x1056b0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056c0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad42d9d940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, '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.0lmtef3AlC/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.E5xf4zuGza/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:41:39 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:41:39 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:41:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:41:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:39 INFO - 'HOME': '/Users/cltbld', 09:41:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:39 INFO - 'LOGNAME': 'cltbld', 09:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:39 INFO - 'MOZ_NO_REMOTE': '1', 09:41:39 INFO - 'NO_EM_RESTART': '1', 09:41:39 INFO - 'PAGER': '/bin/cat', 09:41:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:39 INFO - 'PWD': '/builds/slave/test', 09:41:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:39 INFO - 'SHELL': '/bin/bash', 09:41:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:41:39 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:41:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:39 INFO - 'USER': 'cltbld', 09:41:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:39 INFO - 'XPC_FLAGS': '0x0', 09:41:39 INFO - 'XPC_SERVICE_NAME': '0', 09:41:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:39 INFO - Downloading/unpacking psutil>=0.7.1 09:41:39 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:41:39 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:41:39 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:41:39 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:41:39 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:41:39 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:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:41:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:41:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:41:42 INFO - Installing collected packages: psutil 09:41:42 INFO - Running setup.py install for psutil 09:41:42 INFO - building 'psutil._psutil_osx' extension 09:41:42 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:41:42 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:41:42 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:41:43 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:41:43 INFO - building 'psutil._psutil_posix' extension 09:41:43 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:41:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:41:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:41:43 INFO - ^ 09:41:43 INFO - 1 warning generated. 09:41:43 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:41:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:41:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:41:43 INFO - Successfully installed psutil 09:41:43 INFO - Cleaning up... 09:41:43 INFO - Return code: 0 09:41:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:41:43 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:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:43 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:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:43 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 0x1056b0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056c0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad42d9d940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, '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.0lmtef3AlC/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.E5xf4zuGza/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:41:43 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:41:43 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:41:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:41:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:43 INFO - 'HOME': '/Users/cltbld', 09:41:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:43 INFO - 'LOGNAME': 'cltbld', 09:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:43 INFO - 'MOZ_NO_REMOTE': '1', 09:41:43 INFO - 'NO_EM_RESTART': '1', 09:41:43 INFO - 'PAGER': '/bin/cat', 09:41:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:43 INFO - 'PWD': '/builds/slave/test', 09:41:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:43 INFO - 'SHELL': '/bin/bash', 09:41:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:41:43 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:41:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:43 INFO - 'USER': 'cltbld', 09:41:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:43 INFO - 'XPC_FLAGS': '0x0', 09:41:43 INFO - 'XPC_SERVICE_NAME': '0', 09:41:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:41:43 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:41:43 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:41:43 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:41:43 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:41:43 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:41:43 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:41:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:41:46 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:41:46 INFO - Installing collected packages: mozsystemmonitor 09:41:46 INFO - Running setup.py install for mozsystemmonitor 09:41:46 INFO - Successfully installed mozsystemmonitor 09:41:46 INFO - Cleaning up... 09:41:46 INFO - Return code: 0 09:41:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:41: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:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41: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:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41: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', '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 0x1056b0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056c0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad42d9d940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, '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.0lmtef3AlC/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.E5xf4zuGza/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:41: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:41: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 blobuploader==1.2.4 09:41:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:41:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:46 INFO - 'HOME': '/Users/cltbld', 09:41:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:46 INFO - 'LOGNAME': 'cltbld', 09:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:46 INFO - 'MOZ_NO_REMOTE': '1', 09:41:46 INFO - 'NO_EM_RESTART': '1', 09:41:46 INFO - 'PAGER': '/bin/cat', 09:41:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:46 INFO - 'PWD': '/builds/slave/test', 09:41:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:46 INFO - 'SHELL': '/bin/bash', 09:41:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:41:46 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:41:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:46 INFO - 'USER': 'cltbld', 09:41:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:46 INFO - 'XPC_FLAGS': '0x0', 09:41:46 INFO - 'XPC_SERVICE_NAME': '0', 09:41:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:46 INFO - Downloading/unpacking blobuploader==1.2.4 09:41: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:41: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:41: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:41: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:41: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:41: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:41:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:41:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:41: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:41: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:41: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:41: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:41: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:41: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:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:41:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:41: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:41: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:41: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:41: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:41: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:41: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:41:50 INFO - Downloading docopt-0.6.1.tar.gz 09:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:41:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:41:50 INFO - Running setup.py install for blobuploader 09:41:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:41:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:41:50 INFO - Running setup.py install for requests 09:41:50 INFO - Running setup.py install for docopt 09:41:51 INFO - Successfully installed blobuploader requests docopt 09:41:51 INFO - Cleaning up... 09:41:51 INFO - Return code: 0 09:41:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:51 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:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:51 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:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:51 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 0x1056b0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056c0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad42d9d940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, '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.0lmtef3AlC/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.E5xf4zuGza/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:41:51 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:41:51 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:41:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:41:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:51 INFO - 'HOME': '/Users/cltbld', 09:41:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:51 INFO - 'LOGNAME': 'cltbld', 09:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:51 INFO - 'MOZ_NO_REMOTE': '1', 09:41:51 INFO - 'NO_EM_RESTART': '1', 09:41:51 INFO - 'PAGER': '/bin/cat', 09:41:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:51 INFO - 'PWD': '/builds/slave/test', 09:41:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:51 INFO - 'SHELL': '/bin/bash', 09:41:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:41:51 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:41:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:51 INFO - 'USER': 'cltbld', 09:41:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:51 INFO - 'XPC_FLAGS': '0x0', 09:41:51 INFO - 'XPC_SERVICE_NAME': '0', 09:41:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-4i6r6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Op2OA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0WoKOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-cC84EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gsuQog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-9CJ0Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ponK0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-34mFxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-_P4R46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-XYsgvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-LV3VAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-924YB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-EptIun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-afDssn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gz9M7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:52 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-SL8KLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:53 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-7tz3GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:41:53 INFO - Running setup.py install for manifestparser 09:41:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:41:53 INFO - Running setup.py install for mozcrash 09:41:53 INFO - Running setup.py install for mozdebug 09:41:53 INFO - Running setup.py install for mozdevice 09:41:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:41:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:41:53 INFO - Running setup.py install for mozfile 09:41:53 INFO - Running setup.py install for mozhttpd 09:41:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:41:54 INFO - Running setup.py install for mozinfo 09:41:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:41:54 INFO - Running setup.py install for mozInstall 09:41:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:41:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:41:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:41:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:41:54 INFO - Running setup.py install for mozleak 09:41:54 INFO - Running setup.py install for mozlog 09:41:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:41:54 INFO - Running setup.py install for moznetwork 09:41:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:41:54 INFO - Running setup.py install for mozprocess 09:41:54 INFO - Running setup.py install for mozprofile 09:41:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:41:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:41:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:41:55 INFO - Running setup.py install for mozrunner 09:41:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:41:55 INFO - Running setup.py install for mozscreenshot 09:41:55 INFO - Running setup.py install for moztest 09:41:55 INFO - Running setup.py install for mozversion 09:41:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:41:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:41:55 INFO - Cleaning up... 09:41:55 INFO - Return code: 0 09:41:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:55 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 0x1056b0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056c0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad42d9d940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, '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.0lmtef3AlC/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.E5xf4zuGza/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:41:55 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:41:55 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:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:55 INFO - 'HOME': '/Users/cltbld', 09:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:55 INFO - 'LOGNAME': 'cltbld', 09:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:55 INFO - 'MOZ_NO_REMOTE': '1', 09:41:55 INFO - 'NO_EM_RESTART': '1', 09:41:55 INFO - 'PAGER': '/bin/cat', 09:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:55 INFO - 'PWD': '/builds/slave/test', 09:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:55 INFO - 'SHELL': '/bin/bash', 09:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:41:55 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:55 INFO - 'USER': 'cltbld', 09:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:55 INFO - 'XPC_FLAGS': '0x0', 09:41:55 INFO - 'XPC_SERVICE_NAME': '0', 09:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-cPeO1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-fNMts6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-wjvx9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2uD0aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-cJKNwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:56 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)) 09:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-AapPFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:56 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)) 09:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2sIKTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:56 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)) 09:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-BeodNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:56 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)) 09:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-lkNvcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:56 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)) 09:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Dph7mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:57 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)) 09:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:57 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-UDiYhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:57 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)) 09:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:57 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Tcl2yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:57 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)) 09:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:57 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-OKrA9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:57 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)) 09:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:57 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-A7hqRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:57 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)) 09:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:57 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-sb8cgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:57 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)) 09:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:57 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-WmbY0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:57 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)) 09:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:57 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-jzFDwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:57 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)) 09:41:57 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)) 09:41:57 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)) 09:41:57 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)) 09:41:57 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)) 09:41:57 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)) 09:41:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:41:57 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:41:57 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:41:57 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:41:57 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:41:57 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:41:57 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:42:00 INFO - Downloading blessings-1.6.tar.gz 09:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:42:00 INFO - Installing collected packages: blessings 09:42:00 INFO - Running setup.py install for blessings 09:42:00 INFO - Successfully installed blessings 09:42:00 INFO - Cleaning up... 09:42:00 INFO - Return code: 0 09:42:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:00 INFO - Reading from file tmpfile_stdout 09:42:00 INFO - Current package versions: 09:42:00 INFO - blessings == 1.6 09:42:00 INFO - blobuploader == 1.2.4 09:42:00 INFO - docopt == 0.6.1 09:42:00 INFO - manifestparser == 1.1 09:42:00 INFO - mozInstall == 1.12 09:42:00 INFO - mozcrash == 0.17 09:42:00 INFO - mozdebug == 0.1 09:42:00 INFO - mozdevice == 0.48 09:42:00 INFO - mozfile == 1.2 09:42:00 INFO - mozhttpd == 0.7 09:42:00 INFO - mozinfo == 0.9 09:42:00 INFO - mozleak == 0.1 09:42:00 INFO - mozlog == 3.1 09:42:00 INFO - moznetwork == 0.27 09:42:00 INFO - mozprocess == 0.22 09:42:00 INFO - mozprofile == 0.28 09:42:00 INFO - mozrunner == 6.11 09:42:00 INFO - mozscreenshot == 0.1 09:42:00 INFO - mozsystemmonitor == 0.0 09:42:00 INFO - moztest == 0.7 09:42:00 INFO - mozversion == 1.4 09:42:00 INFO - psutil == 3.1.1 09:42:00 INFO - requests == 1.2.3 09:42:00 INFO - wsgiref == 0.1.2 09:42:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:00 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 0x1056b0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056c0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad42d9d940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, '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.0lmtef3AlC/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.E5xf4zuGza/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:42:00 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 09:42:00 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 09:42:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:42:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:00 INFO - 'HOME': '/Users/cltbld', 09:42:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:00 INFO - 'LOGNAME': 'cltbld', 09:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:00 INFO - 'MOZ_NO_REMOTE': '1', 09:42:00 INFO - 'NO_EM_RESTART': '1', 09:42:00 INFO - 'PAGER': '/bin/cat', 09:42:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:00 INFO - 'PWD': '/builds/slave/test', 09:42:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:00 INFO - 'SHELL': '/bin/bash', 09:42:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:42:00 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:42:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:00 INFO - 'USER': 'cltbld', 09:42:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:00 INFO - 'XPC_FLAGS': '0x0', 09:42:00 INFO - 'XPC_SERVICE_NAME': '0', 09:42:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:01 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)) 09:42:01 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)) 09:42:01 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)) 09:42:01 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)) 09:42:01 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)) 09:42:01 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)) 09:42:01 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)) 09:42:01 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)) 09:42:01 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)) 09:42:01 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)) 09:42:01 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)) 09:42:01 INFO - Cleaning up... 09:42:01 INFO - Return code: 0 09:42:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:42:01 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:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:01 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:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:01 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 0x1056b0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056c0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad42d9d940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, '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.0lmtef3AlC/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.E5xf4zuGza/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:42:01 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 09:42:01 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 09:42:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:42:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:01 INFO - 'HOME': '/Users/cltbld', 09:42:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:01 INFO - 'LOGNAME': 'cltbld', 09:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:01 INFO - 'MOZ_NO_REMOTE': '1', 09:42:01 INFO - 'NO_EM_RESTART': '1', 09:42:01 INFO - 'PAGER': '/bin/cat', 09:42:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:01 INFO - 'PWD': '/builds/slave/test', 09:42:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:01 INFO - 'SHELL': '/bin/bash', 09:42:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:42:01 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:42:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:01 INFO - 'USER': 'cltbld', 09:42:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:01 INFO - 'XPC_FLAGS': '0x0', 09:42:01 INFO - 'XPC_SERVICE_NAME': '0', 09:42:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:01 INFO - Downloading/unpacking jsonschema 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:03 INFO - Downloading/unpacking functools32 (from jsonschema) 09:42:03 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:42:03 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:42:03 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:42:03 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:42:03 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:42:03 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:42:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:04 INFO - warning: no files found matching '*.txt' 09:42:04 INFO - no previously-included directories found matching 'build' 09:42:04 INFO - no previously-included directories found matching 'dist' 09:42:04 INFO - no previously-included directories found matching '.git*' 09:42:04 INFO - Installing collected packages: jsonschema, functools32 09:42:04 INFO - Running setup.py install for functools32 09:42:04 INFO - warning: no files found matching '*.txt' 09:42:04 INFO - no previously-included directories found matching 'build' 09:42:04 INFO - no previously-included directories found matching 'dist' 09:42:04 INFO - no previously-included directories found matching '.git*' 09:42:04 INFO - Successfully installed jsonschema functools32 09:42:04 INFO - Cleaning up... 09:42:04 INFO - Return code: 0 09:42:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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')]} 09:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056b0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056c0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad42d9d940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, '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.0lmtef3AlC/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.E5xf4zuGza/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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:42: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', 'flake8'] in /builds/slave/test/build 09:42: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 flake8 09:42:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:42:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:04 INFO - 'HOME': '/Users/cltbld', 09:42:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:04 INFO - 'LOGNAME': 'cltbld', 09:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:04 INFO - 'MOZ_NO_REMOTE': '1', 09:42:04 INFO - 'NO_EM_RESTART': '1', 09:42:04 INFO - 'PAGER': '/bin/cat', 09:42:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:04 INFO - 'PWD': '/builds/slave/test', 09:42:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:04 INFO - 'SHELL': '/bin/bash', 09:42:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:42:04 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:42:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:04 INFO - 'USER': 'cltbld', 09:42:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:04 INFO - 'XPC_FLAGS': '0x0', 09:42:04 INFO - 'XPC_SERVICE_NAME': '0', 09:42:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:04 INFO - Downloading/unpacking flake8 09:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:42:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:42:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:42:08 INFO - no previously-included directories found matching 'docs/_build' 09:42:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:42:08 INFO - Running setup.py install for pep8 09:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:42:08 INFO - no previously-included directories found matching 'docs/_build' 09:42:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:42:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:42:08 INFO - Cleaning up... 09:42:08 INFO - Return code: 0 09:42:08 INFO - Running post-action listener: _resource_record_post_action 09:42:08 INFO - Running post-action listener: _start_resource_monitoring 09:42:08 INFO - Starting resource monitoring. 09:42:08 INFO - ##### 09:42:08 INFO - ##### Running install step. 09:42:08 INFO - ##### 09:42:08 INFO - Running pre-action listener: _resource_record_pre_action 09:42:08 INFO - Running main action method: install 09:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:09 INFO - Reading from file tmpfile_stdout 09:42:09 INFO - Detecting whether we're running mozinstall >=1.0... 09:42:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:42:09 INFO - Reading from file tmpfile_stdout 09:42:09 INFO - Output received: 09:42:09 INFO - Usage: mozinstall [options] installer 09:42:09 INFO - Options: 09:42:09 INFO - -h, --help show this help message and exit 09:42:09 INFO - -d DEST, --destination=DEST 09:42:09 INFO - Directory to install application into. [default: 09:42:09 INFO - "/builds/slave/test"] 09:42:09 INFO - --app=APP Application being installed. [default: firefox] 09:42:09 INFO - mkdir: /builds/slave/test/build/application 09:42:09 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'] 09:42:09 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 09:42:42 INFO - Reading from file tmpfile_stdout 09:42:42 INFO - Output received: 09:42:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:42:42 INFO - Running post-action listener: _resource_record_post_action 09:42:42 INFO - ##### 09:42:42 INFO - ##### Running run-tests step. 09:42:42 INFO - ##### 09:42:42 INFO - Running pre-action listener: _resource_record_pre_action 09:42:42 INFO - Running main action method: run_tests 09:42:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:42:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:42:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:42:42 INFO - 2016-04-22 09:42:42.855 screenresolution[1642:7533] starting screenresolution argv=screenresolution get 09:42:42 INFO - 2016-04-22 09:42:42.858 screenresolution[1642:7533] Display 0: 1600x1200x32@60 09:42:42 INFO - 2016-04-22 09:42:42.864 screenresolution[1643:7535] starting screenresolution argv=screenresolution list 09:42:42 INFO - Available Modes on Display 0 09:42:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:42:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:42:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:42:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:42:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:42:43 INFO - Intel Iris: 09:42:43 INFO - Chipset Model: Intel Iris 09:42:43 INFO - Type: GPU 09:42:43 INFO - Bus: Built-In 09:42:43 INFO - VRAM (Dynamic, Max): 1536 MB 09:42:43 INFO - Vendor: Intel (0x8086) 09:42:43 INFO - Device ID: 0x0a2e 09:42:43 INFO - Revision ID: 0x0009 09:42:43 INFO - Displays: 09:42:43 INFO - Display: 09:42:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:42:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:42:43 INFO - Display Serial Number: 1600x1200 60 09:42:43 INFO - Main Display: Yes 09:42:43 INFO - Mirror: Off 09:42:43 INFO - Online: Yes 09:42:43 INFO - Rotation: Supported 09:42:43 INFO - Return code: 0 09:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:42:43 INFO - Python 2.7.3 09:42:43 INFO - Return code: 0 09:42:43 INFO - grabbing minidump binary from tooltool 09:42:43 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:42:43 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 0x10554fe00>, '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 0x1053b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10554ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:42:43 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 09:42:43 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 09:42:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:42:43 INFO - Return code: 0 09:42:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:42:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:42:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:42:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:42:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:42:44 INFO - Return code: 0 09:42:44 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/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 09:42:44 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/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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 09:42:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0lmtef3AlC/Render', 09:42:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:44 INFO - 'HOME': '/Users/cltbld', 09:42:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:44 INFO - 'LOGNAME': 'cltbld', 09:42:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:42:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:44 INFO - 'MOZ_NO_REMOTE': '1', 09:42:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:42:44 INFO - 'NO_EM_RESTART': '1', 09:42:44 INFO - 'PAGER': '/bin/cat', 09:42:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:44 INFO - 'PWD': '/builds/slave/test', 09:42:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:42:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:44 INFO - 'SHELL': '/bin/bash', 09:42:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5xf4zuGza/Listeners', 09:42:44 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 09:42:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:44 INFO - 'USER': 'cltbld', 09:42:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:44 INFO - 'XPC_FLAGS': '0x0', 09:42:44 INFO - 'XPC_SERVICE_NAME': '0', 09:42:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:44 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/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 09:42:44 INFO - mozversion application_buildid: 20160422070002 09:42:44 INFO - mozversion application_changeset: 0da9dcd298a62e744a069c336797b24135f277a0 09:42:44 INFO - mozversion application_display_name: Nightly 09:42:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:42:44 INFO - mozversion application_name: Firefox 09:42:44 INFO - mozversion application_remotingname: firefox 09:42:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:42:44 INFO - mozversion application_vendor: Mozilla 09:42:44 INFO - mozversion application_version: 48.0a1 09:42:44 INFO - mozversion platform_buildid: 20160422070002 09:42:44 INFO - mozversion platform_changeset: 0da9dcd298a62e744a069c336797b24135f277a0 09:42:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:42:44 INFO - mozversion platform_version: 48.0a1 09:42:44 INFO - using testdate: 1461343364 09:42:44 INFO - actual date: 1461343364 09:42:44 INFO - starting webserver on 'localhost:49270' 09:42:44 INFO - SUITE-START | Running 2 tests 09:42:44 INFO - TEST-START | dromaeo_css 09:42:44 INFO - operating with platform_type : mac_ 09:42:44 INFO - Initialising browser for dromaeo_css test... 09:42:44 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpKLxyv7/profile http://localhost:49270/getInfo.html) 09:42:47 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 09:42:47 INFO - PROCESS | 1661 | colorDepth:24 09:42:47 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 09:42:47 INFO - PROCESS | 1661 | __metrics 09:42:47 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:42:48 INFO - TEST-INFO | 1661: exit 0 09:42:48 INFO - Browser initialized. 09:42:48 INFO - Running cycle 1/1 for dromaeo_css test... 09:42:48 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpKLxyv7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:00 INFO - PROCESS | 1664 | RSS: Main: 249122816 09:43:00 INFO - PROCESS | 1664 | 09:43:49 INFO - PROCESS | 1664 | 1461343429819 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] 09:46:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 09:46:01 INFO - PROCESS | 1664 | RSS: Main: 264613888 09:46:01 INFO - PROCESS | 1664 | 09:49:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 09:49:03 INFO - PROCESS | 1664 | RSS: Main: 276193280 09:49:03 INFO - PROCESS | 1664 | 09:52:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 09:52:06 INFO - PROCESS | 1664 | RSS: Main: 277233664 09:52:06 INFO - PROCESS | 1664 | 09:55:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 09:55:08 INFO - PROCESS | 1664 | RSS: Main: 279113728 09:55:08 INFO - PROCESS | 1664 | 09:58:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 09:58:12 INFO - PROCESS | 1664 | RSS: Main: 281792512 09:58:12 INFO - PROCESS | 1664 | 10:01:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 10:01:15 INFO - PROCESS | 1664 | RSS: Main: 282894336 10:01:15 INFO - PROCESS | 1664 | 10:01:15 INFO - PROCESS | 1664 | __start_tp_report 10:01:15 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 10:01:15 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 10:01:15 INFO - PROCESS | 1664 | |i|pagename|runs| 10:01:15 INFO - PROCESS | 1664 | |0;dojo.html;3137.9372412551747;3422.264213194163;3462.2036931505754;3466.913327166822;3495.2485215678626;5658.801941932038;5695.601307908438;5699.629524080932;5719.313682358118;5722.856928576788;5611.242482264893;5717.942820571793;5742.712864356787;5759.769609215627;5859.121131830217;5148.227765835127;5186.092433824085;5207.453217412174;5263.947360526384;5275.36695596529;248.9379809781529;5186.9626074785;5194.558462530689;5220.582353411718;5265.8946821063555;4332.436783218193;5136.229565565139;5139.306193663882;5191.740412979355;5209.843704688866;4997.6501644884875;5286.259923610698;5307.840764777025;5312.442193569696;5314.521693047605;4637.5594318540025;5159.432462429129;5243.79024839006;5262.447443018466;5270.8155214567305;5505.284313039279;5582.27430434041;5603.2435621191435;5626.831195064114;5675.460831221028;4732.716037037754;6161.969190154021;6273.749050037993;6300.21247344082;6306.779262725782;6198.442140207403;6258.87482250357;6268.498520118425;6290.779822706183;6293.842653933642;5796.797112101056;5815.970920145457;5831.5334773218465;5841.357450680422;5892.941070589282;6163.753449862045;6176.227971503562;6215.34738852414;6274.9686251569365;6275.811725648238;6121.392004143319;6147.354527774609;6147.924113280158;6155.507559395238;6162.322144564095;6242.375762423721;6245.375462453809;6282.560220784501;6294.968525157345;6298.905516417258;6105.023196288573;6174.876502469925;6210.192674952227;6229.909765790969;6255;6102.156009074812;6137.959273351834;6271.905921411182;6290.150829638032;6306.306306306303;4839.68542044773;4887.3890763654545;4912.066707325596;4943.2585112233455;4950.653454258168;4347.000189956328;4378.562143785596;4428.4685837699035;4485.0805584855025;4486.394336764561;5695.857603559944;5730.914036289459;5784.3926387729525;5794.188813566104;5803;5277.973610131925;6258.405451482102;6305.274893387227;6314.8421289467215;6342.112104305401;5672.936614228271;5793;5822.068469045017;5842.065269556851;5888.793892213752;5381.3811411687375;5396.64921780083;5402.189671549299;5409.56723462122;5411.02601531728;6265.686715664198;6326.9876819708625;6327.620342779356;6364.745410183541;6375.458086062737;6135.44703110649;6197.96901015492;6231.3145553988115;6254.530910181846;6260.40526150015;6397.584157029778;6404.327545607644;6410.423061924449;6424.582402143846;6443.452306553808;6083.847903802263;6107.977837958671;6203.31763506005;6209.5963762357105;6219.160413344141;6158.353372895961;6193.504519638328;6213.099100630474;6254.21822272216;6270.059491076193;6110.57225994194;6133.969330153321;6151.538634602333;6151.784687536094;6152.630842149485;5075.264086707481;5098.337216161875;5542.528885044816;5663.433656634304;5716.199732037601;5811.506021988178;5996.910046349221;6000.309964354155;6078.7264573093435;6111.572189946661;5080.618953578422;6011.308699499614;6096.817095487142;6156.630602163885;6160.784372546939;5885.499732522783;5916.526677865674;5974.850628734316;5982.4017598239825;6061.787837425845 10:01:15 INFO - PROCESS | 1664 | |1;ext.html;524.1875093604912;524.2791162152041;572.8166986564298;580.9215755872956;636.7614988846692;31084.533731994008;37472;38526.42210366847;38602.227955440874;38815.835524934264;32451.67548324516;39726.40410393846;39899.202015959665;39958.60041399585;40183;9425.293103017268;9485.33602647815;9485.71542853712;9614.278929080312;9638.084381983701;9426.670066547673;9557;9605.66380176694;9607.375520591138;9682.70951871445;8365.456245344063;9617.615295388176;9692.27307951903;9731.124198822105;9755.951250237458;9672.75818104546;9695.272854535939;9697.175740062103;9722.173615242747;9755.12203901645;9270.21203197729;9424.764380890463;9449.905500944971;9453.90546094537;9460.621575136985;38764.8370548884;38864.80567597144;39197.804010979766;39453;39518.0120496987;2737.4935636907235;3032.8331941743195;3042.421939831447;3383.661633836621;3391.728661707082;26551.601725974127;26678.33304167392;26704.73295267042;26992.865035674695;28070.298242543897;2575.6651635287294;2588.521123592123;2627.7635012848937;2658.6012098185233;2729.6451461310103;377475;378716;379401;380675.9999999972;381774;33545;33790.49314260288;33854.830725846216;35567.82216088903;36160.27679446396;35710.285794284486;35824;35825.46261806075;35844.46233306503;36082.09794755152;14689.971701980972;14949.327280272413;15117.773233401507;15135;15141.848581514043;12818.359082045861;12851.871481285254;12884;12988.740225195443;13005.349732513336;8151;8200.05699344571;8222.342212622976;8256.298214651702;8264.173582641688;3378.797272163678;3403.5915690117345;3421.196018935548;3430.691237788611;3435.5362026126154;968.2399316536626;997.4115271989416;1033.245730616639;1063.1601035182275;1078.1105587890022;25823.0961916332;28976;29391.706082939323;29921.251968700955;29964;1047.5704960965968;1079.5411949921252;1085.234909388879;1149.6493569461227;1210.945507452149;12776.297303648389;13365.46538138483;14021.719565608631;14335.641608959859;14338.068025578305;655285;656722;661993;662214;664833;46413;50200.493985179775;54985;55941.60145996383;56263.156052659244;1424.2949739878827;1474.7787831825312;1490.903091299062;1497.341169885247;1503.1657430126386;22293.665595015762;24534.386640334134;27903.720962790114;28014.73933672949;28194.2951426216;38464.61535384722;48391.27413088736;49419.75290123526;49560.75219623879;49723;438429;515569;518041;518141;518899;25523.87238063798;40676.3898541528;42726;42879.571204288804;42912.78543607262;41886.581134188265;42273.286258330394;42874.35688464738;43036.78481607572;43253.56746432495;30857.919972800843;33291.334173316885;35395.82302088473;36497.817510912275;37629.623703763704;34870.30259394747;36445.63554364529;36520.45219321659;37195.81402092972;37231.25537489289;35616;35966.280674386886;36286.45570316395;36597.08507287339;36651.633483664824;28346;33134.502982454804;33269;33356;33606.82376116824;23434.425538874766;24476.632850507613;24544;25135.74864251334;25347.39578126518 10:01:15 INFO - PROCESS | 1664 | |2;jquery.html;336.71715758762633;397.83092185821016;399.5804405374356;401.2356460941906;415.73600763515157;19015.904920475394;20410.489737756565;21016.36950891472;21021.894890525546;21046.684299735516;20324.882131482762;20713.964301784887;20819.37541873746;21314.57370852582;21326.36020919375;4951.158303088484;5427.674339539631;5657.9249942511;5673.149027645865;5680.091185410335;5578.135389014709;5586.273784408021;5631.2960879890015;5648.926703926241;5655.688937108457;5585.525230355424;6023.2169817923605;6104.908426373608;6149.29283132441;6156.784512542062;5515.503604675599;5890.429425186344;6091.664958427307;6096.085587161939;6140.1096840958035;5349.465053494659;5424.1321388578035;5444.537214336747;5449.809256675997;5465.699386533739;13689.31553422325;14187.29063546829;22966.277529185212;25486.872565637237;25794.742052579422;2079.2514694709894;2168.490404754881;2212.093041852833;2261.197274967379;2793.5669971154502;9648.75878103053;9906.90093099067;10142.746431339276;10156.136728378096;10225.700600836044;1692.6191606888474;1711.863050955933;1751.9313218936438;1867.1131212674006;1925.5089952062274;110598.89401105966;115591;117578;120366.3981680086;128517.35741321326;10456.058954694114;10972.780544389227;11712.297262164297;11887.038638624703;11944.462499187557;15200.695986080216;15281.617959550878;15289.694206115815;15301.311440985182;15346;7048.964755176294;8782.341324400695;8929.464232146092;8948.8657670135;8989.921209454908;7403.814904627319;8607.698730544402;8768.824623507495;8795.692150774692;8835.823283534293;4633.027064316531;4698.506656800987;4699.882502937386;4716.033213191287;4775.6657034007285;1563.5622025832786;1711.3240270093243;1943.8833669979847;2016.4656366063004;2038.7553493580865;882.8366752150872;931.231733819588;935.2004036548789;952.2334520710756;958.9280803939732;16123.785792088755;19097.80902190988;19314.62307265848;20681.379558613266;20900.268490602757;781.8358144789544;957.3107362698846;1005.2762011351815;1026.7176526455135;1028.717102796737;10465.9476702616;10658.946705266579;10745.979131982449;10794.298370605886;10822.78354432907;600174;606868;607043.9647801733;612700.3014834226;614840;90679;110060;112025;121262;126662;945.7304668169676;950.8858936927613;979.314479864098;980.0787259975742;981.1856159387692;17564.91217543904;17716.82283177152;17764.378246761302;17899.552511186805;18044.458666240032;45867;48744.0251194967;53181.40455786332;53433.46566534285;53434.46565534295;74081;76431;76463.61768191123;77514.83727743976;78036.21963780516;7710.383169346551;7761.7671469855995;8080.353571714366;8245.628946697292;8317.667293308443;9330;10459.110975567162;12212.877871221173;12549.121561490972;12644.241345519298;8987.775305617412;10871.934332476803;11025;11128.44357782124;11317.773644527228;10790.298630588986;10826;11043.668689939315;11179.60871369498;11183.608573699881;9930.453825039693;11314.83027754568;11464.197506174487;11695.824562631737;11755.000824929635;8161.224683655043;8182.509049457051;8335;8342;8492.320614350961;8407.579621018802;11118;11205.495752690986;11379.943100284445;11485.540578376771 10:01:15 INFO - PROCESS | 1664 | |3;mootools.html;1425.550951450293;1628.6742651469706;1846.686063369227;1916.271816709651;1967.1246295398535;8107.513549187053;8677.566121693913;8767.254783343424;8916.598753056112;8972.282217422598;8636.438631488949;8702.303815694746;8749.650013999448;8821.558922053904;8854.513001784899;2451.240115564172;2462.2613216035206;2466.8889899954456;2481.2928315430104;2482.1064416809936;2436.61014237722;2443.584590619599;2448.926532204028;2481.8510889346608;2484.7887929526014;2375.7861792438675;2430.708315002202;2443.5723748344058;2464.4947785703976;2490.0537795637724;2426.017462927517;2442.5481285962155;2442.9144979925704;2469.2098528470897;2480.06997375984;2422.4186195313173;2434.586120359543;2448.2899959011866;2451.411661201299;2465.90136394544;8844.20402163802;8935.553222338922;8943.105689431004;8948.597313120925;8949.149830766068;4193.958060419387;4339.826406943718;4612.262038073925;5251.553617942442;5455.645383050089;3135.18485193849;3465.648397125123;3571.4107172316535;3649.160693040589;3651.2879988402274;942.9575669094838;1036.315986521902;1045.5399624165343;1055.37205362809;1059.2214722179192;9852.359596626196;11591.362475063868;11715.004224640916;11763.7059073523;11766.294022358601;4823.03539292143;4854.708717476892;4856.732879691651;4906;4930.926036109461;9861.556229969668;9888.653897113567;9970;9984.500774961223;10004.449755263386;5311.575073994071;5370.194470829329;5373.946260537345;5397.16343966678;5421.4578542146255;4401.603855652943;4756.952430475721;4897.118518666674;4912.975435122873;4919.950800492021;4045.777482238505;4068.044009657728;4081.8979525511504;4119.551681195517;4146.771927544014;1184.390039129849;1375.4154484344315;1385.9653508662363;1386.1544457880684;1389.3608939887563;771.1223171577227;869.9951555952885;896.9236915701184;908.4004556992353;946.5172761891484;5674.120511320752;5839.503642190376;5888.470037696542;5893.6463812171405;5961.101540458909;462.6275847942439;469.36869909971034;475.7383439108477;479.3121870116394;483.32817383836493;3554.9111272217883;3908.6482216600643;3920.3531417316394;3974.463447434617;4075.5313138989395;10405;10520.316179448311;10810.189235807346;10881.020708136306;10906.672799816019;10600.893991059991;10612.946935265274;10778.784424311627;10807.297525660806;10823.567057317776;8061.395395345256;8212.219839115274;8274.420790544724;8310.792230194293;8315;5880.588358814842;5922.022866227197;5998;6076.78731244422;6126.663033533198;9611.711648650551;9884.604615815288;9890.258230632875;10013.24900632441;10040.246981476565;8466.957665211634;9581.856272156063;10165.847512287173;10201.795964080527;10309.432981185806;6454.580452270588;7014.929850701427;7229.385502232369;7277.199508054004;7356.96321518389;8259.463134896212;8272.090070092165;8308.33533317321;8320.417570769989;8368.41421100517;7236.38490728294;7389.667464964197;7416.9258307418395;7491.213422590549;7557.05536807899;7078.18600860887;7392.55644661322;7449.962750186214;7452.552846829208;7530.28462296081;7023.438124949889;7031.964840175767;7037.014817925392;7062.39969602569;7126.679299431435;4896;4955.45489996093;5066.06277838601;5071.416787069386;5228.712420816892;4688.413948256468;4722.1972264714395;5003.199488081889;5092.159793634009;5251.52736253739 10:01:15 INFO - PROCESS | 1664 | |4;prototype.html;276.4084858403018;317.729929559874;323.4743541744665;324.4775910783638;328.9259916518785;5234.371875374955;5859.472647461727;6185.762847430509;6213;6246.906296405557;5280.600640830183;5881.85295367615;6085.726142323595;6109.69451527423;6138.72867039195;4378.518362980061;4483.215437298476;4595.609373203281;4608.976955115219;4616.33063205835;4540.682152249344;4616.792244349012;4630.8147674093;4635.46692130406;4641.234196357614;4379.978100109495;4548.204064288753;4559.156556037127;4584.951007579972;4610.30845373195;3863.285292220948;4262.744235345874;4515.796789144496;4524.796384162721;4528.615067719248;3394.507796369537;3860.401637746154;3864.53625564934;3880.825362858678;3898.649121579043;4815.759212039419;5950.702464876739;5953.523718102585;5953.553483488712;5954.821355359346;4443.089166720814;5121.129408000612;5167.173252279617;5274.92087618686;5287.41838397776;5835.533157347402;5882.911756323659;6248.687775567137;6493.350664933469;6518.413342799124;3723.4600982857605;3980.5024371953505;4115.464989551369;4268.442018663197;4285.742855428684;6726.630035348054;6861.794146175573;6898.517103802736;6928.376446119823;6954.547954382949;3748.231612519427;4329.242382583036;4330.372096046056;4355.564443555682;4367.301231802896;3499;3818.427235914635;4166.66666666666;4294.56434852117;4358.346248062816;4338.3709362142945;4760.880977975509;5016.698998060128;5167.974160129251;5249.370075590953;5824.446677565625;6162.238307182798;6602.372774586406;6621.9006714899315;6626.801195964129;1203.7652657731833;1417.7731562950084;1427.757281262188;1500.4973333933037;1522.3834347089446;917.7426925112505;970.737900766789;976.814405263012;997.7555498902815;1003.0370843989851;4567.611753000966;5093.0577843099145;6067.848303792441;6113.908291375633;6115.4190351916495;6477.222733272038;6745.628990405575;6749.291324410964;6777.525573209927;6802.251752307242;5314.9635821014535;5765.654060756368;5848.941510584839;5905.498032667186;6165.414285642857;3484.61669216386;3504.9474257886154;3554.2003049314217;3611.4582812577796;3627.183883626163;6758.797236082925;6841.281665425158;7158.2841715829045;7251.637418129072;7287.380572651384;6509.349065093453;7093.574385536885;7098.787036388917;7106.857862842714;7142.5000249982;6788.2193547742645;6892.517523773388;6919.481038922202;7222.133343998754;7246.239144889816;6837.829054273683;6856.451483881177;6871.312868713088;6890.793276201722;6895.34494223048;6350.206224221973;6780.966095169492;6792.796216113525;6822.795316140524;6834.726610935507;6159.476444502267;6672.833179170365;7187.5687458752645;7255.206745403163;7279.59962202084;3568.946465803067;4161.0221597923855;4283.464566929134;4325.026868954586;4341.327094300388;5962.642241465526;6442.484601231984;6739.865202695821;6770.898436523555;6827.746843541719;5975.745093530408;6570.934290657224;6577.2570268879745;6620.470362370903;6645.833854153685;5842.766289348378;5887.882242355215;6129.570930034854;6572;6597.472202223907;5414.485623865727;5428.728563571726;5917.727688546983;5924.940750592439;6071.028635418312;6233.501319894488;6619.635920024445;6624.370684784938;6634.535582509371;6647.966760166169;6231.22109736283;6466;6471.805845824632;6494.772682956074;6502.512311576746 10:01:15 INFO - PROCESS | 1664 | |5;yui.html;692.4737199728206;695.8747425463415;700.8002719225021;756.1077928044906;769.3191525499931;14650.78023829642;14942.701145977075;15033.548993530212;15079.62300942477;15113.848861511382;11702;13999.510017149401;14052.508162214324;14089.013769036172;14133.646658833535;718.9532680375759;804.8752443371258;901.4005686218657;910.9316801239917;938.4275591888942;887.6538150121426;938.549496241801;938.648006997376;942.9575669094872;946.711253067814;947.052947052947;964.2045312617084;987.521052289639;988.6342053440237;990.8166989107002;894.3426581462685;967.690339091491;973.5931578868538;975.327024353194;983.3902980152351;696.8014115976922;718.4862823081522;727.7671145233527;731.0131322714293;736.8968344431784;14753.926230368887;14865.405383784635;14873.33070011852;14876.181810000446;14886;12549;12561.120721549496;12601;12678.429470673842;12747.745045099138;9980.700578982642;10009.59961601535;10062.849057264073;10167;10171.135453486462;3456.1359660084977;3484.61669216386;3485.041613556267;3490.7730997485337;3493.790372577628;78686.21313786904;78850.21149788485;79907.60046199732;80256.59871700604;80807.7878831818;9343.626254949726;9406.717798466058;9435.622575096919;9591.520423978773;9666.806663866684;21265.468363291042;21368.358949231548;21371.57256854854;21422.678659820114;21650.242241521788;7285.271472852778;7335.266473352729;7386.409087273113;7659.157492675801;7706.460547761603;4088.7546747195265;4127.422160897477;4131.173765246903;4131.5042194936195;4138.985948442591;3532.1699400640828;3649.6532829381167;3651.543557055368;3672.761270517408;3849.1531862990096;606.3875485759327;665.5973136252497;671.4762485261406;690.892911598703;705.8764716174752;514.0644027869242;522.8188650473786;548.8902219556105;572.2474945446725;573.5067841656172;7531.610500726384;7784.883226751604;7859.567723775133;7878.094019187753;7879.803004924923;525.2410267163988;561.6461629173676;574.4829653312053;577.2985822226016;583.0962008886294;3433.2446861690387;3650.908727281839;3798.877105427324;3830.578636349999;3869.245497128033;92619.53690231641;94141.5292923531;95734.52132739291;95819.52090239504;96333.55499667511;81480.59259703664;81750.18249817425;83666;84077.57961210277;85391.14608853956;70986;71297;71902.9214561782;71938;72286;7729.613519324123;8015.7595272141925;8151.673933042612;8200.933878595744;8207.753767386988;34161.658383415845;34310.97067087991;41270.38094428646;41739.16521669611;42667.35998959956;51958;57418.13872791828;58576.4142358571;60768.08847867197;60783;10910;10917.23579349438;11048.171387145836;11108.222424430536;11252.549898003988;12142.028637709138;12155.209911355734;12355.196912201038;12466.065045121471;12487.750244995232;11491.827622585835;11570.94214528922;11634;11920.70198245016;11973.461194246105;11377.886221137682;11507.827382589101;11732.061435085343;11829.17195796286;11864.99147572466;10917.508712107816;11490.54037838477;11665.00847427978;11703.473343699725;11805.881941180822;8727.519986400555;9187.954060229657;9439.972258687629;9590.376625519319;9779.364341317792;9510.714678559654;9641.42151470914;9925;9951.353162044445;9951.800963980824 10:01:15 INFO - PROCESS | 1664 | __end_tp_report 10:01:15 INFO - PROCESS | 1664 | __start_cc_report 10:01:15 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,414 10:01:15 INFO - PROCESS | 1664 | __end_cc_report 10:01:15 INFO - PROCESS | 1664 | __startTimestamp1461344475138__endTimestamp 10:01:15 INFO - PROCESS | 1664 | 10:01:15 INFO - PROCESS | 1664 | ------- Summary: start ------- 10:01:15 INFO - PROCESS | 1664 | Number of tests: 6 10:01:15 INFO - PROCESS | 1664 | 10:01:15 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5682.18 Median:5885.50 stddev:783.58 (13.3%) stddev-sans-first:760.13 10:01:15 INFO - PROCESS | 1664 | Values: 3137.9 3422.3 3462.2 3466.9 3495.2 5658.8 5695.6 5699.6 5719.3 5722.9 5611.2 5717.9 5742.7 5759.8 5859.1 5148.2 5186.1 5207.5 5263.9 5275.4 248.9 5187.0 5194.6 5220.6 5265.9 4332.4 5136.2 5139.3 5191.7 5209.8 4997.7 5286.3 5307.8 5312.4 5314.5 4637.6 5159.4 5243.8 5262.4 5270.8 5505.3 5582.3 5603.2 5626.8 5675.5 4732.7 6162.0 6273.7 6300.2 6306.8 6198.4 6258.9 6268.5 6290.8 6293.8 5796.8 5816.0 5831.5 5841.4 5892.9 6163.8 6176.2 6215.3 6275.0 6275.8 6121.4 6147.4 6147.9 6155.5 6162.3 6242.4 6245.4 6282.6 6295.0 6298.9 6105.0 6174.9 6210.2 6229.9 6255.0 6102.2 6138.0 6271.9 6290.2 6306.3 4839.7 4887.4 4912.1 4943.3 4950.7 4347.0 4378.6 4428.5 4485.1 4486.4 5695.9 5730.9 5784.4 5794.2 5803.0 5278.0 6258.4 6305.3 6314.8 6342.1 5672.9 5793.0 5822.1 5842.1 5888.8 5381.4 5396.6 5402.2 5409.6 5411.0 6265.7 6327.0 6327.6 6364.7 6375.5 6135.4 6198.0 6231.3 6254.5 6260.4 6397.6 6404.3 6410.4 6424.6 6443.5 6083.8 6108.0 6203.3 6209.6 6219.2 6158.4 6193.5 6213.1 6254.2 6270.1 6110.6 6134.0 6151.5 6151.8 6152.6 5075.3 5098.3 5542.5 5663.4 5716.2 5811.5 5996.9 6000.3 6078.7 6111.6 5080.6 6011.3 6096.8 6156.6 6160.8 5885.5 5916.5 5974.9 5982.4 6061.8 10:01:15 INFO - PROCESS | 1664 | 10:01:15 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:62925.57 Median:36558.77 stddev:141269.77 (386.4%) stddev-sans-first:141588.37 10:01:15 INFO - PROCESS | 1664 | Values: 524.2 524.3 572.8 580.9 636.8 31084.5 37472.0 38526.4 38602.2 38815.8 32451.7 39726.4 39899.2 39958.6 40183.0 9425.3 9485.3 9485.7 9614.3 9638.1 9426.7 9557.0 9605.7 9607.4 9682.7 8365.5 9617.6 9692.3 9731.1 9756.0 9672.8 9695.3 9697.2 9722.2 9755.1 9270.2 9424.8 9449.9 9453.9 9460.6 38764.8 38864.8 39197.8 39453.0 39518.0 2737.5 3032.8 3042.4 3383.7 3391.7 26551.6 26678.3 26704.7 26992.9 28070.3 2575.7 2588.5 2627.8 2658.6 2729.6 377475.0 378716.0 379401.0 380676.0 381774.0 33545.0 33790.5 33854.8 35567.8 36160.3 35710.3 35824.0 35825.5 35844.5 36082.1 14690.0 14949.3 15117.8 15135.0 15141.8 12818.4 12851.9 12884.0 12988.7 13005.3 8151.0 8200.1 8222.3 8256.3 8264.2 3378.8 3403.6 3421.2 3430.7 3435.5 968.2 997.4 1033.2 1063.2 1078.1 25823.1 28976.0 29391.7 29921.3 29964.0 1047.6 1079.5 1085.2 1149.6 1210.9 12776.3 13365.5 14021.7 14335.6 14338.1 655285.0 656722.0 661993.0 662214.0 664833.0 46413.0 50200.5 54985.0 55941.6 56263.2 1424.3 1474.8 1490.9 1497.3 1503.2 22293.7 24534.4 27903.7 28014.7 28194.3 38464.6 48391.3 49419.8 49560.8 49723.0 438429.0 515569.0 518041.0 518141.0 518899.0 25523.9 40676.4 42726.0 42879.6 42912.8 41886.6 42273.3 42874.4 43036.8 43253.6 30857.9 33291.3 35395.8 36497.8 37629.6 34870.3 36445.6 36520.5 37195.8 37231.3 35616.0 35966.3 36286.5 36597.1 36651.6 28346.0 33134.5 33269.0 33356.0 33606.8 23434.4 24476.6 24544.0 25135.7 25347.4 10:01:15 INFO - PROCESS | 1664 | 10:01:15 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34540.50 Median:1565.14 stddev:101120.54 (6460.8%) stddev-sans-first:101371.59 10:01:15 INFO - PROCESS | 1664 | Values: 336.7 397.8 399.6 401.2 415.7 19015.9 20410.5 21016.4 21021.9 21046.7 20324.9 20714.0 20819.4 21314.6 21326.4 4951.2 5427.7 5657.9 5673.1 5680.1 5578.1 5586.3 5631.3 5648.9 5655.7 5585.5 6023.2 6104.9 6149.3 6156.8 5515.5 5890.4 6091.7 6096.1 6140.1 5349.5 5424.1 5444.5 5449.8 5465.7 13689.3 14187.3 22966.3 25486.9 25794.7 2079.3 2168.5 2212.1 2261.2 2793.6 9648.8 9906.9 10142.7 10156.1 10225.7 1692.6 1711.9 1751.9 1867.1 1925.5 110598.9 115591.0 117578.0 120366.4 128517.4 10456.1 10972.8 11712.3 11887.0 11944.5 15200.7 15281.6 15289.7 15301.3 15346.0 7049.0 8782.3 8929.5 8948.9 8989.9 7403.8 8607.7 8768.8 8795.7 8835.8 4633.0 4698.5 4699.9 4716.0 4775.7 1563.6 1711.3 1943.9 2016.5 2038.8 882.8 931.2 935.2 952.2 958.9 16123.8 19097.8 19314.6 20681.4 20900.3 781.8 957.3 1005.3 1026.7 1028.7 10465.9 10658.9 10746.0 10794.3 10822.8 600174.0 606868.0 607044.0 612700.3 614840.0 90679.0 110060.0 112025.0 121262.0 126662.0 945.7 950.9 979.3 980.1 981.2 17564.9 17716.8 17764.4 17899.6 18044.5 45867.0 48744.0 53181.4 53433.5 53434.5 74081.0 76431.0 76463.6 77514.8 78036.2 7710.4 7761.8 8080.4 8245.6 8317.7 9330.0 10459.1 12212.9 12549.1 12644.2 8987.8 10871.9 11025.0 11128.4 11317.8 10790.3 10826.0 11043.7 11179.6 11183.6 9930.5 11314.8 11464.2 11695.8 11755.0 8161.2 8182.5 8335.0 8342.0 8492.3 8407.6 11118.0 11205.5 11379.9 11485.5 10:01:15 INFO - PROCESS | 1664 | 10:01:15 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5695.43 Median:4901.56 stddev:3176.09 (64.8%) stddev-sans-first:3168.79 10:01:15 INFO - PROCESS | 1664 | Values: 1425.6 1628.7 1846.7 1916.3 1967.1 8107.5 8677.6 8767.3 8916.6 8972.3 8636.4 8702.3 8749.7 8821.6 8854.5 2451.2 2462.3 2466.9 2481.3 2482.1 2436.6 2443.6 2448.9 2481.9 2484.8 2375.8 2430.7 2443.6 2464.5 2490.1 2426.0 2442.5 2442.9 2469.2 2480.1 2422.4 2434.6 2448.3 2451.4 2465.9 8844.2 8935.6 8943.1 8948.6 8949.1 4194.0 4339.8 4612.3 5251.6 5455.6 3135.2 3465.6 3571.4 3649.2 3651.3 943.0 1036.3 1045.5 1055.4 1059.2 9852.4 11591.4 11715.0 11763.7 11766.3 4823.0 4854.7 4856.7 4906.0 4930.9 9861.6 9888.7 9970.0 9984.5 10004.4 5311.6 5370.2 5373.9 5397.2 5421.5 4401.6 4757.0 4897.1 4913.0 4920.0 4045.8 4068.0 4081.9 4119.6 4146.8 1184.4 1375.4 1386.0 1386.2 1389.4 771.1 870.0 896.9 908.4 946.5 5674.1 5839.5 5888.5 5893.6 5961.1 462.6 469.4 475.7 479.3 483.3 3554.9 3908.6 3920.4 3974.5 4075.5 10405.0 10520.3 10810.2 10881.0 10906.7 10600.9 10612.9 10778.8 10807.3 10823.6 8061.4 8212.2 8274.4 8310.8 8315.0 5880.6 5922.0 5998.0 6076.8 6126.7 9611.7 9884.6 9890.3 10013.2 10040.2 8467.0 9581.9 10165.8 10201.8 10309.4 6454.6 7014.9 7229.4 7277.2 7357.0 8259.5 8272.1 8308.3 8320.4 8368.4 7236.4 7389.7 7416.9 7491.2 7557.1 7078.2 7392.6 7450.0 7452.6 7530.3 7023.4 7032.0 7037.0 7062.4 7126.7 4896.0 4955.5 5066.1 5071.4 5228.7 4688.4 4722.2 5003.2 5092.2 5251.5 10:01:15 INFO - PROCESS | 1664 | 10:01:15 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5253.76 Median:5937.82 stddev:1715.68 (28.9%) stddev-sans-first:1679.32 10:01:15 INFO - PROCESS | 1664 | Values: 276.4 317.7 323.5 324.5 328.9 5234.4 5859.5 6185.8 6213.0 6246.9 5280.6 5881.9 6085.7 6109.7 6138.7 4378.5 4483.2 4595.6 4609.0 4616.3 4540.7 4616.8 4630.8 4635.5 4641.2 4380.0 4548.2 4559.2 4585.0 4610.3 3863.3 4262.7 4515.8 4524.8 4528.6 3394.5 3860.4 3864.5 3880.8 3898.6 4815.8 5950.7 5953.5 5953.6 5954.8 4443.1 5121.1 5167.2 5274.9 5287.4 5835.5 5882.9 6248.7 6493.4 6518.4 3723.5 3980.5 4115.5 4268.4 4285.7 6726.6 6861.8 6898.5 6928.4 6954.5 3748.2 4329.2 4330.4 4355.6 4367.3 3499.0 3818.4 4166.7 4294.6 4358.3 4338.4 4760.9 5016.7 5168.0 5249.4 5824.4 6162.2 6602.4 6621.9 6626.8 1203.8 1417.8 1427.8 1500.5 1522.4 917.7 970.7 976.8 997.8 1003.0 4567.6 5093.1 6067.8 6113.9 6115.4 6477.2 6745.6 6749.3 6777.5 6802.3 5315.0 5765.7 5848.9 5905.5 6165.4 3484.6 3504.9 3554.2 3611.5 3627.2 6758.8 6841.3 7158.3 7251.6 7287.4 6509.3 7093.6 7098.8 7106.9 7142.5 6788.2 6892.5 6919.5 7222.1 7246.2 6837.8 6856.5 6871.3 6890.8 6895.3 6350.2 6781.0 6792.8 6822.8 6834.7 6159.5 6672.8 7187.6 7255.2 7279.6 3568.9 4161.0 4283.5 4325.0 4341.3 5962.6 6442.5 6739.9 6770.9 6827.7 5975.7 6570.9 6577.3 6620.5 6645.8 5842.8 5887.9 6129.6 6572.0 6597.5 5414.5 5428.7 5917.7 5924.9 6071.0 6233.5 6619.6 6624.4 6634.5 6648.0 6231.2 6466.0 6471.8 6494.8 6502.5 10:01:15 INFO - PROCESS | 1664 | 10:01:15 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17944.56 Median:29579.76 stddev:25501.39 (86.2%) stddev-sans-first:25540.03 10:01:15 INFO - PROCESS | 1664 | Values: 692.5 695.9 700.8 756.1 769.3 14650.8 14942.7 15033.5 15079.6 15113.8 11702.0 13999.5 14052.5 14089.0 14133.6 719.0 804.9 901.4 910.9 938.4 887.7 938.5 938.6 943.0 946.7 947.1 964.2 987.5 988.6 990.8 894.3 967.7 973.6 975.3 983.4 696.8 718.5 727.8 731.0 736.9 14753.9 14865.4 14873.3 14876.2 14886.0 12549.0 12561.1 12601.0 12678.4 12747.7 9980.7 10009.6 10062.8 10167.0 10171.1 3456.1 3484.6 3485.0 3490.8 3493.8 78686.2 78850.2 79907.6 80256.6 80807.8 9343.6 9406.7 9435.6 9591.5 9666.8 21265.5 21368.4 21371.6 21422.7 21650.2 7285.3 7335.3 7386.4 7659.2 7706.5 4088.8 4127.4 4131.2 4131.5 4139.0 3532.2 3649.7 3651.5 3672.8 3849.2 606.4 665.6 671.5 690.9 705.9 514.1 522.8 548.9 572.2 573.5 7531.6 7784.9 7859.6 7878.1 7879.8 525.2 561.6 574.5 577.3 583.1 3433.2 3650.9 3798.9 3830.6 3869.2 92619.5 94141.5 95734.5 95819.5 96333.6 81480.6 81750.2 83666.0 84077.6 85391.1 70986.0 71297.0 71902.9 71938.0 72286.0 7729.6 8015.8 8151.7 8200.9 8207.8 34161.7 34311.0 41270.4 41739.2 42667.4 51958.0 57418.1 58576.4 60768.1 60783.0 10910.0 10917.2 11048.2 11108.2 11252.5 12142.0 12155.2 12355.2 12466.1 12487.8 11491.8 11570.9 11634.0 11920.7 11973.5 11377.9 11507.8 11732.1 11829.2 11865.0 10917.5 11490.5 11665.0 11703.5 11805.9 8727.5 9188.0 9440.0 9590.4 9779.4 9510.7 9641.4 9925.0 9951.4 9951.8 10:01:15 INFO - PROCESS | 1664 | -------- Summary: end -------- 10:01:15 INFO - PROCESS | 1664 | 10:01:15 INFO - TEST-INFO | 1664: exit 0 10:01:15 INFO - TEST-OK | dromaeo_css | took 1111114ms 10:01:15 INFO - TEST-START | kraken 10:01:15 INFO - operating with platform_type : mac_ 10:01:15 INFO - Initialising browser for kraken test... 10:01:15 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp1Pt4G3/profile http://localhost:49270/getInfo.html) 10:01:18 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 10:01:18 INFO - PROCESS | 1675 | colorDepth:24 10:01:18 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 10:01:18 INFO - PROCESS | 1675 | __metrics 10:01:18 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:01:19 INFO - TEST-INFO | 1675: exit 0 10:01:19 INFO - Browser initialized. 10:01:19 INFO - Running cycle 1/1 for kraken test... 10:01:19 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmp1Pt4G3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:31 INFO - PROCESS | 1678 | RSS: Main: 249335808 10:01:31 INFO - PROCESS | 1678 | 10:01:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 10:01:34 INFO - PROCESS | 1678 | RSS: Main: 261476352 10:01:34 INFO - PROCESS | 1678 | 10:01:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 10:01:38 INFO - PROCESS | 1678 | RSS: Main: 270327808 10:01:38 INFO - PROCESS | 1678 | 10:01:41 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 10:01:42 INFO - PROCESS | 1678 | RSS: Main: 273334272 10:01:42 INFO - PROCESS | 1678 | 10:01:43 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 10:01:44 INFO - PROCESS | 1678 | RSS: Main: 275312640 10:01:44 INFO - PROCESS | 1678 | 10:01:46 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:01:47 INFO - PROCESS | 1678 | RSS: Main: 275824640 10:01:47 INFO - PROCESS | 1678 | 10:01:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 10:01:50 INFO - PROCESS | 1678 | RSS: Main: 276508672 10:01:50 INFO - PROCESS | 1678 | 10:01:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 10:01:54 INFO - PROCESS | 1678 | RSS: Main: 276238336 10:01:54 INFO - PROCESS | 1678 | 10:01:57 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 10:01:57 INFO - PROCESS | 1678 | RSS: Main: 276361216 10:01:57 INFO - PROCESS | 1678 | 10:01:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:00 INFO - PROCESS | 1678 | RSS: Main: 276303872 10:02:00 INFO - PROCESS | 1678 | 10:02:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:02 INFO - PROCESS | 1678 | RSS: Main: 276512768 10:02:02 INFO - PROCESS | 1678 | 10:02:04 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:05 INFO - PROCESS | 1678 | RSS: Main: 276697088 10:02:05 INFO - PROCESS | 1678 | 10:02:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:02:08 INFO - PROCESS | 1678 | RSS: Main: 276873216 10:02:08 INFO - PROCESS | 1678 | 10:02:11 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:02:12 INFO - PROCESS | 1678 | RSS: Main: 276746240 10:02:12 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 10:02:14 INFO - PROCESS | 1678 | RSS: Main: 278446080 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | __start_tp_report 10:02:14 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 10:02:14 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 10:02:14 INFO - PROCESS | 1678 | |i|pagename|runs| 10:02:14 INFO - PROCESS | 1678 | |0;ai-astar;115;109;116;117;119;128;116;117;115;117 10:02:14 INFO - PROCESS | 1678 | |1;audio-beat-detection;154;121;143;161;120;144;142;123;170;120 10:02:14 INFO - PROCESS | 1678 | |2;audio-dft;196;197;201;211;224;196;195;192;201;197 10:02:14 INFO - PROCESS | 1678 | |3;audio-fft;70;70;71;109;56;55;55;64;121;55 10:02:14 INFO - PROCESS | 1678 | |4;audio-oscillator;81;82;123;79;85;82;118;82;82;119 10:02:14 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;89;87;88;88;91;87;90;87;89;86 10:02:14 INFO - PROCESS | 1678 | |6;imaging-darkroom;95;94;102;103;151;118;96;96;111;98 10:02:14 INFO - PROCESS | 1678 | |7;imaging-desaturate;103;92;91;92;138;103;139;91;146;153 10:02:14 INFO - PROCESS | 1678 | |8;json-parse-financial;61;61;61;60;62;61;61;79;63;60 10:02:14 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;61;66;69;66;80;59;82;96;96;95 10:02:14 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;82;83;83;82;83;82;87;74;88;108 10:02:14 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;135;139;138;135;160;155;137;137;174;141 10:02:14 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;190;193;151;153;190;155;216;178;210;219 10:02:14 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;70;70;71;68;71;69;67;86;96;99 10:02:14 INFO - PROCESS | 1678 | __end_tp_report 10:02:14 INFO - PROCESS | 1678 | __start_cc_report 10:02:14 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1074 10:02:14 INFO - PROCESS | 1678 | __end_cc_report 10:02:14 INFO - PROCESS | 1678 | __startTimestamp1461344534630__endTimestamp 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | ------- Summary: start ------- 10:02:14 INFO - PROCESS | 1678 | Number of tests: 14 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:116.90 Median:117.00 stddev:4.70 (4.0%) stddev-sans-first:4.94 10:02:14 INFO - PROCESS | 1678 | Values: 115.0 109.0 116.0 117.0 119.0 128.0 116.0 117.0 115.0 117.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:143.50 stddev:18.30 (12.8%) stddev-sans-first:18.68 10:02:14 INFO - PROCESS | 1678 | Values: 154.0 121.0 143.0 161.0 120.0 144.0 142.0 123.0 170.0 120.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:201.00 Median:199.00 stddev:9.59 (4.8%) stddev-sans-first:10.00 10:02:14 INFO - PROCESS | 1678 | Values: 196.0 197.0 201.0 211.0 224.0 196.0 195.0 192.0 201.0 197.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:72.60 Median:60.00 stddev:23.48 (39.1%) stddev-sans-first:24.89 10:02:14 INFO - PROCESS | 1678 | Values: 70.0 70.0 71.0 109.0 56.0 55.0 55.0 64.0 121.0 55.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:82.00 stddev:18.52 (22.6%) stddev-sans-first:19.10 10:02:14 INFO - PROCESS | 1678 | Values: 81.0 82.0 123.0 79.0 85.0 82.0 118.0 82.0 82.0 119.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.50 stddev:1.55 (1.8%) stddev-sans-first:1.62 10:02:14 INFO - PROCESS | 1678 | Values: 89.0 87.0 88.0 88.0 91.0 87.0 90.0 87.0 89.0 86.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:106.40 Median:94.50 stddev:17.47 (18.5%) stddev-sans-first:18.03 10:02:14 INFO - PROCESS | 1678 | Values: 95.0 94.0 102.0 103.0 151.0 118.0 96.0 96.0 111.0 98.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:114.80 Median:122.00 stddev:25.84 (21.2%) stddev-sans-first:27.05 10:02:14 INFO - PROCESS | 1678 | Values: 103.0 92.0 91.0 92.0 138.0 103.0 139.0 91.0 146.0 153.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:61.00 stddev:5.72 (9.4%) stddev-sans-first:6.03 10:02:14 INFO - PROCESS | 1678 | Values: 61.0 61.0 61.0 60.0 62.0 61.0 61.0 79.0 63.0 60.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:81.00 stddev:14.78 (18.2%) stddev-sans-first:14.50 10:02:14 INFO - PROCESS | 1678 | Values: 61.0 66.0 69.0 66.0 80.0 59.0 82.0 96.0 96.0 95.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:83.00 stddev:8.83 (10.6%) stddev-sans-first:9.29 10:02:14 INFO - PROCESS | 1678 | Values: 82.0 83.0 83.0 82.0 83.0 82.0 87.0 74.0 88.0 108.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:140.00 stddev:13.31 (9.5%) stddev-sans-first:13.61 10:02:14 INFO - PROCESS | 1678 | Values: 135.0 139.0 138.0 135.0 160.0 155.0 137.0 137.0 174.0 141.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.50 Median:191.50 stddev:25.78 (13.5%) stddev-sans-first:27.29 10:02:14 INFO - PROCESS | 1678 | Values: 190.0 193.0 151.0 153.0 190.0 155.0 216.0 178.0 210.0 219.0 10:02:14 INFO - PROCESS | 1678 | 10:02:14 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:71.00 stddev:12.20 (17.2%) stddev-sans-first:12.70 10:02:14 INFO - PROCESS | 1678 | Values: 70.0 70.0 71.0 68.0 71.0 69.0 67.0 86.0 96.0 99.0 10:02:14 INFO - PROCESS | 1678 | -------- Summary: end -------- 10:02:14 INFO - PROCESS | 1678 | 10:02:15 INFO - TEST-INFO | 1678: exit 0 10:02:15 INFO - TEST-OK | kraken | took 59732ms 10:02:15 INFO - SUITE-END | took 1170s 10:02:15 INFO - Completed test suite (00:19:31) 10:02:15 INFO - javascript benchmark 10:02:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.9372412551747, 3422.264213194163, 3462.2036931505754, 3466.913327166822, 3495.2485215678626, 5658.801941932038, 5695.601307908438, 5699.629524080932, 5719.313682358118, 5722.856928576788, 5611.242482264893, 5717.942820571793, 5742.712864356787, 5759.769609215627, 5859.121131830217, 5148.227765835127, 5186.092433824085, 5207.453217412174, 5263.947360526384, 5275.36695596529, 248.9379809781529, 5186.9626074785, 5194.558462530689, 5220.582353411718, 5265.8946821063555, 4332.436783218193, 5136.229565565139, 5139.306193663882, 5191.740412979355, 5209.843704688866, 4997.6501644884875, 5286.259923610698, 5307.840764777025, 5312.442193569696, 5314.521693047605, 4637.5594318540025, 5159.432462429129, 5243.79024839006, 5262.447443018466, 5270.8155214567305, 5505.284313039279, 5582.27430434041, 5603.2435621191435, 5626.831195064114, 5675.460831221028, 4732.716037037754, 6161.969190154021, 6273.749050037993, 6300.21247344082, 6306.779262725782, 6198.442140207403, 6258.87482250357, 6268.498520118425, 6290.779822706183, 6293.842653933642, 5796.797112101056, 5815.970920145457, 5831.5334773218465, 5841.357450680422, 5892.941070589282, 6163.753449862045, 6176.227971503562, 6215.34738852414, 6274.9686251569365, 6275.811725648238, 6121.392004143319, 6147.354527774609, 6147.924113280158, 6155.507559395238, 6162.322144564095, 6242.375762423721, 6245.375462453809, 6282.560220784501, 6294.968525157345, 6298.905516417258, 6105.023196288573, 6174.876502469925, 6210.192674952227, 6229.909765790969, 6255.0, 6102.156009074812, 6137.959273351834, 6271.905921411182, 6290.150829638032, 6306.306306306303, 4839.68542044773, 4887.3890763654545, 4912.066707325596, 4943.2585112233455, 4950.653454258168, 4347.000189956328, 4378.562143785596, 4428.4685837699035, 4485.0805584855025, 4486.394336764561, 5695.857603559944, 5730.914036289459, 5784.3926387729525, 5794.188813566104, 5803.0, 5277.973610131925, 6258.405451482102, 6305.274893387227, 6314.8421289467215, 6342.112104305401, 5672.936614228271, 5793.0, 5822.068469045017, 5842.065269556851, 5888.793892213752, 5381.3811411687375, 5396.64921780083, 5402.189671549299, 5409.56723462122, 5411.02601531728, 6265.686715664198, 6326.9876819708625, 6327.620342779356, 6364.745410183541, 6375.458086062737, 6135.44703110649, 6197.96901015492, 6231.3145553988115, 6254.530910181846, 6260.40526150015, 6397.584157029778, 6404.327545607644, 6410.423061924449, 6424.582402143846, 6443.452306553808, 6083.847903802263, 6107.977837958671, 6203.31763506005, 6209.5963762357105, 6219.160413344141, 6158.353372895961, 6193.504519638328, 6213.099100630474, 6254.21822272216, 6270.059491076193, 6110.57225994194, 6133.969330153321, 6151.538634602333, 6151.784687536094, 6152.630842149485, 5075.264086707481, 5098.337216161875, 5542.528885044816, 5663.433656634304, 5716.199732037601, 5811.506021988178, 5996.910046349221, 6000.309964354155, 6078.7264573093435, 6111.572189946661, 5080.618953578422, 6011.308699499614, 6096.817095487142, 6156.630602163885, 6160.784372546939, 5885.499732522783, 5916.526677865674, 5974.850628734316, 5982.4017598239825, 6061.787837425845], "value": 5634.9422754478965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.1875093604912, 524.2791162152041, 572.8166986564298, 580.9215755872956, 636.7614988846692, 31084.533731994008, 37472.0, 38526.42210366847, 38602.227955440874, 38815.835524934264, 32451.67548324516, 39726.40410393846, 39899.202015959665, 39958.60041399585, 40183.0, 9425.293103017268, 9485.33602647815, 9485.71542853712, 9614.278929080312, 9638.084381983701, 9426.670066547673, 9557.0, 9605.66380176694, 9607.375520591138, 9682.70951871445, 8365.456245344063, 9617.615295388176, 9692.27307951903, 9731.124198822105, 9755.951250237458, 9672.75818104546, 9695.272854535939, 9697.175740062103, 9722.173615242747, 9755.12203901645, 9270.21203197729, 9424.764380890463, 9449.905500944971, 9453.90546094537, 9460.621575136985, 38764.8370548884, 38864.80567597144, 39197.804010979766, 39453.0, 39518.0120496987, 2737.4935636907235, 3032.8331941743195, 3042.421939831447, 3383.661633836621, 3391.728661707082, 26551.601725974127, 26678.33304167392, 26704.73295267042, 26992.865035674695, 28070.298242543897, 2575.6651635287294, 2588.521123592123, 2627.7635012848937, 2658.6012098185233, 2729.6451461310103, 377475.0, 378716.0, 379401.0, 380675.9999999972, 381774.0, 33545.0, 33790.49314260288, 33854.830725846216, 35567.82216088903, 36160.27679446396, 35710.285794284486, 35824.0, 35825.46261806075, 35844.46233306503, 36082.09794755152, 14689.971701980972, 14949.327280272413, 15117.773233401507, 15135.0, 15141.848581514043, 12818.359082045861, 12851.871481285254, 12884.0, 12988.740225195443, 13005.349732513336, 8151.0, 8200.05699344571, 8222.342212622976, 8256.298214651702, 8264.173582641688, 3378.797272163678, 3403.5915690117345, 3421.196018935548, 3430.691237788611, 3435.5362026126154, 968.2399316536626, 997.4115271989416, 1033.245730616639, 1063.1601035182275, 1078.1105587890022, 25823.0961916332, 28976.0, 29391.706082939323, 29921.251968700955, 29964.0, 1047.5704960965968, 1079.5411949921252, 1085.234909388879, 1149.6493569461227, 1210.945507452149, 12776.297303648389, 13365.46538138483, 14021.719565608631, 14335.641608959859, 14338.068025578305, 655285.0, 656722.0, 661993.0, 662214.0, 664833.0, 46413.0, 50200.493985179775, 54985.0, 55941.60145996383, 56263.156052659244, 1424.2949739878827, 1474.7787831825312, 1490.903091299062, 1497.341169885247, 1503.1657430126386, 22293.665595015762, 24534.386640334134, 27903.720962790114, 28014.73933672949, 28194.2951426216, 38464.61535384722, 48391.27413088736, 49419.75290123526, 49560.75219623879, 49723.0, 438429.0, 515569.0, 518041.0, 518141.0, 518899.0, 25523.87238063798, 40676.3898541528, 42726.0, 42879.571204288804, 42912.78543607262, 41886.581134188265, 42273.286258330394, 42874.35688464738, 43036.78481607572, 43253.56746432495, 30857.919972800843, 33291.334173316885, 35395.82302088473, 36497.817510912275, 37629.623703763704, 34870.30259394747, 36445.63554364529, 36520.45219321659, 37195.81402092972, 37231.25537489289, 35616.0, 35966.280674386886, 36286.45570316395, 36597.08507287339, 36651.633483664824, 28346.0, 33134.502982454804, 33269.0, 33356.0, 33606.82376116824, 23434.425538874766, 24476.632850507613, 24544.0, 25135.74864251334, 25347.39578126518], "value": 17890.43486053188, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.71715758762633, 397.83092185821016, 399.5804405374356, 401.2356460941906, 415.73600763515157, 19015.904920475394, 20410.489737756565, 21016.36950891472, 21021.894890525546, 21046.684299735516, 20324.882131482762, 20713.964301784887, 20819.37541873746, 21314.57370852582, 21326.36020919375, 4951.158303088484, 5427.674339539631, 5657.9249942511, 5673.149027645865, 5680.091185410335, 5578.135389014709, 5586.273784408021, 5631.2960879890015, 5648.926703926241, 5655.688937108457, 5585.525230355424, 6023.2169817923605, 6104.908426373608, 6149.29283132441, 6156.784512542062, 5515.503604675599, 5890.429425186344, 6091.664958427307, 6096.085587161939, 6140.1096840958035, 5349.465053494659, 5424.1321388578035, 5444.537214336747, 5449.809256675997, 5465.699386533739, 13689.31553422325, 14187.29063546829, 22966.277529185212, 25486.872565637237, 25794.742052579422, 2079.2514694709894, 2168.490404754881, 2212.093041852833, 2261.197274967379, 2793.5669971154502, 9648.75878103053, 9906.90093099067, 10142.746431339276, 10156.136728378096, 10225.700600836044, 1692.6191606888474, 1711.863050955933, 1751.9313218936438, 1867.1131212674006, 1925.5089952062274, 110598.89401105966, 115591.0, 117578.0, 120366.3981680086, 128517.35741321326, 10456.058954694114, 10972.780544389227, 11712.297262164297, 11887.038638624703, 11944.462499187557, 15200.695986080216, 15281.617959550878, 15289.694206115815, 15301.311440985182, 15346.0, 7048.964755176294, 8782.341324400695, 8929.464232146092, 8948.8657670135, 8989.921209454908, 7403.814904627319, 8607.698730544402, 8768.824623507495, 8795.692150774692, 8835.823283534293, 4633.027064316531, 4698.506656800987, 4699.882502937386, 4716.033213191287, 4775.6657034007285, 1563.5622025832786, 1711.3240270093243, 1943.8833669979847, 2016.4656366063004, 2038.7553493580865, 882.8366752150872, 931.231733819588, 935.2004036548789, 952.2334520710756, 958.9280803939732, 16123.785792088755, 19097.80902190988, 19314.62307265848, 20681.379558613266, 20900.268490602757, 781.8358144789544, 957.3107362698846, 1005.2762011351815, 1026.7176526455135, 1028.717102796737, 10465.9476702616, 10658.946705266579, 10745.979131982449, 10794.298370605886, 10822.78354432907, 600174.0, 606868.0, 607043.9647801733, 612700.3014834226, 614840.0, 90679.0, 110060.0, 112025.0, 121262.0, 126662.0, 945.7304668169676, 950.8858936927613, 979.314479864098, 980.0787259975742, 981.1856159387692, 17564.91217543904, 17716.82283177152, 17764.378246761302, 17899.552511186805, 18044.458666240032, 45867.0, 48744.0251194967, 53181.40455786332, 53433.46566534285, 53434.46565534295, 74081.0, 76431.0, 76463.61768191123, 77514.83727743976, 78036.21963780516, 7710.383169346551, 7761.7671469855995, 8080.353571714366, 8245.628946697292, 8317.667293308443, 9330.0, 10459.110975567162, 12212.877871221173, 12549.121561490972, 12644.241345519298, 8987.775305617412, 10871.934332476803, 11025.0, 11128.44357782124, 11317.773644527228, 10790.298630588986, 10826.0, 11043.668689939315, 11179.60871369498, 11183.608573699881, 9930.453825039693, 11314.83027754568, 11464.197506174487, 11695.824562631737, 11755.000824929635, 8161.224683655043, 8182.509049457051, 8335.0, 8342.0, 8492.320614350961, 8407.579621018802, 11118.0, 11205.495752690986, 11379.943100284445, 11485.540578376771], "value": 9380.758968001486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.550951450293, 1628.6742651469706, 1846.686063369227, 1916.271816709651, 1967.1246295398535, 8107.513549187053, 8677.566121693913, 8767.254783343424, 8916.598753056112, 8972.282217422598, 8636.438631488949, 8702.303815694746, 8749.650013999448, 8821.558922053904, 8854.513001784899, 2451.240115564172, 2462.2613216035206, 2466.8889899954456, 2481.2928315430104, 2482.1064416809936, 2436.61014237722, 2443.584590619599, 2448.926532204028, 2481.8510889346608, 2484.7887929526014, 2375.7861792438675, 2430.708315002202, 2443.5723748344058, 2464.4947785703976, 2490.0537795637724, 2426.017462927517, 2442.5481285962155, 2442.9144979925704, 2469.2098528470897, 2480.06997375984, 2422.4186195313173, 2434.586120359543, 2448.2899959011866, 2451.411661201299, 2465.90136394544, 8844.20402163802, 8935.553222338922, 8943.105689431004, 8948.597313120925, 8949.149830766068, 4193.958060419387, 4339.826406943718, 4612.262038073925, 5251.553617942442, 5455.645383050089, 3135.18485193849, 3465.648397125123, 3571.4107172316535, 3649.160693040589, 3651.2879988402274, 942.9575669094838, 1036.315986521902, 1045.5399624165343, 1055.37205362809, 1059.2214722179192, 9852.359596626196, 11591.362475063868, 11715.004224640916, 11763.7059073523, 11766.294022358601, 4823.03539292143, 4854.708717476892, 4856.732879691651, 4906.0, 4930.926036109461, 9861.556229969668, 9888.653897113567, 9970.0, 9984.500774961223, 10004.449755263386, 5311.575073994071, 5370.194470829329, 5373.946260537345, 5397.16343966678, 5421.4578542146255, 4401.603855652943, 4756.952430475721, 4897.118518666674, 4912.975435122873, 4919.950800492021, 4045.777482238505, 4068.044009657728, 4081.8979525511504, 4119.551681195517, 4146.771927544014, 1184.390039129849, 1375.4154484344315, 1385.9653508662363, 1386.1544457880684, 1389.3608939887563, 771.1223171577227, 869.9951555952885, 896.9236915701184, 908.4004556992353, 946.5172761891484, 5674.120511320752, 5839.503642190376, 5888.470037696542, 5893.6463812171405, 5961.101540458909, 462.6275847942439, 469.36869909971034, 475.7383439108477, 479.3121870116394, 483.32817383836493, 3554.9111272217883, 3908.6482216600643, 3920.3531417316394, 3974.463447434617, 4075.5313138989395, 10405.0, 10520.316179448311, 10810.189235807346, 10881.020708136306, 10906.672799816019, 10600.893991059991, 10612.946935265274, 10778.784424311627, 10807.297525660806, 10823.567057317776, 8061.395395345256, 8212.219839115274, 8274.420790544724, 8310.792230194293, 8315.0, 5880.588358814842, 5922.022866227197, 5998.0, 6076.78731244422, 6126.663033533198, 9611.711648650551, 9884.604615815288, 9890.258230632875, 10013.24900632441, 10040.246981476565, 8466.957665211634, 9581.856272156063, 10165.847512287173, 10201.795964080527, 10309.432981185806, 6454.580452270588, 7014.929850701427, 7229.385502232369, 7277.199508054004, 7356.96321518389, 8259.463134896212, 8272.090070092165, 8308.33533317321, 8320.417570769989, 8368.41421100517, 7236.38490728294, 7389.667464964197, 7416.9258307418395, 7491.213422590549, 7557.05536807899, 7078.18600860887, 7392.55644661322, 7449.962750186214, 7452.552846829208, 7530.28462296081, 7023.438124949889, 7031.964840175767, 7037.014817925392, 7062.39969602569, 7126.679299431435, 4896.0, 4955.45489996093, 5066.06277838601, 5071.416787069386, 5228.712420816892, 4688.413948256468, 4722.1972264714395, 5003.199488081889, 5092.159793634009, 5251.52736253739], "value": 4529.4511590043, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.4084858403018, 317.729929559874, 323.4743541744665, 324.4775910783638, 328.9259916518785, 5234.371875374955, 5859.472647461727, 6185.762847430509, 6213.0, 6246.906296405557, 5280.600640830183, 5881.85295367615, 6085.726142323595, 6109.69451527423, 6138.72867039195, 4378.518362980061, 4483.215437298476, 4595.609373203281, 4608.976955115219, 4616.33063205835, 4540.682152249344, 4616.792244349012, 4630.8147674093, 4635.46692130406, 4641.234196357614, 4379.978100109495, 4548.204064288753, 4559.156556037127, 4584.951007579972, 4610.30845373195, 3863.285292220948, 4262.744235345874, 4515.796789144496, 4524.796384162721, 4528.615067719248, 3394.507796369537, 3860.401637746154, 3864.53625564934, 3880.825362858678, 3898.649121579043, 4815.759212039419, 5950.702464876739, 5953.523718102585, 5953.553483488712, 5954.821355359346, 4443.089166720814, 5121.129408000612, 5167.173252279617, 5274.92087618686, 5287.41838397776, 5835.533157347402, 5882.911756323659, 6248.687775567137, 6493.350664933469, 6518.413342799124, 3723.4600982857605, 3980.5024371953505, 4115.464989551369, 4268.442018663197, 4285.742855428684, 6726.630035348054, 6861.794146175573, 6898.517103802736, 6928.376446119823, 6954.547954382949, 3748.231612519427, 4329.242382583036, 4330.372096046056, 4355.564443555682, 4367.301231802896, 3499.0, 3818.427235914635, 4166.66666666666, 4294.56434852117, 4358.346248062816, 4338.3709362142945, 4760.880977975509, 5016.698998060128, 5167.974160129251, 5249.370075590953, 5824.446677565625, 6162.238307182798, 6602.372774586406, 6621.9006714899315, 6626.801195964129, 1203.7652657731833, 1417.7731562950084, 1427.757281262188, 1500.4973333933037, 1522.3834347089446, 917.7426925112505, 970.737900766789, 976.814405263012, 997.7555498902815, 1003.0370843989851, 4567.611753000966, 5093.0577843099145, 6067.848303792441, 6113.908291375633, 6115.4190351916495, 6477.222733272038, 6745.628990405575, 6749.291324410964, 6777.525573209927, 6802.251752307242, 5314.9635821014535, 5765.654060756368, 5848.941510584839, 5905.498032667186, 6165.414285642857, 3484.61669216386, 3504.9474257886154, 3554.2003049314217, 3611.4582812577796, 3627.183883626163, 6758.797236082925, 6841.281665425158, 7158.2841715829045, 7251.637418129072, 7287.380572651384, 6509.349065093453, 7093.574385536885, 7098.787036388917, 7106.857862842714, 7142.5000249982, 6788.2193547742645, 6892.517523773388, 6919.481038922202, 7222.133343998754, 7246.239144889816, 6837.829054273683, 6856.451483881177, 6871.312868713088, 6890.793276201722, 6895.34494223048, 6350.206224221973, 6780.966095169492, 6792.796216113525, 6822.795316140524, 6834.726610935507, 6159.476444502267, 6672.833179170365, 7187.5687458752645, 7255.206745403163, 7279.59962202084, 3568.946465803067, 4161.0221597923855, 4283.464566929134, 4325.026868954586, 4341.327094300388, 5962.642241465526, 6442.484601231984, 6739.865202695821, 6770.898436523555, 6827.746843541719, 5975.745093530408, 6570.934290657224, 6577.2570268879745, 6620.470362370903, 6645.833854153685, 5842.766289348378, 5887.882242355215, 6129.570930034854, 6572.0, 6597.472202223907, 5414.485623865727, 5428.728563571726, 5917.727688546983, 5924.940750592439, 6071.028635418312, 6233.501319894488, 6619.635920024445, 6624.370684784938, 6634.535582509371, 6647.966760166169, 6231.22109736283, 6466.0, 6471.805845824632, 6494.772682956074, 6502.512311576746], "value": 4687.852639963873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.4737199728206, 695.8747425463415, 700.8002719225021, 756.1077928044906, 769.3191525499931, 14650.78023829642, 14942.701145977075, 15033.548993530212, 15079.62300942477, 15113.848861511382, 11702.0, 13999.510017149401, 14052.508162214324, 14089.013769036172, 14133.646658833535, 718.9532680375759, 804.8752443371258, 901.4005686218657, 910.9316801239917, 938.4275591888942, 887.6538150121426, 938.549496241801, 938.648006997376, 942.9575669094872, 946.711253067814, 947.052947052947, 964.2045312617084, 987.521052289639, 988.6342053440237, 990.8166989107002, 894.3426581462685, 967.690339091491, 973.5931578868538, 975.327024353194, 983.3902980152351, 696.8014115976922, 718.4862823081522, 727.7671145233527, 731.0131322714293, 736.8968344431784, 14753.926230368887, 14865.405383784635, 14873.33070011852, 14876.181810000446, 14886.0, 12549.0, 12561.120721549496, 12601.0, 12678.429470673842, 12747.745045099138, 9980.700578982642, 10009.59961601535, 10062.849057264073, 10167.0, 10171.135453486462, 3456.1359660084977, 3484.61669216386, 3485.041613556267, 3490.7730997485337, 3493.790372577628, 78686.21313786904, 78850.21149788485, 79907.60046199732, 80256.59871700604, 80807.7878831818, 9343.626254949726, 9406.717798466058, 9435.622575096919, 9591.520423978773, 9666.806663866684, 21265.468363291042, 21368.358949231548, 21371.57256854854, 21422.678659820114, 21650.242241521788, 7285.271472852778, 7335.266473352729, 7386.409087273113, 7659.157492675801, 7706.460547761603, 4088.7546747195265, 4127.422160897477, 4131.173765246903, 4131.5042194936195, 4138.985948442591, 3532.1699400640828, 3649.6532829381167, 3651.543557055368, 3672.761270517408, 3849.1531862990096, 606.3875485759327, 665.5973136252497, 671.4762485261406, 690.892911598703, 705.8764716174752, 514.0644027869242, 522.8188650473786, 548.8902219556105, 572.2474945446725, 573.5067841656172, 7531.610500726384, 7784.883226751604, 7859.567723775133, 7878.094019187753, 7879.803004924923, 525.2410267163988, 561.6461629173676, 574.4829653312053, 577.2985822226016, 583.0962008886294, 3433.2446861690387, 3650.908727281839, 3798.877105427324, 3830.578636349999, 3869.245497128033, 92619.53690231641, 94141.5292923531, 95734.52132739291, 95819.52090239504, 96333.55499667511, 81480.59259703664, 81750.18249817425, 83666.0, 84077.57961210277, 85391.14608853956, 70986.0, 71297.0, 71902.9214561782, 71938.0, 72286.0, 7729.613519324123, 8015.7595272141925, 8151.673933042612, 8200.933878595744, 8207.753767386988, 34161.658383415845, 34310.97067087991, 41270.38094428646, 41739.16521669611, 42667.35998959956, 51958.0, 57418.13872791828, 58576.4142358571, 60768.08847867197, 60783.0, 10910.0, 10917.23579349438, 11048.171387145836, 11108.222424430536, 11252.549898003988, 12142.028637709138, 12155.209911355734, 12355.196912201038, 12466.065045121471, 12487.750244995232, 11491.827622585835, 11570.94214528922, 11634.0, 11920.70198245016, 11973.461194246105, 11377.886221137682, 11507.827382589101, 11732.061435085343, 11829.17195796286, 11864.99147572466, 10917.508712107816, 11490.54037838477, 11665.00847427978, 11703.473343699725, 11805.881941180822, 8727.519986400555, 9187.954060229657, 9439.972258687629, 9590.376625519319, 9779.364341317792, 9510.714678559654, 9641.42151470914, 9925.0, 9951.353162044445, 9951.800963980824], "value": 6840.414190422977, "unit": "score"}], "name": "dromaeo_css", "value": 7183.143247652211, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 116.0, 117.0, 119.0, 128.0, 116.0, 117.0, 115.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 143.0, 161.0, 120.0, 144.0, 142.0, 123.0, 170.0, 120.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 201.0, 211.0, 224.0, 196.0, 195.0, 192.0, 201.0, 197.0], "value": 201.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 109.0, 56.0, 55.0, 55.0, 64.0, 121.0, 55.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 123.0, 79.0, 85.0, 82.0, 118.0, 82.0, 82.0, 119.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 88.0, 91.0, 87.0, 90.0, 87.0, 89.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 102.0, 103.0, 151.0, 118.0, 96.0, 96.0, 111.0, 98.0], "value": 106.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 92.0, 91.0, 92.0, 138.0, 103.0, 139.0, 91.0, 146.0, 153.0], "value": 114.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 79.0, 63.0, 60.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 69.0, 66.0, 80.0, 59.0, 82.0, 96.0, 96.0, 95.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 83.0, 82.0, 87.0, 74.0, 88.0, 108.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 138.0, 135.0, 160.0, 155.0, 137.0, 137.0, 174.0, 141.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 193.0, 151.0, 153.0, 190.0, 155.0, 216.0, 178.0, 210.0, 219.0], "value": 185.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 68.0, 71.0, 69.0, 67.0, 86.0, 96.0, 99.0], "value": 76.7, "unit": "score"}], "name": "kraken", "value": 1565.4, "alertThreshold": 2.0}]} 10:02:15 INFO - Return code: 0 10:02:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:02:15 ERROR - # TBPL SUCCESS # 10:02:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:02:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:02:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:02:15 INFO - 2016-04-22 10:02:15.909 screenresolution[1683:10634] starting screenresolution argv=screenresolution get 10:02:15 INFO - 2016-04-22 10:02:15.912 screenresolution[1683:10634] Display 0: 1600x1200x32@60 10:02:15 INFO - 2016-04-22 10:02:15.918 screenresolution[1684:10637] starting screenresolution argv=screenresolution list 10:02:15 INFO - Available Modes on Display 0 10:02:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:02:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:02:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:02:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:02:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:02:16 INFO - Intel Iris: 10:02:16 INFO - Chipset Model: Intel Iris 10:02:16 INFO - Type: GPU 10:02:16 INFO - Bus: Built-In 10:02:16 INFO - VRAM (Dynamic, Max): 1536 MB 10:02:16 INFO - Vendor: Intel (0x8086) 10:02:16 INFO - Device ID: 0x0a2e 10:02:16 INFO - Revision ID: 0x0009 10:02:16 INFO - Displays: 10:02:16 INFO - Display: 10:02:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:02:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:02:16 INFO - Display Serial Number: 1600x1200 60 10:02:16 INFO - Main Display: Yes 10:02:16 INFO - Mirror: Off 10:02:16 INFO - Online: Yes 10:02:16 INFO - Rotation: Supported 10:02:16 INFO - Return code: 0 10:02:16 INFO - Running post-action listener: _resource_record_post_action 10:02:16 INFO - Running post-run listener: _resource_record_post_run 10:02:17 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 37762560; Write bytes: 698089984; Read time: 394; Write time: 1976 10:02:17 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 374026752; Write bytes: 368039424; Read time: 28250; Write time: 632 10:02:17 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 36791808; Write bytes: 300608512; Read time: 379; Write time: 1289 10:02:17 INFO - Running post-run listener: _upload_blobber_files 10:02:17 INFO - Blob upload gear active. 10:02:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:02:17 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:02:17 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:02:17 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:02:17 INFO - (blobuploader) - INFO - Open directory for files ... 10:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:02:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:18 INFO - (blobuploader) - INFO - Done attempting. 10:02:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:02:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:02:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:20 INFO - (blobuploader) - INFO - Done attempting. 10:02:20 INFO - (blobuploader) - INFO - Iteration through files over. 10:02:20 INFO - Return code: 0 10:02:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:02:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:02:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92050ff6a6dde94f7ee45a225ef2f0c2b7f53dae951392ca14619629c4600103f0b8199fe35988951eb1fd084b3060927d0de1c3b97c1dab3b8409ab0421336c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0843bdf0bd2e3809aefd4f1b3628e4ae12c9e04e3ff0719a90867240d17b7e5cd945dcbc6b7419330896707ce1b163decb1106852fe12ce4b68cae28aaf8f87"} 10:02:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:02:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:02:20 INFO - Contents: 10:02:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92050ff6a6dde94f7ee45a225ef2f0c2b7f53dae951392ca14619629c4600103f0b8199fe35988951eb1fd084b3060927d0de1c3b97c1dab3b8409ab0421336c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0843bdf0bd2e3809aefd4f1b3628e4ae12c9e04e3ff0719a90867240d17b7e5cd945dcbc6b7419330896707ce1b163decb1106852fe12ce4b68cae28aaf8f87"} 10:02:20 INFO - Running post-run listener: copy_logs_to_upload_dir 10:02:20 INFO - Copying logs to upload dir... 10:02:20 INFO - mkdir: /builds/slave/test/build/upload/logs 10:02:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.548732 ========= master_lag: 17.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-04-22 10:02:37.716468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 10:02:37.720318) ========= 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.0lmtef3AlC/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.E5xf4zuGza/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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/92050ff6a6dde94f7ee45a225ef2f0c2b7f53dae951392ca14619629c4600103f0b8199fe35988951eb1fd084b3060927d0de1c3b97c1dab3b8409ab0421336c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0843bdf0bd2e3809aefd4f1b3628e4ae12c9e04e3ff0719a90867240d17b7e5cd945dcbc6b7419330896707ce1b163decb1106852fe12ce4b68cae28aaf8f87"} build_url:https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011085 build_url: 'https://queue.taskcluster.net/v1/task/CGGwCGAFRMWYo6b1MNgvBg/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/92050ff6a6dde94f7ee45a225ef2f0c2b7f53dae951392ca14619629c4600103f0b8199fe35988951eb1fd084b3060927d0de1c3b97c1dab3b8409ab0421336c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0843bdf0bd2e3809aefd4f1b3628e4ae12c9e04e3ff0719a90867240d17b7e5cd945dcbc6b7419330896707ce1b163decb1106852fe12ce4b68cae28aaf8f87"}' ========= master_lag: 0.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 10:02:38.155355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 10:02:38.155785) ========= 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.0lmtef3AlC/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.E5xf4zuGza/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005031 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 10:02:38.194622) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 10:02:38.195001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 10:02:38.200354) ========= ========= Total master_lag: 18.00 =========