builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0126 starttime: 1461070523.04 results: success (0) buildid: 20160419025149 builduid: 5368043b0c0c49f09efeef07374319b6 revision: 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:23.038035) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:23.038500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:23.038777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:23.436558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:23.436913) ========= 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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-19 05:55:23-- 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% 9.29M=0.001s 2016-04-19 05:55:23 (9.29 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124475 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:23.587805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:23.588148) ========= 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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.027110 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:23.643879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-19 05:55:23.644233) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 --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 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bSaEEmnAzh/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.ekgIdBmTAf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-19 05:55:23,711 truncating revision to first 12 chars 2016-04-19 05:55:23,711 Setting DEBUG logging. 2016-04-19 05:55:23,711 attempt 1/10 2016-04-19 05:55:23,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6f8f469a45c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 05:55:24,365 unpacking tar archive at: fx-team-6f8f469a45c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.892526 ========= master_lag: 6.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-19 05:55:30.542231) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:30.542594) ========= script_repo_revision: 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 05:55:30.543075) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 6 secs) (at 2016-04-19 05:55:30.543544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 6 secs) (at 2016-04-19 05:55:37.072908) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-19 05:55:37.073379) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:55:37 INFO - MultiFileLogger online at 20160419 05:55:37 in /builds/slave/test 05:55:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:55:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:55:37 INFO - {'append_to_log': False, 05:55:37 INFO - 'base_work_dir': '/builds/slave/test', 05:55:37 INFO - 'blob_upload_branch': 'Fx-Team', 05:55:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:55:37 INFO - 'branch': 'Fx-Team', 05:55:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:55:37 INFO - 'config_files': ('talos/mac_config.py',), 05:55:37 INFO - 'default_actions': ('clobber', 05:55:37 INFO - 'read-buildbot-config', 05:55:37 INFO - 'download-and-extract', 05:55:37 INFO - 'populate-webroot', 05:55:37 INFO - 'create-virtualenv', 05:55:37 INFO - 'install', 05:55:37 INFO - 'run-tests'), 05:55:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:55:37 INFO - 'download_minidump_stackwalk': True, 05:55:37 INFO - 'download_symbols': 'ondemand', 05:55:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:55:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:55:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:55:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:55:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:55:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:55:37 INFO - 'installer_path': 'installer.exe', 05:55:37 INFO - 'log_level': 'info', 05:55:37 INFO - 'log_name': 'talos', 05:55:37 INFO - 'log_to_console': True, 05:55:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:55:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:55:37 INFO - 'opt_config_files': (), 05:55:37 INFO - 'pip_index': False, 05:55:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:55:37 INFO - 'cmd': ('bash', 05:55:37 INFO - '-c', 05:55:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:55:37 INFO - 'enabled': True, 05:55:37 INFO - 'halt_on_failure': False, 05:55:37 INFO - 'name': 'check_screen_resolution'},), 05:55:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:55:37 INFO - 'cmd': ('bash', 05:55:37 INFO - '-c', 05:55:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:55:37 INFO - 'enabled': True, 05:55:37 INFO - 'halt_on_failure': False, 05:55:37 INFO - 'name': 'check_screen_resolution'},), 05:55:37 INFO - 'run_cmd_checks_enabled': True, 05:55:37 INFO - 'sps_profile': False, 05:55:37 INFO - 'sps_profile_interval': 0, 05:55:37 INFO - 'suite': 'dromaeojs', 05:55:37 INFO - 'system_bits': '32', 05:55:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:55:37 INFO - 'title': 't-yosemite-r7-0126', 05:55:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:55:37 INFO - 'use_talos_json': True, 05:55:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:55:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:55:37 INFO - 'work_dir': 'build'} 05:55:37 INFO - ##### 05:55:37 INFO - ##### Running clobber step. 05:55:37 INFO - ##### 05:55:37 INFO - Running pre-action listener: _resource_record_pre_action 05:55:37 INFO - Running main action method: clobber 05:55:37 INFO - rmtree: /builds/slave/test/build 05:55:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:55:39 INFO - Running post-action listener: _resource_record_post_action 05:55:39 INFO - ##### 05:55:39 INFO - ##### Running read-buildbot-config step. 05:55:39 INFO - ##### 05:55:39 INFO - Running pre-action listener: _resource_record_pre_action 05:55:39 INFO - Running main action method: read_buildbot_config 05:55:39 INFO - Using buildbot properties: 05:55:39 INFO - { 05:55:39 INFO - "project": "", 05:55:39 INFO - "product": "firefox", 05:55:39 INFO - "script_repo_revision": "production", 05:55:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:55:39 INFO - "repository": "", 05:55:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:55:39 INFO - "buildid": "20160419025149", 05:55:39 INFO - "pgo_build": "False", 05:55:39 INFO - "basedir": "/builds/slave/test", 05:55:39 INFO - "buildnumber": 737, 05:55:39 INFO - "slavename": "t-yosemite-r7-0126", 05:55:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:55:39 INFO - "platform": "yosemite_r7", 05:55:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:55:39 INFO - "branch": "fx-team", 05:55:39 INFO - "repo_path": "integration/fx-team", 05:55:39 INFO - "revision": "6f8f469a45c08371398d2a98bb7fb7b2a5d07355", 05:55:39 INFO - "stage_platform": "macosx64", 05:55:39 INFO - "builduid": "5368043b0c0c49f09efeef07374319b6", 05:55:39 INFO - "slavebuilddir": "test" 05:55:39 INFO - } 05:55:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:55:39 INFO - Running post-action listener: _resource_record_post_action 05:55:39 INFO - ##### 05:55:39 INFO - ##### Running download-and-extract step. 05:55:39 INFO - ##### 05:55:39 INFO - Running pre-action listener: _resource_record_pre_action 05:55:39 INFO - Running main action method: download_and_extract 05:55:39 INFO - mkdir: /builds/slave/test/build/tests 05:55: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')]} 05:55:39 INFO - https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/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 05:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/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 05:55:40 INFO - Downloaded 1199 bytes. 05:55:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:55:40 INFO - Using the following test package requirements: 05:55:40 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:55:40 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:55:40 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:55:40 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:55:40 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:55:40 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:55:40 INFO - u'jsshell-mac.zip'], 05:55:40 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:55:40 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:55:40 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:55:40 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:55:40 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:55:40 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:55:40 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:55:40 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:55:40 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:55:40 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:55:40 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:55:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:40 INFO - https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/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 05:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/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 05:55:42 INFO - Downloaded 18037983 bytes. 05:55:42 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'] 05:55:42 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 05:55:45 INFO - Return code: 0 05:55:45 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 05:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:45 INFO - https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/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 05:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/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 05:55:46 INFO - Downloaded 18037983 bytes. 05:55:46 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'] 05:55:46 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 05:55:49 INFO - Return code: 0 05:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:49 INFO - https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/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 05:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/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 05:55:50 INFO - Downloaded 10845952 bytes. 05:55:50 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'] 05:55:50 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 05:55:51 INFO - Return code: 0 05:55: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')]} 05:55:51 INFO - https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:55:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:55:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:55:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSxPGsJAQjiglkkbOfn-lQ/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 05:55:54 INFO - Downloaded 109952045 bytes. 05:55:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:55:54 INFO - mkdir: /builds/slave/test/properties 05:55:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:55:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:55:54 INFO - Contents: 05:55:54 INFO - build_url:https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:55:55 INFO - Running post-action listener: _resource_record_post_action 05:55:55 INFO - Running post-action listener: set_extra_try_arguments 05:55:55 INFO - ##### 05:55:55 INFO - ##### Running populate-webroot step. 05:55:55 INFO - ##### 05:55:55 INFO - Running pre-action listener: _resource_record_pre_action 05:55:55 INFO - Running main action method: populate_webroot 05:55:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:55:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:55:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:55:55 INFO - '--tppagecycles', 05:55:55 INFO - '7'], 05:55:55 INFO - 'tests': ['tsvgm']}}, 05:55:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:55:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:55:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:55:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:55:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:55 INFO - 'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:55 INFO - 'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['damp', 'tps']}, 05:55:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:55 INFO - 'tests': ['damp', 'tps']}, 05:55:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['dromaeo_dom']}, 05:55:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:55:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['a11yr', 05:55:55 INFO - 'ts_paint', 05:55:55 INFO - 'tpaint', 05:55:55 INFO - 'sessionrestore', 05:55:55 INFO - 'sessionrestore_no_auto_restore', 05:55:55 INFO - 'tabpaint']}, 05:55:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:55:55 INFO - 'ts_paint', 05:55:55 INFO - 'tpaint', 05:55:55 INFO - 'sessionrestore', 05:55:55 INFO - 'sessionrestore_no_auto_restore', 05:55:55 INFO - 'tabpaint']}, 05:55:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:55:55 INFO - 'ts_paint', 05:55:55 INFO - 'tpaint', 05:55:55 INFO - 'sessionrestore', 05:55:55 INFO - 'sessionrestore_no_auto_restore', 05:55:55 INFO - 'tabpaint']}, 05:55:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:55:55 INFO - 'ts_paint', 05:55:55 INFO - 'tpaint', 05:55:55 INFO - 'sessionrestore', 05:55:55 INFO - 'sessionrestore_no_auto_restore', 05:55:55 INFO - 'tabpaint']}, 05:55:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['a11yr', 05:55:55 INFO - 'ts_paint', 05:55:55 INFO - 'tpaint', 05:55:55 INFO - 'sessionrestore', 05:55:55 INFO - 'sessionrestore_no_auto_restore', 05:55:55 INFO - 'tabpaint']}, 05:55:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['a11yr', 05:55:55 INFO - 'ts_paint', 05:55:55 INFO - 'tpaint', 05:55:55 INFO - 'sessionrestore', 05:55:55 INFO - 'sessionrestore_no_auto_restore', 05:55:55 INFO - 'tabpaint']}, 05:55:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['tsvgx', 05:55:55 INFO - 'tsvgr_opacity', 05:55:55 INFO - 'tart', 05:55:55 INFO - 'tscrollx', 05:55:55 INFO - 'cart']}, 05:55:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:55:55 INFO - 'tsvgr_opacity', 05:55:55 INFO - 'tart', 05:55:55 INFO - 'tscrollx', 05:55:55 INFO - 'cart']}, 05:55:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:55 INFO - 'talos_options': ['--disable-e10s'], 05:55:55 INFO - 'tests': ['tp5o']}, 05:55:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:55 INFO - 'tests': ['tp5o']}, 05:55:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:55 INFO - 'talos_options': ['--disable-e10s', 05:55:55 INFO - '--xperf_path', 05:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:55 INFO - 'tests': ['tp5n']}, 05:55:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:55 INFO - 'talos_options': ['--xperf_path', 05:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:55 INFO - 'tests': ['tp5n']}}, 05:55:55 INFO - 'talos.zip': {'path': '', 05:55:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:55:55 INFO - Running post-action listener: _resource_record_post_action 05:55:55 INFO - ##### 05:55:55 INFO - ##### Running create-virtualenv step. 05:55:55 INFO - ##### 05:55:55 INFO - Running pre-action listener: _resource_record_pre_action 05:55:55 INFO - Running main action method: create_virtualenv 05:55:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:55:55 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 05:55:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:55:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:55:55 INFO - Using real prefix '/tools/python27' 05:55:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:55:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:55:58 INFO - Installing pip.................done. 05:55:58 INFO - Return code: 0 05:55:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:59 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 0x103923a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103933420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8572cda750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, '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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:55:59 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 05:55:59 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 05:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:59 INFO - 'HOME': '/Users/cltbld', 05:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:59 INFO - 'LOGNAME': 'cltbld', 05:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:59 INFO - 'MOZ_NO_REMOTE': '1', 05:55:59 INFO - 'NO_EM_RESTART': '1', 05:55:59 INFO - 'PAGER': '/bin/cat', 05:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:59 INFO - 'PWD': '/builds/slave/test', 05:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:59 INFO - 'SHELL': '/bin/bash', 05:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:55:59 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:59 INFO - 'USER': 'cltbld', 05:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:59 INFO - 'XPC_FLAGS': '0x0', 05:55:59 INFO - 'XPC_SERVICE_NAME': '0', 05:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:59 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 05:55:59 INFO - Cleaning up... 05:55:59 INFO - Return code: 0 05:55:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:59 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 0x103923a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103933420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8572cda750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, '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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:55:59 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 05:55:59 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 05:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:59 INFO - 'HOME': '/Users/cltbld', 05:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:59 INFO - 'LOGNAME': 'cltbld', 05:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:59 INFO - 'MOZ_NO_REMOTE': '1', 05:55:59 INFO - 'NO_EM_RESTART': '1', 05:55:59 INFO - 'PAGER': '/bin/cat', 05:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:59 INFO - 'PWD': '/builds/slave/test', 05:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:59 INFO - 'SHELL': '/bin/bash', 05:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:55:59 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:59 INFO - 'USER': 'cltbld', 05:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:59 INFO - 'XPC_FLAGS': '0x0', 05:55:59 INFO - 'XPC_SERVICE_NAME': '0', 05:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:59 INFO - Downloading/unpacking psutil>=0.7.1 05:55:59 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 05:55:59 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 05:55:59 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 05:55:59 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 05:55:59 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 05:55:59 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 05:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:56:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:02 INFO - Installing collected packages: psutil 05:56:02 INFO - Running setup.py install for psutil 05:56:02 INFO - building 'psutil._psutil_osx' extension 05:56:02 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 05:56:03 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 05:56:03 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 05:56:03 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 05:56:03 INFO - building 'psutil._psutil_posix' extension 05:56:03 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 05:56:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:56:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:56:03 INFO - ^ 05:56:03 INFO - 1 warning generated. 05:56:03 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 05:56:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:03 INFO - Successfully installed psutil 05:56:03 INFO - Cleaning up... 05:56:03 INFO - Return code: 0 05:56:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:56:03 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')]} 05:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:03 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')]} 05:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:03 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 0x103923a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103933420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8572cda750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, '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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:56:03 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 05:56:03 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 05:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:04 INFO - 'HOME': '/Users/cltbld', 05:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:04 INFO - 'LOGNAME': 'cltbld', 05:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:04 INFO - 'MOZ_NO_REMOTE': '1', 05:56:04 INFO - 'NO_EM_RESTART': '1', 05:56:04 INFO - 'PAGER': '/bin/cat', 05:56:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:04 INFO - 'PWD': '/builds/slave/test', 05:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:04 INFO - 'SHELL': '/bin/bash', 05:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:56:04 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:04 INFO - 'USER': 'cltbld', 05:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:04 INFO - 'XPC_FLAGS': '0x0', 05:56:04 INFO - 'XPC_SERVICE_NAME': '0', 05:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:56:06 INFO - Installing collected packages: mozsystemmonitor 05:56:06 INFO - Running setup.py install for mozsystemmonitor 05:56:06 INFO - Successfully installed mozsystemmonitor 05:56:06 INFO - Cleaning up... 05:56:07 INFO - Return code: 0 05:56:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:07 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 0x103923a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103933420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8572cda750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, '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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:56:07 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 05:56:07 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 05:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:07 INFO - 'HOME': '/Users/cltbld', 05:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:07 INFO - 'LOGNAME': 'cltbld', 05:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:07 INFO - 'MOZ_NO_REMOTE': '1', 05:56:07 INFO - 'NO_EM_RESTART': '1', 05:56:07 INFO - 'PAGER': '/bin/cat', 05:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:07 INFO - 'PWD': '/builds/slave/test', 05:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:07 INFO - 'SHELL': '/bin/bash', 05:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:56:07 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:07 INFO - 'USER': 'cltbld', 05:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:07 INFO - 'XPC_FLAGS': '0x0', 05:56:07 INFO - 'XPC_SERVICE_NAME': '0', 05:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:56:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:56:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:56:10 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 05:56:10 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 05:56:10 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 05:56:10 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 05:56:10 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 05:56:10 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 05:56:10 INFO - Downloading docopt-0.6.1.tar.gz 05:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:56:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:56:10 INFO - Running setup.py install for blobuploader 05:56:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:56:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:56:11 INFO - Running setup.py install for requests 05:56:11 INFO - Running setup.py install for docopt 05:56:11 INFO - Successfully installed blobuploader requests docopt 05:56:11 INFO - Cleaning up... 05:56:11 INFO - Return code: 0 05:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:11 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 0x103923a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103933420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8572cda750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, '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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:56:11 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 05:56:11 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 05:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:11 INFO - 'HOME': '/Users/cltbld', 05:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:11 INFO - 'LOGNAME': 'cltbld', 05:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:11 INFO - 'MOZ_NO_REMOTE': '1', 05:56:11 INFO - 'NO_EM_RESTART': '1', 05:56:11 INFO - 'PAGER': '/bin/cat', 05:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:11 INFO - 'PWD': '/builds/slave/test', 05:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:11 INFO - 'SHELL': '/bin/bash', 05:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:56:11 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:11 INFO - 'USER': 'cltbld', 05:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:11 INFO - 'XPC_FLAGS': '0x0', 05:56:11 INFO - 'XPC_SERVICE_NAME': '0', 05:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-L9x2LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-IOarzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-bGsMf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-yEwV6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Yj5Dyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-uLq4AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-B6kikg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-hDHOo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VuYYn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:56:12 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-pfEM3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:56:13 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Dk2ZsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:56:13 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Fw85NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:56:13 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Gxq5sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:56:13 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-MKgUCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:13 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-u0AOYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:56:13 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-jXuwj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:56:13 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-feDgYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:56:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:56:13 INFO - Running setup.py install for manifestparser 05:56:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:56:13 INFO - Running setup.py install for mozcrash 05:56:14 INFO - Running setup.py install for mozdebug 05:56:14 INFO - Running setup.py install for mozdevice 05:56:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:56:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:56:14 INFO - Running setup.py install for mozfile 05:56:14 INFO - Running setup.py install for mozhttpd 05:56:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:56:14 INFO - Running setup.py install for mozinfo 05:56:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:56:14 INFO - Running setup.py install for mozInstall 05:56:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:56:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:56:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:56:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:56:14 INFO - Running setup.py install for mozleak 05:56:15 INFO - Running setup.py install for mozlog 05:56:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:56:15 INFO - Running setup.py install for moznetwork 05:56:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:56:15 INFO - Running setup.py install for mozprocess 05:56:15 INFO - Running setup.py install for mozprofile 05:56:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:56:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:56:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:56:15 INFO - Running setup.py install for mozrunner 05:56:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:56:15 INFO - Running setup.py install for mozscreenshot 05:56:16 INFO - Running setup.py install for moztest 05:56:16 INFO - Running setup.py install for mozversion 05:56:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:56:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:56:16 INFO - Cleaning up... 05:56:16 INFO - Return code: 0 05:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:16 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 0x103923a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103933420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8572cda750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, '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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:56:16 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 05:56:16 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 05:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:16 INFO - 'HOME': '/Users/cltbld', 05:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:16 INFO - 'LOGNAME': 'cltbld', 05:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:16 INFO - 'MOZ_NO_REMOTE': '1', 05:56:16 INFO - 'NO_EM_RESTART': '1', 05:56:16 INFO - 'PAGER': '/bin/cat', 05:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:16 INFO - 'PWD': '/builds/slave/test', 05:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:16 INFO - 'SHELL': '/bin/bash', 05:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:56:16 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:16 INFO - 'USER': 'cltbld', 05:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:16 INFO - 'XPC_FLAGS': '0x0', 05:56:16 INFO - 'XPC_SERVICE_NAME': '0', 05:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:56:16 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4JIzUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:56:16 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)) 05:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:56:16 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OhOwya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:56:16 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)) 05:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:56:16 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-i0iLq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:56:16 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)) 05:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:56:16 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-TdmfnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:56:17 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)) 05:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:56:17 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-FLV2aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:56:17 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)) 05:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:56:17 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-BqwsPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:56:17 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)) 05:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:56:17 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-nH6Xzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:56:17 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)) 05:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:56:17 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-32pBVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:56:17 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)) 05:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:56:17 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-vXNGjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:56:17 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)) 05:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:56:17 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4oV0aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:56:17 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)) 05:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:56:17 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-gAZh_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:56:17 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)) 05:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:56:17 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-QntkAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:56:17 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)) 05:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:56:17 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-URx4D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:56:18 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)) 05:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:56:18 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-K2FlFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:56:18 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)) 05:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:18 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-SP9Xrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:18 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)) 05:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:56:18 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-b2vLv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:56:18 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)) 05:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:56:18 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-5nbWWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:56:18 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)) 05:56:18 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)) 05:56:18 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)) 05:56:18 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)) 05:56:18 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)) 05:56:18 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)) 05:56:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:56:18 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 05:56:18 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 05:56:18 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 05:56:18 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 05:56:18 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 05:56:18 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 05:56:20 INFO - Downloading blessings-1.6.tar.gz 05:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:56:20 INFO - Installing collected packages: blessings 05:56:20 INFO - Running setup.py install for blessings 05:56:21 INFO - Successfully installed blessings 05:56:21 INFO - Cleaning up... 05:56:21 INFO - Return code: 0 05:56:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:56:21 INFO - Reading from file tmpfile_stdout 05:56:21 INFO - Current package versions: 05:56:21 INFO - blessings == 1.6 05:56:21 INFO - blobuploader == 1.2.4 05:56:21 INFO - docopt == 0.6.1 05:56:21 INFO - manifestparser == 1.1 05:56:21 INFO - mozInstall == 1.12 05:56:21 INFO - mozcrash == 0.17 05:56:21 INFO - mozdebug == 0.1 05:56:21 INFO - mozdevice == 0.48 05:56:21 INFO - mozfile == 1.2 05:56:21 INFO - mozhttpd == 0.7 05:56:21 INFO - mozinfo == 0.9 05:56:21 INFO - mozleak == 0.1 05:56:21 INFO - mozlog == 3.1 05:56:21 INFO - moznetwork == 0.27 05:56:21 INFO - mozprocess == 0.22 05:56:21 INFO - mozprofile == 0.28 05:56:21 INFO - mozrunner == 6.11 05:56:21 INFO - mozscreenshot == 0.1 05:56:21 INFO - mozsystemmonitor == 0.0 05:56:21 INFO - moztest == 0.7 05:56:21 INFO - mozversion == 1.4 05:56:21 INFO - psutil == 3.1.1 05:56:21 INFO - requests == 1.2.3 05:56:21 INFO - wsgiref == 0.1.2 05:56:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:21 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 0x103923a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103933420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8572cda750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, '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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:56:21 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 05:56:21 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 05:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:21 INFO - 'HOME': '/Users/cltbld', 05:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:21 INFO - 'LOGNAME': 'cltbld', 05:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:21 INFO - 'MOZ_NO_REMOTE': '1', 05:56:21 INFO - 'NO_EM_RESTART': '1', 05:56:21 INFO - 'PAGER': '/bin/cat', 05:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:21 INFO - 'PWD': '/builds/slave/test', 05:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:21 INFO - 'SHELL': '/bin/bash', 05:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:56:21 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:21 INFO - 'USER': 'cltbld', 05:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:21 INFO - 'XPC_FLAGS': '0x0', 05:56:21 INFO - 'XPC_SERVICE_NAME': '0', 05:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:21 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)) 05:56:21 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)) 05:56:21 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)) 05:56:21 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)) 05:56:21 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)) 05:56:21 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)) 05:56:21 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)) 05:56:21 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)) 05:56:21 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)) 05:56:21 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)) 05:56:21 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)) 05:56:21 INFO - Cleaning up... 05:56:21 INFO - Return code: 0 05:56:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:21 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 0x103923a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103933420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8572cda750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, '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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:56:21 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 05:56:21 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 05:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:21 INFO - 'HOME': '/Users/cltbld', 05:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:21 INFO - 'LOGNAME': 'cltbld', 05:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:21 INFO - 'MOZ_NO_REMOTE': '1', 05:56:21 INFO - 'NO_EM_RESTART': '1', 05:56:21 INFO - 'PAGER': '/bin/cat', 05:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:21 INFO - 'PWD': '/builds/slave/test', 05:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:21 INFO - 'SHELL': '/bin/bash', 05:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:56:21 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:21 INFO - 'USER': 'cltbld', 05:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:21 INFO - 'XPC_FLAGS': '0x0', 05:56:21 INFO - 'XPC_SERVICE_NAME': '0', 05:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:21 INFO - Downloading/unpacking jsonschema 05:56:21 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 05:56:21 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 05:56:21 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 05:56:21 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 05:56:21 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 05:56:21 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 05:56:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:56:24 INFO - Downloading/unpacking functools32 (from jsonschema) 05:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:24 INFO - Downloading functools32-3.2.3-2.tar.gz 05:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:56:24 INFO - warning: no files found matching '*.txt' 05:56:24 INFO - no previously-included directories found matching 'build' 05:56:24 INFO - no previously-included directories found matching 'dist' 05:56:24 INFO - no previously-included directories found matching '.git*' 05:56:24 INFO - Installing collected packages: jsonschema, functools32 05:56:24 INFO - Running setup.py install for functools32 05:56:25 INFO - warning: no files found matching '*.txt' 05:56:25 INFO - no previously-included directories found matching 'build' 05:56:25 INFO - no previously-included directories found matching 'dist' 05:56:25 INFO - no previously-included directories found matching '.git*' 05:56:25 INFO - Successfully installed jsonschema functools32 05:56:25 INFO - Cleaning up... 05:56:25 INFO - Return code: 0 05:56:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:25 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 0x103923a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103933420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8572cda750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, '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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 05:56:25 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 05:56:25 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 05:56:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:56:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:25 INFO - 'HOME': '/Users/cltbld', 05:56:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:25 INFO - 'LOGNAME': 'cltbld', 05:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:25 INFO - 'MOZ_NO_REMOTE': '1', 05:56:25 INFO - 'NO_EM_RESTART': '1', 05:56:25 INFO - 'PAGER': '/bin/cat', 05:56:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:25 INFO - 'PWD': '/builds/slave/test', 05:56:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:25 INFO - 'SHELL': '/bin/bash', 05:56:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:56:25 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:56:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:25 INFO - 'USER': 'cltbld', 05:56:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:25 INFO - 'XPC_FLAGS': '0x0', 05:56:25 INFO - 'XPC_SERVICE_NAME': '0', 05:56:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:25 INFO - Downloading/unpacking flake8 05:56:25 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 05:56:25 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 05:56:25 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 05:56:25 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 05:56:25 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 05:56:25 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 05:56:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:56:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:56:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:56:28 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 05:56:28 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 05:56:28 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 05:56:28 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 05:56:28 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 05:56:28 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 05:56:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:56:28 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 05:56:28 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 05:56:28 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 05:56:28 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 05:56:28 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 05:56:28 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 05:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:56:29 INFO - no previously-included directories found matching 'docs/_build' 05:56:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:56:29 INFO - Running setup.py install for pep8 05:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:56:29 INFO - no previously-included directories found matching 'docs/_build' 05:56:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:56:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:56:29 INFO - Cleaning up... 05:56:29 INFO - Return code: 0 05:56:29 INFO - Running post-action listener: _resource_record_post_action 05:56:29 INFO - Running post-action listener: _start_resource_monitoring 05:56:29 INFO - Starting resource monitoring. 05:56:29 INFO - ##### 05:56:29 INFO - ##### Running install step. 05:56:29 INFO - ##### 05:56:29 INFO - Running pre-action listener: _resource_record_pre_action 05:56:29 INFO - Running main action method: install 05:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:56:29 INFO - Reading from file tmpfile_stdout 05:56:29 INFO - Detecting whether we're running mozinstall >=1.0... 05:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:56:29 INFO - Reading from file tmpfile_stdout 05:56:29 INFO - Output received: 05:56:29 INFO - Usage: mozinstall [options] installer 05:56:29 INFO - Options: 05:56:29 INFO - -h, --help show this help message and exit 05:56:29 INFO - -d DEST, --destination=DEST 05:56:29 INFO - Directory to install application into. [default: 05:56:29 INFO - "/builds/slave/test"] 05:56:29 INFO - --app=APP Application being installed. [default: firefox] 05:56:29 INFO - mkdir: /builds/slave/test/build/application 05:56:29 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'] 05:56:29 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 05:57:03 INFO - Reading from file tmpfile_stdout 05:57:03 INFO - Output received: 05:57:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:57:03 INFO - Running post-action listener: _resource_record_post_action 05:57:03 INFO - ##### 05:57:03 INFO - ##### Running run-tests step. 05:57:03 INFO - ##### 05:57:03 INFO - Running pre-action listener: _resource_record_pre_action 05:57:03 INFO - Running main action method: run_tests 05:57:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:57:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:57:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:57:03 INFO - 2016-04-19 05:57:03.717 screenresolution[1641:7658] starting screenresolution argv=screenresolution get 05:57:03 INFO - 2016-04-19 05:57:03.719 screenresolution[1641:7658] Display 0: 1600x1200x32@60 05:57:03 INFO - 2016-04-19 05:57:03.725 screenresolution[1642:7660] starting screenresolution argv=screenresolution list 05:57:03 INFO - Available Modes on Display 0 05:57:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:57:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:57:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:57:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:57:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:57:03 INFO - Intel Iris: 05:57:03 INFO - Chipset Model: Intel Iris 05:57:03 INFO - Type: GPU 05:57:03 INFO - Bus: Built-In 05:57:03 INFO - VRAM (Dynamic, Max): 1536 MB 05:57:03 INFO - Vendor: Intel (0x8086) 05:57:03 INFO - Device ID: 0x0a2e 05:57:03 INFO - Revision ID: 0x0009 05:57:03 INFO - Displays: 05:57:03 INFO - Display: 05:57:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:57:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:57:03 INFO - Display Serial Number: 1600x1200 60 05:57:03 INFO - Main Display: Yes 05:57:03 INFO - Mirror: Off 05:57:03 INFO - Online: Yes 05:57:03 INFO - Rotation: Supported 05:57:03 INFO - Return code: 0 05:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:03 INFO - Python 2.7.3 05:57:03 INFO - Return code: 0 05:57:03 INFO - grabbing minidump binary from tooltool 05:57:03 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')]} 05:57:03 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 0x1037c2e00>, '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 0x1035ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037bdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:03 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 05:57:03 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 05:57:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:04 INFO - Return code: 0 05:57:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:57:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:57:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:57:05 INFO - Return code: 0 05:57:05 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:57:05 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:57:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bSaEEmnAzh/Render', 05:57:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:05 INFO - 'HOME': '/Users/cltbld', 05:57:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:05 INFO - 'LOGNAME': 'cltbld', 05:57:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:05 INFO - 'MOZ_NO_REMOTE': '1', 05:57:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:05 INFO - 'NO_EM_RESTART': '1', 05:57:05 INFO - 'PAGER': '/bin/cat', 05:57:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:05 INFO - 'PWD': '/builds/slave/test', 05:57:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:05 INFO - 'SHELL': '/bin/bash', 05:57:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekgIdBmTAf/Listeners', 05:57:05 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 05:57:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:05 INFO - 'USER': 'cltbld', 05:57:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:05 INFO - 'XPC_FLAGS': '0x0', 05:57:05 INFO - 'XPC_SERVICE_NAME': '0', 05:57:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:57:05 INFO - mozversion application_buildid: 20160419025149 05:57:05 INFO - mozversion application_changeset: 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 05:57:05 INFO - mozversion application_display_name: Nightly 05:57:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:05 INFO - mozversion application_name: Firefox 05:57:05 INFO - mozversion application_remotingname: firefox 05:57:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:57:05 INFO - mozversion application_vendor: Mozilla 05:57:05 INFO - mozversion application_version: 48.0a1 05:57:05 INFO - mozversion platform_buildid: 20160419025149 05:57:05 INFO - mozversion platform_changeset: 6f8f469a45c08371398d2a98bb7fb7b2a5d07355 05:57:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:57:05 INFO - mozversion platform_version: 48.0a1 05:57:05 INFO - using testdate: 1461070625 05:57:05 INFO - actual date: 1461070625 05:57:05 INFO - starting webserver on 'localhost:49270' 05:57:05 INFO - SUITE-START | Running 2 tests 05:57:05 INFO - TEST-START | dromaeo_css 05:57:05 INFO - operating with platform_type : mac_ 05:57:05 INFO - Initialising browser for dromaeo_css test... 05:57:05 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp3guAdR/profile http://localhost:49270/getInfo.html) 05:57:07 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 05:57:07 INFO - PROCESS | 1660 | colorDepth:24 05:57:07 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 05:57:07 INFO - PROCESS | 1660 | __metrics 05:57:07 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:57:07 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:57:08 INFO - TEST-INFO | 1660: exit 0 05:57:08 INFO - Browser initialized. 05:57:08 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:08 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp3guAdR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:20 INFO - PROCESS | 1662 | RSS: Main: 237469696 05:57:20 INFO - PROCESS | 1662 | 05:58:11 INFO - PROCESS | 1662 | 1461070691883 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:00:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 06:00:23 INFO - PROCESS | 1662 | RSS: Main: 329523200 06:00:23 INFO - PROCESS | 1662 | 06:03:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 06:03:26 INFO - PROCESS | 1662 | RSS: Main: 374169600 06:03:26 INFO - PROCESS | 1662 | 06:06:28 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 06:06:29 INFO - PROCESS | 1662 | RSS: Main: 373719040 06:06:29 INFO - PROCESS | 1662 | 06:09:31 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 06:09:32 INFO - PROCESS | 1662 | RSS: Main: 376676352 06:09:32 INFO - PROCESS | 1662 | 06:12:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 06:12:36 INFO - PROCESS | 1662 | RSS: Main: 342409216 06:12:36 INFO - PROCESS | 1662 | 06:15:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 06:15:39 INFO - PROCESS | 1662 | RSS: Main: 382488576 06:15:39 INFO - PROCESS | 1662 | 06:15:39 INFO - PROCESS | 1662 | __start_tp_report 06:15:39 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 06:15:39 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 06:15:39 INFO - PROCESS | 1662 | |i|pagename|runs| 06:15:39 INFO - PROCESS | 1662 | |0;dojo.html;3383.9492407613884;3482.4428091505347;3509.2455122148763;3514.630963748806;3544.503769472273;5612.494875461208;5685.715714214293;5718.456746609076;5737.1967924490555;5738.167965644979;5130.743462826862;5730.598858079936;5733.226014488043;5762.596618236725;5878.088896221093;5134.845954621367;5164.147915593922;5199.870003249911;5203.609729270301;5298.947010529884;5280.894382112356;5309.8938021239555;5327.946720532803;5367.624266301341;5377.7580008899495;5141.15170996785;5237.502437268454;5239.318888544503;5254.369475662945;5278.736063196844;5199.610029247821;5207.270982062514;5248.632595718302;5309.814156504503;5320.015797077553;5161.8193363232485;5187.170052791535;5208.166693329049;5226.686398816083;5267.157254839208;5564.972175139139;5636.746346414421;5658.66048037115;5665.830025099212;5669.688167150805;6160.322364539897;6163.599366041238;6272.56092073555;6280.089387038854;6287.6856157192415;6238.532110091716;6251.062340648894;6268.279147898004;6306.842328941767;6318.147050148217;5615.438456154352;5777.133429985452;5779.595428320062;5784;5790.449907258803;6231.906521402183;6304.054391841169;6306.243250809932;6311.684415779193;6315.778947736807;5400.6759594423675;5965.224520812353;6141.305698451804;6180.103884936749;6187.597806142587;6101.095933926387;6188.195534580475;6291.402316779899;6296.622202667854;6299.464545513682;6128.014278093809;6195.907061394083;6233.563650544509;6254.186955695731;6257.624542527463;6218.06728990655;6250.874982500324;6254.155688981929;6261.592996455307;6274.152989346471;4835.274708793639;4888.731119788375;4909.337239472697;4910.189818679949;4950.702957822542;4429.844955426544;4432.3794668746405;4465.263231566755;4482.887927801766;4504.707194032378;5650.604457688005;5652.463016013555;5663.688497132697;5667.858303542444;5681.545476361881;6207;6250.562460627712;6316.652584107918;6328.841778955563;6333.018382150682;5621.634593751393;5623.8594035149445;5625.38120806711;5635.802746903839;5662.943370566324;5250.632455728139;5338.386085600128;5358;5370.167624018283;5381.919271210935;6324.2410910691015;6346.555741098079;6378.617282963037;6381.553291269566;6390.520710946605;6195.132681424694;6279.277883043508;6286.057091436322;6291.716872740646;6333.398327158912;5288.8148914789335;6220.844478888064;6265.028920517327;6356.141920840812;6358.554901156875;6192.133101365723;6211.751529938932;6225.8132256032395;6229.719662615103;6237.126802247598;6269.059641053878;6291.182146321132;6299.905501417391;6304.621722696653;6315.368463153648;4423.026934074498;5281.524662780368;6019.097135429721;6132.141500189888;6159.538034647329;6112.663803490673;6113.719560719409;6121.593291404719;6123.313124872426;6137.039921714347;5981.790637327673;5998.820035398945;6034.9094763577705;6054.455099041107;6057.697115144137;5956.791512297222;6038.84902877414;6117.857853872152;6141.929035482259;6144.480762887195;6035.245594300713;6045.939540604538;6051.939480605138;6052.970994930961;6084.756609735561 06:15:39 INFO - PROCESS | 1662 | |1;ext.html;524.2136794807789;532.3133158225888;532.3266068423443;546.5136028934247;609.2019454514586;29264.414711705755;36654.26691466169;37555.43666845;37556.43665345015;37572;33444.83277583609;40004.39993400101;40664.59335406645;40698.389524157086;40765.59234407655;8304.750857474286;8586.87119693202;9385.530723463833;9588.328816982814;9598.280128990318;11291.943540282327;11649.767004659901;11654.766904661901;11657.358845263507;11667.6499705009;11279.266847654917;11387.601433949772;11401.258918170333;11409.08727301818;11412.828807567894;8372.413931024801;11311.547538098466;11368.772624547546;11665;11678.532858685643;11224.719382015433;11353.659390218307;11418.54325826966;11421.371824549646;11425.771484570261;36964;39928;39952.20095598072;39985.80007099975;40078.797636070674;3063.188255112375;3331.783434076777;3333.616634087087;3374.4432168692138;3702.8148592570533;26936.735630349365;27091.729082709317;27677;27864;28090.157295281173;2682.9597556036674;2688.421989272316;2714.212878265301;2812.803103782736;2866.8779242452683;346734;348540;349117.99999999744;349475;349823;57580.71209644009;57913.20867913259;58319;58393.83212335729;58403;66079.66960165168;69058.65470672614;70904;71008.28991710016;71075.6446217776;16174;16444.34222631105;16548.75176872348;16765.736625555393;16777.993320400816;11706.941465292619;11912.821307680391;12642.683932901567;12892.033097517724;12916.677083072998;19153.042347882827;19156.521086972938;19213.519662008563;19255.711164332548;19329.613407731766;7860.331871790848;8039.397045221632;8048.718294859652;8059.717909873127;8105.878411823827;869.3132425384002;963.8746962894779;1092.3718861654581;1107.2747350485445;1135.6649788312468;29097;29312.706872931423;29364.11907642774;30021;30273.09180724582;1076.9338355028465;1093.2223200385922;1112.054753459553;1114.7436089699415;1138.538891748843;15094.39622415091;15097.24513774307;15128.243587820565;15674.764878526832;15916.840831591768;640260;648132;651490;653166;654321;48856.75571622119;60390.39609603935;60590.697046514484;60843.39156608466;60854.39145608487;1332.1540821578367;1460.1312219229542;1499.0555949751588;1504.1952555382818;1512.470635277644;28217;28584.285392865346;28831.56752648754;28838;29363.853180734815;47941.76029119832;48688.5131148684;49414.75292623658;49423.50576494189;49484.50515494943;418787;422076;422175;423273;424193;23451.716759654002;26103.738962610132;26476.470470590866;26677.733222667524;26927.326816829736;42141.83936204736;42313;42702.57297426986;43025.78487107545;43574.12851742884;33963.981080567624;35293.47059794157;35699.46450803292;35982.46026309555;36021.91934241977;28166.577501337088;33858.49212261769;34870.825645871606;35086.947391578295;35623.64376356203;36058.4591231137;36140.4578931311;36579.634203657624;36764;37195.81402092972;27092.864535677196;28712.707928142867;30462.695373046874;31908.6809131915;32007;23234.53530929338;24389;25168.33593586841;25568.488630227665;25815.612765808903 06:15:39 INFO - PROCESS | 1662 | |2;jquery.html;394.33554460733654;397.2610943644822;397.29281878256705;398.6013986013988;406.50609509446036;16282.511524654265;19043.143058562364;19070.90464547677;20028.49928751778;20071.297504587325;18256.634867302648;18997;19386.418407447763;20421.693674594855;20454.284100056502;5746.798862039829;5887.646741195521;5928.88142237155;5931.822045338625;5936.614120082181;4841.2496063110275;5807.0998995155815;5834.620749651281;5836.387179346171;5863.091220860752;5690.06113991191;5712.571557133211;5831.183634291181;5838.766449342022;5838.8906107839375;5171.534561889429;5755.338136114358;5835.679037652927;5861.970690146564;5876.177335173079;5048.444671086178;5127.102757017507;5154.92267615986;5157.819476318311;5167.199084141964;23826.523469530686;24181;24211.394715132086;24263.63604545933;24538.319252112327;2138.7540432850265;2199.3511913985412;2332.8367014309006;2852.3297025199063;2879;7549.698012079511;14290.64273393163;14486.492972745904;14730.410783568645;14854;1682.6634673065314;1700.846923776866;1771.9354068888706;1772.335374234662;1913.062599326334;107119.46440267826;114236;119692.99999999913;120934;123034;11572.59495917639;11596.536138554533;11725.648230553097;11730.765384692259;11856.525738970517;15050.548483545512;15100.471483498244;15165.469208577646;15339.61650958735;15387.692246155015;8541.743747687578;8730.519821409756;8741.73244879489;8834.116588341243;8848.070952550019;8478.788030299293;8497.830043399097;8506.78733031679;8597.656093756304;8640.783980400414;3518.683318501347;3841.2893614681375;4592.724436533818;4594.88512787183;4671.8364857229835;1868.7666140347305;1921.5196200949763;1959.960800784005;1979.1291831594053;2014.194322271074;717.1921925660979;748.1657951384276;906.6509393883402;936.7470782888582;938.9765255868658;19267.614647706967;19896.60206795856;20130.798692013184;20428.795712042986;20581.176752929714;937.6483818568037;951.5355229954313;953.5280036381897;981.1758123176423;984.1388784813288;9233.630654773868;9482.762930926781;10444.067847448094;10652.733681658021;10688.625898093529;545398;555841;556842;562081;572666;119359.40320298343;123170;123419.3829030867;124648;127711.78305735519;1008.1833714691123;1014.4420568687045;1058.5183741397645;1079.2337440417234;1082.4479515447022;17533.211005504527;17797.73303400476;17826.643467130845;17882.463526094238;18180;34909;45792;46150;47181.76409117933;47190.52809471861;64654;65099.34900650933;65462.018069729944;66421.33578664152;67014.66492667701;8040.798980025546;8187.590620468834;8199.549024803693;8284.792880178044;8634.222919937236;9226.215771659485;11081.27971681838;12223.327716975651;12236.877631223573;12682.429290682127;9625.903740962502;10826.56693732242;10867.29362591429;11140.442977850913;11207.71980700489;8720.825583488167;8980.910190898268;11020.559177632806;11139.387333696724;11300;10832.458377080957;11186.552537898393;11356.54573817038;11461;11517.481713322753;7087.220405755466;8041.678332866853;8134.227248411392;8247;8497.107803680525;9502.904970950201;9753.170980466739;11101.50043248072;11327.376994265394;11500.079993600324 06:15:39 INFO - PROCESS | 1662 | |3;mootools.html;1378.3246209357415;1409.915405075696;1575.6769862178255;1779.5373202967232;1975.160556763375;7895.526268423899;8654.09132041136;8867.334949878768;8868.11318868112;8873.20141187293;8462.196091371325;8706.259967902735;8713.346499012569;8715.564221788902;8717.825643487127;2039.8164165225128;2223.3107736601623;2230.230570453191;2235.3852690510075;2408.4219787251022;2236.1279101150562;2261.31030035839;2402.231285988484;2478.120267305108;2480.268320845346;2414.7328270607695;2440.5606990741658;2445.877706114696;2446.6819313489223;2447.902083916641;2417.468157005456;2431.9270421887372;2433.6471211674207;2434.9408007516786;2435.403326185078;1800.639872025587;1863.4875409262427;2195.5279614882716;2201.8238540916686;2362.751911049332;8592.656293748243;8603.612837422332;8616.138386161396;8627.137286271385;8643.870341944814;5156.767945442464;5387.946120538783;5391.56867450603;5397.649152805055;5422.91865622016;2976.613040304768;3494.860205591773;3504.351694936445;3555.6622120898473;3561.8041007744564;997.4214955325893;1016.1972042086817;1016.2784423059562;1029.7477118106037;1030.9123724483427;11624.825627615592;11656.475458604384;11703.473343699468;11706.765864682744;11709.765804683944;4661.883452913704;4755.191617425046;4806.435985143187;4848.272759086165;4922.384701912261;8569.742907712778;9846.310758246855;9869.259805514472;9875.901240987641;9890.703278901645;5344.385395679469;5347.556159836822;5384.757685904144;5387.4073851876265;5396.271503347077;4367.781610919505;4790.976045119752;4803.423589169252;4890.437599676012;4941.308216849644;3736.290104880064;3975.8012099394914;4021.6581590564547;4084.019835239521;4120.134771697977;1313;1330.5941687785319;1331.9533816316575;1345.1256683155832;1351.7837146056584;779.3142035009156;878.9252913502296;898.5937008581549;930.3162175800916;948.3049669334521;5580.386157522669;5730.19777231188;5813.12803079533;5871.794487192928;5904.940950590525;864.9524276164872;900.4372267332917;915.4004127296631;971.7764914069803;971.9659811906549;2920;3800.8289626966853;3917.0990672144994;3917.745346552522;3934.213157368538;10219.335743176669;10571.629992950364;10638.680839574825;10640.893591064145;10741.892581074246;10596.894031059745;10658.946705266424;10796.298240614335;10923;10957.397343146204;8060.516369017761;8204.548749818698;8345.290650294672;8362.331013518904;8377.99464064304;5551.944480555143;5639.238702775073;5737.426257374229;5808.651480911159;5816.970915145397;9935.65225217114;9967.950160249153;10054.19566434698;10063;10102.09081182697;8373.78580105869;9780.510974451392;10375.377477351383;10379.948100259451;10383.2212584055;6850.4862135341045;7076.646167691491;7103.183133939663;7433.145188303414;7478.925210747823;7771.961140194489;7860.331871790733;7862.4103192261955;7923.603819808871;8363.080061193386;7298;7330;7357.742479013423;7492.363149132167;7501.324880760758;7132.572045677276;7264.709411623688;7310.853782924418;7387.224341444071;7451.850962980819;6900.551464154814;6983.196932352845;7003.684834182576;7009.12385951756;7017.964910175417;4666.719996800203;4747.216709242936;4791.904161916812;4865;4980.676256043345;4252.851150209728;4825.131476334153;4841.953666227938;4919.827806026772;4947.950520494893 06:15:39 INFO - PROCESS | 1662 | |4;prototype.html;311.92201949512634;318.2886249232965;327.2603915151758;329.8004707152173;329.904327744954;5776.624519406236;5918.852028699279;5931.911021334673;6014.338422773497;6057.121717350987;5067.214581739827;5554.972225138868;5925.762969481216;5942.732577034033;5946.167536544887;4195.496540415139;4295.720778149426;4512.413386259798;4535.501094879577;4566.20091483989;4411.345745345496;4489.573490518395;4568.172730907647;4590.954090459086;4607.4471063472265;4070.287699652564;4201.243776120297;4456.353828694837;4470.575295346936;4471;3792.051987003249;4504.594586487199;4507;4533.410656614652;4559.931601025987;3592.3354179476883;3778;3946.861859834921;3947.940780888289;3951.68386529077;5673.46102120302;5722.427757224286;5727.706568723001;5733.054046082391;5757.827265182052;5210.739463026834;5211.400688920785;5232.162853943389;5234.8429547113265;5256.8685782855355;5028.572571331441;5165.767540460688;6035.818925432244;6295.150154729145;6337.197681391174;4114.074333274989;4144.378343248507;4157.729747566398;4183.832646694129;4187.413762073312;5246.081935661244;6231.59494632852;6680.699368528428;6724.83187920301;6744.966275168642;3688.741788074809;4092.202020606013;4251.341042138473;4270.743755374688;4276.593723596254;3949.328614135604;4327.545607711145;4330.740155590612;4334.111507141091;4348.478182618106;4878.56092951636;5046.470120637354;5068.797248110108;5107.821226257063;5111.667741596784;6039.8490037748525;6192.318844927055;6225.937740622627;6341.841453963688;6395.2645445773405;1421.580633713057;1473.5284708893266;1474.837767845536;1479.1051413894654;1479.4673917389732;879.4898958603994;940.6472572785206;946.966856160031;979.3106890613777;979.6571200079915;5814.342912269983;5867.471927526458;5892.882142357129;5897;5911.733971971272;6249.875002499924;6513.2509761377105;6525.282218955911;6551.8362040948405;6556.606603603704;4858.8785280367565;5608.69152196625;5848.8537786554825;5863.208466857005;5890.705464726747;2503.1489293639884;2683.812133150661;3318.286568387808;3421.3157368526395;3455.913602159966;6468.288488266287;6490.4807615390655;6688.264290927994;6826.624535650587;6980.267071957473;5654.293213348249;6197.81406557804;6874.106366172366;6895.862082758316;6906.723731050803;5843.328017277982;6007.609505382224;6650.600963942179;6960.199577048603;7004.509684322151;6038.275406951194;6579.4736421085245;6605.966970165118;6610.9669451652435;6630.90053649186;5428.212909128075;5995.880082398415;6013.87972240544;6298.464630506275;6538.705758240986;5237.3453318335205;5928.733207005781;6064.909026364519;6851.554648947803;6936.7918962429185;3928.1750832325533;4117.608827161415;4222.577742225752;4277;4283.965116569729;4820.4456487504385;5913.231279933753;6598.637074960731;6615;6627.00594910748;5793.594448388572;6258.874822503433;6363.5545511813725;6370.55406121567;6371.076193951943;5388.946110539001;6093.878122437438;6297.874042519215;6321;6341.397567231105;5437.830866363751;5992.520598352208;6052.243469566304;6212.720427580679;6221;6324.905126423016;6326.114343991753;6358.459530939922;6361.554691171758;6385.393387628168;5057.671251368649;5330.760115794721;5829.94170058294;6153.107799369156;6187.535934804998 06:15:39 INFO - PROCESS | 1662 | |5;yui.html;671.3722669304201;706.5019161491149;715.39906478558;749.6551586270315;762.2263402646319;14519.201443920594;14949.028313159664;14959.700805983874;14959.850401495982;16221.675566488693;15662.060276383425;15675.137867417288;15690.05859648419;15714.84285157148;15739.921300393511;711.6299524247388;734.1483878700708;898.9999999999984;918.1874041473277;919.4850883505259;731.108048181218;731.210292883687;732.4909188114262;808.8473924657369;855.3755758296447;950.8240975419535;957.5116690487866;957.9042095790435;959.3811991265629;959.4387283439196;950.5009869818332;951.4909523405014;952.7046615549202;952.9094736000069;952.980940381192;544.9754761035763;685.0341019163006;707.9185893622248;710.6233696141002;713.8465229975528;14819.77770333446;14854.405823767036;14854.405823767036;14892.404303827834;14902.254887255594;11504.884951150549;12224.694382640417;12237.816432753516;12302.323372214525;12556.497740090386;7920.445568810185;10010.59957601695;10065.496725163712;10131.746706332327;10410.063094321547;3465.151037995707;3539.628339024391;3539.8761043363615;3548.201654627714;3653.5433070866143;84634.73047904349;84845.57577212136;85446.57276713639;85525;85921;9671.516424178762;9690.903090969141;9693.951530242304;9893.554790034466;10013.849792253122;18727.90636046811;21664.675029874565;22122.004509797098;22167.002484887897;22205.889705514983;6435.6138631681315;7277.963610181915;7520.849583008309;7799.415043871732;7826.804329891798;4093.16090201508;4131.772752498581;4135.6898232632675;4213.536510983789;4228.429162063144;3542.4155014422845;3647.8176091195865;3653.707703383723;3655.9268814624093;3657.3416784978426;638.256431257589;651.6285717141184;653.2552889705739;662.6554191820227;695.9373656370951;564.7599770097692;589.2104579862919;602.4066294699717;616.211249600512;618.3723520626568;7143.571385716874;7375.557466551917;7760.961195193988;7994.880076798852;8148.455007811029;521.2363886905702;562.4375624375624;590.6810322425841;600.5825950964038;608.8568239795894;3756.2487502499607;3774.7168962327937;3815.3132436161204;3849.2301539692176;3973.642372186517;102935.94128117396;103737.96262037283;103867;105537;105730;65428;71084.64457677679;74240;75023;78463.60768196122;65623.01565476522;65701.6859662804;66893;68910;70557;6666.633335166613;8161.102278749214;8171;8334.49993000422;8430.704925327584;37593.488781346416;37630.811845940596;39426;39797.59040945114;40563.98590035273;58494;58630.7068464672;58980.41019589749;59068.40931590629;60453.69773151106;10511.421871796818;10912.399818010086;10937.343759374464;11092.722681933015;11223.102151827998;9642.855357169788;11943.76112477763;12050;12311.56909508163;12378.62864114078;11300.773984520429;11367.147463940073;11500.137489688139;11566.65300041;11766.411679416165;11232;11262.83105753398;11404.828927565926;11545.422728863692;11694.649160525198;11188.272762270426;11239.719007024563;11354.716132096764;11512;11667.241629294069;9442.716718498456;9516.143547080796;9956.751081223027;9965.451900145561;10049.799004019733;9483.203109506825;9683;9712.30866841144;9760.951195243979;9876.308658394131 06:15:39 INFO - PROCESS | 1662 | __end_tp_report 06:15:39 INFO - PROCESS | 1662 | __start_cc_report 06:15:39 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1154 06:15:39 INFO - PROCESS | 1662 | __end_cc_report 06:15:39 INFO - PROCESS | 1662 | __startTimestamp1461071739549__endTimestamp 06:15:39 INFO - PROCESS | 1662 | 06:15:39 INFO - PROCESS | 1662 | ------- Summary: start ------- 06:15:39 INFO - PROCESS | 1662 | Number of tests: 6 06:15:39 INFO - PROCESS | 1662 | 06:15:39 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5738.06 Median:5998.82 stddev:639.22 (10.7%) stddev-sans-first:613.93 06:15:39 INFO - PROCESS | 1662 | Values: 3383.9 3482.4 3509.2 3514.6 3544.5 5612.5 5685.7 5718.5 5737.2 5738.2 5130.7 5730.6 5733.2 5762.6 5878.1 5134.8 5164.1 5199.9 5203.6 5298.9 5280.9 5309.9 5327.9 5367.6 5377.8 5141.2 5237.5 5239.3 5254.4 5278.7 5199.6 5207.3 5248.6 5309.8 5320.0 5161.8 5187.2 5208.2 5226.7 5267.2 5565.0 5636.7 5658.7 5665.8 5669.7 6160.3 6163.6 6272.6 6280.1 6287.7 6238.5 6251.1 6268.3 6306.8 6318.1 5615.4 5777.1 5779.6 5784.0 5790.4 6231.9 6304.1 6306.2 6311.7 6315.8 5400.7 5965.2 6141.3 6180.1 6187.6 6101.1 6188.2 6291.4 6296.6 6299.5 6128.0 6195.9 6233.6 6254.2 6257.6 6218.1 6250.9 6254.2 6261.6 6274.2 4835.3 4888.7 4909.3 4910.2 4950.7 4429.8 4432.4 4465.3 4482.9 4504.7 5650.6 5652.5 5663.7 5667.9 5681.5 6207.0 6250.6 6316.7 6328.8 6333.0 5621.6 5623.9 5625.4 5635.8 5662.9 5250.6 5338.4 5358.0 5370.2 5381.9 6324.2 6346.6 6378.6 6381.6 6390.5 6195.1 6279.3 6286.1 6291.7 6333.4 5288.8 6220.8 6265.0 6356.1 6358.6 6192.1 6211.8 6225.8 6229.7 6237.1 6269.1 6291.2 6299.9 6304.6 6315.4 4423.0 5281.5 6019.1 6132.1 6159.5 6112.7 6113.7 6121.6 6123.3 6137.0 5981.8 5998.8 6034.9 6054.5 6057.7 5956.8 6038.8 6117.9 6141.9 6144.5 6035.2 6045.9 6051.9 6053.0 6084.8 06:15:39 INFO - PROCESS | 1662 | 06:15:39 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:61684.77 Median:3332.70 stddev:131068.79 (3932.8%) stddev-sans-first:131356.03 06:15:39 INFO - PROCESS | 1662 | Values: 524.2 532.3 532.3 546.5 609.2 29264.4 36654.3 37555.4 37556.4 37572.0 33444.8 40004.4 40664.6 40698.4 40765.6 8304.8 8586.9 9385.5 9588.3 9598.3 11291.9 11649.8 11654.8 11657.4 11667.6 11279.3 11387.6 11401.3 11409.1 11412.8 8372.4 11311.5 11368.8 11665.0 11678.5 11224.7 11353.7 11418.5 11421.4 11425.8 36964.0 39928.0 39952.2 39985.8 40078.8 3063.2 3331.8 3333.6 3374.4 3702.8 26936.7 27091.7 27677.0 27864.0 28090.2 2683.0 2688.4 2714.2 2812.8 2866.9 346734.0 348540.0 349118.0 349475.0 349823.0 57580.7 57913.2 58319.0 58393.8 58403.0 66079.7 69058.7 70904.0 71008.3 71075.6 16174.0 16444.3 16548.8 16765.7 16778.0 11706.9 11912.8 12642.7 12892.0 12916.7 19153.0 19156.5 19213.5 19255.7 19329.6 7860.3 8039.4 8048.7 8059.7 8105.9 869.3 963.9 1092.4 1107.3 1135.7 29097.0 29312.7 29364.1 30021.0 30273.1 1076.9 1093.2 1112.1 1114.7 1138.5 15094.4 15097.2 15128.2 15674.8 15916.8 640260.0 648132.0 651490.0 653166.0 654321.0 48856.8 60390.4 60590.7 60843.4 60854.4 1332.2 1460.1 1499.1 1504.2 1512.5 28217.0 28584.3 28831.6 28838.0 29363.9 47941.8 48688.5 49414.8 49423.5 49484.5 418787.0 422076.0 422175.0 423273.0 424193.0 23451.7 26103.7 26476.5 26677.7 26927.3 42141.8 42313.0 42702.6 43025.8 43574.1 33964.0 35293.5 35699.5 35982.5 36021.9 28166.6 33858.5 34870.8 35086.9 35623.6 36058.5 36140.5 36579.6 36764.0 37195.8 27092.9 28712.7 30462.7 31908.7 32007.0 23234.5 24389.0 25168.3 25568.5 25815.6 06:15:39 INFO - PROCESS | 1662 | 06:15:39 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:33046.09 Median:18894.00 stddev:93332.89 (494.0%) stddev-sans-first:93562.51 06:15:39 INFO - PROCESS | 1662 | Values: 394.3 397.3 397.3 398.6 406.5 16282.5 19043.1 19070.9 20028.5 20071.3 18256.6 18997.0 19386.4 20421.7 20454.3 5746.8 5887.6 5928.9 5931.8 5936.6 4841.2 5807.1 5834.6 5836.4 5863.1 5690.1 5712.6 5831.2 5838.8 5838.9 5171.5 5755.3 5835.7 5862.0 5876.2 5048.4 5127.1 5154.9 5157.8 5167.2 23826.5 24181.0 24211.4 24263.6 24538.3 2138.8 2199.4 2332.8 2852.3 2879.0 7549.7 14290.6 14486.5 14730.4 14854.0 1682.7 1700.8 1771.9 1772.3 1913.1 107119.5 114236.0 119693.0 120934.0 123034.0 11572.6 11596.5 11725.6 11730.8 11856.5 15050.5 15100.5 15165.5 15339.6 15387.7 8541.7 8730.5 8741.7 8834.1 8848.1 8478.8 8497.8 8506.8 8597.7 8640.8 3518.7 3841.3 4592.7 4594.9 4671.8 1868.8 1921.5 1960.0 1979.1 2014.2 717.2 748.2 906.7 936.7 939.0 19267.6 19896.6 20130.8 20428.8 20581.2 937.6 951.5 953.5 981.2 984.1 9233.6 9482.8 10444.1 10652.7 10688.6 545398.0 555841.0 556842.0 562081.0 572666.0 119359.4 123170.0 123419.4 124648.0 127711.8 1008.2 1014.4 1058.5 1079.2 1082.4 17533.2 17797.7 17826.6 17882.5 18180.0 34909.0 45792.0 46150.0 47181.8 47190.5 64654.0 65099.3 65462.0 66421.3 67014.7 8040.8 8187.6 8199.5 8284.8 8634.2 9226.2 11081.3 12223.3 12236.9 12682.4 9625.9 10826.6 10867.3 11140.4 11207.7 8720.8 8980.9 11020.6 11139.4 11300.0 10832.5 11186.6 11356.5 11461.0 11517.5 7087.2 8041.7 8134.2 8247.0 8497.1 9502.9 9753.2 11101.5 11327.4 11500.1 06:15:39 INFO - PROCESS | 1662 | 06:15:39 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5647.87 Median:4921.11 stddev:3179.68 (64.6%) stddev-sans-first:3172.41 06:15:39 INFO - PROCESS | 1662 | Values: 1378.3 1409.9 1575.7 1779.5 1975.2 7895.5 8654.1 8867.3 8868.1 8873.2 8462.2 8706.3 8713.3 8715.6 8717.8 2039.8 2223.3 2230.2 2235.4 2408.4 2236.1 2261.3 2402.2 2478.1 2480.3 2414.7 2440.6 2445.9 2446.7 2447.9 2417.5 2431.9 2433.6 2434.9 2435.4 1800.6 1863.5 2195.5 2201.8 2362.8 8592.7 8603.6 8616.1 8627.1 8643.9 5156.8 5387.9 5391.6 5397.6 5422.9 2976.6 3494.9 3504.4 3555.7 3561.8 997.4 1016.2 1016.3 1029.7 1030.9 11624.8 11656.5 11703.5 11706.8 11709.8 4661.9 4755.2 4806.4 4848.3 4922.4 8569.7 9846.3 9869.3 9875.9 9890.7 5344.4 5347.6 5384.8 5387.4 5396.3 4367.8 4791.0 4803.4 4890.4 4941.3 3736.3 3975.8 4021.7 4084.0 4120.1 1313.0 1330.6 1332.0 1345.1 1351.8 779.3 878.9 898.6 930.3 948.3 5580.4 5730.2 5813.1 5871.8 5904.9 865.0 900.4 915.4 971.8 972.0 2920.0 3800.8 3917.1 3917.7 3934.2 10219.3 10571.6 10638.7 10640.9 10741.9 10596.9 10658.9 10796.3 10923.0 10957.4 8060.5 8204.5 8345.3 8362.3 8378.0 5551.9 5639.2 5737.4 5808.7 5817.0 9935.7 9968.0 10054.2 10063.0 10102.1 8373.8 9780.5 10375.4 10379.9 10383.2 6850.5 7076.6 7103.2 7433.1 7478.9 7772.0 7860.3 7862.4 7923.6 8363.1 7298.0 7330.0 7357.7 7492.4 7501.3 7132.6 7264.7 7310.9 7387.2 7451.9 6900.6 6983.2 7003.7 7009.1 7018.0 4666.7 4747.2 4791.9 4865.0 4980.7 4252.9 4825.1 4842.0 4919.8 4948.0 06:15:39 INFO - PROCESS | 1662 | 06:15:39 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5079.77 Median:5785.11 stddev:1600.69 (27.7%) stddev-sans-first:1564.67 06:15:39 INFO - PROCESS | 1662 | Values: 311.9 318.3 327.3 329.8 329.9 5776.6 5918.9 5931.9 6014.3 6057.1 5067.2 5555.0 5925.8 5942.7 5946.2 4195.5 4295.7 4512.4 4535.5 4566.2 4411.3 4489.6 4568.2 4591.0 4607.4 4070.3 4201.2 4456.4 4470.6 4471.0 3792.1 4504.6 4507.0 4533.4 4559.9 3592.3 3778.0 3946.9 3947.9 3951.7 5673.5 5722.4 5727.7 5733.1 5757.8 5210.7 5211.4 5232.2 5234.8 5256.9 5028.6 5165.8 6035.8 6295.2 6337.2 4114.1 4144.4 4157.7 4183.8 4187.4 5246.1 6231.6 6680.7 6724.8 6745.0 3688.7 4092.2 4251.3 4270.7 4276.6 3949.3 4327.5 4330.7 4334.1 4348.5 4878.6 5046.5 5068.8 5107.8 5111.7 6039.8 6192.3 6225.9 6341.8 6395.3 1421.6 1473.5 1474.8 1479.1 1479.5 879.5 940.6 947.0 979.3 979.7 5814.3 5867.5 5892.9 5897.0 5911.7 6249.9 6513.3 6525.3 6551.8 6556.6 4858.9 5608.7 5848.9 5863.2 5890.7 2503.1 2683.8 3318.3 3421.3 3455.9 6468.3 6490.5 6688.3 6826.6 6980.3 5654.3 6197.8 6874.1 6895.9 6906.7 5843.3 6007.6 6650.6 6960.2 7004.5 6038.3 6579.5 6606.0 6611.0 6630.9 5428.2 5995.9 6013.9 6298.5 6538.7 5237.3 5928.7 6064.9 6851.6 6936.8 3928.2 4117.6 4222.6 4277.0 4284.0 4820.4 5913.2 6598.6 6615.0 6627.0 5793.6 6258.9 6363.6 6370.6 6371.1 5388.9 6093.9 6297.9 6321.0 6341.4 5437.8 5992.5 6052.2 6212.7 6221.0 6324.9 6326.1 6358.5 6361.6 6385.4 5057.7 5330.8 5829.9 6153.1 6187.5 06:15:39 INFO - PROCESS | 1662 | 06:15:39 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18006.01 Median:29609.96 stddev:25879.43 (87.4%) stddev-sans-first:25919.29 06:15:39 INFO - PROCESS | 1662 | Values: 671.4 706.5 715.4 749.7 762.2 14519.2 14949.0 14959.7 14959.9 16221.7 15662.1 15675.1 15690.1 15714.8 15739.9 711.6 734.1 899.0 918.2 919.5 731.1 731.2 732.5 808.8 855.4 950.8 957.5 957.9 959.4 959.4 950.5 951.5 952.7 952.9 953.0 545.0 685.0 707.9 710.6 713.8 14819.8 14854.4 14854.4 14892.4 14902.3 11504.9 12224.7 12237.8 12302.3 12556.5 7920.4 10010.6 10065.5 10131.7 10410.1 3465.2 3539.6 3539.9 3548.2 3653.5 84634.7 84845.6 85446.6 85525.0 85921.0 9671.5 9690.9 9694.0 9893.6 10013.8 18727.9 21664.7 22122.0 22167.0 22205.9 6435.6 7278.0 7520.8 7799.4 7826.8 4093.2 4131.8 4135.7 4213.5 4228.4 3542.4 3647.8 3653.7 3655.9 3657.3 638.3 651.6 653.3 662.7 695.9 564.8 589.2 602.4 616.2 618.4 7143.6 7375.6 7761.0 7994.9 8148.5 521.2 562.4 590.7 600.6 608.9 3756.2 3774.7 3815.3 3849.2 3973.6 102935.9 103738.0 103867.0 105537.0 105730.0 65428.0 71084.6 74240.0 75023.0 78463.6 65623.0 65701.7 66893.0 68910.0 70557.0 6666.6 8161.1 8171.0 8334.5 8430.7 37593.5 37630.8 39426.0 39797.6 40564.0 58494.0 58630.7 58980.4 59068.4 60453.7 10511.4 10912.4 10937.3 11092.7 11223.1 9642.9 11943.8 12050.0 12311.6 12378.6 11300.8 11367.1 11500.1 11566.7 11766.4 11232.0 11262.8 11404.8 11545.4 11694.6 11188.3 11239.7 11354.7 11512.0 11667.2 9442.7 9516.1 9956.8 9965.5 10049.8 9483.2 9683.0 9712.3 9761.0 9876.3 06:15:39 INFO - PROCESS | 1662 | -------- Summary: end -------- 06:15:39 INFO - PROCESS | 1662 | 06:15:40 INFO - TEST-INFO | 1662: exit 0 06:15:40 INFO - TEST-OK | dromaeo_css | took 1114671ms 06:15:40 INFO - TEST-START | kraken 06:15:40 INFO - operating with platform_type : mac_ 06:15:40 INFO - Initialising browser for kraken test... 06:15:40 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp51zgRh/profile http://localhost:49270/getInfo.html) 06:15:42 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 06:15:42 INFO - PROCESS | 1668 | colorDepth:24 06:15:42 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 06:15:42 INFO - PROCESS | 1668 | __metrics 06:15:42 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:15:42 ERROR - PROCESS | 1668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:15:43 INFO - TEST-INFO | 1668: exit 0 06:15:43 INFO - Browser initialized. 06:15:43 INFO - Running cycle 1/1 for kraken test... 06:15:43 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp51zgRh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:55 INFO - PROCESS | 1670 | RSS: Main: 237756416 06:15:55 INFO - PROCESS | 1670 | 06:15:57 INFO - PROCESS | 1670 | 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) 06:15:58 INFO - PROCESS | 1670 | RSS: Main: 285806592 06:15:58 INFO - PROCESS | 1670 | 06:16:01 INFO - PROCESS | 1670 | 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) 06:16:01 INFO - PROCESS | 1670 | RSS: Main: 299249664 06:16:01 INFO - PROCESS | 1670 | 06:16:05 INFO - PROCESS | 1670 | 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) 06:16:05 INFO - PROCESS | 1670 | RSS: Main: 386781184 06:16:05 INFO - PROCESS | 1670 | 06:16:07 INFO - PROCESS | 1670 | 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) 06:16:08 INFO - PROCESS | 1670 | RSS: Main: 287617024 06:16:08 INFO - PROCESS | 1670 | 06:16:10 INFO - PROCESS | 1670 | 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) 06:16:11 INFO - PROCESS | 1670 | RSS: Main: 292302848 06:16:11 INFO - PROCESS | 1670 | 06:16:14 INFO - PROCESS | 1670 | 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) 06:16:14 INFO - PROCESS | 1670 | RSS: Main: 328601600 06:16:14 INFO - PROCESS | 1670 | 06:16:17 INFO - PROCESS | 1670 | 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) 06:16:18 INFO - PROCESS | 1670 | RSS: Main: 330452992 06:16:18 INFO - PROCESS | 1670 | 06:16:21 INFO - PROCESS | 1670 | 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) 06:16:21 INFO - PROCESS | 1670 | RSS: Main: 327155712 06:16:21 INFO - PROCESS | 1670 | 06:16:23 INFO - PROCESS | 1670 | 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) 06:16:24 INFO - PROCESS | 1670 | RSS: Main: 320004096 06:16:24 INFO - PROCESS | 1670 | 06:16:25 INFO - PROCESS | 1670 | 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) 06:16:26 INFO - PROCESS | 1670 | RSS: Main: 327290880 06:16:26 INFO - PROCESS | 1670 | 06:16:28 INFO - PROCESS | 1670 | 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) 06:16:29 INFO - PROCESS | 1670 | RSS: Main: 329682944 06:16:29 INFO - PROCESS | 1670 | 06:16:32 INFO - PROCESS | 1670 | 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) 06:16:32 INFO - PROCESS | 1670 | RSS: Main: 334327808 06:16:32 INFO - PROCESS | 1670 | 06:16:35 INFO - PROCESS | 1670 | 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) 06:16:36 INFO - PROCESS | 1670 | RSS: Main: 332070912 06:16:36 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | 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) 06:16:38 INFO - PROCESS | 1670 | RSS: Main: 397221888 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | __start_tp_report 06:16:38 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 06:16:38 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 06:16:38 INFO - PROCESS | 1670 | |i|pagename|runs| 06:16:38 INFO - PROCESS | 1670 | |0;ai-astar;114;110;112;111;113;112;119;112;114;112 06:16:38 INFO - PROCESS | 1670 | |1;audio-beat-detection;159;121;145;171;118;143;142;124;193;149 06:16:38 INFO - PROCESS | 1670 | |2;audio-dft;185;183;184;182;183;179;183;183;184;183 06:16:38 INFO - PROCESS | 1670 | |3;audio-fft;77;72;90;90;55;60;57;78;86;73 06:16:38 INFO - PROCESS | 1670 | |4;audio-oscillator;91;95;139;77;77;81;125;80;77;124 06:16:38 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;89;86;89;86;88;86;89;112;74;105 06:16:38 INFO - PROCESS | 1670 | |6;imaging-darkroom;93;93;94;93;93;104;147;94;93;94 06:16:38 INFO - PROCESS | 1670 | |7;imaging-desaturate;85;84;86;85;99;139;70;133;137;144 06:16:38 INFO - PROCESS | 1670 | |8;json-parse-financial;60;60;61;59;60;59;60;78;60;57 06:16:38 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;65;65;75;78;71;67;65;90;96;95 06:16:38 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;82;82;82;82;82;80;79;82;83;80 06:16:38 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;141;136;136;136;136;140;148;146;184;151 06:16:38 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;169;218;170;170;219;214;171;168;169;169 06:16:38 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;59;69;101;69;70;70;66;73;91;96 06:16:38 INFO - PROCESS | 1670 | __end_tp_report 06:16:38 INFO - PROCESS | 1670 | __start_cc_report 06:16:38 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,2007 06:16:38 INFO - PROCESS | 1670 | __end_cc_report 06:16:38 INFO - PROCESS | 1670 | __startTimestamp1461071798548__endTimestamp 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | ------- Summary: start ------- 06:16:38 INFO - PROCESS | 1670 | Number of tests: 14 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:2.47 (2.2%) stddev-sans-first:2.59 06:16:38 INFO - PROCESS | 1670 | Values: 114.0 110.0 112.0 111.0 113.0 112.0 119.0 112.0 114.0 112.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:147.00 stddev:23.40 (15.9%) stddev-sans-first:24.38 06:16:38 INFO - PROCESS | 1670 | Values: 159.0 121.0 145.0 171.0 118.0 143.0 142.0 124.0 193.0 149.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:1.60 (0.9%) stddev-sans-first:1.50 06:16:38 INFO - PROCESS | 1670 | Values: 185.0 183.0 184.0 182.0 183.0 179.0 183.0 183.0 184.0 183.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:73.80 Median:77.50 stddev:13.05 (16.8%) stddev-sans-first:13.79 06:16:38 INFO - PROCESS | 1670 | Values: 77.0 72.0 90.0 90.0 55.0 60.0 57.0 78.0 86.0 73.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:78.50 stddev:23.71 (30.2%) stddev-sans-first:25.06 06:16:38 INFO - PROCESS | 1670 | Values: 91.0 95.0 139.0 77.0 77.0 81.0 125.0 80.0 77.0 124.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:87.00 stddev:10.64 (12.2%) stddev-sans-first:11.27 06:16:38 INFO - PROCESS | 1670 | Values: 89.0 86.0 89.0 86.0 88.0 86.0 89.0 112.0 74.0 105.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:93.00 stddev:16.92 (18.2%) stddev-sans-first:17.77 06:16:38 INFO - PROCESS | 1670 | Values: 93.0 93.0 94.0 93.0 93.0 104.0 147.0 94.0 93.0 94.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:106.20 Median:84.50 stddev:28.55 (33.8%) stddev-sans-first:29.23 06:16:38 INFO - PROCESS | 1670 | Values: 85.0 84.0 86.0 85.0 99.0 139.0 70.0 133.0 137.0 144.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:60.00 stddev:5.93 (9.9%) stddev-sans-first:6.27 06:16:38 INFO - PROCESS | 1670 | Values: 60.0 60.0 61.0 59.0 60.0 59.0 60.0 78.0 60.0 57.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:76.70 Median:76.50 stddev:12.59 (16.5%) stddev-sans-first:12.62 06:16:38 INFO - PROCESS | 1670 | Values: 65.0 65.0 75.0 78.0 71.0 67.0 65.0 90.0 96.0 95.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 06:16:38 INFO - PROCESS | 1670 | Values: 82.0 82.0 82.0 82.0 82.0 80.0 79.0 82.0 83.0 80.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:143.50 stddev:14.65 (10.2%) stddev-sans-first:15.45 06:16:38 INFO - PROCESS | 1670 | Values: 141.0 136.0 136.0 136.0 136.0 140.0 148.0 146.0 184.0 151.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:170.50 stddev:23.03 (13.5%) stddev-sans-first:23.80 06:16:38 INFO - PROCESS | 1670 | Values: 169.0 218.0 170.0 170.0 219.0 214.0 171.0 168.0 169.0 169.0 06:16:38 INFO - PROCESS | 1670 | 06:16:38 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:70.00 stddev:14.21 (20.3%) stddev-sans-first:13.60 06:16:38 INFO - PROCESS | 1670 | Values: 59.0 69.0 101.0 69.0 70.0 70.0 66.0 73.0 91.0 96.0 06:16:38 INFO - PROCESS | 1670 | -------- Summary: end -------- 06:16:38 INFO - PROCESS | 1670 | 06:16:39 INFO - TEST-INFO | 1670: exit 0 06:16:39 INFO - TEST-OK | kraken | took 59299ms 06:16:39 INFO - SUITE-END | took 1173s 06:16:39 INFO - Completed test suite (00:19:34) 06:16:39 INFO - javascript benchmark 06:16:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3383.9492407613884, 3482.4428091505347, 3509.2455122148763, 3514.630963748806, 3544.503769472273, 5612.494875461208, 5685.715714214293, 5718.456746609076, 5737.1967924490555, 5738.167965644979, 5130.743462826862, 5730.598858079936, 5733.226014488043, 5762.596618236725, 5878.088896221093, 5134.845954621367, 5164.147915593922, 5199.870003249911, 5203.609729270301, 5298.947010529884, 5280.894382112356, 5309.8938021239555, 5327.946720532803, 5367.624266301341, 5377.7580008899495, 5141.15170996785, 5237.502437268454, 5239.318888544503, 5254.369475662945, 5278.736063196844, 5199.610029247821, 5207.270982062514, 5248.632595718302, 5309.814156504503, 5320.015797077553, 5161.8193363232485, 5187.170052791535, 5208.166693329049, 5226.686398816083, 5267.157254839208, 5564.972175139139, 5636.746346414421, 5658.66048037115, 5665.830025099212, 5669.688167150805, 6160.322364539897, 6163.599366041238, 6272.56092073555, 6280.089387038854, 6287.6856157192415, 6238.532110091716, 6251.062340648894, 6268.279147898004, 6306.842328941767, 6318.147050148217, 5615.438456154352, 5777.133429985452, 5779.595428320062, 5784.0, 5790.449907258803, 6231.906521402183, 6304.054391841169, 6306.243250809932, 6311.684415779193, 6315.778947736807, 5400.6759594423675, 5965.224520812353, 6141.305698451804, 6180.103884936749, 6187.597806142587, 6101.095933926387, 6188.195534580475, 6291.402316779899, 6296.622202667854, 6299.464545513682, 6128.014278093809, 6195.907061394083, 6233.563650544509, 6254.186955695731, 6257.624542527463, 6218.06728990655, 6250.874982500324, 6254.155688981929, 6261.592996455307, 6274.152989346471, 4835.274708793639, 4888.731119788375, 4909.337239472697, 4910.189818679949, 4950.702957822542, 4429.844955426544, 4432.3794668746405, 4465.263231566755, 4482.887927801766, 4504.707194032378, 5650.604457688005, 5652.463016013555, 5663.688497132697, 5667.858303542444, 5681.545476361881, 6207.0, 6250.562460627712, 6316.652584107918, 6328.841778955563, 6333.018382150682, 5621.634593751393, 5623.8594035149445, 5625.38120806711, 5635.802746903839, 5662.943370566324, 5250.632455728139, 5338.386085600128, 5358.0, 5370.167624018283, 5381.919271210935, 6324.2410910691015, 6346.555741098079, 6378.617282963037, 6381.553291269566, 6390.520710946605, 6195.132681424694, 6279.277883043508, 6286.057091436322, 6291.716872740646, 6333.398327158912, 5288.8148914789335, 6220.844478888064, 6265.028920517327, 6356.141920840812, 6358.554901156875, 6192.133101365723, 6211.751529938932, 6225.8132256032395, 6229.719662615103, 6237.126802247598, 6269.059641053878, 6291.182146321132, 6299.905501417391, 6304.621722696653, 6315.368463153648, 4423.026934074498, 5281.524662780368, 6019.097135429721, 6132.141500189888, 6159.538034647329, 6112.663803490673, 6113.719560719409, 6121.593291404719, 6123.313124872426, 6137.039921714347, 5981.790637327673, 5998.820035398945, 6034.9094763577705, 6054.455099041107, 6057.697115144137, 5956.791512297222, 6038.84902877414, 6117.857853872152, 6141.929035482259, 6144.480762887195, 6035.245594300713, 6045.939540604538, 6051.939480605138, 6052.970994930961, 6084.756609735561], "value": 5699.335224814435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.2136794807789, 532.3133158225888, 532.3266068423443, 546.5136028934247, 609.2019454514586, 29264.414711705755, 36654.26691466169, 37555.43666845, 37556.43665345015, 37572.0, 33444.83277583609, 40004.39993400101, 40664.59335406645, 40698.389524157086, 40765.59234407655, 8304.750857474286, 8586.87119693202, 9385.530723463833, 9588.328816982814, 9598.280128990318, 11291.943540282327, 11649.767004659901, 11654.766904661901, 11657.358845263507, 11667.6499705009, 11279.266847654917, 11387.601433949772, 11401.258918170333, 11409.08727301818, 11412.828807567894, 8372.413931024801, 11311.547538098466, 11368.772624547546, 11665.0, 11678.532858685643, 11224.719382015433, 11353.659390218307, 11418.54325826966, 11421.371824549646, 11425.771484570261, 36964.0, 39928.0, 39952.20095598072, 39985.80007099975, 40078.797636070674, 3063.188255112375, 3331.783434076777, 3333.616634087087, 3374.4432168692138, 3702.8148592570533, 26936.735630349365, 27091.729082709317, 27677.0, 27864.0, 28090.157295281173, 2682.9597556036674, 2688.421989272316, 2714.212878265301, 2812.803103782736, 2866.8779242452683, 346734.0, 348540.0, 349117.99999999744, 349475.0, 349823.0, 57580.71209644009, 57913.20867913259, 58319.0, 58393.83212335729, 58403.0, 66079.66960165168, 69058.65470672614, 70904.0, 71008.28991710016, 71075.6446217776, 16174.0, 16444.34222631105, 16548.75176872348, 16765.736625555393, 16777.993320400816, 11706.941465292619, 11912.821307680391, 12642.683932901567, 12892.033097517724, 12916.677083072998, 19153.042347882827, 19156.521086972938, 19213.519662008563, 19255.711164332548, 19329.613407731766, 7860.331871790848, 8039.397045221632, 8048.718294859652, 8059.717909873127, 8105.878411823827, 869.3132425384002, 963.8746962894779, 1092.3718861654581, 1107.2747350485445, 1135.6649788312468, 29097.0, 29312.706872931423, 29364.11907642774, 30021.0, 30273.09180724582, 1076.9338355028465, 1093.2223200385922, 1112.054753459553, 1114.7436089699415, 1138.538891748843, 15094.39622415091, 15097.24513774307, 15128.243587820565, 15674.764878526832, 15916.840831591768, 640260.0, 648132.0, 651490.0, 653166.0, 654321.0, 48856.75571622119, 60390.39609603935, 60590.697046514484, 60843.39156608466, 60854.39145608487, 1332.1540821578367, 1460.1312219229542, 1499.0555949751588, 1504.1952555382818, 1512.470635277644, 28217.0, 28584.285392865346, 28831.56752648754, 28838.0, 29363.853180734815, 47941.76029119832, 48688.5131148684, 49414.75292623658, 49423.50576494189, 49484.50515494943, 418787.0, 422076.0, 422175.0, 423273.0, 424193.0, 23451.716759654002, 26103.738962610132, 26476.470470590866, 26677.733222667524, 26927.326816829736, 42141.83936204736, 42313.0, 42702.57297426986, 43025.78487107545, 43574.12851742884, 33963.981080567624, 35293.47059794157, 35699.46450803292, 35982.46026309555, 36021.91934241977, 28166.577501337088, 33858.49212261769, 34870.825645871606, 35086.947391578295, 35623.64376356203, 36058.4591231137, 36140.4578931311, 36579.634203657624, 36764.0, 37195.81402092972, 27092.864535677196, 28712.707928142867, 30462.695373046874, 31908.6809131915, 32007.0, 23234.53530929338, 24389.0, 25168.33593586841, 25568.488630227665, 25815.612765808903], "value": 19571.542498387345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.33554460733654, 397.2610943644822, 397.29281878256705, 398.6013986013988, 406.50609509446036, 16282.511524654265, 19043.143058562364, 19070.90464547677, 20028.49928751778, 20071.297504587325, 18256.634867302648, 18997.0, 19386.418407447763, 20421.693674594855, 20454.284100056502, 5746.798862039829, 5887.646741195521, 5928.88142237155, 5931.822045338625, 5936.614120082181, 4841.2496063110275, 5807.0998995155815, 5834.620749651281, 5836.387179346171, 5863.091220860752, 5690.06113991191, 5712.571557133211, 5831.183634291181, 5838.766449342022, 5838.8906107839375, 5171.534561889429, 5755.338136114358, 5835.679037652927, 5861.970690146564, 5876.177335173079, 5048.444671086178, 5127.102757017507, 5154.92267615986, 5157.819476318311, 5167.199084141964, 23826.523469530686, 24181.0, 24211.394715132086, 24263.63604545933, 24538.319252112327, 2138.7540432850265, 2199.3511913985412, 2332.8367014309006, 2852.3297025199063, 2879.0, 7549.698012079511, 14290.64273393163, 14486.492972745904, 14730.410783568645, 14854.0, 1682.6634673065314, 1700.846923776866, 1771.9354068888706, 1772.335374234662, 1913.062599326334, 107119.46440267826, 114236.0, 119692.99999999913, 120934.0, 123034.0, 11572.59495917639, 11596.536138554533, 11725.648230553097, 11730.765384692259, 11856.525738970517, 15050.548483545512, 15100.471483498244, 15165.469208577646, 15339.61650958735, 15387.692246155015, 8541.743747687578, 8730.519821409756, 8741.73244879489, 8834.116588341243, 8848.070952550019, 8478.788030299293, 8497.830043399097, 8506.78733031679, 8597.656093756304, 8640.783980400414, 3518.683318501347, 3841.2893614681375, 4592.724436533818, 4594.88512787183, 4671.8364857229835, 1868.7666140347305, 1921.5196200949763, 1959.960800784005, 1979.1291831594053, 2014.194322271074, 717.1921925660979, 748.1657951384276, 906.6509393883402, 936.7470782888582, 938.9765255868658, 19267.614647706967, 19896.60206795856, 20130.798692013184, 20428.795712042986, 20581.176752929714, 937.6483818568037, 951.5355229954313, 953.5280036381897, 981.1758123176423, 984.1388784813288, 9233.630654773868, 9482.762930926781, 10444.067847448094, 10652.733681658021, 10688.625898093529, 545398.0, 555841.0, 556842.0, 562081.0, 572666.0, 119359.40320298343, 123170.0, 123419.3829030867, 124648.0, 127711.78305735519, 1008.1833714691123, 1014.4420568687045, 1058.5183741397645, 1079.2337440417234, 1082.4479515447022, 17533.211005504527, 17797.73303400476, 17826.643467130845, 17882.463526094238, 18180.0, 34909.0, 45792.0, 46150.0, 47181.76409117933, 47190.52809471861, 64654.0, 65099.34900650933, 65462.018069729944, 66421.33578664152, 67014.66492667701, 8040.798980025546, 8187.590620468834, 8199.549024803693, 8284.792880178044, 8634.222919937236, 9226.215771659485, 11081.27971681838, 12223.327716975651, 12236.877631223573, 12682.429290682127, 9625.903740962502, 10826.56693732242, 10867.29362591429, 11140.442977850913, 11207.71980700489, 8720.825583488167, 8980.910190898268, 11020.559177632806, 11139.387333696724, 11300.0, 10832.458377080957, 11186.552537898393, 11356.54573817038, 11461.0, 11517.481713322753, 7087.220405755466, 8041.678332866853, 8134.227248411392, 8247.0, 8497.107803680525, 9502.904970950201, 9753.170980466739, 11101.50043248072, 11327.376994265394, 11500.079993600324], "value": 9361.397257576657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.3246209357415, 1409.915405075696, 1575.6769862178255, 1779.5373202967232, 1975.160556763375, 7895.526268423899, 8654.09132041136, 8867.334949878768, 8868.11318868112, 8873.20141187293, 8462.196091371325, 8706.259967902735, 8713.346499012569, 8715.564221788902, 8717.825643487127, 2039.8164165225128, 2223.3107736601623, 2230.230570453191, 2235.3852690510075, 2408.4219787251022, 2236.1279101150562, 2261.31030035839, 2402.231285988484, 2478.120267305108, 2480.268320845346, 2414.7328270607695, 2440.5606990741658, 2445.877706114696, 2446.6819313489223, 2447.902083916641, 2417.468157005456, 2431.9270421887372, 2433.6471211674207, 2434.9408007516786, 2435.403326185078, 1800.639872025587, 1863.4875409262427, 2195.5279614882716, 2201.8238540916686, 2362.751911049332, 8592.656293748243, 8603.612837422332, 8616.138386161396, 8627.137286271385, 8643.870341944814, 5156.767945442464, 5387.946120538783, 5391.56867450603, 5397.649152805055, 5422.91865622016, 2976.613040304768, 3494.860205591773, 3504.351694936445, 3555.6622120898473, 3561.8041007744564, 997.4214955325893, 1016.1972042086817, 1016.2784423059562, 1029.7477118106037, 1030.9123724483427, 11624.825627615592, 11656.475458604384, 11703.473343699468, 11706.765864682744, 11709.765804683944, 4661.883452913704, 4755.191617425046, 4806.435985143187, 4848.272759086165, 4922.384701912261, 8569.742907712778, 9846.310758246855, 9869.259805514472, 9875.901240987641, 9890.703278901645, 5344.385395679469, 5347.556159836822, 5384.757685904144, 5387.4073851876265, 5396.271503347077, 4367.781610919505, 4790.976045119752, 4803.423589169252, 4890.437599676012, 4941.308216849644, 3736.290104880064, 3975.8012099394914, 4021.6581590564547, 4084.019835239521, 4120.134771697977, 1313.0, 1330.5941687785319, 1331.9533816316575, 1345.1256683155832, 1351.7837146056584, 779.3142035009156, 878.9252913502296, 898.5937008581549, 930.3162175800916, 948.3049669334521, 5580.386157522669, 5730.19777231188, 5813.12803079533, 5871.794487192928, 5904.940950590525, 864.9524276164872, 900.4372267332917, 915.4004127296631, 971.7764914069803, 971.9659811906549, 2920.0, 3800.8289626966853, 3917.0990672144994, 3917.745346552522, 3934.213157368538, 10219.335743176669, 10571.629992950364, 10638.680839574825, 10640.893591064145, 10741.892581074246, 10596.894031059745, 10658.946705266424, 10796.298240614335, 10923.0, 10957.397343146204, 8060.516369017761, 8204.548749818698, 8345.290650294672, 8362.331013518904, 8377.99464064304, 5551.944480555143, 5639.238702775073, 5737.426257374229, 5808.651480911159, 5816.970915145397, 9935.65225217114, 9967.950160249153, 10054.19566434698, 10063.0, 10102.09081182697, 8373.78580105869, 9780.510974451392, 10375.377477351383, 10379.948100259451, 10383.2212584055, 6850.4862135341045, 7076.646167691491, 7103.183133939663, 7433.145188303414, 7478.925210747823, 7771.961140194489, 7860.331871790733, 7862.4103192261955, 7923.603819808871, 8363.080061193386, 7298.0, 7330.0, 7357.742479013423, 7492.363149132167, 7501.324880760758, 7132.572045677276, 7264.709411623688, 7310.853782924418, 7387.224341444071, 7451.850962980819, 6900.551464154814, 6983.196932352845, 7003.684834182576, 7009.12385951756, 7017.964910175417, 4666.719996800203, 4747.216709242936, 4791.904161916812, 4865.0, 4980.676256043345, 4252.851150209728, 4825.131476334153, 4841.953666227938, 4919.827806026772, 4947.950520494893], "value": 4534.304021534646, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.92201949512634, 318.2886249232965, 327.2603915151758, 329.8004707152173, 329.904327744954, 5776.624519406236, 5918.852028699279, 5931.911021334673, 6014.338422773497, 6057.121717350987, 5067.214581739827, 5554.972225138868, 5925.762969481216, 5942.732577034033, 5946.167536544887, 4195.496540415139, 4295.720778149426, 4512.413386259798, 4535.501094879577, 4566.20091483989, 4411.345745345496, 4489.573490518395, 4568.172730907647, 4590.954090459086, 4607.4471063472265, 4070.287699652564, 4201.243776120297, 4456.353828694837, 4470.575295346936, 4471.0, 3792.051987003249, 4504.594586487199, 4507.0, 4533.410656614652, 4559.931601025987, 3592.3354179476883, 3778.0, 3946.861859834921, 3947.940780888289, 3951.68386529077, 5673.46102120302, 5722.427757224286, 5727.706568723001, 5733.054046082391, 5757.827265182052, 5210.739463026834, 5211.400688920785, 5232.162853943389, 5234.8429547113265, 5256.8685782855355, 5028.572571331441, 5165.767540460688, 6035.818925432244, 6295.150154729145, 6337.197681391174, 4114.074333274989, 4144.378343248507, 4157.729747566398, 4183.832646694129, 4187.413762073312, 5246.081935661244, 6231.59494632852, 6680.699368528428, 6724.83187920301, 6744.966275168642, 3688.741788074809, 4092.202020606013, 4251.341042138473, 4270.743755374688, 4276.593723596254, 3949.328614135604, 4327.545607711145, 4330.740155590612, 4334.111507141091, 4348.478182618106, 4878.56092951636, 5046.470120637354, 5068.797248110108, 5107.821226257063, 5111.667741596784, 6039.8490037748525, 6192.318844927055, 6225.937740622627, 6341.841453963688, 6395.2645445773405, 1421.580633713057, 1473.5284708893266, 1474.837767845536, 1479.1051413894654, 1479.4673917389732, 879.4898958603994, 940.6472572785206, 946.966856160031, 979.3106890613777, 979.6571200079915, 5814.342912269983, 5867.471927526458, 5892.882142357129, 5897.0, 5911.733971971272, 6249.875002499924, 6513.2509761377105, 6525.282218955911, 6551.8362040948405, 6556.606603603704, 4858.8785280367565, 5608.69152196625, 5848.8537786554825, 5863.208466857005, 5890.705464726747, 2503.1489293639884, 2683.812133150661, 3318.286568387808, 3421.3157368526395, 3455.913602159966, 6468.288488266287, 6490.4807615390655, 6688.264290927994, 6826.624535650587, 6980.267071957473, 5654.293213348249, 6197.81406557804, 6874.106366172366, 6895.862082758316, 6906.723731050803, 5843.328017277982, 6007.609505382224, 6650.600963942179, 6960.199577048603, 7004.509684322151, 6038.275406951194, 6579.4736421085245, 6605.966970165118, 6610.9669451652435, 6630.90053649186, 5428.212909128075, 5995.880082398415, 6013.87972240544, 6298.464630506275, 6538.705758240986, 5237.3453318335205, 5928.733207005781, 6064.909026364519, 6851.554648947803, 6936.7918962429185, 3928.1750832325533, 4117.608827161415, 4222.577742225752, 4277.0, 4283.965116569729, 4820.4456487504385, 5913.231279933753, 6598.637074960731, 6615.0, 6627.00594910748, 5793.594448388572, 6258.874822503433, 6363.5545511813725, 6370.55406121567, 6371.076193951943, 5388.946110539001, 6093.878122437438, 6297.874042519215, 6321.0, 6341.397567231105, 5437.830866363751, 5992.520598352208, 6052.243469566304, 6212.720427580679, 6221.0, 6324.905126423016, 6326.114343991753, 6358.459530939922, 6361.554691171758, 6385.393387628168, 5057.671251368649, 5330.760115794721, 5829.94170058294, 6153.107799369156, 6187.535934804998], "value": 4560.210403885076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.3722669304201, 706.5019161491149, 715.39906478558, 749.6551586270315, 762.2263402646319, 14519.201443920594, 14949.028313159664, 14959.700805983874, 14959.850401495982, 16221.675566488693, 15662.060276383425, 15675.137867417288, 15690.05859648419, 15714.84285157148, 15739.921300393511, 711.6299524247388, 734.1483878700708, 898.9999999999984, 918.1874041473277, 919.4850883505259, 731.108048181218, 731.210292883687, 732.4909188114262, 808.8473924657369, 855.3755758296447, 950.8240975419535, 957.5116690487866, 957.9042095790435, 959.3811991265629, 959.4387283439196, 950.5009869818332, 951.4909523405014, 952.7046615549202, 952.9094736000069, 952.980940381192, 544.9754761035763, 685.0341019163006, 707.9185893622248, 710.6233696141002, 713.8465229975528, 14819.77770333446, 14854.405823767036, 14854.405823767036, 14892.404303827834, 14902.254887255594, 11504.884951150549, 12224.694382640417, 12237.816432753516, 12302.323372214525, 12556.497740090386, 7920.445568810185, 10010.59957601695, 10065.496725163712, 10131.746706332327, 10410.063094321547, 3465.151037995707, 3539.628339024391, 3539.8761043363615, 3548.201654627714, 3653.5433070866143, 84634.73047904349, 84845.57577212136, 85446.57276713639, 85525.0, 85921.0, 9671.516424178762, 9690.903090969141, 9693.951530242304, 9893.554790034466, 10013.849792253122, 18727.90636046811, 21664.675029874565, 22122.004509797098, 22167.002484887897, 22205.889705514983, 6435.6138631681315, 7277.963610181915, 7520.849583008309, 7799.415043871732, 7826.804329891798, 4093.16090201508, 4131.772752498581, 4135.6898232632675, 4213.536510983789, 4228.429162063144, 3542.4155014422845, 3647.8176091195865, 3653.707703383723, 3655.9268814624093, 3657.3416784978426, 638.256431257589, 651.6285717141184, 653.2552889705739, 662.6554191820227, 695.9373656370951, 564.7599770097692, 589.2104579862919, 602.4066294699717, 616.211249600512, 618.3723520626568, 7143.571385716874, 7375.557466551917, 7760.961195193988, 7994.880076798852, 8148.455007811029, 521.2363886905702, 562.4375624375624, 590.6810322425841, 600.5825950964038, 608.8568239795894, 3756.2487502499607, 3774.7168962327937, 3815.3132436161204, 3849.2301539692176, 3973.642372186517, 102935.94128117396, 103737.96262037283, 103867.0, 105537.0, 105730.0, 65428.0, 71084.64457677679, 74240.0, 75023.0, 78463.60768196122, 65623.01565476522, 65701.6859662804, 66893.0, 68910.0, 70557.0, 6666.633335166613, 8161.102278749214, 8171.0, 8334.49993000422, 8430.704925327584, 37593.488781346416, 37630.811845940596, 39426.0, 39797.59040945114, 40563.98590035273, 58494.0, 58630.7068464672, 58980.41019589749, 59068.40931590629, 60453.69773151106, 10511.421871796818, 10912.399818010086, 10937.343759374464, 11092.722681933015, 11223.102151827998, 9642.855357169788, 11943.76112477763, 12050.0, 12311.56909508163, 12378.62864114078, 11300.773984520429, 11367.147463940073, 11500.137489688139, 11566.65300041, 11766.411679416165, 11232.0, 11262.83105753398, 11404.828927565926, 11545.422728863692, 11694.649160525198, 11188.272762270426, 11239.719007024563, 11354.716132096764, 11512.0, 11667.241629294069, 9442.716718498456, 9516.143547080796, 9956.751081223027, 9965.451900145561, 10049.799004019733, 9483.203109506825, 9683.0, 9712.30866841144, 9760.951195243979, 9876.308658394131], "value": 6807.346184464371, "unit": "score"}], "name": "dromaeo_css", "value": 7264.694635099821, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 112.0, 111.0, 113.0, 112.0, 119.0, 112.0, 114.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 121.0, 145.0, 171.0, 118.0, 143.0, 142.0, 124.0, 193.0, 149.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 184.0, 182.0, 183.0, 179.0, 183.0, 183.0, 184.0, 183.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 90.0, 90.0, 55.0, 60.0, 57.0, 78.0, 86.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 139.0, 77.0, 77.0, 81.0, 125.0, 80.0, 77.0, 124.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 88.0, 86.0, 89.0, 112.0, 74.0, 105.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 104.0, 147.0, 94.0, 93.0, 94.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 86.0, 85.0, 99.0, 139.0, 70.0, 133.0, 137.0, 144.0], "value": 106.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 60.0, 59.0, 60.0, 78.0, 60.0, 57.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 75.0, 78.0, 71.0, 67.0, 65.0, 90.0, 96.0, 95.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 82.0, 80.0, 79.0, 82.0, 83.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 136.0, 136.0, 136.0, 140.0, 148.0, 146.0, 184.0, 151.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 218.0, 170.0, 170.0, 219.0, 214.0, 171.0, 168.0, 169.0, 169.0], "value": 183.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 69.0, 101.0, 69.0, 70.0, 70.0, 66.0, 73.0, 91.0, 96.0], "value": 76.4, "unit": "score"}], "name": "kraken", "value": 1534.1000000000001, "alertThreshold": 2.0}]} 06:16:39 INFO - Return code: 0 06:16:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:16:39 ERROR - # TBPL SUCCESS # 06:16:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:16:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:16:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:16:39 INFO - 2016-04-19 06:16:39.826 screenresolution[1674:9720] starting screenresolution argv=screenresolution get 06:16:39 INFO - 2016-04-19 06:16:39.829 screenresolution[1674:9720] Display 0: 1600x1200x32@60 06:16:39 INFO - 2016-04-19 06:16:39.835 screenresolution[1675:9723] starting screenresolution argv=screenresolution list 06:16:39 INFO - Available Modes on Display 0 06:16:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:16:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:16:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:16:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:16:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:16:40 INFO - Intel Iris: 06:16:40 INFO - Chipset Model: Intel Iris 06:16:40 INFO - Type: GPU 06:16:40 INFO - Bus: Built-In 06:16:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:16:40 INFO - Vendor: Intel (0x8086) 06:16:40 INFO - Device ID: 0x0a2e 06:16:40 INFO - Revision ID: 0x0009 06:16:40 INFO - Displays: 06:16:40 INFO - Display: 06:16:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:16:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:16:40 INFO - Display Serial Number: 1600x1200 60 06:16:40 INFO - Main Display: Yes 06:16:40 INFO - Mirror: Off 06:16:40 INFO - Online: Yes 06:16:40 INFO - Rotation: Supported 06:16:40 INFO - Return code: 0 06:16:40 INFO - Running post-action listener: _resource_record_post_action 06:16:40 INFO - Running post-run listener: _resource_record_post_run 06:16:41 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37643776; Write bytes: 693231104; Read time: 392; Write time: 2104 06:16:41 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 400583168; Write bytes: 397469696; Read time: 29858; Write time: 876 06:16:41 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 30526976; Write bytes: 294913536; Read time: 304; Write time: 1226 06:16:41 INFO - Running post-run listener: _upload_blobber_files 06:16:41 INFO - Blob upload gear active. 06:16:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:16:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:16:41 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'] 06:16:41 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 06:16:41 INFO - (blobuploader) - INFO - Open directory for files ... 06:16:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:16:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:16:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:42 INFO - (blobuploader) - INFO - Done attempting. 06:16:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:16:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:16:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:43 INFO - (blobuploader) - INFO - Done attempting. 06:16:43 INFO - (blobuploader) - INFO - Iteration through files over. 06:16:43 INFO - Return code: 0 06:16:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:16:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:16:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/facb307af0c35c99f0157398de192f625935a5fd2d2bb1791e187d36966383ee4bd4b3ea51ea40b240be38c2af7cb76aec0b45368565309850df06d265a3af80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08fb74e1058074cf75113bc49146cfab1445da16825b6aec0a37fd6a0f1e02e3cb7b5409034ecc4b55619e9c21fbf0da88c42ee894df2a82f72dd155d4ed1092"} 06:16:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:16:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:16:43 INFO - Contents: 06:16:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/facb307af0c35c99f0157398de192f625935a5fd2d2bb1791e187d36966383ee4bd4b3ea51ea40b240be38c2af7cb76aec0b45368565309850df06d265a3af80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08fb74e1058074cf75113bc49146cfab1445da16825b6aec0a37fd6a0f1e02e3cb7b5409034ecc4b55619e9c21fbf0da88c42ee894df2a82f72dd155d4ed1092"} 06:16:43 INFO - Running post-run listener: copy_logs_to_upload_dir 06:16:43 INFO - Copying logs to upload dir... 06:16:43 INFO - mkdir: /builds/slave/test/build/upload/logs 06:16:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.259047 ========= master_lag: 2.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-19 06:16:46.010368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-19 06:16:46.011683) ========= 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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/facb307af0c35c99f0157398de192f625935a5fd2d2bb1791e187d36966383ee4bd4b3ea51ea40b240be38c2af7cb76aec0b45368565309850df06d265a3af80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08fb74e1058074cf75113bc49146cfab1445da16825b6aec0a37fd6a0f1e02e3cb7b5409034ecc4b55619e9c21fbf0da88c42ee894df2a82f72dd155d4ed1092"} build_url:https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/NSxPGsJAQjiglkkbOfn-lQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/facb307af0c35c99f0157398de192f625935a5fd2d2bb1791e187d36966383ee4bd4b3ea51ea40b240be38c2af7cb76aec0b45368565309850df06d265a3af80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08fb74e1058074cf75113bc49146cfab1445da16825b6aec0a37fd6a0f1e02e3cb7b5409034ecc4b55619e9c21fbf0da88c42ee894df2a82f72dd155d4ed1092"}' ========= master_lag: 1.94 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-19 06:16:47.964074) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-04-19 06:16:47.964466) ========= 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.bSaEEmnAzh/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.ekgIdBmTAf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005115 ========= master_lag: 7.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2016-04-19 06:16:55.026591) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-19 06:16:55.026930) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-19 06:16:56.888423) ========= ========= Total master_lag: 17.74 =========