builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0013 starttime: 1455101457.45 results: success (0) buildid: 20160208164823 builduid: 30a40c8c361641e58b7426d55eb90c1e revision: 49945e5fe79e6cf2b083f56fd49d917ca886db0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.452992) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.453419) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.453706) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005721 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.475284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.475589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.490505) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.490897) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005491 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.539499) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.539794) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.540165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.540438) ========= 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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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-02-10 02:50:57-- 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% 38.0M=0s 2016-02-10 02:50:57 (38.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137335 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.692289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.692598) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.019802 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:57.741367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 02:50:57.741692) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 49945e5fe79e6cf2b083f56fd49d917ca886db0b --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 49945e5fe79e6cf2b083f56fd49d917ca886db0b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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-02-10 02:50:57,816 truncating revision to first 12 chars 2016-02-10 02:50:57,816 Setting DEBUG logging. 2016-02-10 02:50:57,816 attempt 1/10 2016-02-10 02:50:57,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/49945e5fe79e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 02:50:59,028 unpacking tar archive at: fx-team-49945e5fe79e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.446863 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 02:50:59.202675) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:59.203089) ========= echo 49945e5fe79e6cf2b083f56fd49d917ca886db0b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'49945e5fe79e6cf2b083f56fd49d917ca886db0b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 49945e5fe79e6cf2b083f56fd49d917ca886db0b program finished with exit code 0 elapsedTime=0.004646 script_repo_revision: '49945e5fe79e6cf2b083f56fd49d917ca886db0b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:59.252382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:59.252716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:59.264998) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-02-10 02:50:59.265301) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:50:59 INFO - MultiFileLogger online at 20160210 02:50:59 in /builds/slave/test 02:50:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:50:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:50:59 INFO - {'append_to_log': False, 02:50:59 INFO - 'base_work_dir': '/builds/slave/test', 02:50:59 INFO - 'blob_upload_branch': 'Fx-Team', 02:50:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:50:59 INFO - 'branch': 'Fx-Team', 02:50:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:50:59 INFO - 'config_files': ('talos/mac_config.py',), 02:50:59 INFO - 'default_actions': ('clobber', 02:50:59 INFO - 'read-buildbot-config', 02:50:59 INFO - 'download-and-extract', 02:50:59 INFO - 'populate-webroot', 02:50:59 INFO - 'create-virtualenv', 02:50:59 INFO - 'install', 02:50:59 INFO - 'run-tests'), 02:50:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:50:59 INFO - 'download_minidump_stackwalk': True, 02:50:59 INFO - 'download_symbols': 'ondemand', 02:50:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:50:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:50:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:50:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:50:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:50:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:50:59 INFO - 'installer_path': 'installer.exe', 02:50:59 INFO - 'log_level': 'info', 02:50:59 INFO - 'log_name': 'talos', 02:50:59 INFO - 'log_to_console': True, 02:50:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:50:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:50:59 INFO - 'opt_config_files': (), 02:50:59 INFO - 'pip_index': False, 02:50:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:59 INFO - 'cmd': ('bash', 02:50:59 INFO - '-c', 02:50:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:59 INFO - 'enabled': True, 02:50:59 INFO - 'halt_on_failure': False, 02:50:59 INFO - 'name': 'check_screen_resolution'},), 02:50:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:59 INFO - 'cmd': ('bash', 02:50:59 INFO - '-c', 02:50:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:59 INFO - 'enabled': True, 02:50:59 INFO - 'halt_on_failure': False, 02:50:59 INFO - 'name': 'check_screen_resolution'},), 02:50:59 INFO - 'run_cmd_checks_enabled': True, 02:50:59 INFO - 'sps_profile': False, 02:50:59 INFO - 'sps_profile_interval': 0, 02:50:59 INFO - 'suite': 'dromaeojs-e10s', 02:50:59 INFO - 'system_bits': '32', 02:50:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:50:59 INFO - 'title': 't-yosemite-r7-0013', 02:50:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:50:59 INFO - 'use_talos_json': True, 02:50:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:50:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:50:59 INFO - 'work_dir': 'build'} 02:50:59 INFO - ##### 02:50:59 INFO - ##### Running clobber step. 02:50:59 INFO - ##### 02:50:59 INFO - Running pre-action listener: _resource_record_pre_action 02:50:59 INFO - Running main action method: clobber 02:50:59 INFO - rmtree: /builds/slave/test/build 02:50:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:51:00 INFO - Running post-action listener: _resource_record_post_action 02:51:00 INFO - ##### 02:51:00 INFO - ##### Running read-buildbot-config step. 02:51:00 INFO - ##### 02:51:00 INFO - Running pre-action listener: _resource_record_pre_action 02:51:00 INFO - Running main action method: read_buildbot_config 02:51:00 INFO - Using buildbot properties: 02:51:00 INFO - { 02:51:00 INFO - "project": "", 02:51:00 INFO - "product": "firefox", 02:51:00 INFO - "script_repo_revision": "production", 02:51:00 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 02:51:00 INFO - "repository": "", 02:51:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 02:51:00 INFO - "buildid": "20160208164823", 02:51:00 INFO - "pgo_build": "False", 02:51:00 INFO - "basedir": "/builds/slave/test", 02:51:00 INFO - "buildnumber": 355, 02:51:00 INFO - "slavename": "t-yosemite-r7-0013", 02:51:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:51:00 INFO - "platform": "yosemite_r7", 02:51:00 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:51:00 INFO - "branch": "fx-team", 02:51:00 INFO - "repo_path": "integration/fx-team", 02:51:00 INFO - "revision": "49945e5fe79e6cf2b083f56fd49d917ca886db0b", 02:51:00 INFO - "stage_platform": "macosx64", 02:51:00 INFO - "builduid": "30a40c8c361641e58b7426d55eb90c1e", 02:51:00 INFO - "slavebuilddir": "test" 02:51:00 INFO - } 02:51:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:51:00 INFO - Running post-action listener: _resource_record_post_action 02:51:00 INFO - ##### 02:51:00 INFO - ##### Running download-and-extract step. 02:51:00 INFO - ##### 02:51:00 INFO - Running pre-action listener: _resource_record_pre_action 02:51:00 INFO - Running main action method: download_and_extract 02:51:00 INFO - mkdir: /builds/slave/test/build/tests 02:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:00 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:51:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:51:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:51:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:51:01 INFO - Downloaded 1277 bytes. 02:51:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:51:01 INFO - Using the following test package requirements: 02:51:01 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:51:01 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:51:01 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:51:01 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:51:01 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:51:01 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:51:01 INFO - u'jsshell-mac.zip'], 02:51:01 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:51:01 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:51:01 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:51:01 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:51:01 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:51:01 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:51:01 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:51:01 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:51:01 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:51:01 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:51:01 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:51:01 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:51:01 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:01 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:51:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:51:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:51:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:51:02 INFO - Downloaded 17753849 bytes. 02:51:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:51:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:51:05 INFO - Return code: 0 02:51:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:51:05 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')]} 02:51:05 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:51:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:51:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:51:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:51:06 INFO - Downloaded 17753849 bytes. 02:51:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:51:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:51:10 INFO - Return code: 0 02:51:10 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')]} 02:51:10 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:51:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:51:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:51:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:51:11 INFO - Downloaded 10706547 bytes. 02:51:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:51:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:51:11 INFO - Return code: 0 02:51: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')]} 02:51:11 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:51:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:51:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:51:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:51:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 02:51:14 INFO - Downloaded 111836573 bytes. 02:51:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:51:14 INFO - mkdir: /builds/slave/test/properties 02:51:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:51:14 INFO - Writing to file /builds/slave/test/properties/build_url 02:51:14 INFO - Contents: 02:51:14 INFO - build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:51:15 INFO - Running post-action listener: _resource_record_post_action 02:51:15 INFO - Running post-action listener: set_extra_try_arguments 02:51:15 INFO - ##### 02:51:15 INFO - ##### Running populate-webroot step. 02:51:15 INFO - ##### 02:51:15 INFO - Running pre-action listener: _resource_record_pre_action 02:51:15 INFO - Running main action method: populate_webroot 02:51:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:51:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:51:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:51:15 INFO - '--tppagecycles', 02:51:15 INFO - '7'], 02:51:15 INFO - 'tests': ['tsvgm']}}, 02:51:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:51:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:51:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:51:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:51:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:51:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:51:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:15 INFO - 'talos_options': ['--e10s'], 02:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:15 INFO - 'tests': ['damp', 'tps']}, 02:51:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:15 INFO - 'talos_options': ['--e10s'], 02:51:15 INFO - 'tests': ['damp', 'tps']}, 02:51:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:51:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:51:15 INFO - 'other': {'tests': ['a11yr', 02:51:15 INFO - 'ts_paint', 02:51:15 INFO - 'tpaint', 02:51:15 INFO - 'sessionrestore', 02:51:15 INFO - 'sessionrestore_no_auto_restore']}, 02:51:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:51:15 INFO - 'tests': ['a11yr', 02:51:15 INFO - 'ts_paint', 02:51:15 INFO - 'tpaint', 02:51:15 INFO - 'sessionrestore', 02:51:15 INFO - 'sessionrestore_no_auto_restore']}, 02:51:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:51:15 INFO - 'tests': ['a11yr', 02:51:15 INFO - 'ts_paint', 02:51:15 INFO - 'tpaint', 02:51:15 INFO - 'sessionrestore', 02:51:15 INFO - 'sessionrestore_no_auto_restore']}, 02:51:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:51:15 INFO - 'tests': ['a11yr', 02:51:15 INFO - 'ts_paint', 02:51:15 INFO - 'tpaint', 02:51:15 INFO - 'sessionrestore', 02:51:15 INFO - 'sessionrestore_no_auto_restore']}, 02:51:15 INFO - 'other_l64': {'tests': ['a11yr', 02:51:15 INFO - 'ts_paint', 02:51:15 INFO - 'tpaint', 02:51:15 INFO - 'sessionrestore', 02:51:15 INFO - 'sessionrestore_no_auto_restore']}, 02:51:15 INFO - 'other_nol64': {'tests': ['a11yr', 02:51:15 INFO - 'ts_paint', 02:51:15 INFO - 'tpaint', 02:51:15 INFO - 'sessionrestore', 02:51:15 INFO - 'sessionrestore_no_auto_restore']}, 02:51:15 INFO - 'svgr': {'tests': ['tsvgx', 02:51:15 INFO - 'tsvgr_opacity', 02:51:15 INFO - 'tart', 02:51:15 INFO - 'tscrollx', 02:51:15 INFO - 'cart']}, 02:51:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:51:15 INFO - 'tests': ['tsvgx', 02:51:15 INFO - 'tsvgr_opacity', 02:51:15 INFO - 'tart', 02:51:15 INFO - 'tscrollx', 02:51:15 INFO - 'cart']}, 02:51:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:15 INFO - 'tests': ['tp5o']}, 02:51:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:15 INFO - 'talos_options': ['--e10s'], 02:51:15 INFO - 'tests': ['tp5o']}, 02:51:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:15 INFO - 'talos_options': ['--xperf_path', 02:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:15 INFO - 'tests': ['tp5n']}, 02:51:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:15 INFO - 'talos_options': ['--e10s', 02:51:15 INFO - '--xperf_path', 02:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:15 INFO - 'tests': ['tp5n']}}, 02:51:15 INFO - 'talos.zip': {'path': '', 02:51:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:51:15 INFO - Running post-action listener: _resource_record_post_action 02:51:15 INFO - ##### 02:51:15 INFO - ##### Running create-virtualenv step. 02:51:15 INFO - ##### 02:51:15 INFO - Running pre-action listener: _resource_record_pre_action 02:51:15 INFO - Running main action method: create_virtualenv 02:51:15 INFO - Creating virtualenv /builds/slave/test/build/venv 02:51:15 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 02:51:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:51:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:51:15 INFO - Using real prefix '/tools/python27' 02:51:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:51:16 INFO - Installing distribute.............................................................................................................................................................................................done. 02:51:18 INFO - Installing pip.................done. 02:51:18 INFO - Return code: 0 02:51:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:51:18 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')]} 02:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:18 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')]} 02:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:18 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 0x10ff9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f895ad9dda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, '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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:51:18 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 02:51:18 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 02:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:18 INFO - 'HOME': '/Users/cltbld', 02:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:18 INFO - 'LOGNAME': 'cltbld', 02:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:18 INFO - 'MOZ_NO_REMOTE': '1', 02:51:18 INFO - 'NO_EM_RESTART': '1', 02:51:18 INFO - 'PAGER': '/bin/cat', 02:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:18 INFO - 'PWD': '/builds/slave/test', 02:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:18 INFO - 'SHELL': '/bin/bash', 02:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:51:18 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:18 INFO - 'USER': 'cltbld', 02:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:18 INFO - 'XPC_FLAGS': '0x0', 02:51:18 INFO - 'XPC_SERVICE_NAME': '0', 02:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:19 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 02:51:19 INFO - Cleaning up... 02:51:19 INFO - Return code: 0 02:51:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:19 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 0x10ff9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f895ad9dda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, '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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:51:19 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 02:51:19 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 02:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:19 INFO - 'HOME': '/Users/cltbld', 02:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:19 INFO - 'LOGNAME': 'cltbld', 02:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:19 INFO - 'MOZ_NO_REMOTE': '1', 02:51:19 INFO - 'NO_EM_RESTART': '1', 02:51:19 INFO - 'PAGER': '/bin/cat', 02:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:19 INFO - 'PWD': '/builds/slave/test', 02:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:19 INFO - 'SHELL': '/bin/bash', 02:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:51:19 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:19 INFO - 'USER': 'cltbld', 02:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:19 INFO - 'XPC_FLAGS': '0x0', 02:51:19 INFO - 'XPC_SERVICE_NAME': '0', 02:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:19 INFO - Downloading/unpacking psutil>=0.7.1 02:51:19 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 02:51:19 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 02:51:19 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 02:51:19 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 02:51:19 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 02:51:19 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 02:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:22 INFO - Installing collected packages: psutil 02:51:22 INFO - Running setup.py install for psutil 02:51:22 INFO - building 'psutil._psutil_osx' extension 02:51:22 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 02:51:22 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 02:51:22 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 02:51:22 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 02:51:22 INFO - building 'psutil._psutil_posix' extension 02:51:22 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 02:51:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:51:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:51:22 INFO - ^ 02:51:22 INFO - 1 warning generated. 02:51:22 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 02:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:23 INFO - Successfully installed psutil 02:51:23 INFO - Cleaning up... 02:51:23 INFO - Return code: 0 02:51:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:51:23 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')]} 02:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:23 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')]} 02:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:23 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 0x10ff9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f895ad9dda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, '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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:51:23 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 02:51:23 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 02:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:23 INFO - 'HOME': '/Users/cltbld', 02:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:23 INFO - 'LOGNAME': 'cltbld', 02:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:23 INFO - 'MOZ_NO_REMOTE': '1', 02:51:23 INFO - 'NO_EM_RESTART': '1', 02:51:23 INFO - 'PAGER': '/bin/cat', 02:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:23 INFO - 'PWD': '/builds/slave/test', 02:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:23 INFO - 'SHELL': '/bin/bash', 02:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:51:23 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:23 INFO - 'USER': 'cltbld', 02:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:23 INFO - 'XPC_FLAGS': '0x0', 02:51:23 INFO - 'XPC_SERVICE_NAME': '0', 02:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:51:25 INFO - Installing collected packages: mozsystemmonitor 02:51:25 INFO - Running setup.py install for mozsystemmonitor 02:51:25 INFO - Successfully installed mozsystemmonitor 02:51:25 INFO - Cleaning up... 02:51:26 INFO - Return code: 0 02:51:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ff9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f895ad9dda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, '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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:26 INFO - 'HOME': '/Users/cltbld', 02:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:26 INFO - 'LOGNAME': 'cltbld', 02:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:26 INFO - 'MOZ_NO_REMOTE': '1', 02:51:26 INFO - 'NO_EM_RESTART': '1', 02:51:26 INFO - 'PAGER': '/bin/cat', 02:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:26 INFO - 'PWD': '/builds/slave/test', 02:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:26 INFO - 'SHELL': '/bin/bash', 02:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:51:26 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:26 INFO - 'USER': 'cltbld', 02:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:26 INFO - 'XPC_FLAGS': '0x0', 02:51:26 INFO - 'XPC_SERVICE_NAME': '0', 02:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:26 INFO - Downloading/unpacking blobuploader==1.2.4 02:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:28 INFO - Downloading blobuploader-1.2.4.tar.gz 02:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:51:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:51:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:29 INFO - Downloading docopt-0.6.1.tar.gz 02:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:51:29 INFO - Installing collected packages: blobuploader, requests, docopt 02:51:29 INFO - Running setup.py install for blobuploader 02:51:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:51:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:51:29 INFO - Running setup.py install for requests 02:51:30 INFO - Running setup.py install for docopt 02:51:30 INFO - Successfully installed blobuploader requests docopt 02:51:30 INFO - Cleaning up... 02:51:30 INFO - Return code: 0 02:51:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:30 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 0x10ff9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f895ad9dda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, '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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:51:30 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 02:51:30 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 02:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:30 INFO - 'HOME': '/Users/cltbld', 02:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:30 INFO - 'LOGNAME': 'cltbld', 02:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:30 INFO - 'MOZ_NO_REMOTE': '1', 02:51:30 INFO - 'NO_EM_RESTART': '1', 02:51:30 INFO - 'PAGER': '/bin/cat', 02:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:30 INFO - 'PWD': '/builds/slave/test', 02:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:30 INFO - 'SHELL': '/bin/bash', 02:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:51:30 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:30 INFO - 'USER': 'cltbld', 02:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:30 INFO - 'XPC_FLAGS': '0x0', 02:51:30 INFO - 'XPC_SERVICE_NAME': '0', 02:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:30 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-SwUzp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mmWAYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-FrqQ94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-AFogM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-7Q3QU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-4wLug1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-A9WkII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-AplrcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-AW1vVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-lXREBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-727e6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-IvmAhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-aBRgYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Js5MHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-SIODli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-b0YMMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-m2N978-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:51:32 INFO - Running setup.py install for manifestparser 02:51:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:51:32 INFO - Running setup.py install for mozcrash 02:51:33 INFO - Running setup.py install for mozdebug 02:51:33 INFO - Running setup.py install for mozdevice 02:51:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:51:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:51:33 INFO - Running setup.py install for mozfile 02:51:33 INFO - Running setup.py install for mozhttpd 02:51:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:51:33 INFO - Running setup.py install for mozinfo 02:51:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:51:33 INFO - Running setup.py install for mozInstall 02:51:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:51:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:51:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:51:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:51:33 INFO - Running setup.py install for mozleak 02:51:34 INFO - Running setup.py install for mozlog 02:51:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:51:34 INFO - Running setup.py install for moznetwork 02:51:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:51:34 INFO - Running setup.py install for mozprocess 02:51:34 INFO - Running setup.py install for mozprofile 02:51:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:51:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:51:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:51:34 INFO - Running setup.py install for mozrunner 02:51:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:51:34 INFO - Running setup.py install for mozscreenshot 02:51:35 INFO - Running setup.py install for moztest 02:51:35 INFO - Running setup.py install for mozversion 02:51:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:51:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:51:35 INFO - Cleaning up... 02:51:35 INFO - Return code: 0 02:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:35 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')]} 02:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:35 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')]} 02:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:35 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 0x10ff9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f895ad9dda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, '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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:51:35 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 02:51:35 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 02:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:35 INFO - 'HOME': '/Users/cltbld', 02:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:35 INFO - 'LOGNAME': 'cltbld', 02:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:35 INFO - 'MOZ_NO_REMOTE': '1', 02:51:35 INFO - 'NO_EM_RESTART': '1', 02:51:35 INFO - 'PAGER': '/bin/cat', 02:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:35 INFO - 'PWD': '/builds/slave/test', 02:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:35 INFO - 'SHELL': '/bin/bash', 02:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:51:35 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:35 INFO - 'USER': 'cltbld', 02:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:35 INFO - 'XPC_FLAGS': '0x0', 02:51:35 INFO - 'XPC_SERVICE_NAME': '0', 02:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:35 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Jw2emz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:35 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)) 02:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:35 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-6zoa0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 02:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:35 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-P65xh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:35 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)) 02:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:35 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-dUmVHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-bkjVqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-yXfIxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-in4ktx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-_zghIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-_7pcjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Vc6q7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-YU1XJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-4n8VFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-OmVxAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:36 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)) 02:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-1IObRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:37 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)) 02:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-8EfdOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:37 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)) 02:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-NeT8Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:37 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)) 02:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-MtbwIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:37 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)) 02:51:37 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:51:37 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:51:37 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)) 02:51:37 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)) 02:51:37 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)) 02:51:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:51:37 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 02:51:37 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 02:51:37 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 02:51:37 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 02:51:37 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 02:51:37 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 02:51:39 INFO - Downloading blessings-1.6.tar.gz 02:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:51:39 INFO - Installing collected packages: blessings 02:51:39 INFO - Running setup.py install for blessings 02:51:39 INFO - Successfully installed blessings 02:51:39 INFO - Cleaning up... 02:51:40 INFO - Return code: 0 02:51:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:40 INFO - Reading from file tmpfile_stdout 02:51:40 INFO - Current package versions: 02:51:40 INFO - blessings == 1.6 02:51:40 INFO - blobuploader == 1.2.4 02:51:40 INFO - docopt == 0.6.1 02:51:40 INFO - manifestparser == 1.1 02:51:40 INFO - mozInstall == 1.12 02:51:40 INFO - mozcrash == 0.16 02:51:40 INFO - mozdebug == 0.1 02:51:40 INFO - mozdevice == 0.48 02:51:40 INFO - mozfile == 1.2 02:51:40 INFO - mozhttpd == 0.7 02:51:40 INFO - mozinfo == 0.9 02:51:40 INFO - mozleak == 0.1 02:51:40 INFO - mozlog == 3.1 02:51:40 INFO - moznetwork == 0.27 02:51:40 INFO - mozprocess == 0.22 02:51:40 INFO - mozprofile == 0.28 02:51:40 INFO - mozrunner == 6.11 02:51:40 INFO - mozscreenshot == 0.1 02:51:40 INFO - mozsystemmonitor == 0.0 02:51:40 INFO - moztest == 0.7 02:51:40 INFO - mozversion == 1.4 02:51:40 INFO - psutil == 3.1.1 02:51:40 INFO - requests == 1.2.3 02:51:40 INFO - wsgiref == 0.1.2 02:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51: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')]} 02:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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')]} 02:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:40 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 0x10ff9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f895ad9dda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, '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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:51:40 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 02:51:40 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 02:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:40 INFO - 'HOME': '/Users/cltbld', 02:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:40 INFO - 'LOGNAME': 'cltbld', 02:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:40 INFO - 'MOZ_NO_REMOTE': '1', 02:51:40 INFO - 'NO_EM_RESTART': '1', 02:51:40 INFO - 'PAGER': '/bin/cat', 02:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:40 INFO - 'PWD': '/builds/slave/test', 02:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:40 INFO - 'SHELL': '/bin/bash', 02:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:51:40 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:40 INFO - 'USER': 'cltbld', 02:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:40 INFO - 'XPC_FLAGS': '0x0', 02:51:40 INFO - 'XPC_SERVICE_NAME': '0', 02:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:40 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)) 02:51:40 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)) 02:51:40 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)) 02:51:40 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)) 02:51:40 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)) 02:51:40 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)) 02:51:40 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)) 02:51:40 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)) 02:51:40 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)) 02:51:40 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)) 02:51:40 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)) 02:51:40 INFO - Cleaning up... 02:51:40 INFO - Return code: 0 02:51:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:51: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')]} 02:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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')]} 02:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:40 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 0x10ff9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f895ad9dda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, '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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:51:40 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 02:51:40 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 02:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:40 INFO - 'HOME': '/Users/cltbld', 02:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:40 INFO - 'LOGNAME': 'cltbld', 02:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:40 INFO - 'MOZ_NO_REMOTE': '1', 02:51:40 INFO - 'NO_EM_RESTART': '1', 02:51:40 INFO - 'PAGER': '/bin/cat', 02:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:40 INFO - 'PWD': '/builds/slave/test', 02:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:40 INFO - 'SHELL': '/bin/bash', 02:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:51:40 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:40 INFO - 'USER': 'cltbld', 02:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:40 INFO - 'XPC_FLAGS': '0x0', 02:51:40 INFO - 'XPC_SERVICE_NAME': '0', 02:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:40 INFO - Downloading/unpacking jsonschema 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 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 02:51:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:51:43 INFO - Downloading/unpacking functools32 (from jsonschema) 02:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:43 INFO - Downloading functools32-3.2.3-2.tar.gz 02:51:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:51:43 INFO - warning: no files found matching '*.txt' 02:51:43 INFO - no previously-included directories found matching 'build' 02:51:43 INFO - no previously-included directories found matching 'dist' 02:51:43 INFO - no previously-included directories found matching '.git*' 02:51:43 INFO - Installing collected packages: jsonschema, functools32 02:51:43 INFO - Running setup.py install for functools32 02:51:43 INFO - warning: no files found matching '*.txt' 02:51:43 INFO - no previously-included directories found matching 'build' 02:51:43 INFO - no previously-included directories found matching 'dist' 02:51:43 INFO - no previously-included directories found matching '.git*' 02:51:43 INFO - Successfully installed jsonschema functools32 02:51:43 INFO - Cleaning up... 02:51:43 INFO - Return code: 0 02:51:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffa34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f895ad9dda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, '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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 02:51:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:43 INFO - 'HOME': '/Users/cltbld', 02:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:43 INFO - 'LOGNAME': 'cltbld', 02:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:43 INFO - 'MOZ_NO_REMOTE': '1', 02:51:43 INFO - 'NO_EM_RESTART': '1', 02:51:43 INFO - 'PAGER': '/bin/cat', 02:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:43 INFO - 'PWD': '/builds/slave/test', 02:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:43 INFO - 'SHELL': '/bin/bash', 02:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:51:43 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:43 INFO - 'USER': 'cltbld', 02:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:43 INFO - 'XPC_FLAGS': '0x0', 02:51:43 INFO - 'XPC_SERVICE_NAME': '0', 02:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:44 INFO - Downloading/unpacking flake8 02:51:44 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 02:51:44 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 02:51:44 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 02:51:44 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 02:51:44 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 02:51:44 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 02:51:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:51:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:51:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:51:47 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 02:51:47 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 02:51:47 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 02:51:47 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 02:51:47 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 02:51:47 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 02:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:47 INFO - no previously-included directories found matching 'docs/_build' 02:51:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:51:47 INFO - Running setup.py install for pep8 02:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:47 INFO - no previously-included directories found matching 'docs/_build' 02:51:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:51:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:51:47 INFO - Cleaning up... 02:51:48 INFO - Return code: 0 02:51:48 INFO - Running post-action listener: _resource_record_post_action 02:51:48 INFO - Running post-action listener: _start_resource_monitoring 02:51:48 INFO - Starting resource monitoring. 02:51:48 INFO - ##### 02:51:48 INFO - ##### Running install step. 02:51:48 INFO - ##### 02:51:48 INFO - Running pre-action listener: _resource_record_pre_action 02:51:48 INFO - Running main action method: install 02:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:48 INFO - Reading from file tmpfile_stdout 02:51:48 INFO - Detecting whether we're running mozinstall >=1.0... 02:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:51:48 INFO - Reading from file tmpfile_stdout 02:51:48 INFO - Output received: 02:51:48 INFO - Usage: mozinstall [options] installer 02:51:48 INFO - Options: 02:51:48 INFO - -h, --help show this help message and exit 02:51:48 INFO - -d DEST, --destination=DEST 02:51:48 INFO - Directory to install application into. [default: 02:51:48 INFO - "/builds/slave/test"] 02:51:48 INFO - --app=APP Application being installed. [default: firefox] 02:51:48 INFO - mkdir: /builds/slave/test/build/application 02:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:52:22 INFO - Reading from file tmpfile_stdout 02:52:22 INFO - Output received: 02:52:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:52:22 INFO - Running post-action listener: _resource_record_post_action 02:52:22 INFO - ##### 02:52:22 INFO - ##### Running run-tests step. 02:52:22 INFO - ##### 02:52:22 INFO - Running pre-action listener: _resource_record_pre_action 02:52:22 INFO - Running main action method: run_tests 02:52:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:52:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:52:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:52:22 INFO - 2016-02-10 02:52:22.557 screenresolution[2579:22909] starting screenresolution argv=screenresolution get 02:52:22 INFO - 2016-02-10 02:52:22.560 screenresolution[2579:22909] Display 0: 1600x1200x32@60 02:52:22 INFO - 2016-02-10 02:52:22.566 screenresolution[2580:22912] starting screenresolution argv=screenresolution list 02:52:22 INFO - Available Modes on Display 0 02:52:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:52:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:52:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:52:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:52:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:52:22 INFO - Intel Iris: 02:52:22 INFO - Chipset Model: Intel Iris 02:52:22 INFO - Type: GPU 02:52:22 INFO - Bus: Built-In 02:52:22 INFO - VRAM (Dynamic, Max): 1536 MB 02:52:22 INFO - Vendor: Intel (0x8086) 02:52:22 INFO - Device ID: 0x0a2e 02:52:22 INFO - Revision ID: 0x0009 02:52:22 INFO - Displays: 02:52:22 INFO - Display: 02:52:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:52:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:52:22 INFO - Display Serial Number: 1600x1200 60 02:52:22 INFO - Main Display: Yes 02:52:22 INFO - Mirror: Off 02:52:22 INFO - Online: Yes 02:52:22 INFO - Rotation: Supported 02:52:22 INFO - Return code: 0 02:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:52:22 INFO - Python 2.7.3 02:52:22 INFO - Return code: 0 02:52:22 INFO - grabbing minidump binary from tooltool 02:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:22 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 0x10fe40d30>, '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 0x10fc64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe37b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:52:22 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 02:52:22 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 02:52:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:52:22 INFO - Return code: 0 02:52:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:52:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:52:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:52:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:52:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:52:24 INFO - Return code: 0 02:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0iRbGuwWZ/Render', 02:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:24 INFO - 'HOME': '/Users/cltbld', 02:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:24 INFO - 'LOGNAME': 'cltbld', 02:52:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:52:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:24 INFO - 'MOZ_NO_REMOTE': '1', 02:52:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:52:24 INFO - 'NO_EM_RESTART': '1', 02:52:24 INFO - 'PAGER': '/bin/cat', 02:52:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:24 INFO - 'PWD': '/builds/slave/test', 02:52:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:24 INFO - 'SHELL': '/bin/bash', 02:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ffaBFUzQN6/Listeners', 02:52:24 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 02:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:24 INFO - 'USER': 'cltbld', 02:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:24 INFO - 'XPC_FLAGS': '0x0', 02:52:24 INFO - 'XPC_SERVICE_NAME': '0', 02:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:52:24 INFO - mozversion application_buildid: 20160208164823 02:52:24 INFO - mozversion application_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:52:24 INFO - mozversion application_display_name: Nightly 02:52:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:52:24 INFO - mozversion application_name: Firefox 02:52:24 INFO - mozversion application_remotingname: firefox 02:52:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:52:24 INFO - mozversion application_vendor: Mozilla 02:52:24 INFO - mozversion application_version: 47.0a1 02:52:24 INFO - mozversion platform_buildid: 20160208164823 02:52:24 INFO - mozversion platform_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:52:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:52:24 INFO - mozversion platform_version: 47.0a1 02:52:24 INFO - using testdate: 1455101544 02:52:24 INFO - actual date: 1455101544 02:52:24 INFO - starting webserver on 'localhost:51968' 02:52:24 INFO - SUITE-START | Running 2 tests 02:52:24 INFO - TEST-START | dromaeo_css 02:52:24 INFO - operating with platform_type : mac_ 02:52:24 INFO - Initialising browser for dromaeo_css test... 02:52:24 INFO - TEST-INFO | started process 2598 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpPptcZH/profile http://localhost:51968/getInfo.html) 02:52:27 INFO - PROCESS | 2598 | __metrics Screen width/height:1600/1200 02:52:27 INFO - PROCESS | 2598 | colorDepth:24 02:52:27 INFO - PROCESS | 2598 | Browser inner width/height: 1024/689 02:52:27 INFO - PROCESS | 2598 | __metrics 02:52:28 INFO - PROCESS | 2598 | 02:52:28 INFO - PROCESS | 2598 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 02:52:28 INFO - PROCESS | 2598 | 02:52:28 INFO - TEST-INFO | 2598: exit 0 02:52:28 INFO - Browser initialized. 02:52:28 INFO - Running cycle 1/1 for dromaeo_css test... 02:52:28 INFO - TEST-INFO | started process 2602 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpPptcZH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:40 INFO - PROCESS | 2602 | RSS: Main: 258846720 02:52:40 INFO - PROCESS | 2602 | 02:53:30 INFO - PROCESS | 2602 | 1455101610075 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] 02:55:40 INFO - PROCESS | 2602 | Cycle 1(1): loaded http://localhost:51968/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51968/tests/dromaeo/cssquery-ext.html) 02:55:42 INFO - PROCESS | 2602 | RSS: Main: 271749120 02:55:42 INFO - PROCESS | 2602 | 02:58:44 INFO - PROCESS | 2602 | Cycle 1(1): loaded http://localhost:51968/tests/dromaeo/cssquery-ext.html (next: http://localhost:51968/tests/dromaeo/cssquery-jquery.html) 02:58:45 INFO - PROCESS | 2602 | RSS: Main: 282750976 02:58:45 INFO - PROCESS | 2602 | 03:01:46 INFO - PROCESS | 2602 | Cycle 1(1): loaded http://localhost:51968/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51968/tests/dromaeo/cssquery-mootools.html) 03:01:47 INFO - PROCESS | 2602 | RSS: Main: 284622848 03:01:47 INFO - PROCESS | 2602 | 03:04:49 INFO - PROCESS | 2602 | Cycle 1(1): loaded http://localhost:51968/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51968/tests/dromaeo/cssquery-prototype.html) 03:04:49 INFO - PROCESS | 2602 | RSS: Main: 287105024 03:04:49 INFO - PROCESS | 2602 | 03:07:52 INFO - PROCESS | 2602 | Cycle 1(1): loaded http://localhost:51968/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51968/tests/dromaeo/cssquery-yui.html) 03:07:52 INFO - PROCESS | 2602 | RSS: Main: 289566720 03:07:52 INFO - PROCESS | 2602 | 03:10:55 INFO - PROCESS | 2602 | Cycle 1(1): loaded http://localhost:51968/tests/dromaeo/cssquery-yui.html (next: http://localhost:51968/tests/dromaeo/cssquery-dojo.html) 03:10:55 INFO - PROCESS | 2602 | RSS: Main: 291463168 03:10:55 INFO - PROCESS | 2602 | 03:10:55 INFO - PROCESS | 2602 | __start_tp_report 03:10:55 INFO - PROCESS | 2602 | _x_x_mozilla_page_load 03:10:55 INFO - PROCESS | 2602 | _x_x_mozilla_page_load_details 03:10:55 INFO - PROCESS | 2602 | |i|pagename|runs| 03:10:55 INFO - PROCESS | 2602 | |0;dojo.html;2895.8117722348047;3546.46802979553;3568.357695614788;3616.674499295063;3628.0567052566344;5830.504407125394;5878.676672783001;5891.55813314001;5895.764169433223;5913.881722365551;5707.058335374669;5828;5850.151727999438;5939.910901336472;6021.367756385582;4382.882364996922;5258.684478931276;5279.234510995903;5284.4187139414635;5313.601479889005;5286.418493965661;5328.8401347959625;5358.812441564546;5368.62419630626;5377.784888604451;4739.549742774431;4974.303597496335;5257.737113144328;5311.176767601028;5311.973440132774;5240.580753539708;5263.289455923478;5286.127788914824;5332.280142180794;5374.811881584164;5160.329157209539;5249.763760630781;5261.15821468567;5277.973610131925;5322.467753224685;5656.66060036395;5771.220885180489;5779.335376431723;5788.131780232957;5819.563532735062;6202.131701561785;6218.28489723683;6231.283402408736;6243.408985271107;6258.843528911768;6185.381461853779;6222.595531290452;6225.284092329395;6250.031245157008;6289.937100628981;5963.940360596382;6016.699165041818;6022.217111775529;6029.06549484835;6061.363556826558;6219.564630475823;6297.118403423525;6346.524010699216;6366.6180029198395;6374.298827129012;6222.097795819581;6258.530610204253;6275.184226050585;6277.309495955441;6310.242770867525;6247.843803904848;6282.340354262828;6287.465565426898;6291.685415729286;6294.370562943761;4436.12855961949;5661.745221465044;6208.037754148114;6273.215848018997;6313.652749098844;6241.126242326078;6241.563090583706;6260.154879091265;6273.435390814758;6276.246850377984;4917;4999.525045120708;5014.598832093424;5017.874553136201;5038.571721403721;4025.7922623212917;4311.900465381308;4455.331700244989;4459.219636563654;4565.56627120423;4989.827390563215;5871.6183448075735;5875.853103672443;5925.940740592625;5935.436133567304;6170;6236;6312.968435157794;6325.462335701425;6332.335104813928;5882.823515294548;5897.49871260939;5899.115132730125;5943.851403714855;5953.791617293374;5401.405845357008;5453.64551304164;5490.56075513958;5502.2296878437055;5517.889642207214;6276.560640755103;6397.904031439532;6412.839679008062;6481.740730370827;6503.317151699192;6244.188255526752;6292.27638821523;6299.181106456132;6304.211973503312;6307.180066591497;6337.96831015842;6424.164858568356;6456.967715161394;6479.481641468766;6489.480841532761;6254;6274.278457977391;6289.779857704958;6295.842603934938;6310.84222894413;6243.7814676486105;6273.717682704198;6287.905681414874;6293.716782744696;6294.937050629435;6056.485198757979;6150.907736383869;6231.314555398993;6249.718762655601;6255.906161407674;4809.3026511154985;6153.630782153085;6199.597026193283;6230.345813689497;6253.7185826637;6001.699915004319;6070.423309785563;6120.204373431426;6122.785702500391;6142.846428839315;6100.248138957816;6116.26604807426;6117.014657940032;6162.414570615963;6201.348858369806;6149.739303442694;6159.72281247336;6161;6164.815055548341;6201.96899015502 03:10:55 INFO - PROCESS | 2602 | |1;ext.html;470.89169491017054;475.7217028038597;524.2686452398906;543.7553101104502;565.8202647480005;37331.626683733186;37497.25005499895;37631;37747.62252377476;37765.86702398925;38847.223055538874;39370;39382.80308598453;39510.80244598773;39518.81443556698;9177.724668259929;9357.485338306391;9414.858777118314;9428.245740340757;9461.479618620973;9319.673811416602;9536.952315238448;9557.952210238975;9577.090176433228;9634.518274086302;9489.051094890525;9583.472908990003;9590.280728945321;9599.952000240024;9605.37565058269;8127.918720812805;9468.715938521855;9576.47329396883;9588.95205523975;9596.424214547149;9304.8604270936;9344.579493922789;9442.480663563501;9472.573734181979;9519;37942.86171414862;37948.81025594882;38160.473581057006;38297.425538616946;38304.80847595772;3170.2074481379655;3182.554442378069;3356.781809182395;3391.101358140095;3414.453687410027;28413.289667758472;29255.414891702047;29269.56095658567;29346.70653293461;29394.265143371373;2783.846888421136;2812.6624805023325;2827.5758636204528;2870.4976629089824;2972.658144313388;469830;471017;471910;472757;474290;55873.88252235014;62804.05793913095;63412;64740;65869.34130658727;61354.38645613576;61743.382566173765;61837.69081154565;62106;62416.37583624196;15771.05373677583;15793.36826526949;15846.60383490422;16067.598310042109;16089.758653620205;11964.880351196376;12059.879401205875;12246.142770006192;12259.632211033684;12283.385830708428;19870.205191792455;20213.09041093125;20249.493762656053;20287.59424811525;20319.695204571944;7330.706771729071;7390.593517356489;8481.491110533265;8667.783305417415;8708.608112634947;825.2490233887133;980.3333733061587;1104.812181929074;1118.2507719827736;1119.997602146091;30119.397612047636;30312.69687303143;30470;30593.541096883564;30815.691843081284;1019.2661283875598;1069.550788668761;1074.925074925075;1164.6273192578462;1166.7724793665154;14355;14500.85499144995;14510.637234069232;14548.927255363868;14782.778258326134;432832;435508;439906;440819;538651;55933.44066559364;56008.439915601135;56381.71809140928;56455.71772141113;56474.43525564774;1262.0912942681255;1414.151509094535;1421.6374824419706;1432.0763107795415;1451.6806302613409;29003;29131;29137.56293655639;29657.703422965493;29722.405551889275;50166.49833501764;50259.74870125626;50426.24360634667;50567.74716126396;50573;490543;495702;495890;500363;501207;30419.84790076124;32671.34657306888;34166;34176.974690759314;34352.82823585866;42569.36145957875;42913.35629965615;43155.78422107869;43280.78359608182;43785.343219852366;35869;36103.63896361003;36417.45373819342;36594;36659.81670091632;35124.12189695176;35337.82331088328;35349.6353496358;35677;35692.28615427729;35837.64162358343;35958.28083438369;36695.63304366922;36914.44628330631;36939;29599.816007359463;31768.841155794074;32086.67913320837;32155.51766723454;32566.348673025932;24325.148619798223;24723;24784.380390490383;25175;25550.488990220463 03:10:55 INFO - PROCESS | 2602 | |2;jquery.html;311.21107991242206;324.94151052810497;346.71049673522606;352.32002235685115;358.1672611179009;15248.771268430955;18677;19206;19485.415437536896;20743.377698669025;11596.072314214864;11701.648950531477;11789.469473873674;11972.22180558263;19813.405597832087;5187.273781670569;5279.63042587019;5282.102042652758;5282.471752824726;5438.700871452069;4390.670699697535;5275.208718692188;5294.179402192647;5401.7299135043095;5422.48486393792;3936.3898595717565;5753.741081651336;6019.638821670714;6029.336772954972;6038.969805150968;5377.7311134443125;5934.31755348134;5964.850878728045;6003.249593800775;6020.397960203988;5367.329083864517;5388.649737767033;5395.082835917903;5407.891842163174;5408.4050754416985;12438.502459901592;13001.86998130016;13003.82965533097;13018.609441716764;18884.81115188858;2104.2740254612136;2162.1459523488293;2201.8899055047345;2229.1974889039934;2505.8747062646794;7866.7639970800965;9493.762655933588;9517.5717092731;9623.1820295275;9780.217582593446;1700.4813531872774;1782.9821701782946;1814.1654838774048;1836.6877630802796;1848.5378655336167;94825;100090;100179.49910250475;100274;102419;11242.94378528102;11286.943565282121;11296.54813807455;11302.095832333558;11416.885831141748;13392.26342551169;13491;13496.460141594227;13506.459741610226;13527.256000919848;6984.860302793915;8364.247217750431;8396.748097557083;8439.746807595782;8486.490810551386;8498.74503764888;8501.19238672325;8522.786930326667;8578.785530361665;8591.312694984386;3674.761140525857;4371.584699453547;4371.9725864421835;4466.486354069259;4562.58936695699;1832.9533348599657;1856.5637075287298;1929.4308179087202;1944.6110777844488;1944.8055194480721;860.3676297921023;867.9913200868036;912.5756523216736;931.3852857114272;935.242453612576;19070.90464547696;19353.516162095777;19432.611347772967;19508.90245548763;20030.898300593606;817.595290331278;881;943.9197668198143;958.9089036541517;1037.5019990404649;9478.099580539838;10179.9491002546;10259.333143345659;10396;10728.839067413996;575761;581548;586269;587281;587541;115674;120122.3993880025;121046;122985;123626.49174820061;1104.0946423932298;1130.6947124276398;1171.4435643069473;1175.1362748379934;1180.8701042885275;17646.911765441604;17974.910125449813;18021.729674054637;18051.638967220846;18324.083795810424;46504.06991860076;48638.27042594293;49357.506424935294;50037.249441257685;51307.48692513027;65705.34294656992;67349;67731;68087.3191268081;68202;6800.945853392732;7510.737124200627;7547.16981132086;7701.6919323228685;7704.961475192812;9973;11657.300561966309;11848.822267665819;11871.287722736663;12110.273383597012;9560.426374417279;9972.401655900669;10542.894571054192;10590.576376944837;10610.681679549625;10046.196304295785;10060.547275372479;10226.948865255627;10546.998035186645;10589.576416943237;10435;10583.470826458492;10609.363438193424;10693.625723099654;10757.623483178051;7611.65747541373;7777.300042996158;7817.179196184319;7817.921820781947;7823.452358335089;9739.464329461947;10578.15374770032;10758.139348851917;10788.892111078789;10794.946025270137 03:10:55 INFO - PROCESS | 2602 | |3;mootools.html;1457.36604577009;1532.134344095586;1742.2595396956299;1860.525565980674;1868.3740946782827;7769.533827970312;8393.53835539045;8696.304295656348;8849.469031858085;8863.202311791945;6984.685689143988;7065.364117229448;8580.91419085809;8583.914160858389;8601.010883748371;2474.35666726651;2483.788877945368;2487.4900645367657;2502.9374265643414;2521.8739063046864;2141.8714877107345;2521.684789401325;2551.515212109693;2552.34915096651;2569.678790151231;2148.731408573928;2426.575349313863;2485.751424857518;2504.799616030713;2505.649209110726;2158.557495713375;2304.7925686688195;2337.31049340445;2374.893129809163;2448.6327050942323;2478.7025556933104;2479.4297311618247;2481.1936120760643;2484.3789052736815;2490.476999830038;8562.571871406468;8569.914300856974;8611.35414843883;8686.087960764155;8734.650613975433;4500.797464114123;5375.892482150335;5488.835334939959;5497.147942068986;5520.089185284423;3545;3574;3624.3476174288617;3627.2020155565733;3695;885.3713863157166;1019.9286049976505;1031.381171297223;1039.5062345385957;1062.1555863088786;11850.762984740257;11969.700757481045;12039.63881083569;12055.638330850088;12064.974477169451;4919.163742163841;4973.303737476756;4995.075910956412;5057.443681195065;5060.3168572242275;10406.271560990657;10425.895741042492;10441.582336706446;10483.47582620881;10508.264421490576;5478.548184731049;5479.75341109651;5561.6663000220115;5564.165375193753;5577.609567330329;4862.124817532807;4970.956099219205;4997.350344455198;5021.573166280834;5028.17035189197;3852.3451013327804;3878.6897048236074;3913.373860182357;3915.5105611798526;3925.568187499373;1239.8698136695698;1270.5362542672044;1284.2872205925614;1287.6394609509352;1289.664687181321;1101.9559217631365;1108.8780234174235;1136.244397475686;1262.4950019991893;1362.046567402822;7949.403794715419;7982.481138726081;8068.556229407439;8099.757007289791;8333.374996875138;1168.3282112785182;1169.6257197696825;1185.211834130311;1186.5787645385935;1209.776191404593;6264.404881536338;6281.057841323746;6357.237131544151;6362.745490180341;6383.840403989844;10302.175825933908;10585.629502967358;10698.197635177237;10732;10768.300060496043;10176.542055607515;10334.276600637882;10384.065434110966;10594.258401911793;10649.893501065046;8275.54484503346;8314.916850831536;8333.791655208668;8377.748667539861;8394.706185283485;6682.498812588978;7676.808079797826;7867.17394673551;7904.6442910068035;7935.484193527403;9446.480443575669;9526.571304291185;9551.522423878918;9742.659006934724;9764.316497845082;9797.608095676092;9953.601855925683;9969.700908972742;10074.546645400827;10080.344777589433;7021.122359705037;7149.320814522612;7275.599842008741;7436;7446.813829654086;8158.796030099295;8192.139825318256;8198.262156405952;8209.343252539664;8244.969378827647;7552.622368881424;7711.884321735066;7764.495307804975;7775.377969762292;7783.92216077832;7537.133229678438;7580.128285247267;7663.961680191786;7664.923350766421;7675.577843218676;6527.738890444329;7578.3558397534625;7622.047244094489;7659.119201291923;7960.084590271961;6857.828554286183;7028.402585780266;7049.154101507852;7065.752698655522;7066.04608377883;7126.714931402893;7171.533850299714;7180.210176880434;7186.6047367395295;7199.460040497089 03:10:55 INFO - PROCESS | 2602 | |4;prototype.html;288.5570649053703;293.7004255659228;324.1248628702503;335.8052329648804;337.1554256587249;5434.91847622286;6680.064790929274;6832.624205668686;6982.581045137289;7027.613481258535;5536.723163841802;6723.495737819659;6809.625470599115;6853.314668533144;6904.551204171726;5020.7489625518765;5028.120078986181;5028.868504586466;5034.647574669774;5034.748262586874;4880.877978050542;5025.773840177201;5031.3207716958295;5038.193888977764;5057.49425057495;4927.236278376858;4934.25986102084;4952.05910876934;4959.553640172384;4964.404271487427;4145.854895078673;4933.950660493403;4939.950600494021;4946.356973593428;4956.132676781549;3988.8404463821703;4087.4890638670167;4166.958330416687;4172.457580514544;4174.874753757392;6598.5051121165625;6603.372679595431;6607.1410716607015;6617.834554136137;6632.701528431232;5877.9118313225335;5890.911636325459;5910.34986151523;5924.466797988159;5926.674032928187;6573.342665733437;6793.946938224583;7067.964660176666;7361.895715642643;7363.7422690205585;4278.7860606969525;4302.623160588613;4681.782736488538;4685.601723853477;4708.505606911293;6454.2577603575255;7586.279303466162;7801.882971755372;7806.570638614874;7845.529268243867;4632.72203667781;4771.73755443447;4775.570198682135;4776.164171270014;4800.903981920342;4881.511848815161;4890.095332363524;4896.069746748107;4905.87735306613;4907.950920490821;5859.970700146472;5873.295204575478;5884.146798714162;5885.293764748172;5905.734241959122;7400.111986561539;7401;7421.146568144624;7431.925680743123;7445.478816482794;1403.277312184226;1621.9432319868984;1698.346136737365;1698.8471037606676;1703.6081701208543;1069.844872493484;1078.9514471848786;1079.0935614084208;1088.0751361342795;1088.9128869690405;6801.625910574867;6804.931950680529;6808.455323574102;6830.658467076726;6832.282610325844;7686.9231307686205;7707.383409327241;7714.4185441984255;7732.7680169595005;7736.574488403079;5834;6627.939529675229;6803;6808.2170550386345;6830.180378354629;3936.5472970608175;4011.719179657396;4074.0629655179473;4088.8773336799945;4111.588841115865;7976.800579985546;8037.23646253605;8053.959730201312;8069.9596502018285;8083.070446898564;8023.398245131639;8034.718784842503;8050.7923811428755;8059.395545334006;8084.514929104273;7859.4891332063235;8108.5540295283145;8117.863499110129;8124.2688158064875;8130.634121464548;6047.395260473917;6637.933620663732;7758.68965241384;7789.805254868674;7808.336291415066;5980.461758441761;7631.771046868603;7638.770836874903;7667.961660191663;7681.385489160965;6545.181852268466;8091.150429205084;8125.268725814705;8133.633986470742;8148.3073938713505;4818.204996175592;4822.469528351809;4825.710457372569;4826.251930950708;4826.565609095198;7461.515001524884;7688.8462230756195;7699.807504812425;7711.0746710395115;7756.108047574376;7414.703411863681;7418.925810741824;7433.553986760811;7448.292412220831;7497.212792656693;7394.926050739424;7424.96287518559;7437.590932498764;7438.73964411243;7465.925340746523;6326.525510586633;6670.466362691071;7217.170025447141;7231.529950553408;7265.891011634935;6672.199336079701;7402.222766609644;7412.518186317872;7415.1101867776215;7438.479306448497;7068.045813815069;7186.10173728284;7216.3505284524645;7250.347468727839;7264.927350726636 03:10:55 INFO - PROCESS | 2602 | |5;yui.html;634.9555531112821;661.6923130744204;670.9530332876699;690.4407429981718;720.783764870539;13946.302684865741;14592;14766.704665906675;14939.477118300862;16507.257173427195;15190.54428367148;15285.388584456636;15287.770683439758;15304.387824487007;15322.616934576614;833.0586437325828;857.7255278310943;858.6436628799041;865.3034307382554;869.2958703450194;845.5560830563973;853.9837593263996;857.9442336248123;862.2326129744532;866.1857853617611;872.2585802068255;891.1534042659467;906.3519583497798;908.2824568590805;909.1181553892714;877.5831480046991;886.7206829848609;895.5074708910073;901.3285102598606;904.7421484876844;648.8540078482304;670.058567712365;672.5359501943643;676.4824908944661;677.664556044761;12244.142909996304;15076.472323468626;15103.39586416542;15109.54671359861;15141.848581514154;12419.875801242053;12516.812247816199;12771.425285862066;12863.549775757803;12938.223706577635;10144.847827282596;10168.678071850612;10231.437270950095;10285.742856428575;10902.454877256105;3484.860605575774;3486.2853115111343;3505.964940350589;3507.368673638744;3513.9824300878586;72953.63523182404;74416.99999999946;74473.62763186204;74684;75713;9439.386439881386;9471;9780.608775648894;9817.361871478332;10025.749356266006;20521.48696282575;20521.692174617394;20535.4866128348;20571.765694058406;20587.794122058887;7322.1579518356075;7481.21447248042;7548.131964824115;7668.65491052904;7956.721514746956;4095.28332541804;4159.500859896832;4175.352820312856;4178.080822219107;4179.874603761892;3552.8934131976084;3605.7475976681903;3607.260511595117;3618.493410922473;3619.077135330474;654.7951768745531;676.4047638078558;689.5345641691838;700.2157583506404;716.330231233798;547.8000529806592;585.7071464267866;601.5187849720206;610.91141784441;615.3450433561023;8270.751877443687;8272.37957153204;8423.915760842314;8503.957480212559;8544.786380340542;511.55239165729984;591.9492900102352;609.2232403685337;615.5161784300925;615.5752530753765;3819.3698039823676;3921.509811273591;4043.7353299462548;4063.8577649782114;4076.4089207065404;85202.86992825105;91095.54452227829;92980.53509732409;93268.53365733128;93325.5333723327;66404;74593.25406745863;78539;78765;80212;71682.64158679174;75100.12249693801;80586.79119813208;82081.9479513017;82386.58806705927;6722.428593569602;8702.869456958024;8901.777455563662;8905.547523320925;8961.372703910663;37128.07179820526;50305.24542131944;51008.48991510038;51174;51249.7437512825;67270;71373.28626713666;71386;71597.28402715907;72411;10691.984261495145;11409.486573104065;11478.426078695864;11520.654380368602;11693.941530292293;11688.94155529217;11774.882251177378;12046.096542759504;12087.51649934028;12140.392980351124;11592.710182245173;11612.419379030845;11656.941715291368;11789.174757766874;11949.462274197856;10706;10732.678019659423;10756.784864302514;10825;10911.127109831035;10578.141367785642;11226.045786107945;11284.32294062359;11584.015358694269;11738.060955123741;9001.864972025556;9089.773130538564;9469.573869176042;9581;9670.516474176122;9788.021197880154;9824.508774561386;9837.577344121744;9950.701478955643;9962.55168517404 03:10:55 INFO - PROCESS | 2602 | __end_tp_report 03:10:55 INFO - PROCESS | 2602 | __start_cc_report 03:10:55 INFO - PROCESS | 2602 | _x_x_mozilla_cycle_collect,372 03:10:55 INFO - PROCESS | 2602 | __end_cc_report 03:10:55 INFO - PROCESS | 2602 | __startTimestamp1455102655521__endTimestamp 03:10:55 INFO - PROCESS | 2602 | 03:10:55 INFO - PROCESS | 2602 | ------- Summary: start ------- 03:10:55 INFO - PROCESS | 2602 | Number of tests: 6 03:10:55 INFO - PROCESS | 2602 | 03:10:55 INFO - PROCESS | 2602 | [#0] dojo.html Cycles:165 Average:5801.33 Median:6116.27 stddev:675.09 (11.0%) stddev-sans-first:637.53 03:10:55 INFO - PROCESS | 2602 | Values: 2895.8 3546.5 3568.4 3616.7 3628.1 5830.5 5878.7 5891.6 5895.8 5913.9 5707.1 5828.0 5850.2 5939.9 6021.4 4382.9 5258.7 5279.2 5284.4 5313.6 5286.4 5328.8 5358.8 5368.6 5377.8 4739.5 4974.3 5257.7 5311.2 5312.0 5240.6 5263.3 5286.1 5332.3 5374.8 5160.3 5249.8 5261.2 5278.0 5322.5 5656.7 5771.2 5779.3 5788.1 5819.6 6202.1 6218.3 6231.3 6243.4 6258.8 6185.4 6222.6 6225.3 6250.0 6289.9 5963.9 6016.7 6022.2 6029.1 6061.4 6219.6 6297.1 6346.5 6366.6 6374.3 6222.1 6258.5 6275.2 6277.3 6310.2 6247.8 6282.3 6287.5 6291.7 6294.4 4436.1 5661.7 6208.0 6273.2 6313.7 6241.1 6241.6 6260.2 6273.4 6276.2 4917.0 4999.5 5014.6 5017.9 5038.6 4025.8 4311.9 4455.3 4459.2 4565.6 4989.8 5871.6 5875.9 5925.9 5935.4 6170.0 6236.0 6313.0 6325.5 6332.3 5882.8 5897.5 5899.1 5943.9 5953.8 5401.4 5453.6 5490.6 5502.2 5517.9 6276.6 6397.9 6412.8 6481.7 6503.3 6244.2 6292.3 6299.2 6304.2 6307.2 6338.0 6424.2 6457.0 6479.5 6489.5 6254.0 6274.3 6289.8 6295.8 6310.8 6243.8 6273.7 6287.9 6293.7 6294.9 6056.5 6150.9 6231.3 6249.7 6255.9 4809.3 6153.6 6199.6 6230.3 6253.7 6001.7 6070.4 6120.2 6122.8 6142.8 6100.2 6116.3 6117.0 6162.4 6201.3 6149.7 6159.7 6161.0 6164.8 6202.0 03:10:55 INFO - PROCESS | 2602 | 03:10:55 INFO - PROCESS | 2602 | [#1] ext.html Cycles:180 Average:61962.72 Median:37689.31 stddev:126496.99 (335.6%) stddev-sans-first:126767.59 03:10:55 INFO - PROCESS | 2602 | Values: 470.9 475.7 524.3 543.8 565.8 37331.6 37497.3 37631.0 37747.6 37765.9 38847.2 39370.0 39382.8 39510.8 39518.8 9177.7 9357.5 9414.9 9428.2 9461.5 9319.7 9537.0 9558.0 9577.1 9634.5 9489.1 9583.5 9590.3 9600.0 9605.4 8127.9 9468.7 9576.5 9589.0 9596.4 9304.9 9344.6 9442.5 9472.6 9519.0 37942.9 37948.8 38160.5 38297.4 38304.8 3170.2 3182.6 3356.8 3391.1 3414.5 28413.3 29255.4 29269.6 29346.7 29394.3 2783.8 2812.7 2827.6 2870.5 2972.7 469830.0 471017.0 471910.0 472757.0 474290.0 55873.9 62804.1 63412.0 64740.0 65869.3 61354.4 61743.4 61837.7 62106.0 62416.4 15771.1 15793.4 15846.6 16067.6 16089.8 11964.9 12059.9 12246.1 12259.6 12283.4 19870.2 20213.1 20249.5 20287.6 20319.7 7330.7 7390.6 8481.5 8667.8 8708.6 825.2 980.3 1104.8 1118.3 1120.0 30119.4 30312.7 30470.0 30593.5 30815.7 1019.3 1069.6 1074.9 1164.6 1166.8 14355.0 14500.9 14510.6 14548.9 14782.8 432832.0 435508.0 439906.0 440819.0 538651.0 55933.4 56008.4 56381.7 56455.7 56474.4 1262.1 1414.2 1421.6 1432.1 1451.7 29003.0 29131.0 29137.6 29657.7 29722.4 50166.5 50259.7 50426.2 50567.7 50573.0 490543.0 495702.0 495890.0 500363.0 501207.0 30419.8 32671.3 34166.0 34177.0 34352.8 42569.4 42913.4 43155.8 43280.8 43785.3 35869.0 36103.6 36417.5 36594.0 36659.8 35124.1 35337.8 35349.6 35677.0 35692.3 35837.6 35958.3 36695.6 36914.4 36939.0 29599.8 31768.8 32086.7 32155.5 32566.3 24325.1 24723.0 24784.4 25175.0 25550.5 03:10:55 INFO - PROCESS | 2602 | 03:10:55 INFO - PROCESS | 2602 | [#2] jquery.html Cycles:180 Average:32618.39 Median:318.08 stddev:96995.91 (30494.5%) stddev-sans-first:97237.67 03:10:55 INFO - PROCESS | 2602 | Values: 311.2 324.9 346.7 352.3 358.2 15248.8 18677.0 19206.0 19485.4 20743.4 11596.1 11701.6 11789.5 11972.2 19813.4 5187.3 5279.6 5282.1 5282.5 5438.7 4390.7 5275.2 5294.2 5401.7 5422.5 3936.4 5753.7 6019.6 6029.3 6039.0 5377.7 5934.3 5964.9 6003.2 6020.4 5367.3 5388.6 5395.1 5407.9 5408.4 12438.5 13001.9 13003.8 13018.6 18884.8 2104.3 2162.1 2201.9 2229.2 2505.9 7866.8 9493.8 9517.6 9623.2 9780.2 1700.5 1783.0 1814.2 1836.7 1848.5 94825.0 100090.0 100179.5 100274.0 102419.0 11242.9 11286.9 11296.5 11302.1 11416.9 13392.3 13491.0 13496.5 13506.5 13527.3 6984.9 8364.2 8396.7 8439.7 8486.5 8498.7 8501.2 8522.8 8578.8 8591.3 3674.8 4371.6 4372.0 4466.5 4562.6 1833.0 1856.6 1929.4 1944.6 1944.8 860.4 868.0 912.6 931.4 935.2 19070.9 19353.5 19432.6 19508.9 20030.9 817.6 881.0 943.9 958.9 1037.5 9478.1 10179.9 10259.3 10396.0 10728.8 575761.0 581548.0 586269.0 587281.0 587541.0 115674.0 120122.4 121046.0 122985.0 123626.5 1104.1 1130.7 1171.4 1175.1 1180.9 17646.9 17974.9 18021.7 18051.6 18324.1 46504.1 48638.3 49357.5 50037.2 51307.5 65705.3 67349.0 67731.0 68087.3 68202.0 6800.9 7510.7 7547.2 7701.7 7705.0 9973.0 11657.3 11848.8 11871.3 12110.3 9560.4 9972.4 10542.9 10590.6 10610.7 10046.2 10060.5 10226.9 10547.0 10589.6 10435.0 10583.5 10609.4 10693.6 10757.6 7611.7 7777.3 7817.2 7817.9 7823.5 9739.5 10578.2 10758.1 10788.9 10794.9 03:10:55 INFO - PROCESS | 2602 | 03:10:55 INFO - PROCESS | 2602 | [#3] mootools.html Cycles:180 Average:6051.44 Median:5058.88 stddev:3179.13 (62.8%) stddev-sans-first:3169.29 03:10:55 INFO - PROCESS | 2602 | Values: 1457.4 1532.1 1742.3 1860.5 1868.4 7769.5 8393.5 8696.3 8849.5 8863.2 6984.7 7065.4 8580.9 8583.9 8601.0 2474.4 2483.8 2487.5 2502.9 2521.9 2141.9 2521.7 2551.5 2552.3 2569.7 2148.7 2426.6 2485.8 2504.8 2505.6 2158.6 2304.8 2337.3 2374.9 2448.6 2478.7 2479.4 2481.2 2484.4 2490.5 8562.6 8569.9 8611.4 8686.1 8734.7 4500.8 5375.9 5488.8 5497.1 5520.1 3545.0 3574.0 3624.3 3627.2 3695.0 885.4 1019.9 1031.4 1039.5 1062.2 11850.8 11969.7 12039.6 12055.6 12065.0 4919.2 4973.3 4995.1 5057.4 5060.3 10406.3 10425.9 10441.6 10483.5 10508.3 5478.5 5479.8 5561.7 5564.2 5577.6 4862.1 4971.0 4997.4 5021.6 5028.2 3852.3 3878.7 3913.4 3915.5 3925.6 1239.9 1270.5 1284.3 1287.6 1289.7 1102.0 1108.9 1136.2 1262.5 1362.0 7949.4 7982.5 8068.6 8099.8 8333.4 1168.3 1169.6 1185.2 1186.6 1209.8 6264.4 6281.1 6357.2 6362.7 6383.8 10302.2 10585.6 10698.2 10732.0 10768.3 10176.5 10334.3 10384.1 10594.3 10649.9 8275.5 8314.9 8333.8 8377.7 8394.7 6682.5 7676.8 7867.2 7904.6 7935.5 9446.5 9526.6 9551.5 9742.7 9764.3 9797.6 9953.6 9969.7 10074.5 10080.3 7021.1 7149.3 7275.6 7436.0 7446.8 8158.8 8192.1 8198.3 8209.3 8245.0 7552.6 7711.9 7764.5 7775.4 7783.9 7537.1 7580.1 7664.0 7664.9 7675.6 6527.7 7578.4 7622.0 7659.1 7960.1 6857.8 7028.4 7049.2 7065.8 7066.0 7126.7 7171.5 7180.2 7186.6 7199.5 03:10:55 INFO - PROCESS | 2602 | 03:10:55 INFO - PROCESS | 2602 | [#4] prototype.html Cycles:180 Average:5972.82 Median:6654.20 stddev:1956.79 (29.4%) stddev-sans-first:1915.20 03:10:55 INFO - PROCESS | 2602 | Values: 288.6 293.7 324.1 335.8 337.2 5434.9 6680.1 6832.6 6982.6 7027.6 5536.7 6723.5 6809.6 6853.3 6904.6 5020.7 5028.1 5028.9 5034.6 5034.7 4880.9 5025.8 5031.3 5038.2 5057.5 4927.2 4934.3 4952.1 4959.6 4964.4 4145.9 4934.0 4940.0 4946.4 4956.1 3988.8 4087.5 4167.0 4172.5 4174.9 6598.5 6603.4 6607.1 6617.8 6632.7 5877.9 5890.9 5910.3 5924.5 5926.7 6573.3 6793.9 7068.0 7361.9 7363.7 4278.8 4302.6 4681.8 4685.6 4708.5 6454.3 7586.3 7801.9 7806.6 7845.5 4632.7 4771.7 4775.6 4776.2 4800.9 4881.5 4890.1 4896.1 4905.9 4908.0 5860.0 5873.3 5884.1 5885.3 5905.7 7400.1 7401.0 7421.1 7431.9 7445.5 1403.3 1621.9 1698.3 1698.8 1703.6 1069.8 1079.0 1079.1 1088.1 1088.9 6801.6 6804.9 6808.5 6830.7 6832.3 7686.9 7707.4 7714.4 7732.8 7736.6 5834.0 6627.9 6803.0 6808.2 6830.2 3936.5 4011.7 4074.1 4088.9 4111.6 7976.8 8037.2 8054.0 8070.0 8083.1 8023.4 8034.7 8050.8 8059.4 8084.5 7859.5 8108.6 8117.9 8124.3 8130.6 6047.4 6637.9 7758.7 7789.8 7808.3 5980.5 7631.8 7638.8 7668.0 7681.4 6545.2 8091.2 8125.3 8133.6 8148.3 4818.2 4822.5 4825.7 4826.3 4826.6 7461.5 7688.8 7699.8 7711.1 7756.1 7414.7 7418.9 7433.6 7448.3 7497.2 7394.9 7425.0 7437.6 7438.7 7465.9 6326.5 6670.5 7217.2 7231.5 7265.9 6672.2 7402.2 7412.5 7415.1 7438.5 7068.0 7186.1 7216.4 7250.3 7264.9 03:10:55 INFO - PROCESS | 2602 | 03:10:55 INFO - PROCESS | 2602 | [#5] yui.html Cycles:180 Average:18318.58 Median:625.27 stddev:25689.55 (4108.6%) stddev-sans-first:25727.30 03:10:55 INFO - PROCESS | 2602 | Values: 635.0 661.7 671.0 690.4 720.8 13946.3 14592.0 14766.7 14939.5 16507.3 15190.5 15285.4 15287.8 15304.4 15322.6 833.1 857.7 858.6 865.3 869.3 845.6 854.0 857.9 862.2 866.2 872.3 891.2 906.4 908.3 909.1 877.6 886.7 895.5 901.3 904.7 648.9 670.1 672.5 676.5 677.7 12244.1 15076.5 15103.4 15109.5 15141.8 12419.9 12516.8 12771.4 12863.5 12938.2 10144.8 10168.7 10231.4 10285.7 10902.5 3484.9 3486.3 3506.0 3507.4 3514.0 72953.6 74417.0 74473.6 74684.0 75713.0 9439.4 9471.0 9780.6 9817.4 10025.7 20521.5 20521.7 20535.5 20571.8 20587.8 7322.2 7481.2 7548.1 7668.7 7956.7 4095.3 4159.5 4175.4 4178.1 4179.9 3552.9 3605.7 3607.3 3618.5 3619.1 654.8 676.4 689.5 700.2 716.3 547.8 585.7 601.5 610.9 615.3 8270.8 8272.4 8423.9 8504.0 8544.8 511.6 591.9 609.2 615.5 615.6 3819.4 3921.5 4043.7 4063.9 4076.4 85202.9 91095.5 92980.5 93268.5 93325.5 66404.0 74593.3 78539.0 78765.0 80212.0 71682.6 75100.1 80586.8 82081.9 82386.6 6722.4 8702.9 8901.8 8905.5 8961.4 37128.1 50305.2 51008.5 51174.0 51249.7 67270.0 71373.3 71386.0 71597.3 72411.0 10692.0 11409.5 11478.4 11520.7 11693.9 11688.9 11774.9 12046.1 12087.5 12140.4 11592.7 11612.4 11656.9 11789.2 11949.5 10706.0 10732.7 10756.8 10825.0 10911.1 10578.1 11226.0 11284.3 11584.0 11738.1 9001.9 9089.8 9469.6 9581.0 9670.5 9788.0 9824.5 9837.6 9950.7 9962.6 03:10:55 INFO - PROCESS | 2602 | -------- Summary: end -------- 03:10:55 INFO - PROCESS | 2602 | 03:10:56 INFO - TEST-INFO | 2602: exit 0 03:10:56 INFO - TEST-OK | dromaeo_css | took 1111263ms 03:10:56 INFO - TEST-START | kraken 03:10:56 INFO - operating with platform_type : mac_ 03:10:56 INFO - Initialising browser for kraken test... 03:10:56 INFO - TEST-INFO | started process 2609 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpeMaXK0/profile http://localhost:51968/getInfo.html) 03:10:58 INFO - PROCESS | 2609 | __metrics Screen width/height:1600/1200 03:10:58 INFO - PROCESS | 2609 | colorDepth:24 03:10:58 INFO - PROCESS | 2609 | Browser inner width/height: 1024/689 03:10:58 INFO - PROCESS | 2609 | __metrics 03:10:59 INFO - TEST-INFO | 2609: exit 0 03:10:59 INFO - Browser initialized. 03:10:59 INFO - Running cycle 1/1 for kraken test... 03:10:59 INFO - TEST-INFO | started process 2612 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpeMaXK0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:11 INFO - PROCESS | 2612 | RSS: Main: 257953792 03:11:11 INFO - PROCESS | 2612 | 03:11:14 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51968/tests/kraken/driver.html?testName=audio-beat-detection) 03:11:15 INFO - PROCESS | 2612 | RSS: Main: 269582336 03:11:15 INFO - PROCESS | 2612 | 03:11:17 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51968/tests/kraken/driver.html?testName=audio-dft) 03:11:18 INFO - PROCESS | 2612 | RSS: Main: 279044096 03:11:18 INFO - PROCESS | 2612 | 03:11:21 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51968/tests/kraken/driver.html?testName=audio-fft) 03:11:22 INFO - PROCESS | 2612 | RSS: Main: 281600000 03:11:22 INFO - PROCESS | 2612 | 03:11:24 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51968/tests/kraken/driver.html?testName=audio-oscillator) 03:11:24 INFO - PROCESS | 2612 | RSS: Main: 283537408 03:11:24 INFO - PROCESS | 2612 | 03:11:27 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51968/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:11:27 INFO - PROCESS | 2612 | RSS: Main: 283992064 03:11:27 INFO - PROCESS | 2612 | 03:11:30 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51968/tests/kraken/driver.html?testName=imaging-darkroom) 03:11:31 INFO - PROCESS | 2612 | RSS: Main: 284307456 03:11:31 INFO - PROCESS | 2612 | 03:11:34 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51968/tests/kraken/driver.html?testName=imaging-desaturate) 03:11:34 INFO - PROCESS | 2612 | RSS: Main: 285515776 03:11:34 INFO - PROCESS | 2612 | 03:11:37 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51968/tests/kraken/driver.html?testName=json-parse-financial) 03:11:38 INFO - PROCESS | 2612 | RSS: Main: 285986816 03:11:38 INFO - PROCESS | 2612 | 03:11:39 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51968/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:11:40 INFO - PROCESS | 2612 | RSS: Main: 285679616 03:11:40 INFO - PROCESS | 2612 | 03:11:42 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51968/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:11:42 INFO - PROCESS | 2612 | RSS: Main: 285409280 03:11:42 INFO - PROCESS | 2612 | 03:11:44 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51968/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:11:45 INFO - PROCESS | 2612 | RSS: Main: 285548544 03:11:45 INFO - PROCESS | 2612 | 03:11:48 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:11:48 INFO - PROCESS | 2612 | RSS: Main: 284647424 03:11:48 INFO - PROCESS | 2612 | 03:11:51 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:11:51 INFO - PROCESS | 2612 | RSS: Main: 286576640 03:11:51 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | Cycle 1(1): loaded http://localhost:51968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51968/tests/kraken/driver.html?testName=ai-astar) 03:11:53 INFO - PROCESS | 2612 | RSS: Main: 286781440 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | __start_tp_report 03:11:53 INFO - PROCESS | 2612 | _x_x_mozilla_page_load 03:11:53 INFO - PROCESS | 2612 | _x_x_mozilla_page_load_details 03:11:53 INFO - PROCESS | 2612 | |i|pagename|runs| 03:11:53 INFO - PROCESS | 2612 | |0;ai-astar;115;109;115;115;116;128;117;115;115;114 03:11:53 INFO - PROCESS | 2612 | |1;audio-beat-detection;149;124;143;161;158;172;143;122;154;135 03:11:53 INFO - PROCESS | 2612 | |2;audio-dft;198;202;201;208;220;232;266;197;198;202 03:11:53 INFO - PROCESS | 2612 | |3;audio-fft;55;71;68;76;136;58;46;66;78;143 03:11:53 INFO - PROCESS | 2612 | |4;audio-oscillator;85;88;128;79;79;83;118;115;116;131 03:11:53 INFO - PROCESS | 2612 | |5;imaging-gaussian-blur;87;94;90;98;89;94;88;92;74;140 03:11:53 INFO - PROCESS | 2612 | |6;imaging-darkroom;97;103;101;96;131;103;108;139;152;112 03:11:53 INFO - PROCESS | 2612 | |7;imaging-desaturate;92;96;92;97;129;92;92;93;117;117 03:11:53 INFO - PROCESS | 2612 | |8;json-parse-financial;57;56;56;56;55;57;58;63;53;55 03:11:53 INFO - PROCESS | 2612 | |9;json-stringify-tinderbox;65;65;65;76;73;75;71;67;67;68 03:11:53 INFO - PROCESS | 2612 | |10;stanford-crypto-aes;85;84;84;86;87;83;85;85;86;83 03:11:53 INFO - PROCESS | 2612 | |11;stanford-crypto-ccm;129;120;150;135;132;123;139;135;127;123 03:11:53 INFO - PROCESS | 2612 | |12;stanford-crypto-pbkdf2;126;148;141;136;141;143;143;156;141;122 03:11:53 INFO - PROCESS | 2612 | |13;stanford-crypto-sha256-iterative;69;67;71;68;69;66;67;66;70;69 03:11:53 INFO - PROCESS | 2612 | __end_tp_report 03:11:53 INFO - PROCESS | 2612 | __start_cc_report 03:11:53 INFO - PROCESS | 2612 | _x_x_mozilla_cycle_collect,922 03:11:53 INFO - PROCESS | 2612 | __end_cc_report 03:11:53 INFO - PROCESS | 2612 | __startTimestamp1455102713726__endTimestamp 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | ------- Summary: start ------- 03:11:53 INFO - PROCESS | 2612 | Number of tests: 14 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.00 stddev:4.75 (4.1%) stddev-sans-first:5.02 03:11:53 INFO - PROCESS | 2612 | Values: 115.0 109.0 115.0 115.0 116.0 128.0 117.0 115.0 115.0 114.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:151.50 stddev:16.04 (10.6%) stddev-sans-first:16.98 03:11:53 INFO - PROCESS | 2612 | Values: 149.0 124.0 143.0 161.0 158.0 172.0 143.0 122.0 154.0 135.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#2] audio-dft Cycles:10 Average:212.40 Median:205.00 stddev:21.94 (10.7%) stddev-sans-first:22.64 03:11:53 INFO - PROCESS | 2612 | Values: 198.0 202.0 201.0 208.0 220.0 232.0 266.0 197.0 198.0 202.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#3] audio-fft Cycles:10 Average:79.70 Median:67.00 stddev:33.02 (49.3%) stddev-sans-first:33.79 03:11:53 INFO - PROCESS | 2612 | Values: 55.0 71.0 68.0 76.0 136.0 58.0 46.0 66.0 78.0 143.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:79.00 stddev:21.19 (26.8%) stddev-sans-first:21.54 03:11:53 INFO - PROCESS | 2612 | Values: 85.0 88.0 128.0 79.0 79.0 83.0 118.0 115.0 116.0 131.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:91.00 stddev:17.19 (18.9%) stddev-sans-first:18.01 03:11:53 INFO - PROCESS | 2612 | Values: 87.0 94.0 90.0 98.0 89.0 94.0 88.0 92.0 74.0 140.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#6] imaging-darkroom Cycles:10 Average:114.20 Median:135.00 stddev:19.50 (14.4%) stddev-sans-first:19.66 03:11:53 INFO - PROCESS | 2612 | Values: 97.0 103.0 101.0 96.0 131.0 103.0 108.0 139.0 152.0 112.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#7] imaging-desaturate Cycles:10 Average:101.70 Median:92.00 stddev:13.82 (15.0%) stddev-sans-first:14.21 03:11:53 INFO - PROCESS | 2612 | Values: 92.0 96.0 92.0 97.0 129.0 92.0 92.0 93.0 117.0 117.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:2.63 (4.7%) stddev-sans-first:2.79 03:11:53 INFO - PROCESS | 2612 | Values: 57.0 56.0 56.0 56.0 55.0 57.0 58.0 63.0 53.0 55.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:4.24 (6.1%) stddev-sans-first:4.21 03:11:53 INFO - PROCESS | 2612 | Values: 65.0 65.0 65.0 76.0 73.0 75.0 71.0 67.0 67.0 68.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:1.32 (1.5%) stddev-sans-first:1.39 03:11:53 INFO - PROCESS | 2612 | Values: 85.0 84.0 84.0 86.0 87.0 83.0 85.0 85.0 86.0 83.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:133.50 stddev:8.98 (6.7%) stddev-sans-first:9.49 03:11:53 INFO - PROCESS | 2612 | Values: 129.0 120.0 150.0 135.0 132.0 123.0 139.0 135.0 127.0 123.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.70 Median:142.00 stddev:9.87 (6.9%) stddev-sans-first:9.13 03:11:53 INFO - PROCESS | 2612 | Values: 126.0 148.0 141.0 136.0 141.0 143.0 143.0 156.0 141.0 122.0 03:11:53 INFO - PROCESS | 2612 | 03:11:53 INFO - PROCESS | 2612 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.69 (2.4%) stddev-sans-first:1.76 03:11:53 INFO - PROCESS | 2612 | Values: 69.0 67.0 71.0 68.0 69.0 66.0 67.0 66.0 70.0 69.0 03:11:53 INFO - PROCESS | 2612 | -------- Summary: end -------- 03:11:53 INFO - PROCESS | 2612 | 03:11:54 INFO - TEST-INFO | 2612: exit 0 03:11:54 INFO - TEST-OK | kraken | took 58352ms 03:11:54 INFO - SUITE-END | took 1169s 03:11:54 INFO - Completed test suite (00:19:30) 03:11:54 INFO - Working with test: dromaeo_css 03:11:54 INFO - Generating results file: dromaeo_css 03:11:54 INFO - Working with test: kraken 03:11:54 INFO - Generating results file: kraken 03:11:54 INFO - javascript benchmark 03:11:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:11:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 03:11:54 INFO - process_Request line: dromaeo_css 7504.41 graph.html#tests=[[72,64,61]] 03:11:54 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:11:54 INFO - process_Request line: kraken 1516.60 graph.html#tests=[[232,64,61]] 03:11:54 INFO - RETURN: dromaeo_css: 7504.41 03:11:54 INFO - RETURN: kraken: 1516.60 03:11:54 INFO - javascript benchmark 03:11:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2895.8117722348047, 3546.46802979553, 3568.357695614788, 3616.674499295063, 3628.0567052566344, 5830.504407125394, 5878.676672783001, 5891.55813314001, 5895.764169433223, 5913.881722365551, 5707.058335374669, 5828.0, 5850.151727999438, 5939.910901336472, 6021.367756385582, 4382.882364996922, 5258.684478931276, 5279.234510995903, 5284.4187139414635, 5313.601479889005, 5286.418493965661, 5328.8401347959625, 5358.812441564546, 5368.62419630626, 5377.784888604451, 4739.549742774431, 4974.303597496335, 5257.737113144328, 5311.176767601028, 5311.973440132774, 5240.580753539708, 5263.289455923478, 5286.127788914824, 5332.280142180794, 5374.811881584164, 5160.329157209539, 5249.763760630781, 5261.15821468567, 5277.973610131925, 5322.467753224685, 5656.66060036395, 5771.220885180489, 5779.335376431723, 5788.131780232957, 5819.563532735062, 6202.131701561785, 6218.28489723683, 6231.283402408736, 6243.408985271107, 6258.843528911768, 6185.381461853779, 6222.595531290452, 6225.284092329395, 6250.031245157008, 6289.937100628981, 5963.940360596382, 6016.699165041818, 6022.217111775529, 6029.06549484835, 6061.363556826558, 6219.564630475823, 6297.118403423525, 6346.524010699216, 6366.6180029198395, 6374.298827129012, 6222.097795819581, 6258.530610204253, 6275.184226050585, 6277.309495955441, 6310.242770867525, 6247.843803904848, 6282.340354262828, 6287.465565426898, 6291.685415729286, 6294.370562943761, 4436.12855961949, 5661.745221465044, 6208.037754148114, 6273.215848018997, 6313.652749098844, 6241.126242326078, 6241.563090583706, 6260.154879091265, 6273.435390814758, 6276.246850377984, 4917.0, 4999.525045120708, 5014.598832093424, 5017.874553136201, 5038.571721403721, 4025.7922623212917, 4311.900465381308, 4455.331700244989, 4459.219636563654, 4565.56627120423, 4989.827390563215, 5871.6183448075735, 5875.853103672443, 5925.940740592625, 5935.436133567304, 6170.0, 6236.0, 6312.968435157794, 6325.462335701425, 6332.335104813928, 5882.823515294548, 5897.49871260939, 5899.115132730125, 5943.851403714855, 5953.791617293374, 5401.405845357008, 5453.64551304164, 5490.56075513958, 5502.2296878437055, 5517.889642207214, 6276.560640755103, 6397.904031439532, 6412.839679008062, 6481.740730370827, 6503.317151699192, 6244.188255526752, 6292.27638821523, 6299.181106456132, 6304.211973503312, 6307.180066591497, 6337.96831015842, 6424.164858568356, 6456.967715161394, 6479.481641468766, 6489.480841532761, 6254.0, 6274.278457977391, 6289.779857704958, 6295.842603934938, 6310.84222894413, 6243.7814676486105, 6273.717682704198, 6287.905681414874, 6293.716782744696, 6294.937050629435, 6056.485198757979, 6150.907736383869, 6231.314555398993, 6249.718762655601, 6255.906161407674, 4809.3026511154985, 6153.630782153085, 6199.597026193283, 6230.345813689497, 6253.7185826637, 6001.699915004319, 6070.423309785563, 6120.204373431426, 6122.785702500391, 6142.846428839315, 6100.248138957816, 6116.26604807426, 6117.014657940032, 6162.414570615963, 6201.348858369806, 6149.739303442694, 6159.72281247336, 6161.0, 6164.815055548341, 6201.96899015502], "unit": "score", "name": "dojo.html", "value": 5759.069221052856}, {"lowerIsBetter": false, "replicates": [470.89169491017054, 475.7217028038597, 524.2686452398906, 543.7553101104502, 565.8202647480005, 37331.626683733186, 37497.25005499895, 37631.0, 37747.62252377476, 37765.86702398925, 38847.223055538874, 39370.0, 39382.80308598453, 39510.80244598773, 39518.81443556698, 9177.724668259929, 9357.485338306391, 9414.858777118314, 9428.245740340757, 9461.479618620973, 9319.673811416602, 9536.952315238448, 9557.952210238975, 9577.090176433228, 9634.518274086302, 9489.051094890525, 9583.472908990003, 9590.280728945321, 9599.952000240024, 9605.37565058269, 8127.918720812805, 9468.715938521855, 9576.47329396883, 9588.95205523975, 9596.424214547149, 9304.8604270936, 9344.579493922789, 9442.480663563501, 9472.573734181979, 9519.0, 37942.86171414862, 37948.81025594882, 38160.473581057006, 38297.425538616946, 38304.80847595772, 3170.2074481379655, 3182.554442378069, 3356.781809182395, 3391.101358140095, 3414.453687410027, 28413.289667758472, 29255.414891702047, 29269.56095658567, 29346.70653293461, 29394.265143371373, 2783.846888421136, 2812.6624805023325, 2827.5758636204528, 2870.4976629089824, 2972.658144313388, 469830.0, 471017.0, 471910.0, 472757.0, 474290.0, 55873.88252235014, 62804.05793913095, 63412.0, 64740.0, 65869.34130658727, 61354.38645613576, 61743.382566173765, 61837.69081154565, 62106.0, 62416.37583624196, 15771.05373677583, 15793.36826526949, 15846.60383490422, 16067.598310042109, 16089.758653620205, 11964.880351196376, 12059.879401205875, 12246.142770006192, 12259.632211033684, 12283.385830708428, 19870.205191792455, 20213.09041093125, 20249.493762656053, 20287.59424811525, 20319.695204571944, 7330.706771729071, 7390.593517356489, 8481.491110533265, 8667.783305417415, 8708.608112634947, 825.2490233887133, 980.3333733061587, 1104.812181929074, 1118.2507719827736, 1119.997602146091, 30119.397612047636, 30312.69687303143, 30470.0, 30593.541096883564, 30815.691843081284, 1019.2661283875598, 1069.550788668761, 1074.925074925075, 1164.6273192578462, 1166.7724793665154, 14355.0, 14500.85499144995, 14510.637234069232, 14548.927255363868, 14782.778258326134, 432832.0, 435508.0, 439906.0, 440819.0, 538651.0, 55933.44066559364, 56008.439915601135, 56381.71809140928, 56455.71772141113, 56474.43525564774, 1262.0912942681255, 1414.151509094535, 1421.6374824419706, 1432.0763107795415, 1451.6806302613409, 29003.0, 29131.0, 29137.56293655639, 29657.703422965493, 29722.405551889275, 50166.49833501764, 50259.74870125626, 50426.24360634667, 50567.74716126396, 50573.0, 490543.0, 495702.0, 495890.0, 500363.0, 501207.0, 30419.84790076124, 32671.34657306888, 34166.0, 34176.974690759314, 34352.82823585866, 42569.36145957875, 42913.35629965615, 43155.78422107869, 43280.78359608182, 43785.343219852366, 35869.0, 36103.63896361003, 36417.45373819342, 36594.0, 36659.81670091632, 35124.12189695176, 35337.82331088328, 35349.6353496358, 35677.0, 35692.28615427729, 35837.64162358343, 35958.28083438369, 36695.63304366922, 36914.44628330631, 36939.0, 29599.816007359463, 31768.841155794074, 32086.67913320837, 32155.51766723454, 32566.348673025932, 24325.148619798223, 24723.0, 24784.380390490383, 25175.0, 25550.488990220463], "unit": "score", "name": "ext.html", "value": 19430.312640882337}, {"lowerIsBetter": false, "replicates": [311.21107991242206, 324.94151052810497, 346.71049673522606, 352.32002235685115, 358.1672611179009, 15248.771268430955, 18677.0, 19206.0, 19485.415437536896, 20743.377698669025, 11596.072314214864, 11701.648950531477, 11789.469473873674, 11972.22180558263, 19813.405597832087, 5187.273781670569, 5279.63042587019, 5282.102042652758, 5282.471752824726, 5438.700871452069, 4390.670699697535, 5275.208718692188, 5294.179402192647, 5401.7299135043095, 5422.48486393792, 3936.3898595717565, 5753.741081651336, 6019.638821670714, 6029.336772954972, 6038.969805150968, 5377.7311134443125, 5934.31755348134, 5964.850878728045, 6003.249593800775, 6020.397960203988, 5367.329083864517, 5388.649737767033, 5395.082835917903, 5407.891842163174, 5408.4050754416985, 12438.502459901592, 13001.86998130016, 13003.82965533097, 13018.609441716764, 18884.81115188858, 2104.2740254612136, 2162.1459523488293, 2201.8899055047345, 2229.1974889039934, 2505.8747062646794, 7866.7639970800965, 9493.762655933588, 9517.5717092731, 9623.1820295275, 9780.217582593446, 1700.4813531872774, 1782.9821701782946, 1814.1654838774048, 1836.6877630802796, 1848.5378655336167, 94825.0, 100090.0, 100179.49910250475, 100274.0, 102419.0, 11242.94378528102, 11286.943565282121, 11296.54813807455, 11302.095832333558, 11416.885831141748, 13392.26342551169, 13491.0, 13496.460141594227, 13506.459741610226, 13527.256000919848, 6984.860302793915, 8364.247217750431, 8396.748097557083, 8439.746807595782, 8486.490810551386, 8498.74503764888, 8501.19238672325, 8522.786930326667, 8578.785530361665, 8591.312694984386, 3674.761140525857, 4371.584699453547, 4371.9725864421835, 4466.486354069259, 4562.58936695699, 1832.9533348599657, 1856.5637075287298, 1929.4308179087202, 1944.6110777844488, 1944.8055194480721, 860.3676297921023, 867.9913200868036, 912.5756523216736, 931.3852857114272, 935.242453612576, 19070.90464547696, 19353.516162095777, 19432.611347772967, 19508.90245548763, 20030.898300593606, 817.595290331278, 881.0, 943.9197668198143, 958.9089036541517, 1037.5019990404649, 9478.099580539838, 10179.9491002546, 10259.333143345659, 10396.0, 10728.839067413996, 575761.0, 581548.0, 586269.0, 587281.0, 587541.0, 115674.0, 120122.3993880025, 121046.0, 122985.0, 123626.49174820061, 1104.0946423932298, 1130.6947124276398, 1171.4435643069473, 1175.1362748379934, 1180.8701042885275, 17646.911765441604, 17974.910125449813, 18021.729674054637, 18051.638967220846, 18324.083795810424, 46504.06991860076, 48638.27042594293, 49357.506424935294, 50037.249441257685, 51307.48692513027, 65705.34294656992, 67349.0, 67731.0, 68087.3191268081, 68202.0, 6800.945853392732, 7510.737124200627, 7547.16981132086, 7701.6919323228685, 7704.961475192812, 9973.0, 11657.300561966309, 11848.822267665819, 11871.287722736663, 12110.273383597012, 9560.426374417279, 9972.401655900669, 10542.894571054192, 10590.576376944837, 10610.681679549625, 10046.196304295785, 10060.547275372479, 10226.948865255627, 10546.998035186645, 10589.576416943237, 10435.0, 10583.470826458492, 10609.363438193424, 10693.625723099654, 10757.623483178051, 7611.65747541373, 7777.300042996158, 7817.179196184319, 7817.921820781947, 7823.452358335089, 9739.464329461947, 10578.15374770032, 10758.139348851917, 10788.892111078789, 10794.946025270137], "unit": "score", "name": "jquery.html", "value": 8836.508888386768}, {"lowerIsBetter": false, "replicates": [1457.36604577009, 1532.134344095586, 1742.2595396956299, 1860.525565980674, 1868.3740946782827, 7769.533827970312, 8393.53835539045, 8696.304295656348, 8849.469031858085, 8863.202311791945, 6984.685689143988, 7065.364117229448, 8580.91419085809, 8583.914160858389, 8601.010883748371, 2474.35666726651, 2483.788877945368, 2487.4900645367657, 2502.9374265643414, 2521.8739063046864, 2141.8714877107345, 2521.684789401325, 2551.515212109693, 2552.34915096651, 2569.678790151231, 2148.731408573928, 2426.575349313863, 2485.751424857518, 2504.799616030713, 2505.649209110726, 2158.557495713375, 2304.7925686688195, 2337.31049340445, 2374.893129809163, 2448.6327050942323, 2478.7025556933104, 2479.4297311618247, 2481.1936120760643, 2484.3789052736815, 2490.476999830038, 8562.571871406468, 8569.914300856974, 8611.35414843883, 8686.087960764155, 8734.650613975433, 4500.797464114123, 5375.892482150335, 5488.835334939959, 5497.147942068986, 5520.089185284423, 3545.0, 3574.0, 3624.3476174288617, 3627.2020155565733, 3695.0, 885.3713863157166, 1019.9286049976505, 1031.381171297223, 1039.5062345385957, 1062.1555863088786, 11850.762984740257, 11969.700757481045, 12039.63881083569, 12055.638330850088, 12064.974477169451, 4919.163742163841, 4973.303737476756, 4995.075910956412, 5057.443681195065, 5060.3168572242275, 10406.271560990657, 10425.895741042492, 10441.582336706446, 10483.47582620881, 10508.264421490576, 5478.548184731049, 5479.75341109651, 5561.6663000220115, 5564.165375193753, 5577.609567330329, 4862.124817532807, 4970.956099219205, 4997.350344455198, 5021.573166280834, 5028.17035189197, 3852.3451013327804, 3878.6897048236074, 3913.373860182357, 3915.5105611798526, 3925.568187499373, 1239.8698136695698, 1270.5362542672044, 1284.2872205925614, 1287.6394609509352, 1289.664687181321, 1101.9559217631365, 1108.8780234174235, 1136.244397475686, 1262.4950019991893, 1362.046567402822, 7949.403794715419, 7982.481138726081, 8068.556229407439, 8099.757007289791, 8333.374996875138, 1168.3282112785182, 1169.6257197696825, 1185.211834130311, 1186.5787645385935, 1209.776191404593, 6264.404881536338, 6281.057841323746, 6357.237131544151, 6362.745490180341, 6383.840403989844, 10302.175825933908, 10585.629502967358, 10698.197635177237, 10732.0, 10768.300060496043, 10176.542055607515, 10334.276600637882, 10384.065434110966, 10594.258401911793, 10649.893501065046, 8275.54484503346, 8314.916850831536, 8333.791655208668, 8377.748667539861, 8394.706185283485, 6682.498812588978, 7676.808079797826, 7867.17394673551, 7904.6442910068035, 7935.484193527403, 9446.480443575669, 9526.571304291185, 9551.522423878918, 9742.659006934724, 9764.316497845082, 9797.608095676092, 9953.601855925683, 9969.700908972742, 10074.546645400827, 10080.344777589433, 7021.122359705037, 7149.320814522612, 7275.599842008741, 7436.0, 7446.813829654086, 8158.796030099295, 8192.139825318256, 8198.262156405952, 8209.343252539664, 8244.969378827647, 7552.622368881424, 7711.884321735066, 7764.495307804975, 7775.377969762292, 7783.92216077832, 7537.133229678438, 7580.128285247267, 7663.961680191786, 7664.923350766421, 7675.577843218676, 6527.738890444329, 7578.3558397534625, 7622.047244094489, 7659.119201291923, 7960.084590271961, 6857.828554286183, 7028.402585780266, 7049.154101507852, 7065.752698655522, 7066.04608377883, 7126.714931402893, 7171.533850299714, 7180.210176880434, 7186.6047367395295, 7199.460040497089], "unit": "score", "name": "mootools.html", "value": 4933.84482322862}, {"lowerIsBetter": false, "replicates": [288.5570649053703, 293.7004255659228, 324.1248628702503, 335.8052329648804, 337.1554256587249, 5434.91847622286, 6680.064790929274, 6832.624205668686, 6982.581045137289, 7027.613481258535, 5536.723163841802, 6723.495737819659, 6809.625470599115, 6853.314668533144, 6904.551204171726, 5020.7489625518765, 5028.120078986181, 5028.868504586466, 5034.647574669774, 5034.748262586874, 4880.877978050542, 5025.773840177201, 5031.3207716958295, 5038.193888977764, 5057.49425057495, 4927.236278376858, 4934.25986102084, 4952.05910876934, 4959.553640172384, 4964.404271487427, 4145.854895078673, 4933.950660493403, 4939.950600494021, 4946.356973593428, 4956.132676781549, 3988.8404463821703, 4087.4890638670167, 4166.958330416687, 4172.457580514544, 4174.874753757392, 6598.5051121165625, 6603.372679595431, 6607.1410716607015, 6617.834554136137, 6632.701528431232, 5877.9118313225335, 5890.911636325459, 5910.34986151523, 5924.466797988159, 5926.674032928187, 6573.342665733437, 6793.946938224583, 7067.964660176666, 7361.895715642643, 7363.7422690205585, 4278.7860606969525, 4302.623160588613, 4681.782736488538, 4685.601723853477, 4708.505606911293, 6454.2577603575255, 7586.279303466162, 7801.882971755372, 7806.570638614874, 7845.529268243867, 4632.72203667781, 4771.73755443447, 4775.570198682135, 4776.164171270014, 4800.903981920342, 4881.511848815161, 4890.095332363524, 4896.069746748107, 4905.87735306613, 4907.950920490821, 5859.970700146472, 5873.295204575478, 5884.146798714162, 5885.293764748172, 5905.734241959122, 7400.111986561539, 7401.0, 7421.146568144624, 7431.925680743123, 7445.478816482794, 1403.277312184226, 1621.9432319868984, 1698.346136737365, 1698.8471037606676, 1703.6081701208543, 1069.844872493484, 1078.9514471848786, 1079.0935614084208, 1088.0751361342795, 1088.9128869690405, 6801.625910574867, 6804.931950680529, 6808.455323574102, 6830.658467076726, 6832.282610325844, 7686.9231307686205, 7707.383409327241, 7714.4185441984255, 7732.7680169595005, 7736.574488403079, 5834.0, 6627.939529675229, 6803.0, 6808.2170550386345, 6830.180378354629, 3936.5472970608175, 4011.719179657396, 4074.0629655179473, 4088.8773336799945, 4111.588841115865, 7976.800579985546, 8037.23646253605, 8053.959730201312, 8069.9596502018285, 8083.070446898564, 8023.398245131639, 8034.718784842503, 8050.7923811428755, 8059.395545334006, 8084.514929104273, 7859.4891332063235, 8108.5540295283145, 8117.863499110129, 8124.2688158064875, 8130.634121464548, 6047.395260473917, 6637.933620663732, 7758.68965241384, 7789.805254868674, 7808.336291415066, 5980.461758441761, 7631.771046868603, 7638.770836874903, 7667.961660191663, 7681.385489160965, 6545.181852268466, 8091.150429205084, 8125.268725814705, 8133.633986470742, 8148.3073938713505, 4818.204996175592, 4822.469528351809, 4825.710457372569, 4826.251930950708, 4826.565609095198, 7461.515001524884, 7688.8462230756195, 7699.807504812425, 7711.0746710395115, 7756.108047574376, 7414.703411863681, 7418.925810741824, 7433.553986760811, 7448.292412220831, 7497.212792656693, 7394.926050739424, 7424.96287518559, 7437.590932498764, 7438.73964411243, 7465.925340746523, 6326.525510586633, 6670.466362691071, 7217.170025447141, 7231.529950553408, 7265.891011634935, 6672.199336079701, 7402.222766609644, 7412.518186317872, 7415.1101867776215, 7438.479306448497, 7068.045813815069, 7186.10173728284, 7216.3505284524645, 7250.347468727839, 7264.927350726636], "unit": "score", "name": "prototype.html", "value": 5308.248175013214}, {"lowerIsBetter": false, "replicates": [634.9555531112821, 661.6923130744204, 670.9530332876699, 690.4407429981718, 720.783764870539, 13946.302684865741, 14592.0, 14766.704665906675, 14939.477118300862, 16507.257173427195, 15190.54428367148, 15285.388584456636, 15287.770683439758, 15304.387824487007, 15322.616934576614, 833.0586437325828, 857.7255278310943, 858.6436628799041, 865.3034307382554, 869.2958703450194, 845.5560830563973, 853.9837593263996, 857.9442336248123, 862.2326129744532, 866.1857853617611, 872.2585802068255, 891.1534042659467, 906.3519583497798, 908.2824568590805, 909.1181553892714, 877.5831480046991, 886.7206829848609, 895.5074708910073, 901.3285102598606, 904.7421484876844, 648.8540078482304, 670.058567712365, 672.5359501943643, 676.4824908944661, 677.664556044761, 12244.142909996304, 15076.472323468626, 15103.39586416542, 15109.54671359861, 15141.848581514154, 12419.875801242053, 12516.812247816199, 12771.425285862066, 12863.549775757803, 12938.223706577635, 10144.847827282596, 10168.678071850612, 10231.437270950095, 10285.742856428575, 10902.454877256105, 3484.860605575774, 3486.2853115111343, 3505.964940350589, 3507.368673638744, 3513.9824300878586, 72953.63523182404, 74416.99999999946, 74473.62763186204, 74684.0, 75713.0, 9439.386439881386, 9471.0, 9780.608775648894, 9817.361871478332, 10025.749356266006, 20521.48696282575, 20521.692174617394, 20535.4866128348, 20571.765694058406, 20587.794122058887, 7322.1579518356075, 7481.21447248042, 7548.131964824115, 7668.65491052904, 7956.721514746956, 4095.28332541804, 4159.500859896832, 4175.352820312856, 4178.080822219107, 4179.874603761892, 3552.8934131976084, 3605.7475976681903, 3607.260511595117, 3618.493410922473, 3619.077135330474, 654.7951768745531, 676.4047638078558, 689.5345641691838, 700.2157583506404, 716.330231233798, 547.8000529806592, 585.7071464267866, 601.5187849720206, 610.91141784441, 615.3450433561023, 8270.751877443687, 8272.37957153204, 8423.915760842314, 8503.957480212559, 8544.786380340542, 511.55239165729984, 591.9492900102352, 609.2232403685337, 615.5161784300925, 615.5752530753765, 3819.3698039823676, 3921.509811273591, 4043.7353299462548, 4063.8577649782114, 4076.4089207065404, 85202.86992825105, 91095.54452227829, 92980.53509732409, 93268.53365733128, 93325.5333723327, 66404.0, 74593.25406745863, 78539.0, 78765.0, 80212.0, 71682.64158679174, 75100.12249693801, 80586.79119813208, 82081.9479513017, 82386.58806705927, 6722.428593569602, 8702.869456958024, 8901.777455563662, 8905.547523320925, 8961.372703910663, 37128.07179820526, 50305.24542131944, 51008.48991510038, 51174.0, 51249.7437512825, 67270.0, 71373.28626713666, 71386.0, 71597.28402715907, 72411.0, 10691.984261495145, 11409.486573104065, 11478.426078695864, 11520.654380368602, 11693.941530292293, 11688.94155529217, 11774.882251177378, 12046.096542759504, 12087.51649934028, 12140.392980351124, 11592.710182245173, 11612.419379030845, 11656.941715291368, 11789.174757766874, 11949.462274197856, 10706.0, 10732.678019659423, 10756.784864302514, 10825.0, 10911.127109831035, 10578.141367785642, 11226.045786107945, 11284.32294062359, 11584.015358694269, 11738.060955123741, 9001.864972025556, 9089.773130538564, 9469.573869176042, 9581.0, 9670.516474176122, 9788.021197880154, 9824.508774561386, 9837.577344121744, 9950.701478955643, 9962.55168517404], "unit": "score", "name": "yui.html", "value": 6896.339265934242}], "name": "dromaeo_css", "value": 7504.413721593668}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 115.0, 115.0, 116.0, 128.0, 117.0, 115.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.9}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 143.0, 161.0, 158.0, 172.0, 143.0, 122.0, 154.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [198.0, 202.0, 201.0, 208.0, 220.0, 232.0, 266.0, 197.0, 198.0, 202.0], "unit": "score", "name": "audio-dft", "value": 212.4}, {"lowerIsBetter": true, "replicates": [55.0, 71.0, 68.0, 76.0, 136.0, 58.0, 46.0, 66.0, 78.0, 143.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 128.0, 79.0, 79.0, 83.0, 118.0, 115.0, 116.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 102.2}, {"lowerIsBetter": true, "replicates": [87.0, 94.0, 90.0, 98.0, 89.0, 94.0, 88.0, 92.0, 74.0, 140.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.6}, {"lowerIsBetter": true, "replicates": [97.0, 103.0, 101.0, 96.0, 131.0, 103.0, 108.0, 139.0, 152.0, 112.0], "unit": "score", "name": "imaging-darkroom", "value": 114.2}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 92.0, 97.0, 129.0, 92.0, 92.0, 93.0, 117.0, 117.0], "unit": "score", "name": "imaging-desaturate", "value": 101.7}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 55.0, 57.0, 58.0, 63.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 76.0, 73.0, 75.0, 71.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 84.0, 86.0, 87.0, 83.0, 85.0, 85.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [129.0, 120.0, 150.0, 135.0, 132.0, 123.0, 139.0, 135.0, 127.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.3}, {"lowerIsBetter": true, "replicates": [126.0, 148.0, 141.0, 136.0, 141.0, 143.0, 143.0, 156.0, 141.0, 122.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.7}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 71.0, 68.0, 69.0, 66.0, 67.0, 66.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1516.6000000000001}]} 03:11:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1516.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7504.41"}}} 03:11:55 INFO - Return code: 0 03:11:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:11:55 INFO - # TBPL SUCCESS # 03:11:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:11:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:11:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:11:55 INFO - 2016-02-10 03:11:55.134 screenresolution[2617:25557] starting screenresolution argv=screenresolution get 03:11:55 INFO - 2016-02-10 03:11:55.137 screenresolution[2617:25557] Display 0: 1600x1200x32@60 03:11:55 INFO - 2016-02-10 03:11:55.143 screenresolution[2618:25560] starting screenresolution argv=screenresolution list 03:11:55 INFO - Available Modes on Display 0 03:11:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:11:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:11:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:11:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:11:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:11:55 INFO - Intel Iris: 03:11:55 INFO - Chipset Model: Intel Iris 03:11:55 INFO - Type: GPU 03:11:55 INFO - Bus: Built-In 03:11:55 INFO - VRAM (Dynamic, Max): 1536 MB 03:11:55 INFO - Vendor: Intel (0x8086) 03:11:55 INFO - Device ID: 0x0a2e 03:11:55 INFO - Revision ID: 0x0009 03:11:55 INFO - Displays: 03:11:55 INFO - Display: 03:11:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:11:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:11:55 INFO - Display Serial Number: 1600x1200 60 03:11:55 INFO - Main Display: Yes 03:11:55 INFO - Mirror: Off 03:11:55 INFO - Online: Yes 03:11:55 INFO - Rotation: Supported 03:11:55 INFO - Return code: 0 03:11:55 INFO - Running post-action listener: _resource_record_post_action 03:11:55 INFO - Running post-run listener: _resource_record_post_run 03:11:56 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 970752; Write bytes: 714332160; Read time: 12; Write time: 2205 03:11:56 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399327744; Write bytes: 393291776; Read time: 29836; Write time: 777 03:11:56 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 970752; Write bytes: 305356800; Read time: 12; Write time: 1390 03:11:56 INFO - Running post-run listener: _upload_blobber_files 03:11:56 INFO - Blob upload gear active. 03:11:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:11:56 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 03:11:56 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'] 03:11:56 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 03:11:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:58 INFO - (blobuploader) - INFO - Done attempting. 03:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:11:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:59 INFO - (blobuploader) - INFO - Done attempting. 03:11:59 INFO - (blobuploader) - INFO - Iteration through files over. 03:11:59 INFO - Return code: 0 03:11:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:11:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:11:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3df5e81b6a1b8cb16d0c6568272a1bdc168359f149f890f617ded02d8844115c7a23e4a98a62ca9d110d46af35b95f33650494fa7eed3720156b84b9e0ef5fbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4047d9981d51a1d07c86af74d52ebe6c5ceea23d72ea8cb4422151b5f6e878210031dc72591da07b6fdee4d7379aa0d0cab5b158436b003f95efd16fbdce7515"} 03:11:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:11:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:11:59 INFO - Contents: 03:11:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3df5e81b6a1b8cb16d0c6568272a1bdc168359f149f890f617ded02d8844115c7a23e4a98a62ca9d110d46af35b95f33650494fa7eed3720156b84b9e0ef5fbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4047d9981d51a1d07c86af74d52ebe6c5ceea23d72ea8cb4422151b5f6e878210031dc72591da07b6fdee4d7379aa0d0cab5b158436b003f95efd16fbdce7515"} 03:11:59 INFO - Running post-run listener: copy_logs_to_upload_dir 03:11:59 INFO - Copying logs to upload dir... 03:11:59 INFO - mkdir: /builds/slave/test/build/upload/logs 03:11:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.830311 ========= master_lag: 1.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-02-10 03:12:00.244328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:12:00.245418) ========= 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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3df5e81b6a1b8cb16d0c6568272a1bdc168359f149f890f617ded02d8844115c7a23e4a98a62ca9d110d46af35b95f33650494fa7eed3720156b84b9e0ef5fbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4047d9981d51a1d07c86af74d52ebe6c5ceea23d72ea8cb4422151b5f6e878210031dc72591da07b6fdee4d7379aa0d0cab5b158436b003f95efd16fbdce7515"} build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3df5e81b6a1b8cb16d0c6568272a1bdc168359f149f890f617ded02d8844115c7a23e4a98a62ca9d110d46af35b95f33650494fa7eed3720156b84b9e0ef5fbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4047d9981d51a1d07c86af74d52ebe6c5ceea23d72ea8cb4422151b5f6e878210031dc72591da07b6fdee4d7379aa0d0cab5b158436b003f95efd16fbdce7515"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:12:00.301618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:12:00.301919) ========= 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.B0iRbGuwWZ/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.ffaBFUzQN6/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005104 ========= master_lag: 0.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:12:00.615822) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-10 03:12:00.616100) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-10 03:12:03.313455) ========= ========= Total master_lag: 1.66 =========