builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0132 starttime: 1455101446.96 results: success (0) buildid: 20160208164823 builduid: 30a40c8c361641e58b7426d55eb90c1e revision: 49945e5fe79e6cf2b083f56fd49d917ca886db0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:46.957836) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:46.958379) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:46.958710) ========= 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.2AqqNJz1DG/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.v0AD30VDOc/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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.005445 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:46.982659) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:46.983072) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:46.998917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:46.999388) ========= 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.2AqqNJz1DG/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.v0AD30VDOc/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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.005607 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:47.048428) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:47.048774) ========= 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:47.049234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:47.049549) ========= 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.2AqqNJz1DG/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.v0AD30VDOc/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-02-10 02:50:47 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101410 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:47.166645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:47.167058) ========= 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.2AqqNJz1DG/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.v0AD30VDOc/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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.019916 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:47.216658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 02:50:47.217336) ========= 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.2AqqNJz1DG/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.v0AD30VDOc/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:47,292 truncating revision to first 12 chars 2016-02-10 02:50:47,292 Setting DEBUG logging. 2016-02-10 02:50:47,292 attempt 1/10 2016-02-10 02:50:47,292 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:48,461 unpacking tar archive at: fx-team-49945e5fe79e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.416247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 02:50:48.650996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:48.651683) ========= 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.2AqqNJz1DG/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.v0AD30VDOc/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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.005211 script_repo_revision: '49945e5fe79e6cf2b083f56fd49d917ca886db0b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:48.702766) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:48.703190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:50:48.715841) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-10 02:50:48.716181) ========= /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.2AqqNJz1DG/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.v0AD30VDOc/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:48 INFO - MultiFileLogger online at 20160210 02:50:48 in /builds/slave/test 02:50:48 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:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:50:48 INFO - {'append_to_log': False, 02:50:48 INFO - 'base_work_dir': '/builds/slave/test', 02:50:48 INFO - 'blob_upload_branch': 'Fx-Team', 02:50:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:50:48 INFO - 'branch': 'Fx-Team', 02:50:48 INFO - 'buildbot_json_path': 'buildprops.json', 02:50:48 INFO - 'config_files': ('talos/mac_config.py',), 02:50:48 INFO - 'default_actions': ('clobber', 02:50:48 INFO - 'read-buildbot-config', 02:50:48 INFO - 'download-and-extract', 02:50:48 INFO - 'populate-webroot', 02:50:48 INFO - 'create-virtualenv', 02:50:48 INFO - 'install', 02:50:48 INFO - 'run-tests'), 02:50:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:50:48 INFO - 'download_minidump_stackwalk': True, 02:50:48 INFO - 'download_symbols': 'ondemand', 02:50:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:50:48 INFO - 'tooltool.py': '/tools/tooltool.py', 02:50:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:50:48 INFO - '/tools/misc-python/virtualenv.py')}, 02:50:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:50:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:50:48 INFO - 'installer_path': 'installer.exe', 02:50:48 INFO - 'log_level': 'info', 02:50:48 INFO - 'log_name': 'talos', 02:50:48 INFO - 'log_to_console': True, 02:50:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:50:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:50:48 INFO - 'opt_config_files': (), 02:50:48 INFO - 'pip_index': False, 02:50:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:48 INFO - 'cmd': ('bash', 02:50:48 INFO - '-c', 02:50:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:48 INFO - 'enabled': True, 02:50:48 INFO - 'halt_on_failure': False, 02:50:48 INFO - 'name': 'check_screen_resolution'},), 02:50:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:48 INFO - 'cmd': ('bash', 02:50:48 INFO - '-c', 02:50:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:48 INFO - 'enabled': True, 02:50:48 INFO - 'halt_on_failure': False, 02:50:48 INFO - 'name': 'check_screen_resolution'},), 02:50:48 INFO - 'run_cmd_checks_enabled': True, 02:50:48 INFO - 'sps_profile': False, 02:50:48 INFO - 'sps_profile_interval': 0, 02:50:48 INFO - 'suite': 'dromaeojs-e10s', 02:50:48 INFO - 'system_bits': '32', 02:50:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:50:48 INFO - 'title': 't-yosemite-r7-0132', 02:50:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:50:48 INFO - 'use_talos_json': True, 02:50:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:50:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:50:48 INFO - 'work_dir': 'build'} 02:50:48 INFO - ##### 02:50:48 INFO - ##### Running clobber step. 02:50:48 INFO - ##### 02:50:48 INFO - Running pre-action listener: _resource_record_pre_action 02:50:48 INFO - Running main action method: clobber 02:50:48 INFO - rmtree: /builds/slave/test/build 02:50:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:50:50 INFO - Running post-action listener: _resource_record_post_action 02:50:50 INFO - ##### 02:50:50 INFO - ##### Running read-buildbot-config step. 02:50:50 INFO - ##### 02:50:50 INFO - Running pre-action listener: _resource_record_pre_action 02:50:50 INFO - Running main action method: read_buildbot_config 02:50:50 INFO - Using buildbot properties: 02:50:50 INFO - { 02:50:50 INFO - "project": "", 02:50:50 INFO - "product": "firefox", 02:50:50 INFO - "script_repo_revision": "production", 02:50:50 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 02:50:50 INFO - "repository": "", 02:50:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 02:50:50 INFO - "buildid": "20160208164823", 02:50:50 INFO - "pgo_build": "False", 02:50:50 INFO - "basedir": "/builds/slave/test", 02:50:50 INFO - "buildnumber": 418, 02:50:50 INFO - "slavename": "t-yosemite-r7-0132", 02:50:50 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:50:50 INFO - "platform": "yosemite_r7", 02:50:50 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:50:50 INFO - "branch": "fx-team", 02:50:50 INFO - "repo_path": "integration/fx-team", 02:50:50 INFO - "revision": "49945e5fe79e6cf2b083f56fd49d917ca886db0b", 02:50:50 INFO - "stage_platform": "macosx64", 02:50:50 INFO - "builduid": "30a40c8c361641e58b7426d55eb90c1e", 02:50:50 INFO - "slavebuilddir": "test" 02:50:50 INFO - } 02:50:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:50:50 INFO - Running post-action listener: _resource_record_post_action 02:50:50 INFO - ##### 02:50:50 INFO - ##### Running download-and-extract step. 02:50:50 INFO - ##### 02:50:50 INFO - Running pre-action listener: _resource_record_pre_action 02:50:50 INFO - Running main action method: download_and_extract 02:50:50 INFO - mkdir: /builds/slave/test/build/tests 02:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:50 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:50:50 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:50:50 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:50:51 INFO - Downloaded 1277 bytes. 02:50:51 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:50:51 INFO - Using the following test package requirements: 02:50:51 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:50:51 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:51 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:50:51 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:51 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:50:51 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:51 INFO - u'jsshell-mac.zip'], 02:50:51 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:51 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:50:51 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:50:51 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:51 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:50:51 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:51 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:50:51 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:51 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:50:51 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:50:51 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:50:51 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:50:51 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:51 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:50:51 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:50:51 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:50:51 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:50:51 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:50:52 INFO - Downloaded 17753849 bytes. 02:50:52 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:50:52 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:50:55 INFO - Return code: 0 02:50:55 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:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:56 INFO - Downloaded 17753849 bytes. 02:50:56 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:50:56 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:00 INFO - Return code: 0 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/firefox-47.0a1.en-US.mac.talos.tests.zip 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/firefox-47.0a1.en-US.mac.talos.tests.zip 02:51:00 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:00 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:00 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:01 INFO - Downloaded 10706547 bytes. 02:51:01 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:01 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:01 INFO - Return code: 0 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.dmg 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.dmg 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.dmg 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.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:51:01 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:04 INFO - Downloaded 111836573 bytes. 02:51:04 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:04 INFO - mkdir: /builds/slave/test/properties 02:51:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:51:04 INFO - Writing to file /builds/slave/test/properties/build_url 02:51:04 INFO - Contents: 02:51:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:51:05 INFO - Running post-action listener: _resource_record_post_action 02:51:05 INFO - Running post-action listener: set_extra_try_arguments 02:51:05 INFO - ##### 02:51:05 INFO - ##### Running populate-webroot step. 02:51:05 INFO - ##### 02:51:05 INFO - Running pre-action listener: _resource_record_pre_action 02:51:05 INFO - Running main action method: populate_webroot 02:51:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:51:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:51:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:51:05 INFO - '--tppagecycles', 02:51:05 INFO - '7'], 02:51:05 INFO - 'tests': ['tsvgm']}}, 02:51:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:51:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:51:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:51:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:51:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:51:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:51:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:05 INFO - 'talos_options': ['--e10s'], 02:51:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:05 INFO - 'tests': ['damp', 'tps']}, 02:51:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:05 INFO - 'talos_options': ['--e10s'], 02:51:05 INFO - 'tests': ['damp', 'tps']}, 02:51:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:51:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:51:05 INFO - 'other': {'tests': ['a11yr', 02:51:05 INFO - 'ts_paint', 02:51:05 INFO - 'tpaint', 02:51:05 INFO - 'sessionrestore', 02:51:05 INFO - 'sessionrestore_no_auto_restore']}, 02:51:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:51:05 INFO - 'tests': ['a11yr', 02:51:05 INFO - 'ts_paint', 02:51:05 INFO - 'tpaint', 02:51:05 INFO - 'sessionrestore', 02:51:05 INFO - 'sessionrestore_no_auto_restore']}, 02:51:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:51:05 INFO - 'tests': ['a11yr', 02:51:05 INFO - 'ts_paint', 02:51:05 INFO - 'tpaint', 02:51:05 INFO - 'sessionrestore', 02:51:05 INFO - 'sessionrestore_no_auto_restore']}, 02:51:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:51:05 INFO - 'tests': ['a11yr', 02:51:05 INFO - 'ts_paint', 02:51:05 INFO - 'tpaint', 02:51:05 INFO - 'sessionrestore', 02:51:05 INFO - 'sessionrestore_no_auto_restore']}, 02:51:05 INFO - 'other_l64': {'tests': ['a11yr', 02:51:05 INFO - 'ts_paint', 02:51:05 INFO - 'tpaint', 02:51:05 INFO - 'sessionrestore', 02:51:05 INFO - 'sessionrestore_no_auto_restore']}, 02:51:05 INFO - 'other_nol64': {'tests': ['a11yr', 02:51:05 INFO - 'ts_paint', 02:51:05 INFO - 'tpaint', 02:51:05 INFO - 'sessionrestore', 02:51:05 INFO - 'sessionrestore_no_auto_restore']}, 02:51:05 INFO - 'svgr': {'tests': ['tsvgx', 02:51:05 INFO - 'tsvgr_opacity', 02:51:05 INFO - 'tart', 02:51:05 INFO - 'tscrollx', 02:51:05 INFO - 'cart']}, 02:51:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:51:05 INFO - 'tests': ['tsvgx', 02:51:05 INFO - 'tsvgr_opacity', 02:51:05 INFO - 'tart', 02:51:05 INFO - 'tscrollx', 02:51:05 INFO - 'cart']}, 02:51:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:05 INFO - 'tests': ['tp5o']}, 02:51:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:05 INFO - 'talos_options': ['--e10s'], 02:51:05 INFO - 'tests': ['tp5o']}, 02:51:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:05 INFO - 'talos_options': ['--xperf_path', 02:51:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:05 INFO - 'tests': ['tp5n']}, 02:51:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:05 INFO - 'talos_options': ['--e10s', 02:51:05 INFO - '--xperf_path', 02:51:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:05 INFO - 'tests': ['tp5n']}}, 02:51:05 INFO - 'talos.zip': {'path': '', 02:51:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:51:05 INFO - Running post-action listener: _resource_record_post_action 02:51:05 INFO - ##### 02:51:05 INFO - ##### Running create-virtualenv step. 02:51:05 INFO - ##### 02:51:05 INFO - Running pre-action listener: _resource_record_pre_action 02:51:05 INFO - Running main action method: create_virtualenv 02:51:05 INFO - Creating virtualenv /builds/slave/test/build/venv 02:51:05 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:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:51:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:51:05 INFO - Using real prefix '/tools/python27' 02:51:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:51:06 INFO - Installing distribute.............................................................................................................................................................................................done. 02:51:09 INFO - Installing pip.................done. 02:51:09 INFO - Return code: 0 02:51:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:51:09 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:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:09 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:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:09 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 0x10d381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3884c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0a3d94630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, '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.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:09 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:09 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:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/Render', 02:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:09 INFO - 'HOME': '/Users/cltbld', 02:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:09 INFO - 'LOGNAME': 'cltbld', 02:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:09 INFO - 'MOZ_NO_REMOTE': '1', 02:51:09 INFO - 'NO_EM_RESTART': '1', 02:51:09 INFO - 'PAGER': '/bin/cat', 02:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:09 INFO - 'PWD': '/builds/slave/test', 02:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:09 INFO - 'SHELL': '/bin/bash', 02:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v0AD30VDOc/Listeners', 02:51:09 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 02:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:09 INFO - 'USER': 'cltbld', 02:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:09 INFO - 'XPC_FLAGS': '0x0', 02:51:09 INFO - 'XPC_SERVICE_NAME': '0', 02:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:09 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:09 INFO - Cleaning up... 02:51:09 INFO - Return code: 0 02:51:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:51:09 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:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:09 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:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:09 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 0x10d381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3884c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0a3d94630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, '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.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:09 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:09 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:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/Render', 02:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:09 INFO - 'HOME': '/Users/cltbld', 02:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:09 INFO - 'LOGNAME': 'cltbld', 02:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:09 INFO - 'MOZ_NO_REMOTE': '1', 02:51:09 INFO - 'NO_EM_RESTART': '1', 02:51:09 INFO - 'PAGER': '/bin/cat', 02:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:09 INFO - 'PWD': '/builds/slave/test', 02:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:09 INFO - 'SHELL': '/bin/bash', 02:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v0AD30VDOc/Listeners', 02:51:09 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 02:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:09 INFO - 'USER': 'cltbld', 02:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:09 INFO - 'XPC_FLAGS': '0x0', 02:51:09 INFO - 'XPC_SERVICE_NAME': '0', 02:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:09 INFO - Downloading/unpacking psutil>=0.7.1 02:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:51:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:12 INFO - Installing collected packages: psutil 02:51:12 INFO - Running setup.py install for psutil 02:51:12 INFO - building 'psutil._psutil_osx' extension 02:51:12 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:12 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:13 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:13 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:13 INFO - building 'psutil._psutil_posix' extension 02:51:13 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:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:51:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:51:13 INFO - ^ 02:51:13 INFO - 1 warning generated. 02:51:13 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:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:13 INFO - Successfully installed psutil 02:51:13 INFO - Cleaning up... 02:51:13 INFO - Return code: 0 02:51:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:51:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:13 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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:13 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 0x10d381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3884c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0a3d94630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, '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.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:13 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:13 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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/Render', 02:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:13 INFO - 'HOME': '/Users/cltbld', 02:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:13 INFO - 'LOGNAME': 'cltbld', 02:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:13 INFO - 'MOZ_NO_REMOTE': '1', 02:51:13 INFO - 'NO_EM_RESTART': '1', 02:51:13 INFO - 'PAGER': '/bin/cat', 02:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:13 INFO - 'PWD': '/builds/slave/test', 02:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:13 INFO - 'SHELL': '/bin/bash', 02:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v0AD30VDOc/Listeners', 02:51:13 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 02:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:13 INFO - 'USER': 'cltbld', 02:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:13 INFO - 'XPC_FLAGS': '0x0', 02:51:13 INFO - 'XPC_SERVICE_NAME': '0', 02:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:51:13 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:13 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:13 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:13 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:13 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:13 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:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:51:16 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:16 INFO - Installing collected packages: mozsystemmonitor 02:51:16 INFO - Running setup.py install for mozsystemmonitor 02:51:16 INFO - Successfully installed mozsystemmonitor 02:51:16 INFO - Cleaning up... 02:51:16 INFO - Return code: 0 02:51:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:16 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 0x10d381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3884c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0a3d94630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, '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.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:16 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:16 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:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/Render', 02:51:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:16 INFO - 'HOME': '/Users/cltbld', 02:51:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:16 INFO - 'LOGNAME': 'cltbld', 02:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:16 INFO - 'MOZ_NO_REMOTE': '1', 02:51:16 INFO - 'NO_EM_RESTART': '1', 02:51:16 INFO - 'PAGER': '/bin/cat', 02:51:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:16 INFO - 'PWD': '/builds/slave/test', 02:51:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:16 INFO - 'SHELL': '/bin/bash', 02:51:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v0AD30VDOc/Listeners', 02:51:16 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 02:51:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:16 INFO - 'USER': 'cltbld', 02:51:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:16 INFO - 'XPC_FLAGS': '0x0', 02:51:16 INFO - 'XPC_SERVICE_NAME': '0', 02:51:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:16 INFO - Downloading/unpacking blobuploader==1.2.4 02:51:16 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:16 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:16 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:16 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:16 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:16 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:18 INFO - Downloading blobuploader-1.2.4.tar.gz 02:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:51:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:51:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:20 INFO - Downloading docopt-0.6.1.tar.gz 02:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:51:20 INFO - Installing collected packages: blobuploader, requests, docopt 02:51:20 INFO - Running setup.py install for blobuploader 02:51:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:51:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:51:20 INFO - Running setup.py install for requests 02:51:20 INFO - Running setup.py install for docopt 02:51:20 INFO - Successfully installed blobuploader requests docopt 02:51:20 INFO - Cleaning up... 02:51:21 INFO - Return code: 0 02:51:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:21 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 0x10d381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3884c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0a3d94630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, '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.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:21 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:21 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:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/Render', 02:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:21 INFO - 'HOME': '/Users/cltbld', 02:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:21 INFO - 'LOGNAME': 'cltbld', 02:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:21 INFO - 'MOZ_NO_REMOTE': '1', 02:51:21 INFO - 'NO_EM_RESTART': '1', 02:51:21 INFO - 'PAGER': '/bin/cat', 02:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:21 INFO - 'PWD': '/builds/slave/test', 02:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:21 INFO - 'SHELL': '/bin/bash', 02:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v0AD30VDOc/Listeners', 02:51:21 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 02:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:21 INFO - 'USER': 'cltbld', 02:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:21 INFO - 'XPC_FLAGS': '0x0', 02:51:21 INFO - 'XPC_SERVICE_NAME': '0', 02:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-pXihaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-QJQq4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-wY0zac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-IR91k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-0lhj9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-df8HZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:21 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-LW2_gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-YtePBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-sU_byl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-QpNcoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-YTSDsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-ZifNWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-F_SMeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-qZafAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-QmwHPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-K5OgQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:22 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-0xy9nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:51:23 INFO - Running setup.py install for manifestparser 02:51:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:51:23 INFO - Running setup.py install for mozcrash 02:51:23 INFO - Running setup.py install for mozdebug 02:51:23 INFO - Running setup.py install for mozdevice 02:51:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:51:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:51:23 INFO - Running setup.py install for mozfile 02:51:23 INFO - Running setup.py install for mozhttpd 02:51:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:51:23 INFO - Running setup.py install for mozinfo 02:51:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Running setup.py install for mozInstall 02:51:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Running setup.py install for mozleak 02:51:24 INFO - Running setup.py install for mozlog 02:51:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Running setup.py install for moznetwork 02:51:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Running setup.py install for mozprocess 02:51:24 INFO - Running setup.py install for mozprofile 02:51:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Running setup.py install for mozrunner 02:51:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:51:25 INFO - Running setup.py install for mozscreenshot 02:51:25 INFO - Running setup.py install for moztest 02:51:25 INFO - Running setup.py install for mozversion 02:51:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:51:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:51:25 INFO - Cleaning up... 02:51:25 INFO - Return code: 0 02:51:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:25 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 0x10d381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3884c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0a3d94630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, '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.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:25 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:25 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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/Render', 02:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:25 INFO - 'HOME': '/Users/cltbld', 02:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:25 INFO - 'LOGNAME': 'cltbld', 02:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:25 INFO - 'MOZ_NO_REMOTE': '1', 02:51:25 INFO - 'NO_EM_RESTART': '1', 02:51:25 INFO - 'PAGER': '/bin/cat', 02:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:25 INFO - 'PWD': '/builds/slave/test', 02:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:25 INFO - 'SHELL': '/bin/bash', 02:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v0AD30VDOc/Listeners', 02:51:25 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 02:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:25 INFO - 'USER': 'cltbld', 02:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:25 INFO - 'XPC_FLAGS': '0x0', 02:51:25 INFO - 'XPC_SERVICE_NAME': '0', 02:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:25 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-eAuBTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:25 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-d8epEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:26 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-bTT_Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:26 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-nhotKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:26 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-V2NGen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:26 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-DAccmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:26 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-HJ9mYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:26 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-Qy3jCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:26 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-U8tR2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:26 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-pnVWQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:26 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-XlNk_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:27 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-n3o18y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:27 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-6hW3KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:27 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-npCFnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:27 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-_lVtRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:27 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-EQmTdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:27 INFO - Running setup.py (path:/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/pip-NwRsbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:27 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:27 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:27 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:27 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:27 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:27 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:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:30 INFO - Downloading blessings-1.6.tar.gz 02:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:51:30 INFO - Installing collected packages: blessings 02:51:30 INFO - Running setup.py install for blessings 02:51:30 INFO - Successfully installed blessings 02:51:30 INFO - Cleaning up... 02:51:30 INFO - Return code: 0 02:51:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:51:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:30 INFO - Reading from file tmpfile_stdout 02:51:30 INFO - Current package versions: 02:51:30 INFO - blessings == 1.6 02:51:30 INFO - blobuploader == 1.2.4 02:51:30 INFO - docopt == 0.6.1 02:51:30 INFO - manifestparser == 1.1 02:51:30 INFO - mozInstall == 1.12 02:51:30 INFO - mozcrash == 0.16 02:51:30 INFO - mozdebug == 0.1 02:51:30 INFO - mozdevice == 0.48 02:51:30 INFO - mozfile == 1.2 02:51:30 INFO - mozhttpd == 0.7 02:51:30 INFO - mozinfo == 0.9 02:51:30 INFO - mozleak == 0.1 02:51:30 INFO - mozlog == 3.1 02:51:30 INFO - moznetwork == 0.27 02:51:30 INFO - mozprocess == 0.22 02:51:30 INFO - mozprofile == 0.28 02:51:30 INFO - mozrunner == 6.11 02:51:30 INFO - mozscreenshot == 0.1 02:51:30 INFO - mozsystemmonitor == 0.0 02:51:30 INFO - moztest == 0.7 02:51:30 INFO - mozversion == 1.4 02:51:30 INFO - psutil == 3.1.1 02:51:30 INFO - requests == 1.2.3 02:51:30 INFO - wsgiref == 0.1.2 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', '--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 0x10d381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3884c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0a3d94630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, '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.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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', '--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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 02:51:30 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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 - 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 INFO - Cleaning up... 02:51:30 INFO - Return code: 0 02:51:30 INFO - Installing jsonschema 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', '--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 0x10d381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3884c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0a3d94630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, '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.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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', '--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:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 02:51:30 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:31 INFO - Downloading/unpacking jsonschema 02:51:31 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:31 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:31 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:31 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:31 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:31 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:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:51:33 INFO - Downloading/unpacking functools32 (from jsonschema) 02:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:33 INFO - Downloading functools32-3.2.3-2.tar.gz 02:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:51:33 INFO - warning: no files found matching '*.txt' 02:51:33 INFO - no previously-included directories found matching 'build' 02:51:33 INFO - no previously-included directories found matching 'dist' 02:51:33 INFO - no previously-included directories found matching '.git*' 02:51:33 INFO - Installing collected packages: jsonschema, functools32 02:51:33 INFO - Running setup.py install for functools32 02:51:34 INFO - warning: no files found matching '*.txt' 02:51:34 INFO - no previously-included directories found matching 'build' 02:51:34 INFO - no previously-included directories found matching 'dist' 02:51:34 INFO - no previously-included directories found matching '.git*' 02:51:34 INFO - Successfully installed jsonschema functools32 02:51:34 INFO - Cleaning up... 02:51:34 INFO - Return code: 0 02:51:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:34 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 0x10d381a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3884c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0a3d94630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, '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.2AqqNJz1DG/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.v0AD30VDOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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:34 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:34 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:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/Render', 02:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:34 INFO - 'HOME': '/Users/cltbld', 02:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:34 INFO - 'LOGNAME': 'cltbld', 02:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:34 INFO - 'MOZ_NO_REMOTE': '1', 02:51:34 INFO - 'NO_EM_RESTART': '1', 02:51:34 INFO - 'PAGER': '/bin/cat', 02:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:34 INFO - 'PWD': '/builds/slave/test', 02:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:34 INFO - 'SHELL': '/bin/bash', 02:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v0AD30VDOc/Listeners', 02:51:34 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 02:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:34 INFO - 'USER': 'cltbld', 02:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:34 INFO - 'XPC_FLAGS': '0x0', 02:51:34 INFO - 'XPC_SERVICE_NAME': '0', 02:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:34 INFO - Downloading/unpacking flake8 02:51:34 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:34 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:34 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:34 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:34 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:34 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:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:51:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:51:36 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:36 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:36 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:36 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:36 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:36 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 - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:51:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:51:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:38 INFO - no previously-included directories found matching 'docs/_build' 02:51:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:51:38 INFO - Running setup.py install for pep8 02:51:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:38 INFO - no previously-included directories found matching 'docs/_build' 02:51:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:51:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:51:38 INFO - Cleaning up... 02:51:38 INFO - Return code: 0 02:51:38 INFO - Running post-action listener: _resource_record_post_action 02:51:38 INFO - Running post-action listener: _start_resource_monitoring 02:51:38 INFO - Starting resource monitoring. 02:51:38 INFO - ##### 02:51:38 INFO - ##### Running install step. 02:51:38 INFO - ##### 02:51:38 INFO - Running pre-action listener: _resource_record_pre_action 02:51:38 INFO - Running main action method: install 02:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:38 INFO - Reading from file tmpfile_stdout 02:51:38 INFO - Detecting whether we're running mozinstall >=1.0... 02:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:51:38 INFO - Reading from file tmpfile_stdout 02:51:38 INFO - Output received: 02:51:38 INFO - Usage: mozinstall [options] installer 02:51:38 INFO - Options: 02:51:38 INFO - -h, --help show this help message and exit 02:51:38 INFO - -d DEST, --destination=DEST 02:51:38 INFO - Directory to install application into. [default: 02:51:38 INFO - "/builds/slave/test"] 02:51:38 INFO - --app=APP Application being installed. [default: firefox] 02:51:38 INFO - mkdir: /builds/slave/test/build/application 02:51:38 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:38 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:12 INFO - Reading from file tmpfile_stdout 02:52:12 INFO - Output received: 02:52:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:52:12 INFO - Running post-action listener: _resource_record_post_action 02:52:12 INFO - ##### 02:52:12 INFO - ##### Running run-tests step. 02:52:12 INFO - ##### 02:52:12 INFO - Running pre-action listener: _resource_record_pre_action 02:52:12 INFO - Running main action method: run_tests 02:52:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:52:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:52:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:52:12 INFO - 2016-02-10 02:52:12.872 screenresolution[2316:29140] starting screenresolution argv=screenresolution get 02:52:12 INFO - 2016-02-10 02:52:12.875 screenresolution[2316:29140] Display 0: 1600x1200x32@60 02:52:12 INFO - 2016-02-10 02:52:12.881 screenresolution[2317:29142] starting screenresolution argv=screenresolution list 02:52:12 INFO - Available Modes on Display 0 02:52:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:52:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:52:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:52:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:52:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:52:13 INFO - Intel Iris: 02:52:13 INFO - Chipset Model: Intel Iris 02:52:13 INFO - Type: GPU 02:52:13 INFO - Bus: Built-In 02:52:13 INFO - VRAM (Dynamic, Max): 1536 MB 02:52:13 INFO - Vendor: Intel (0x8086) 02:52:13 INFO - Device ID: 0x0a2e 02:52:13 INFO - Revision ID: 0x0009 02:52:13 INFO - Displays: 02:52:13 INFO - Display: 02:52:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:52:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:52:13 INFO - Display Serial Number: 1600x1200 60 02:52:13 INFO - Main Display: Yes 02:52:13 INFO - Mirror: Off 02:52:13 INFO - Online: Yes 02:52:13 INFO - Rotation: Supported 02:52:13 INFO - Return code: 0 02:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:52:13 INFO - Python 2.7.3 02:52:13 INFO - Return code: 0 02:52:13 INFO - grabbing minidump binary from tooltool 02:52:13 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:13 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 0x10d225d30>, '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 0x10d049db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:52:13 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:13 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:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:52:13 INFO - Return code: 0 02:52:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:52:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:52:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:52:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:52:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:52:14 INFO - Return code: 0 02:52:14 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-0132', '--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:14 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-0132 --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:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2AqqNJz1DG/Render', 02:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:14 INFO - 'HOME': '/Users/cltbld', 02:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:14 INFO - 'LOGNAME': 'cltbld', 02:52:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:52:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:14 INFO - 'MOZ_NO_REMOTE': '1', 02:52:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:52:14 INFO - 'NO_EM_RESTART': '1', 02:52:14 INFO - 'PAGER': '/bin/cat', 02:52:14 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:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:14 INFO - 'PWD': '/builds/slave/test', 02:52:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:14 INFO - 'SHELL': '/bin/bash', 02:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v0AD30VDOc/Listeners', 02:52:14 INFO - 'TMPDIR': '/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/', 02:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:14 INFO - 'USER': 'cltbld', 02:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:14 INFO - 'XPC_FLAGS': '0x0', 02:52:14 INFO - 'XPC_SERVICE_NAME': '0', 02:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:14 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-0132', '--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:14 INFO - mozversion application_buildid: 20160208164823 02:52:14 INFO - mozversion application_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:52:14 INFO - mozversion application_display_name: Nightly 02:52:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:52:14 INFO - mozversion application_name: Firefox 02:52:14 INFO - mozversion application_remotingname: firefox 02:52:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:52:14 INFO - mozversion application_vendor: Mozilla 02:52:14 INFO - mozversion application_version: 47.0a1 02:52:14 INFO - mozversion platform_buildid: 20160208164823 02:52:14 INFO - mozversion platform_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:52:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:52:14 INFO - mozversion platform_version: 47.0a1 02:52:14 INFO - using testdate: 1455101534 02:52:14 INFO - actual date: 1455101534 02:52:15 INFO - starting webserver on 'localhost:50120' 02:52:15 INFO - SUITE-START | Running 2 tests 02:52:15 INFO - TEST-START | dromaeo_css 02:52:15 INFO - operating with platform_type : mac_ 02:52:15 INFO - Initialising browser for dromaeo_css test... 02:52:15 INFO - TEST-INFO | started process 2335 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/tmpd_YUqd/profile http://localhost:50120/getInfo.html) 02:52:18 INFO - PROCESS | 2335 | __metrics Screen width/height:1600/1200 02:52:18 INFO - PROCESS | 2335 | colorDepth:24 02:52:18 INFO - PROCESS | 2335 | Browser inner width/height: 1024/689 02:52:18 INFO - PROCESS | 2335 | __metrics 02:52:18 INFO - TEST-INFO | 2335: exit 0 02:52:18 INFO - Browser initialized. 02:52:18 INFO - Running cycle 1/1 for dromaeo_css test... 02:52:18 INFO - TEST-INFO | started process 2339 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/tmpd_YUqd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:30 INFO - PROCESS | 2339 | RSS: Main: 257101824 02:52:30 INFO - PROCESS | 2339 | 02:53:20 INFO - PROCESS | 2339 | 1455101600244 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:29 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:50120/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50120/tests/dromaeo/cssquery-ext.html) 02:55:31 INFO - PROCESS | 2339 | RSS: Main: 271110144 02:55:31 INFO - PROCESS | 2339 | 02:58:33 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:50120/tests/dromaeo/cssquery-ext.html (next: http://localhost:50120/tests/dromaeo/cssquery-jquery.html) 02:58:34 INFO - PROCESS | 2339 | RSS: Main: 283922432 02:58:34 INFO - PROCESS | 2339 | 03:01:35 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:50120/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50120/tests/dromaeo/cssquery-mootools.html) 03:01:36 INFO - PROCESS | 2339 | RSS: Main: 284442624 03:01:36 INFO - PROCESS | 2339 | 03:04:38 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:50120/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50120/tests/dromaeo/cssquery-prototype.html) 03:04:38 INFO - PROCESS | 2339 | RSS: Main: 287387648 03:04:38 INFO - PROCESS | 2339 | 03:07:41 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:50120/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50120/tests/dromaeo/cssquery-yui.html) 03:07:41 INFO - PROCESS | 2339 | RSS: Main: 288329728 03:07:41 INFO - PROCESS | 2339 | 03:10:44 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:50120/tests/dromaeo/cssquery-yui.html (next: http://localhost:50120/tests/dromaeo/cssquery-dojo.html) 03:10:44 INFO - PROCESS | 2339 | RSS: Main: 291934208 03:10:44 INFO - PROCESS | 2339 | 03:10:44 INFO - PROCESS | 2339 | __start_tp_report 03:10:44 INFO - PROCESS | 2339 | _x_x_mozilla_page_load 03:10:44 INFO - PROCESS | 2339 | _x_x_mozilla_page_load_details 03:10:44 INFO - PROCESS | 2339 | |i|pagename|runs| 03:10:44 INFO - PROCESS | 2339 | |0;dojo.html;3466.3933811582974;3511.2450823073036;3537.1157210697324;3564.8217589120554;3582.943031805616;5697.857553561158;5781.479666829984;5782.392848750884;5798.217240672508;5807.867465844162;5634.098544232924;5692.288463942007;5769.394213607574;5792.739326730297;5846.03540415832;3945.9210815783813;4619.722816631013;4891.510848915115;5156.1234590119675;5197.688138711689;313.0666691275198;5120.385553733558;5166.276721259027;5203.4536373680785;5308.787648494055;4762.452317983441;4767.642426818003;5164.819231326905;5193.740312984354;5278.419373868871;4662.277347011219;4889.899772551183;5221.39953905302;5246.8688282792855;5251.4485978972425;5130.07658621448;5148;5152.124138896359;5191.714455704935;5221.895562088775;4895.7062576245535;5530.198121272433;5643.7460314285545;5669.716514174274;5761.740721667535;6118.010103775202;6220.844478888019;6293.30773614902;6300.054991751228;6302.401271879165;6174.876502469971;6257.2491301044165;6262.185915830958;6282.465990390822;6289.37106289372;5839.532837373;5901.434127973672;5925.111233314951;5933.199018132583;5967.701614919237;6189.6286222825875;6241.34465881085;6326.367363263636;6341.175647165931;6359.141515895388;6211.3478084801345;6230.719617617218;6242.500599951993;6252.968735156386;6268.717907694165;6197.411245931629;6269.8746025079245;6280.497560195174;6295.685215739195;6299.811005669837;6129.603311142676;6188.164597779242;6228.03465462854;6275.309715931244;6285.96857015712;6214.223222097238;6238.095476155932;6244.65654389013;6261.499080073583;6267.310595834546;4862.027594481118;4883.316335713003;4938.530839570235;4962.627802914796;4972.875678108004;4415.271480205794;4457.910841783146;4463.218936686067;4473.821047158142;4498.797554110073;4334.5882141196535;5714.5999780015;5741.024025915604;5818.359980402152;5823.2429784128635;6158.599691020069;6196.845078873064;6224.782132625336;6238.656873871981;6240.469560087353;5816.069428891357;5836.88326233473;5839.386864379179;5843.503302219274;5849.532037436995;5351.598630102758;5448.182772584065;5453.727313634303;5471;5473.644213126134;6328.240611126695;6413.6793160341795;6415.06981487691;6455.160829092282;6481.967590162019;6219.626822390671;6234.501239900706;6274.717637706405;6291.96854015727;6303.46420554258;6176.474999625082;6331.27190373113;6427.775027874002;6440.8389790255615;6451.41937225652;6180.258368995569;6180.938190618036;6200.100985357008;6209.130721698875;6218.06728990655;6227.034809604518;6230.59501132425;6233.283172435228;6238.812835614939;6246.406591373812;4579.542045795394;5224.190250511177;5345.732713364238;6096.725647345791;6115.785947491817;5034.345535080416;6184.5052395809125;6219.284782250099;6219.533534984985;6223.190985171898;5892.175095486549;6074.605150665193;6110.083487476736;6112.541559382975;6119.694015299128;6013.879722405615;6113.083037544404;6114.936124487681;6119.837693858789;6138.094643526033;6087.847803804763;6091.634501929899;6096.420840020191;6100.816975490742;6108.725107370268 03:10:44 INFO - PROCESS | 2339 | |1;ext.html;472.3151430425883;506.31394460506016;515.2863284351174;558.9357223919251;561.3292115921475;37318;37784.62215377845;37806.29871655779;37927.24145517088;37994.86015419542;34792.956211313634;35868.820655896685;38943.610563894355;38947.61052389475;39113.80443097788;9435.056494350561;9619.90380096197;9665.178459830922;9687.32188746788;9733.415995040285;9584.424934503952;9743.220542356594;9749.610015599403;9758;9762.560684769167;9694.66068687596;9767.853482197737;9788.021197880225;9797;9798.608055677765;9649.324547281658;9712.562934667956;9726.881408638026;9746.074122958307;9772.21822254218;9542.475163865985;9638.132568068837;9639.325247232626;9644.75888102803;9661.90338096617;38408.80795596032;38422;38646.22707545834;38666.806665966775;38776;3342.1143396999814;3472.322897035079;3614.36748569002;3734.402495600718;4027.7180597358197;29137.980170694136;29280.414391712045;29539;29587;30050.098497045125;2881.683014868363;2881.9423611527864;2893.3345330573875;2897.5798509216047;3000.939981200386;496003;497598.51200743765;499109;499493;500708;53413;54825.725871370385;64543.70912581722;65055.67472162609;65948.34051659422;62543.374566253755;62783;63050.68474657597;63271;63470.68264658647;15702;15806.92096539533;15841.287142078403;16016.75974860378;16025.118618475863;12181.208221465577;12184.147109702413;12236.143469957196;12237.816432753516;12297.262164269994;19901.60196796056;20122.496937576678;20221.59556808885;20340.186392544427;20360.389188324374;8155.5514446706;8298.543580103153;8323.500589964622;8324.916750832414;8364.247217750431;898.4519443139679;1043.9530221140067;1059.2055958031476;1079.740862193068;1133.4049623947328;26150.692465377037;27972;29442.11673649794;29727.851360743058;29942;1022.7187523431116;1067.658349328223;1081.0972837680467;1149.5514553999926;1215.076541828217;11602.593909213138;13725.519606813714;13745.862541374458;13848.307584620728;14047.508337208148;560293;560481;562529;564999;568138;54220;54244.18633720497;54286;54366;54407.72796135994;1408.7816388459805;1419.1130543410368;1452.0561634937164;1454.7163303155783;1466.0690461556776;23895.44991307509;27861.16416507508;28272;28521.001764938126;28686.42627147487;49094.77263068452;49148.508514915826;49287.26069109038;49313.50686493233;49550.50449495459;518447;523675;524738.376308116;525242;525727.371363156;30414.783408663407;31752;33213.16967075843;33337.499937501445;33363;40677.389839151845;41514.58485415228;41610;41610.79194604129;41914.7425577221;34155.65844341624;35180.47229291512;35433.114172145906;35442.46836297406;35626.28747424985;34193.31613367768;34845.825770870986;34867;34916.47625285674;35028.82485587556;24975.750242497343;34727.305453891284;34827.65172348244;34887;36241.818790905876;31029.913953011535;31246.531302030944;31252.843735781174;31254.53118203183;31470.055898323088;23554.175603853782;24340;24393;24532.141375051786;24802.751972480044 03:10:44 INFO - PROCESS | 2339 | |2;jquery.html;325.86476612205934;359.9316129935312;368.1312103435891;369.36284908532804;372.3818461354153;15470.149141797197;18560.443186704404;19069.904650476747;19586.90206548969;20048.59902801945;10464.05823475887;11201.327920324786;11586;11978.820317695241;19103.662743607954;5209.843704688866;5451.836444906659;5966.045432730764;6021.969890150565;6031.366706495821;5778.768849246047;5920.200772895647;5981.910271345933;6027.427394397547;6051.6671583063135;3917.7649341039487;5849.151872978416;5914.260717410324;5938.940610593903;5940.495057920082;5839;5937.1984782054515;6027.668478233695;6038.969805150968;6081.695915204245;5278.47215278473;5431.755570999315;5484.862878428032;5533.280673512418;5533.833984980457;15480.303386347641;23942.162024329064;24051.87974060136;24092.277231683078;24334.26997190087;1967.9508012299664;2147.076756994492;2157.6979222908803;2173.978260217393;2340.2862127051244;8109.594520273963;9631.470269135194;9889.357191782512;10895.346279223271;14585.489507867174;1768.7081631530782;1783.144090836406;1803.134495442182;1817.8545716342794;1835.6879330513846;70419;85837;95687;98190.0180998188;98234.01765982392;9407.4825884577;11201.495932683049;11208.495617697223;11261.930116638907;11333.26333788301;13196.670083247804;13473.393697283645;13478.123921945238;13483.797743033861;13545.322733863268;8335.54154521495;8360;8394.034686011064;8443.197896199852;8468.49189048659;8431.114732953074;8447.98624165104;8486.40595158333;8531.146885311418;8569.914300857037;4383.07955329378;4455.376247325377;4458.8439404620685;4479.216137175981;4496.033352829158;1661.8919770214898;1761.8326259005373;1791.5252458098614;1883.3408307092682;1897.3928342930406;637.9521535884827;764.6176911544228;864.2524216552762;953.9379940303858;1021.5403068619152;15455.845441545665;18994.52513687169;19005;19271.614567708846;19465.513362165777;928.7863791328033;936.0125068053134;936.9812603747887;948.5304774136708;1027.2706378471369;10723.14214862809;10841.903433850539;10885;11268.774624507463;11323.32060076398;721932;761577;774138;775448;785120;114490.42754786173;117831;119249;119446.40276798561;121003.39498302453;1115.8549388579434;1174.9236299640495;1184.265755231762;1186.0570846177309;1198.646399312205;17401.738973915653;17785.377511787025;17791.110444477985;18534.81465185331;18700.81299186991;31785;48523.75738121287;49224.75387623039;50596.24105638492;53941.73029134829;67749;68488.3151168482;69469;69641;70360.64819675869;7618.619069046415;7796.88304675419;7825.491343062683;7837.902693622783;7987.081485628994;10251;11960.64118076459;12213.45039473208;12226.694332641755;12264.386780660752;9249.12133347331;10133.08802207805;10282.845757313797;10477.476126193507;10588.205884558534;10030.89969100329;10363.274570779973;10444.843327349943;10465.848756636917;10480.004399582027;10568.84146737815;10601;10618.469076545987;10688.465576721288;10704.839427408751;6420.967895160495;7121;7319.121705395173;7596.354309883722;7706.730264440717;8540.44487108336;10755.892441075803;10776.67669969902;10851.891481085087;10898.291611045257 03:10:44 INFO - PROCESS | 2339 | |3;mootools.html;1300.577312373479;1477.2318394434892;1623.6184496643293;1670.7326827707561;1675.2210222246654;6536.771213007546;8654.870176947335;8792.252658524025;8961.148690874365;9008.639654413824;8654.480731156134;8748.868766968484;8811.986621538525;8837.204651581356;8846.11538846115;2485.5526005319034;2498.3004758667603;2506.3608779761134;2522.5207210629924;2523.3313172009434;2473.1096805150223;2537.8477291362483;2538.2765911715164;2544.910928117516;2545.4654522550286;2209.5028618560855;2466.728659847415;2490.252924122765;2517.3832411059225;2525.318164095693;2496.8252222344445;2498.4003839078673;2518.9496210075786;2522.445062086338;2524.886380112899;2466.802655787533;2499.1003238834005;2512.2337687005456;2521.0798058708624;2521.5209110269175;8680.392372533925;8761.34289928258;8763.298936085097;8766.772651828685;8770.517621530813;5380.650257733235;5529.115341545334;5547;5577.721113944327;5581.7209139543265;3618.240169564395;3642.7450078494517;3699.7965111918834;3805.7145714071557;3812.980935095307;1061.4851796878509;1076.2573824061374;1076.682378698278;1112.6161474291357;1113.6659002299277;10147.289689721649;11804.350760708157;11862.525498980116;12027.759444811143;12091;4950.480199578992;4956.157453232959;5032.823851165192;5063.215201643751;5101.9489805101475;10224.386536807666;10228.59085636581;10270.794584108276;10277.383356998604;10347.63783267582;4205.915881682349;4591.977040114778;5195.064888320138;5551.139573366135;5581.5255703265675;5006.424261210008;5045.84862454127;5047.671901326402;5056.342675452242;5060.84817455477;3759.4172903200047;3854.0557563397147;3866.0721426857353;3866.8839934802;3868.2650296443585;1150.2810743285447;1174.4890972427022;1178.4932479033926;1180.8405865208088;1215.1311812054246;958.434523631061;1115.7712668902855;1175.371176420628;1233.784087784634;1338.2505796753849;8004.79988000293;8037.075736290284;8042.839143217103;8160.224778646019;8198.713045043394;1198.7482628647908;1204.9397530123458;1208.317300725105;1215.5867005218267;1228.9201201921846;6157.630542167484;6212.72042758077;6218.595791273553;6225.3774622538285;6255.0617407388345;10833.67498975032;10998.34009959405;11034.668959931216;11122.777544449065;11128.05411540012;9051.728448146434;10643.042126208678;10816.459177041117;10978.011978921935;11017.504212310465;8293.502389856629;8397.118302578263;8442.662293508314;8468.110848360957;8486.915130848613;7879.0939042010905;7944.920550794418;7957.562334071682;7990.840183196187;8016.358691304798;9528.761780955532;9660.275479338938;9678.274129440179;9801.950990245003;9952.601895924083;10028.799424011624;10243.48782560884;10269.794604108025;10298.691039268833;10312.329698569569;7049.08361912948;7075.610841403773;7113.03973963529;7145.21402645719;7146.714131434893;8243.505389676639;8326.25063744266;8364.498130112213;8401.15988401155;8437.240648341678;6800.421964132906;7386.556806591621;7785.961070194613;7938.880916786137;8103.554304513308;7551.848963020599;7554.924450755642;7566.924330756622;7604.12552556441;7643.88534171999;5967.492763115184;7465.58939258346;7467.813304667427;7540.245975402416;7669.424793140648;6927.411170050401;6953.061336719478;6959.478039146983;6973.6164510952385;7014.053102831256;7105.82235444118;7110.288971102848;7152.177499587614;7157.1769246537315;7159.105111861018 03:10:44 INFO - PROCESS | 2339 | |4;prototype.html;297.47198722267973;298.2870938457088;333.66966702964066;334.06128778133444;341.9367417027852;5504.394516603175;6800.795976120712;6820.454363650909;6854.417374523172;6908.861822763542;6880.483963702717;6937.098177236965;6953.860922781541;6956;6957.373836354727;4134.607212314825;5099.439061703219;5107.106256405133;5123.487651234884;5126.871828204287;3453.8618455261885;5034.848954531351;5088.389393272812;5107.336046313974;5119.974400127994;4820.975895120519;4830.468648448667;4838.419389673227;4840.6127509799135;4841.055994081155;4803.879903002418;4807.615390768748;4814.831480898151;4820.276958456225;4840.515948405131;3968.305546529346;4069.7151199416053;4073.674106071507;4152.647025002879;4169.958300416987;6488.837779055514;6515.93484065158;6549.508786841006;6589.967050164766;6597.373249541286;5884.588078834483;5897.616654917417;5902.173695682565;5903.203067585864;5904.793332233351;7075.646217689146;7326.157491888448;7357.889631655529;7364.484486085976;7391.113066432009;4356.6514678825615;4638.257878739386;4694.812207511695;4695.366125573072;4707.646926480494;7696.114946781136;7807.180246074194;7815.218478152196;7823.295903368724;7830.647620857075;4643.86068417948;4706;4730.2431610942085;4745.477997420281;4762;4850.5149485051215;4852.296417019583;4867;4870.342503762017;4877.463479017305;5868.23712917318;5878.5297176225795;5880.529557635379;5892.234009578813;5898.026825573818;7195.604241766649;7406.185319614838;7406.444516661164;7421.628918554159;7424.220456851953;1397.76936805428;1663.4760050584027;1684.8567871730795;1685.292177285543;1689.6705142497094;922.4327038871046;1048.0567489259727;1058.7088550648634;1075.9408232547285;1078.2667785905503;6735.4274886635185;6764.594124352555;6765.830854228585;6772.93227067723;6787.830304242433;6446.677666116675;6881.380675739108;6974.0236366908675;7724.188960159102;7754.9224507755325;6545.803625891231;6738.696758645775;6743.291954344723;6749.966250168718;6819.659017049227;3928.783916884599;4013.478247827764;4059.7564146151326;4064.898377540526;4104.445899803548;7910.129885712567;8078;8107.878381824277;8134.227248411392;8136.4711293766895;6778.423833974069;7785.766427007085;8053.31546818527;8063.153368896299;8070.071941726659;6641.501887358468;7705.730299439493;8093.55485448306;8109.918900810916;8121.390895682847;7784.805379865548;7796.805079873048;7809.180036096128;7815.882761758465;7824.530528168328;6623.834404139935;7370.6314684266645;7402.518836275625;7655.57894315818;7662.846743064996;8112.391570632109;8118.3099436548555;8119.147489513753;8145.063317718538;8148.674053037812;4761.738104404291;4792.616590672668;4800.06398752254;4809.206480930748;4830.661853670209;7514.962425188058;7747.690092396467;7750.651220694969;7768.53388796674;7776.7278145264645;7455.888161677688;7479.513831600929;7479.887801683088;7487.101547814297;7513.361364284097;7269.157144830639;7362.116546014512;7407;7408;7414.8887766682465;7276.090488688914;7280.67236974348;7287.781366559012;7312.305330993547;7344.081989751281;7404.259574042552;7442.96278518604;7444.627768611439;7453.993710849183;7469.775906722807;7067.929320706727;7255.746048888263;7278.09023872016;7290.05229320185;7298.051253337032 03:10:44 INFO - PROCESS | 2339 | |5;yui.html;677.3328271652422;713.4898547538515;717.8026042838216;734.2473964186707;743.4684200796429;13196.604101876936;14399.92000599954;14829.925850370746;15031.849681503181;15188.544343669693;15566;15876.126813025308;15877;15919.602009949727;15939.601509962256;686.3513979289548;851.29342645604;852.0074113657581;869.4001139213954;872.4416373520952;841.0958219913587;850.689498333107;855.5251835231444;860.806318578318;870.190722627959;881.5504092912629;894.1952242981304;903.0878812399491;907.0566610724838;920.7974245665943;879.810840669256;895.136193573205;898.2409863665192;899.6266549381966;915.7847905742178;651.7555916531301;657.4575974820744;663.8871391863395;670.4234358451728;672.1967249137283;15239;15322.15728134952;15326.923365383213;15414;15421.460248891235;12512.499500019989;12604.180728252633;12733.74532509354;12925.870741292561;13177.736445271137;10275.537600807907;10283.691489255334;10319.896801032044;10734.892651073545;11108.666739997812;2782.9443411131865;3512.0693016350688;3512.121969507623;3594.802285874276;3640.890773276806;67394.30422783033;75908;77689.05777355554;78510.42979140443;78758;8637.654493820302;9316.161545460942;9397.483138427315;9428.90571094294;9769.218462523124;20088.79467231971;20382;20600.175992960114;20601.58796824055;20661.690074648894;5804.245448091721;6709.832254193684;7279.59962202084;7529.021227240423;7580.635485612533;3530.878978349785;3581.9641803582153;4135.7518548887165;4136.007358234062;4264.466941632296;3500.1599616092462;3519.1554027033326;3524.2070534129616;3548.183917698892;3565.5899571549603;553.2641586689693;638.9712462939179;651.7165033210474;653.1802587752435;658.4107224034462;561.9241402410704;610.8014895159091;629.2417636747708;630.9022101574263;633.5850018238061;8406.537640429835;8482.491050536988;8662.090480499583;8703.521306328214;8821.514816685143;509.788437798317;530.5967464726835;588.314613475305;602.4216751918208;653.7189008726293;3796.6583007529457;3849.557300910375;3978.5026871641044;4048.4332193492933;4165.895852603649;88909.55545222232;90424.09575904289;90460;91013;96855;77187;77564.22435775683;78193.60903195561;78568;79684.20315796883;66427;67929.98105028429;69397;70661.64669176622;73302.26697733061;8088.87866682012;8089.948306720089;8824.338174637056;8870.53636150028;8925.598348074482;45738;46305.305420418044;47144.528554714016;47258.527414726785;48693.5130648689;66750.33249667441;67094;68408.63182736417;70670.29329706637;72347.82956511313;11117.22179447431;11180.993710566088;11264.549418023187;11445.313281203154;11916.344601047025;11776.82334764962;12064.155509114278;12291.938540307241;12362.505499780267;12402.25586464815;11228.831567526657;11796.882031179579;11805.350705710925;11890.643280701594;11893.345865977455;11348.319100853974;11496;11797.410129493319;11799.646010619352;11862;11313.981741643292;11513.021393181674;11631.825522617337;11653.825192622287;11841.940790295994;9223.400478968846;9239.907600923905;9490.240780737386;9756.268279878896;9759.609615615296;9791.657291994747;10058.195344372287;10069.748256293651;10072.899271007196;10073.748156296151 03:10:44 INFO - PROCESS | 2339 | __end_tp_report 03:10:44 INFO - PROCESS | 2339 | __start_cc_report 03:10:44 INFO - PROCESS | 2339 | _x_x_mozilla_cycle_collect,380 03:10:44 INFO - PROCESS | 2339 | __end_cc_report 03:10:44 INFO - PROCESS | 2339 | __startTimestamp1455102644565__endTimestamp 03:10:44 INFO - PROCESS | 2339 | 03:10:44 INFO - PROCESS | 2339 | ------- Summary: start ------- 03:10:44 INFO - PROCESS | 2339 | Number of tests: 6 03:10:44 INFO - PROCESS | 2339 | 03:10:44 INFO - PROCESS | 2339 | [#0] dojo.html Cycles:165 Average:5697.76 Median:6087.85 stddev:804.78 (13.2%) stddev-sans-first:787.98 03:10:44 INFO - PROCESS | 2339 | Values: 3466.4 3511.2 3537.1 3564.8 3582.9 5697.9 5781.5 5782.4 5798.2 5807.9 5634.1 5692.3 5769.4 5792.7 5846.0 3945.9 4619.7 4891.5 5156.1 5197.7 313.1 5120.4 5166.3 5203.5 5308.8 4762.5 4767.6 5164.8 5193.7 5278.4 4662.3 4889.9 5221.4 5246.9 5251.4 5130.1 5148.0 5152.1 5191.7 5221.9 4895.7 5530.2 5643.7 5669.7 5761.7 6118.0 6220.8 6293.3 6300.1 6302.4 6174.9 6257.2 6262.2 6282.5 6289.4 5839.5 5901.4 5925.1 5933.2 5967.7 6189.6 6241.3 6326.4 6341.2 6359.1 6211.3 6230.7 6242.5 6253.0 6268.7 6197.4 6269.9 6280.5 6295.7 6299.8 6129.6 6188.2 6228.0 6275.3 6286.0 6214.2 6238.1 6244.7 6261.5 6267.3 4862.0 4883.3 4938.5 4962.6 4972.9 4415.3 4457.9 4463.2 4473.8 4498.8 4334.6 5714.6 5741.0 5818.4 5823.2 6158.6 6196.8 6224.8 6238.7 6240.5 5816.1 5836.9 5839.4 5843.5 5849.5 5351.6 5448.2 5453.7 5471.0 5473.6 6328.2 6413.7 6415.1 6455.2 6482.0 6219.6 6234.5 6274.7 6292.0 6303.5 6176.5 6331.3 6427.8 6440.8 6451.4 6180.3 6180.9 6200.1 6209.1 6218.1 6227.0 6230.6 6233.3 6238.8 6246.4 4579.5 5224.2 5345.7 6096.7 6115.8 5034.3 6184.5 6219.3 6219.5 6223.2 5892.2 6074.6 6110.1 6112.5 6119.7 6013.9 6113.1 6114.9 6119.8 6138.1 6087.8 6091.6 6096.4 6100.8 6108.7 03:10:44 INFO - PROCESS | 2339 | 03:10:44 INFO - PROCESS | 2339 | [#1] ext.html Cycles:180 Average:65942.57 Median:20759.51 stddev:141102.84 (679.7%) stddev-sans-first:141413.05 03:10:44 INFO - PROCESS | 2339 | Values: 472.3 506.3 515.3 558.9 561.3 37318.0 37784.6 37806.3 37927.2 37994.9 34793.0 35868.8 38943.6 38947.6 39113.8 9435.1 9619.9 9665.2 9687.3 9733.4 9584.4 9743.2 9749.6 9758.0 9762.6 9694.7 9767.9 9788.0 9797.0 9798.6 9649.3 9712.6 9726.9 9746.1 9772.2 9542.5 9638.1 9639.3 9644.8 9661.9 38408.8 38422.0 38646.2 38666.8 38776.0 3342.1 3472.3 3614.4 3734.4 4027.7 29138.0 29280.4 29539.0 29587.0 30050.1 2881.7 2881.9 2893.3 2897.6 3000.9 496003.0 497598.5 499109.0 499493.0 500708.0 53413.0 54825.7 64543.7 65055.7 65948.3 62543.4 62783.0 63050.7 63271.0 63470.7 15702.0 15806.9 15841.3 16016.8 16025.1 12181.2 12184.1 12236.1 12237.8 12297.3 19901.6 20122.5 20221.6 20340.2 20360.4 8155.6 8298.5 8323.5 8324.9 8364.2 898.5 1044.0 1059.2 1079.7 1133.4 26150.7 27972.0 29442.1 29727.9 29942.0 1022.7 1067.7 1081.1 1149.6 1215.1 11602.6 13725.5 13745.9 13848.3 14047.5 560293.0 560481.0 562529.0 564999.0 568138.0 54220.0 54244.2 54286.0 54366.0 54407.7 1408.8 1419.1 1452.1 1454.7 1466.1 23895.4 27861.2 28272.0 28521.0 28686.4 49094.8 49148.5 49287.3 49313.5 49550.5 518447.0 523675.0 524738.4 525242.0 525727.4 30414.8 31752.0 33213.2 33337.5 33363.0 40677.4 41514.6 41610.0 41610.8 41914.7 34155.7 35180.5 35433.1 35442.5 35626.3 34193.3 34845.8 34867.0 34916.5 35028.8 24975.8 34727.3 34827.7 34887.0 36241.8 31029.9 31246.5 31252.8 31254.5 31470.1 23554.2 24340.0 24393.0 24532.1 24802.8 03:10:44 INFO - PROCESS | 2339 | 03:10:44 INFO - PROCESS | 2339 | [#2] jquery.html Cycles:180 Average:37536.47 Median:28059.63 stddev:125671.18 (447.9%) stddev-sans-first:125992.66 03:10:44 INFO - PROCESS | 2339 | Values: 325.9 359.9 368.1 369.4 372.4 15470.1 18560.4 19069.9 19586.9 20048.6 10464.1 11201.3 11586.0 11978.8 19103.7 5209.8 5451.8 5966.0 6022.0 6031.4 5778.8 5920.2 5981.9 6027.4 6051.7 3917.8 5849.2 5914.3 5938.9 5940.5 5839.0 5937.2 6027.7 6039.0 6081.7 5278.5 5431.8 5484.9 5533.3 5533.8 15480.3 23942.2 24051.9 24092.3 24334.3 1968.0 2147.1 2157.7 2174.0 2340.3 8109.6 9631.5 9889.4 10895.3 14585.5 1768.7 1783.1 1803.1 1817.9 1835.7 70419.0 85837.0 95687.0 98190.0 98234.0 9407.5 11201.5 11208.5 11261.9 11333.3 13196.7 13473.4 13478.1 13483.8 13545.3 8335.5 8360.0 8394.0 8443.2 8468.5 8431.1 8448.0 8486.4 8531.1 8569.9 4383.1 4455.4 4458.8 4479.2 4496.0 1661.9 1761.8 1791.5 1883.3 1897.4 638.0 764.6 864.3 953.9 1021.5 15455.8 18994.5 19005.0 19271.6 19465.5 928.8 936.0 937.0 948.5 1027.3 10723.1 10841.9 10885.0 11268.8 11323.3 721932.0 761577.0 774138.0 775448.0 785120.0 114490.4 117831.0 119249.0 119446.4 121003.4 1115.9 1174.9 1184.3 1186.1 1198.6 17401.7 17785.4 17791.1 18534.8 18700.8 31785.0 48523.8 49224.8 50596.2 53941.7 67749.0 68488.3 69469.0 69641.0 70360.6 7618.6 7796.9 7825.5 7837.9 7987.1 10251.0 11960.6 12213.5 12226.7 12264.4 9249.1 10133.1 10282.8 10477.5 10588.2 10030.9 10363.3 10444.8 10465.8 10480.0 10568.8 10601.0 10618.5 10688.5 10704.8 6421.0 7121.0 7319.1 7596.4 7706.7 8540.4 10755.9 10776.7 10851.9 10898.3 03:10:44 INFO - PROCESS | 2339 | 03:10:44 INFO - PROCESS | 2339 | [#3] mootools.html Cycles:180 Average:6076.77 Median:5052.01 stddev:3205.49 (63.4%) stddev-sans-first:3194.37 03:10:44 INFO - PROCESS | 2339 | Values: 1300.6 1477.2 1623.6 1670.7 1675.2 6536.8 8654.9 8792.3 8961.1 9008.6 8654.5 8748.9 8812.0 8837.2 8846.1 2485.6 2498.3 2506.4 2522.5 2523.3 2473.1 2537.8 2538.3 2544.9 2545.5 2209.5 2466.7 2490.3 2517.4 2525.3 2496.8 2498.4 2518.9 2522.4 2524.9 2466.8 2499.1 2512.2 2521.1 2521.5 8680.4 8761.3 8763.3 8766.8 8770.5 5380.7 5529.1 5547.0 5577.7 5581.7 3618.2 3642.7 3699.8 3805.7 3813.0 1061.5 1076.3 1076.7 1112.6 1113.7 10147.3 11804.4 11862.5 12027.8 12091.0 4950.5 4956.2 5032.8 5063.2 5101.9 10224.4 10228.6 10270.8 10277.4 10347.6 4205.9 4592.0 5195.1 5551.1 5581.5 5006.4 5045.8 5047.7 5056.3 5060.8 3759.4 3854.1 3866.1 3866.9 3868.3 1150.3 1174.5 1178.5 1180.8 1215.1 958.4 1115.8 1175.4 1233.8 1338.3 8004.8 8037.1 8042.8 8160.2 8198.7 1198.7 1204.9 1208.3 1215.6 1228.9 6157.6 6212.7 6218.6 6225.4 6255.1 10833.7 10998.3 11034.7 11122.8 11128.1 9051.7 10643.0 10816.5 10978.0 11017.5 8293.5 8397.1 8442.7 8468.1 8486.9 7879.1 7944.9 7957.6 7990.8 8016.4 9528.8 9660.3 9678.3 9802.0 9952.6 10028.8 10243.5 10269.8 10298.7 10312.3 7049.1 7075.6 7113.0 7145.2 7146.7 8243.5 8326.3 8364.5 8401.2 8437.2 6800.4 7386.6 7786.0 7938.9 8103.6 7551.8 7554.9 7566.9 7604.1 7643.9 5967.5 7465.6 7467.8 7540.2 7669.4 6927.4 6953.1 6959.5 6973.6 7014.1 7105.8 7110.3 7152.2 7157.2 7159.1 03:10:44 INFO - PROCESS | 2339 | 03:10:44 INFO - PROCESS | 2339 | [#4] prototype.html Cycles:180 Average:5993.65 Median:6775.68 stddev:1979.78 (29.2%) stddev-sans-first:1938.62 03:10:44 INFO - PROCESS | 2339 | Values: 297.5 298.3 333.7 334.1 341.9 5504.4 6800.8 6820.5 6854.4 6908.9 6880.5 6937.1 6953.9 6956.0 6957.4 4134.6 5099.4 5107.1 5123.5 5126.9 3453.9 5034.8 5088.4 5107.3 5120.0 4821.0 4830.5 4838.4 4840.6 4841.1 4803.9 4807.6 4814.8 4820.3 4840.5 3968.3 4069.7 4073.7 4152.6 4170.0 6488.8 6515.9 6549.5 6590.0 6597.4 5884.6 5897.6 5902.2 5903.2 5904.8 7075.6 7326.2 7357.9 7364.5 7391.1 4356.7 4638.3 4694.8 4695.4 4707.6 7696.1 7807.2 7815.2 7823.3 7830.6 4643.9 4706.0 4730.2 4745.5 4762.0 4850.5 4852.3 4867.0 4870.3 4877.5 5868.2 5878.5 5880.5 5892.2 5898.0 7195.6 7406.2 7406.4 7421.6 7424.2 1397.8 1663.5 1684.9 1685.3 1689.7 922.4 1048.1 1058.7 1075.9 1078.3 6735.4 6764.6 6765.8 6772.9 6787.8 6446.7 6881.4 6974.0 7724.2 7754.9 6545.8 6738.7 6743.3 6750.0 6819.7 3928.8 4013.5 4059.8 4064.9 4104.4 7910.1 8078.0 8107.9 8134.2 8136.5 6778.4 7785.8 8053.3 8063.2 8070.1 6641.5 7705.7 8093.6 8109.9 8121.4 7784.8 7796.8 7809.2 7815.9 7824.5 6623.8 7370.6 7402.5 7655.6 7662.8 8112.4 8118.3 8119.1 8145.1 8148.7 4761.7 4792.6 4800.1 4809.2 4830.7 7515.0 7747.7 7750.7 7768.5 7776.7 7455.9 7479.5 7479.9 7487.1 7513.4 7269.2 7362.1 7407.0 7408.0 7414.9 7276.1 7280.7 7287.8 7312.3 7344.1 7404.3 7443.0 7444.6 7454.0 7469.8 7067.9 7255.7 7278.1 7290.1 7298.1 03:10:44 INFO - PROCESS | 2339 | 03:10:44 INFO - PROCESS | 2339 | [#5] yui.html Cycles:180 Average:18155.38 Median:606.61 stddev:25249.01 (4162.3%) stddev-sans-first:25285.73 03:10:44 INFO - PROCESS | 2339 | Values: 677.3 713.5 717.8 734.2 743.5 13196.6 14399.9 14829.9 15031.8 15188.5 15566.0 15876.1 15877.0 15919.6 15939.6 686.4 851.3 852.0 869.4 872.4 841.1 850.7 855.5 860.8 870.2 881.6 894.2 903.1 907.1 920.8 879.8 895.1 898.2 899.6 915.8 651.8 657.5 663.9 670.4 672.2 15239.0 15322.2 15326.9 15414.0 15421.5 12512.5 12604.2 12733.7 12925.9 13177.7 10275.5 10283.7 10319.9 10734.9 11108.7 2782.9 3512.1 3512.1 3594.8 3640.9 67394.3 75908.0 77689.1 78510.4 78758.0 8637.7 9316.2 9397.5 9428.9 9769.2 20088.8 20382.0 20600.2 20601.6 20661.7 5804.2 6709.8 7279.6 7529.0 7580.6 3530.9 3582.0 4135.8 4136.0 4264.5 3500.2 3519.2 3524.2 3548.2 3565.6 553.3 639.0 651.7 653.2 658.4 561.9 610.8 629.2 630.9 633.6 8406.5 8482.5 8662.1 8703.5 8821.5 509.8 530.6 588.3 602.4 653.7 3796.7 3849.6 3978.5 4048.4 4165.9 88909.6 90424.1 90460.0 91013.0 96855.0 77187.0 77564.2 78193.6 78568.0 79684.2 66427.0 67930.0 69397.0 70661.6 73302.3 8088.9 8089.9 8824.3 8870.5 8925.6 45738.0 46305.3 47144.5 47258.5 48693.5 66750.3 67094.0 68408.6 70670.3 72347.8 11117.2 11181.0 11264.5 11445.3 11916.3 11776.8 12064.2 12291.9 12362.5 12402.3 11228.8 11796.9 11805.4 11890.6 11893.3 11348.3 11496.0 11797.4 11799.6 11862.0 11314.0 11513.0 11631.8 11653.8 11841.9 9223.4 9239.9 9490.2 9756.3 9759.6 9791.7 10058.2 10069.7 10072.9 10073.7 03:10:44 INFO - PROCESS | 2339 | -------- Summary: end -------- 03:10:44 INFO - PROCESS | 2339 | 03:10:45 INFO - TEST-INFO | 2339: exit 0 03:10:45 INFO - TEST-OK | dromaeo_css | took 1110044ms 03:10:45 INFO - TEST-START | kraken 03:10:45 INFO - operating with platform_type : mac_ 03:10:45 INFO - Initialising browser for kraken test... 03:10:45 INFO - TEST-INFO | started process 2344 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/tmpXjK3ZJ/profile http://localhost:50120/getInfo.html) 03:10:47 INFO - PROCESS | 2344 | __metrics Screen width/height:1600/1200 03:10:47 INFO - PROCESS | 2344 | colorDepth:24 03:10:47 INFO - PROCESS | 2344 | Browser inner width/height: 1024/689 03:10:47 INFO - PROCESS | 2344 | __metrics 03:10:47 INFO - PROCESS | 2344 | 03:10:47 INFO - PROCESS | 2344 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 03:10:47 INFO - PROCESS | 2344 | 03:10:48 INFO - TEST-INFO | 2344: exit 0 03:10:48 INFO - Browser initialized. 03:10:48 INFO - Running cycle 1/1 for kraken test... 03:10:48 INFO - TEST-INFO | started process 2347 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/T/tmpXjK3ZJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:00 INFO - PROCESS | 2347 | RSS: Main: 259203072 03:11:00 INFO - PROCESS | 2347 | 03:11:03 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50120/tests/kraken/driver.html?testName=audio-beat-detection) 03:11:03 INFO - PROCESS | 2347 | RSS: Main: 269762560 03:11:03 INFO - PROCESS | 2347 | 03:11:06 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50120/tests/kraken/driver.html?testName=audio-dft) 03:11:06 INFO - PROCESS | 2347 | RSS: Main: 279564288 03:11:06 INFO - PROCESS | 2347 | 03:11:10 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50120/tests/kraken/driver.html?testName=audio-fft) 03:11:11 INFO - PROCESS | 2347 | RSS: Main: 283185152 03:11:11 INFO - PROCESS | 2347 | 03:11:12 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50120/tests/kraken/driver.html?testName=audio-oscillator) 03:11:13 INFO - PROCESS | 2347 | RSS: Main: 285425664 03:11:13 INFO - PROCESS | 2347 | 03:11:15 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50120/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:11:16 INFO - PROCESS | 2347 | RSS: Main: 284778496 03:11:16 INFO - PROCESS | 2347 | 03:11:19 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50120/tests/kraken/driver.html?testName=imaging-darkroom) 03:11:19 INFO - PROCESS | 2347 | RSS: Main: 286257152 03:11:19 INFO - PROCESS | 2347 | 03:11:22 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50120/tests/kraken/driver.html?testName=imaging-desaturate) 03:11:23 INFO - PROCESS | 2347 | RSS: Main: 285855744 03:11:23 INFO - PROCESS | 2347 | 03:11:25 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50120/tests/kraken/driver.html?testName=json-parse-financial) 03:11:26 INFO - PROCESS | 2347 | RSS: Main: 286494720 03:11:26 INFO - PROCESS | 2347 | 03:11:28 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50120/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:11:28 INFO - PROCESS | 2347 | RSS: Main: 285671424 03:11:28 INFO - PROCESS | 2347 | 03:11:30 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50120/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:11:31 INFO - PROCESS | 2347 | RSS: Main: 284872704 03:11:31 INFO - PROCESS | 2347 | 03:11:33 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50120/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:11:33 INFO - PROCESS | 2347 | RSS: Main: 285286400 03:11:33 INFO - PROCESS | 2347 | 03:11:36 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:11:37 INFO - PROCESS | 2347 | RSS: Main: 285069312 03:11:37 INFO - PROCESS | 2347 | 03:11:39 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:11:40 INFO - PROCESS | 2347 | RSS: Main: 285204480 03:11:40 INFO - PROCESS | 2347 | 03:11:41 INFO - PROCESS | 2347 | Cycle 1(1): loaded http://localhost:50120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50120/tests/kraken/driver.html?testName=ai-astar) 03:11:42 INFO - PROCESS | 2347 | RSS: Main: 286941184 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | __start_tp_report 03:11:42 INFO - PROCESS | 2347 | _x_x_mozilla_page_load 03:11:42 INFO - PROCESS | 2347 | _x_x_mozilla_page_load_details 03:11:42 INFO - PROCESS | 2347 | |i|pagename|runs| 03:11:42 INFO - PROCESS | 2347 | |0;ai-astar;117;114;159;115;116;128;114;115;115;115 03:11:42 INFO - PROCESS | 2347 | |1;audio-beat-detection;154;147;184;161;123;142;139;121;160;124 03:11:42 INFO - PROCESS | 2347 | |2;audio-dft;189;198;206;278;257;264;267;209;202;199 03:11:42 INFO - PROCESS | 2347 | |3;audio-fft;72;75;72;111;59;54;59;60;125;86 03:11:42 INFO - PROCESS | 2347 | |4;audio-oscillator;80;86;123;77;67;115;156;85;78;161 03:11:42 INFO - PROCESS | 2347 | |5;imaging-gaussian-blur;85;92;86;93;87;91;86;91;87;91 03:11:42 INFO - PROCESS | 2347 | |6;imaging-darkroom;95;95;95;95;96;93;95;105;140;95 03:11:42 INFO - PROCESS | 2347 | |7;imaging-desaturate;92;92;91;136;151;100;99;91;93;93 03:11:42 INFO - PROCESS | 2347 | |8;json-parse-financial;55;58;54;57;54;58;57;65;69;86 03:11:42 INFO - PROCESS | 2347 | |9;json-stringify-tinderbox;69;68;72;68;76;71;71;68;67;67 03:11:42 INFO - PROCESS | 2347 | |10;stanford-crypto-aes;84;85;85;82;86;85;88;92;85;85 03:11:42 INFO - PROCESS | 2347 | |11;stanford-crypto-ccm;146;121;128;147;132;132;113;134;145;145 03:11:42 INFO - PROCESS | 2347 | |12;stanford-crypto-pbkdf2;139;140;141;142;138;127;136;141;138;130 03:11:42 INFO - PROCESS | 2347 | |13;stanford-crypto-sha256-iterative;70;68;68;68;70;69;66;69;67;69 03:11:42 INFO - PROCESS | 2347 | __end_tp_report 03:11:42 INFO - PROCESS | 2347 | __start_cc_report 03:11:42 INFO - PROCESS | 2347 | _x_x_mozilla_cycle_collect,917 03:11:42 INFO - PROCESS | 2347 | __end_cc_report 03:11:42 INFO - PROCESS | 2347 | __startTimestamp1455102702094__endTimestamp 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | ------- Summary: start ------- 03:11:42 INFO - PROCESS | 2347 | Number of tests: 14 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#0] ai-astar Cycles:10 Average:120.80 Median:115.50 stddev:14.05 (12.2%) stddev-sans-first:14.83 03:11:42 INFO - PROCESS | 2347 | Values: 117.0 114.0 159.0 115.0 116.0 128.0 114.0 115.0 115.0 115.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:150.50 stddev:20.08 (13.3%) stddev-sans-first:21.07 03:11:42 INFO - PROCESS | 2347 | Values: 154.0 147.0 184.0 161.0 123.0 142.0 139.0 121.0 160.0 124.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#2] audio-dft Cycles:10 Average:226.90 Median:233.00 stddev:34.85 (15.0%) stddev-sans-first:34.16 03:11:42 INFO - PROCESS | 2347 | Values: 189.0 198.0 206.0 278.0 257.0 264.0 267.0 209.0 202.0 199.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#3] audio-fft Cycles:10 Average:77.30 Median:66.00 stddev:23.71 (35.9%) stddev-sans-first:25.07 03:11:42 INFO - PROCESS | 2347 | Values: 72.0 75.0 72.0 111.0 59.0 54.0 59.0 60.0 125.0 86.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:77.50 stddev:34.08 (44.0%) stddev-sans-first:35.14 03:11:42 INFO - PROCESS | 2347 | Values: 80.0 86.0 123.0 77.0 67.0 115.0 156.0 85.0 78.0 161.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#5] imaging-gaussian-blur Cycles:10 Average:88.90 Median:91.00 stddev:2.96 (3.3%) stddev-sans-first:2.78 03:11:42 INFO - PROCESS | 2347 | Values: 85.0 92.0 86.0 93.0 87.0 91.0 86.0 91.0 87.0 91.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#6] imaging-darkroom Cycles:10 Average:100.40 Median:95.00 stddev:14.29 (15.0%) stddev-sans-first:15.02 03:11:42 INFO - PROCESS | 2347 | Values: 95.0 95.0 95.0 95.0 96.0 93.0 95.0 105.0 140.0 95.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#7] imaging-desaturate Cycles:10 Average:103.80 Median:92.00 stddev:21.45 (23.3%) stddev-sans-first:22.32 03:11:42 INFO - PROCESS | 2347 | Values: 92.0 92.0 91.0 136.0 151.0 100.0 99.0 91.0 93.0 93.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:58.00 stddev:9.93 (17.1%) stddev-sans-first:10.27 03:11:42 INFO - PROCESS | 2347 | Values: 55.0 58.0 54.0 57.0 54.0 58.0 57.0 65.0 69.0 86.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:2.83 (4.0%) stddev-sans-first:2.99 03:11:42 INFO - PROCESS | 2347 | Values: 69.0 68.0 72.0 68.0 76.0 71.0 71.0 68.0 67.0 67.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.67 (3.1%) stddev-sans-first:2.76 03:11:42 INFO - PROCESS | 2347 | Values: 84.0 85.0 85.0 82.0 86.0 85.0 88.0 92.0 85.0 85.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:139.50 stddev:11.59 (8.3%) stddev-sans-first:11.49 03:11:42 INFO - PROCESS | 2347 | Values: 146.0 121.0 128.0 147.0 132.0 132.0 113.0 134.0 145.0 145.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:139.50 stddev:4.96 (3.6%) stddev-sans-first:5.22 03:11:42 INFO - PROCESS | 2347 | Values: 139.0 140.0 141.0 142.0 138.0 127.0 136.0 141.0 138.0 130.0 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - PROCESS | 2347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:1.20 03:11:42 INFO - PROCESS | 2347 | Values: 70.0 68.0 68.0 68.0 70.0 69.0 66.0 69.0 67.0 69.0 03:11:42 INFO - PROCESS | 2347 | -------- Summary: end -------- 03:11:42 INFO - PROCESS | 2347 | 03:11:42 INFO - TEST-INFO | 2347: exit 0 03:11:42 INFO - TEST-OK | kraken | took 57749ms 03:11:42 INFO - SUITE-END | took 1167s 03:11:43 INFO - Completed test suite (00:19:28) 03:11:43 INFO - Working with test: dromaeo_css 03:11:43 INFO - Generating results file: dromaeo_css 03:11:43 INFO - Working with test: kraken 03:11:43 INFO - Generating results file: kraken 03:11:43 INFO - javascript benchmark 03:11:43 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:11:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 03:11:43 INFO - process_Request line: dromaeo_css 7517.34 graph.html#tests=[[72,64,61]] 03:11:43 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:11:43 INFO - process_Request line: kraken 1523.00 graph.html#tests=[[232,64,61]] 03:11:43 INFO - RETURN: dromaeo_css: 7517.34 03:11:43 INFO - RETURN: kraken: 1523.00 03:11:43 INFO - javascript benchmark 03:11:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3466.3933811582974, 3511.2450823073036, 3537.1157210697324, 3564.8217589120554, 3582.943031805616, 5697.857553561158, 5781.479666829984, 5782.392848750884, 5798.217240672508, 5807.867465844162, 5634.098544232924, 5692.288463942007, 5769.394213607574, 5792.739326730297, 5846.03540415832, 3945.9210815783813, 4619.722816631013, 4891.510848915115, 5156.1234590119675, 5197.688138711689, 313.0666691275198, 5120.385553733558, 5166.276721259027, 5203.4536373680785, 5308.787648494055, 4762.452317983441, 4767.642426818003, 5164.819231326905, 5193.740312984354, 5278.419373868871, 4662.277347011219, 4889.899772551183, 5221.39953905302, 5246.8688282792855, 5251.4485978972425, 5130.07658621448, 5148.0, 5152.124138896359, 5191.714455704935, 5221.895562088775, 4895.7062576245535, 5530.198121272433, 5643.7460314285545, 5669.716514174274, 5761.740721667535, 6118.010103775202, 6220.844478888019, 6293.30773614902, 6300.054991751228, 6302.401271879165, 6174.876502469971, 6257.2491301044165, 6262.185915830958, 6282.465990390822, 6289.37106289372, 5839.532837373, 5901.434127973672, 5925.111233314951, 5933.199018132583, 5967.701614919237, 6189.6286222825875, 6241.34465881085, 6326.367363263636, 6341.175647165931, 6359.141515895388, 6211.3478084801345, 6230.719617617218, 6242.500599951993, 6252.968735156386, 6268.717907694165, 6197.411245931629, 6269.8746025079245, 6280.497560195174, 6295.685215739195, 6299.811005669837, 6129.603311142676, 6188.164597779242, 6228.03465462854, 6275.309715931244, 6285.96857015712, 6214.223222097238, 6238.095476155932, 6244.65654389013, 6261.499080073583, 6267.310595834546, 4862.027594481118, 4883.316335713003, 4938.530839570235, 4962.627802914796, 4972.875678108004, 4415.271480205794, 4457.910841783146, 4463.218936686067, 4473.821047158142, 4498.797554110073, 4334.5882141196535, 5714.5999780015, 5741.024025915604, 5818.359980402152, 5823.2429784128635, 6158.599691020069, 6196.845078873064, 6224.782132625336, 6238.656873871981, 6240.469560087353, 5816.069428891357, 5836.88326233473, 5839.386864379179, 5843.503302219274, 5849.532037436995, 5351.598630102758, 5448.182772584065, 5453.727313634303, 5471.0, 5473.644213126134, 6328.240611126695, 6413.6793160341795, 6415.06981487691, 6455.160829092282, 6481.967590162019, 6219.626822390671, 6234.501239900706, 6274.717637706405, 6291.96854015727, 6303.46420554258, 6176.474999625082, 6331.27190373113, 6427.775027874002, 6440.8389790255615, 6451.41937225652, 6180.258368995569, 6180.938190618036, 6200.100985357008, 6209.130721698875, 6218.06728990655, 6227.034809604518, 6230.59501132425, 6233.283172435228, 6238.812835614939, 6246.406591373812, 4579.542045795394, 5224.190250511177, 5345.732713364238, 6096.725647345791, 6115.785947491817, 5034.345535080416, 6184.5052395809125, 6219.284782250099, 6219.533534984985, 6223.190985171898, 5892.175095486549, 6074.605150665193, 6110.083487476736, 6112.541559382975, 6119.694015299128, 6013.879722405615, 6113.083037544404, 6114.936124487681, 6119.837693858789, 6138.094643526033, 6087.847803804763, 6091.634501929899, 6096.420840020191, 6100.816975490742, 6108.725107370268], "unit": "score", "name": "dojo.html", "value": 5648.944202833444}, {"lowerIsBetter": false, "replicates": [472.3151430425883, 506.31394460506016, 515.2863284351174, 558.9357223919251, 561.3292115921475, 37318.0, 37784.62215377845, 37806.29871655779, 37927.24145517088, 37994.86015419542, 34792.956211313634, 35868.820655896685, 38943.610563894355, 38947.61052389475, 39113.80443097788, 9435.056494350561, 9619.90380096197, 9665.178459830922, 9687.32188746788, 9733.415995040285, 9584.424934503952, 9743.220542356594, 9749.610015599403, 9758.0, 9762.560684769167, 9694.66068687596, 9767.853482197737, 9788.021197880225, 9797.0, 9798.608055677765, 9649.324547281658, 9712.562934667956, 9726.881408638026, 9746.074122958307, 9772.21822254218, 9542.475163865985, 9638.132568068837, 9639.325247232626, 9644.75888102803, 9661.90338096617, 38408.80795596032, 38422.0, 38646.22707545834, 38666.806665966775, 38776.0, 3342.1143396999814, 3472.322897035079, 3614.36748569002, 3734.402495600718, 4027.7180597358197, 29137.980170694136, 29280.414391712045, 29539.0, 29587.0, 30050.098497045125, 2881.683014868363, 2881.9423611527864, 2893.3345330573875, 2897.5798509216047, 3000.939981200386, 496003.0, 497598.51200743765, 499109.0, 499493.0, 500708.0, 53413.0, 54825.725871370385, 64543.70912581722, 65055.67472162609, 65948.34051659422, 62543.374566253755, 62783.0, 63050.68474657597, 63271.0, 63470.68264658647, 15702.0, 15806.92096539533, 15841.287142078403, 16016.75974860378, 16025.118618475863, 12181.208221465577, 12184.147109702413, 12236.143469957196, 12237.816432753516, 12297.262164269994, 19901.60196796056, 20122.496937576678, 20221.59556808885, 20340.186392544427, 20360.389188324374, 8155.5514446706, 8298.543580103153, 8323.500589964622, 8324.916750832414, 8364.247217750431, 898.4519443139679, 1043.9530221140067, 1059.2055958031476, 1079.740862193068, 1133.4049623947328, 26150.692465377037, 27972.0, 29442.11673649794, 29727.851360743058, 29942.0, 1022.7187523431116, 1067.658349328223, 1081.0972837680467, 1149.5514553999926, 1215.076541828217, 11602.593909213138, 13725.519606813714, 13745.862541374458, 13848.307584620728, 14047.508337208148, 560293.0, 560481.0, 562529.0, 564999.0, 568138.0, 54220.0, 54244.18633720497, 54286.0, 54366.0, 54407.72796135994, 1408.7816388459805, 1419.1130543410368, 1452.0561634937164, 1454.7163303155783, 1466.0690461556776, 23895.44991307509, 27861.16416507508, 28272.0, 28521.001764938126, 28686.42627147487, 49094.77263068452, 49148.508514915826, 49287.26069109038, 49313.50686493233, 49550.50449495459, 518447.0, 523675.0, 524738.376308116, 525242.0, 525727.371363156, 30414.783408663407, 31752.0, 33213.16967075843, 33337.499937501445, 33363.0, 40677.389839151845, 41514.58485415228, 41610.0, 41610.79194604129, 41914.7425577221, 34155.65844341624, 35180.47229291512, 35433.114172145906, 35442.46836297406, 35626.28747424985, 34193.31613367768, 34845.825770870986, 34867.0, 34916.47625285674, 35028.82485587556, 24975.750242497343, 34727.305453891284, 34827.65172348244, 34887.0, 36241.818790905876, 31029.913953011535, 31246.531302030944, 31252.843735781174, 31254.53118203183, 31470.055898323088, 23554.175603853782, 24340.0, 24393.0, 24532.141375051786, 24802.751972480044], "unit": "score", "name": "ext.html", "value": 19493.338492076375}, {"lowerIsBetter": false, "replicates": [325.86476612205934, 359.9316129935312, 368.1312103435891, 369.36284908532804, 372.3818461354153, 15470.149141797197, 18560.443186704404, 19069.904650476747, 19586.90206548969, 20048.59902801945, 10464.05823475887, 11201.327920324786, 11586.0, 11978.820317695241, 19103.662743607954, 5209.843704688866, 5451.836444906659, 5966.045432730764, 6021.969890150565, 6031.366706495821, 5778.768849246047, 5920.200772895647, 5981.910271345933, 6027.427394397547, 6051.6671583063135, 3917.7649341039487, 5849.151872978416, 5914.260717410324, 5938.940610593903, 5940.495057920082, 5839.0, 5937.1984782054515, 6027.668478233695, 6038.969805150968, 6081.695915204245, 5278.47215278473, 5431.755570999315, 5484.862878428032, 5533.280673512418, 5533.833984980457, 15480.303386347641, 23942.162024329064, 24051.87974060136, 24092.277231683078, 24334.26997190087, 1967.9508012299664, 2147.076756994492, 2157.6979222908803, 2173.978260217393, 2340.2862127051244, 8109.594520273963, 9631.470269135194, 9889.357191782512, 10895.346279223271, 14585.489507867174, 1768.7081631530782, 1783.144090836406, 1803.134495442182, 1817.8545716342794, 1835.6879330513846, 70419.0, 85837.0, 95687.0, 98190.0180998188, 98234.01765982392, 9407.4825884577, 11201.495932683049, 11208.495617697223, 11261.930116638907, 11333.26333788301, 13196.670083247804, 13473.393697283645, 13478.123921945238, 13483.797743033861, 13545.322733863268, 8335.54154521495, 8360.0, 8394.034686011064, 8443.197896199852, 8468.49189048659, 8431.114732953074, 8447.98624165104, 8486.40595158333, 8531.146885311418, 8569.914300857037, 4383.07955329378, 4455.376247325377, 4458.8439404620685, 4479.216137175981, 4496.033352829158, 1661.8919770214898, 1761.8326259005373, 1791.5252458098614, 1883.3408307092682, 1897.3928342930406, 637.9521535884827, 764.6176911544228, 864.2524216552762, 953.9379940303858, 1021.5403068619152, 15455.845441545665, 18994.52513687169, 19005.0, 19271.614567708846, 19465.513362165777, 928.7863791328033, 936.0125068053134, 936.9812603747887, 948.5304774136708, 1027.2706378471369, 10723.14214862809, 10841.903433850539, 10885.0, 11268.774624507463, 11323.32060076398, 721932.0, 761577.0, 774138.0, 775448.0, 785120.0, 114490.42754786173, 117831.0, 119249.0, 119446.40276798561, 121003.39498302453, 1115.8549388579434, 1174.9236299640495, 1184.265755231762, 1186.0570846177309, 1198.646399312205, 17401.738973915653, 17785.377511787025, 17791.110444477985, 18534.81465185331, 18700.81299186991, 31785.0, 48523.75738121287, 49224.75387623039, 50596.24105638492, 53941.73029134829, 67749.0, 68488.3151168482, 69469.0, 69641.0, 70360.64819675869, 7618.619069046415, 7796.88304675419, 7825.491343062683, 7837.902693622783, 7987.081485628994, 10251.0, 11960.64118076459, 12213.45039473208, 12226.694332641755, 12264.386780660752, 9249.12133347331, 10133.08802207805, 10282.845757313797, 10477.476126193507, 10588.205884558534, 10030.89969100329, 10363.274570779973, 10444.843327349943, 10465.848756636917, 10480.004399582027, 10568.84146737815, 10601.0, 10618.469076545987, 10688.465576721288, 10704.839427408751, 6420.967895160495, 7121.0, 7319.121705395173, 7596.354309883722, 7706.730264440717, 8540.44487108336, 10755.892441075803, 10776.67669969902, 10851.891481085087, 10898.291611045257], "unit": "score", "name": "jquery.html", "value": 9061.811651814452}, {"lowerIsBetter": false, "replicates": [1300.577312373479, 1477.2318394434892, 1623.6184496643293, 1670.7326827707561, 1675.2210222246654, 6536.771213007546, 8654.870176947335, 8792.252658524025, 8961.148690874365, 9008.639654413824, 8654.480731156134, 8748.868766968484, 8811.986621538525, 8837.204651581356, 8846.11538846115, 2485.5526005319034, 2498.3004758667603, 2506.3608779761134, 2522.5207210629924, 2523.3313172009434, 2473.1096805150223, 2537.8477291362483, 2538.2765911715164, 2544.910928117516, 2545.4654522550286, 2209.5028618560855, 2466.728659847415, 2490.252924122765, 2517.3832411059225, 2525.318164095693, 2496.8252222344445, 2498.4003839078673, 2518.9496210075786, 2522.445062086338, 2524.886380112899, 2466.802655787533, 2499.1003238834005, 2512.2337687005456, 2521.0798058708624, 2521.5209110269175, 8680.392372533925, 8761.34289928258, 8763.298936085097, 8766.772651828685, 8770.517621530813, 5380.650257733235, 5529.115341545334, 5547.0, 5577.721113944327, 5581.7209139543265, 3618.240169564395, 3642.7450078494517, 3699.7965111918834, 3805.7145714071557, 3812.980935095307, 1061.4851796878509, 1076.2573824061374, 1076.682378698278, 1112.6161474291357, 1113.6659002299277, 10147.289689721649, 11804.350760708157, 11862.525498980116, 12027.759444811143, 12091.0, 4950.480199578992, 4956.157453232959, 5032.823851165192, 5063.215201643751, 5101.9489805101475, 10224.386536807666, 10228.59085636581, 10270.794584108276, 10277.383356998604, 10347.63783267582, 4205.915881682349, 4591.977040114778, 5195.064888320138, 5551.139573366135, 5581.5255703265675, 5006.424261210008, 5045.84862454127, 5047.671901326402, 5056.342675452242, 5060.84817455477, 3759.4172903200047, 3854.0557563397147, 3866.0721426857353, 3866.8839934802, 3868.2650296443585, 1150.2810743285447, 1174.4890972427022, 1178.4932479033926, 1180.8405865208088, 1215.1311812054246, 958.434523631061, 1115.7712668902855, 1175.371176420628, 1233.784087784634, 1338.2505796753849, 8004.79988000293, 8037.075736290284, 8042.839143217103, 8160.224778646019, 8198.713045043394, 1198.7482628647908, 1204.9397530123458, 1208.317300725105, 1215.5867005218267, 1228.9201201921846, 6157.630542167484, 6212.72042758077, 6218.595791273553, 6225.3774622538285, 6255.0617407388345, 10833.67498975032, 10998.34009959405, 11034.668959931216, 11122.777544449065, 11128.05411540012, 9051.728448146434, 10643.042126208678, 10816.459177041117, 10978.011978921935, 11017.504212310465, 8293.502389856629, 8397.118302578263, 8442.662293508314, 8468.110848360957, 8486.915130848613, 7879.0939042010905, 7944.920550794418, 7957.562334071682, 7990.840183196187, 8016.358691304798, 9528.761780955532, 9660.275479338938, 9678.274129440179, 9801.950990245003, 9952.601895924083, 10028.799424011624, 10243.48782560884, 10269.794604108025, 10298.691039268833, 10312.329698569569, 7049.08361912948, 7075.610841403773, 7113.03973963529, 7145.21402645719, 7146.714131434893, 8243.505389676639, 8326.25063744266, 8364.498130112213, 8401.15988401155, 8437.240648341678, 6800.421964132906, 7386.556806591621, 7785.961070194613, 7938.880916786137, 8103.554304513308, 7551.848963020599, 7554.924450755642, 7566.924330756622, 7604.12552556441, 7643.88534171999, 5967.492763115184, 7465.58939258346, 7467.813304667427, 7540.245975402416, 7669.424793140648, 6927.411170050401, 6953.061336719478, 6959.478039146983, 6973.6164510952385, 7014.053102831256, 7105.82235444118, 7110.288971102848, 7152.177499587614, 7157.1769246537315, 7159.105111861018], "unit": "score", "name": "mootools.html", "value": 4948.78791561752}, {"lowerIsBetter": false, "replicates": [297.47198722267973, 298.2870938457088, 333.66966702964066, 334.06128778133444, 341.9367417027852, 5504.394516603175, 6800.795976120712, 6820.454363650909, 6854.417374523172, 6908.861822763542, 6880.483963702717, 6937.098177236965, 6953.860922781541, 6956.0, 6957.373836354727, 4134.607212314825, 5099.439061703219, 5107.106256405133, 5123.487651234884, 5126.871828204287, 3453.8618455261885, 5034.848954531351, 5088.389393272812, 5107.336046313974, 5119.974400127994, 4820.975895120519, 4830.468648448667, 4838.419389673227, 4840.6127509799135, 4841.055994081155, 4803.879903002418, 4807.615390768748, 4814.831480898151, 4820.276958456225, 4840.515948405131, 3968.305546529346, 4069.7151199416053, 4073.674106071507, 4152.647025002879, 4169.958300416987, 6488.837779055514, 6515.93484065158, 6549.508786841006, 6589.967050164766, 6597.373249541286, 5884.588078834483, 5897.616654917417, 5902.173695682565, 5903.203067585864, 5904.793332233351, 7075.646217689146, 7326.157491888448, 7357.889631655529, 7364.484486085976, 7391.113066432009, 4356.6514678825615, 4638.257878739386, 4694.812207511695, 4695.366125573072, 4707.646926480494, 7696.114946781136, 7807.180246074194, 7815.218478152196, 7823.295903368724, 7830.647620857075, 4643.86068417948, 4706.0, 4730.2431610942085, 4745.477997420281, 4762.0, 4850.5149485051215, 4852.296417019583, 4867.0, 4870.342503762017, 4877.463479017305, 5868.23712917318, 5878.5297176225795, 5880.529557635379, 5892.234009578813, 5898.026825573818, 7195.604241766649, 7406.185319614838, 7406.444516661164, 7421.628918554159, 7424.220456851953, 1397.76936805428, 1663.4760050584027, 1684.8567871730795, 1685.292177285543, 1689.6705142497094, 922.4327038871046, 1048.0567489259727, 1058.7088550648634, 1075.9408232547285, 1078.2667785905503, 6735.4274886635185, 6764.594124352555, 6765.830854228585, 6772.93227067723, 6787.830304242433, 6446.677666116675, 6881.380675739108, 6974.0236366908675, 7724.188960159102, 7754.9224507755325, 6545.803625891231, 6738.696758645775, 6743.291954344723, 6749.966250168718, 6819.659017049227, 3928.783916884599, 4013.478247827764, 4059.7564146151326, 4064.898377540526, 4104.445899803548, 7910.129885712567, 8078.0, 8107.878381824277, 8134.227248411392, 8136.4711293766895, 6778.423833974069, 7785.766427007085, 8053.31546818527, 8063.153368896299, 8070.071941726659, 6641.501887358468, 7705.730299439493, 8093.55485448306, 8109.918900810916, 8121.390895682847, 7784.805379865548, 7796.805079873048, 7809.180036096128, 7815.882761758465, 7824.530528168328, 6623.834404139935, 7370.6314684266645, 7402.518836275625, 7655.57894315818, 7662.846743064996, 8112.391570632109, 8118.3099436548555, 8119.147489513753, 8145.063317718538, 8148.674053037812, 4761.738104404291, 4792.616590672668, 4800.06398752254, 4809.206480930748, 4830.661853670209, 7514.962425188058, 7747.690092396467, 7750.651220694969, 7768.53388796674, 7776.7278145264645, 7455.888161677688, 7479.513831600929, 7479.887801683088, 7487.101547814297, 7513.361364284097, 7269.157144830639, 7362.116546014512, 7407.0, 7408.0, 7414.8887766682465, 7276.090488688914, 7280.67236974348, 7287.781366559012, 7312.305330993547, 7344.081989751281, 7404.259574042552, 7442.96278518604, 7444.627768611439, 7453.993710849183, 7469.775906722807, 7067.929320706727, 7255.746048888263, 7278.09023872016, 7290.05229320185, 7298.051253337032], "unit": "score", "name": "prototype.html", "value": 5316.318672899183}, {"lowerIsBetter": false, "replicates": [677.3328271652422, 713.4898547538515, 717.8026042838216, 734.2473964186707, 743.4684200796429, 13196.604101876936, 14399.92000599954, 14829.925850370746, 15031.849681503181, 15188.544343669693, 15566.0, 15876.126813025308, 15877.0, 15919.602009949727, 15939.601509962256, 686.3513979289548, 851.29342645604, 852.0074113657581, 869.4001139213954, 872.4416373520952, 841.0958219913587, 850.689498333107, 855.5251835231444, 860.806318578318, 870.190722627959, 881.5504092912629, 894.1952242981304, 903.0878812399491, 907.0566610724838, 920.7974245665943, 879.810840669256, 895.136193573205, 898.2409863665192, 899.6266549381966, 915.7847905742178, 651.7555916531301, 657.4575974820744, 663.8871391863395, 670.4234358451728, 672.1967249137283, 15239.0, 15322.15728134952, 15326.923365383213, 15414.0, 15421.460248891235, 12512.499500019989, 12604.180728252633, 12733.74532509354, 12925.870741292561, 13177.736445271137, 10275.537600807907, 10283.691489255334, 10319.896801032044, 10734.892651073545, 11108.666739997812, 2782.9443411131865, 3512.0693016350688, 3512.121969507623, 3594.802285874276, 3640.890773276806, 67394.30422783033, 75908.0, 77689.05777355554, 78510.42979140443, 78758.0, 8637.654493820302, 9316.161545460942, 9397.483138427315, 9428.90571094294, 9769.218462523124, 20088.79467231971, 20382.0, 20600.175992960114, 20601.58796824055, 20661.690074648894, 5804.245448091721, 6709.832254193684, 7279.59962202084, 7529.021227240423, 7580.635485612533, 3530.878978349785, 3581.9641803582153, 4135.7518548887165, 4136.007358234062, 4264.466941632296, 3500.1599616092462, 3519.1554027033326, 3524.2070534129616, 3548.183917698892, 3565.5899571549603, 553.2641586689693, 638.9712462939179, 651.7165033210474, 653.1802587752435, 658.4107224034462, 561.9241402410704, 610.8014895159091, 629.2417636747708, 630.9022101574263, 633.5850018238061, 8406.537640429835, 8482.491050536988, 8662.090480499583, 8703.521306328214, 8821.514816685143, 509.788437798317, 530.5967464726835, 588.314613475305, 602.4216751918208, 653.7189008726293, 3796.6583007529457, 3849.557300910375, 3978.5026871641044, 4048.4332193492933, 4165.895852603649, 88909.55545222232, 90424.09575904289, 90460.0, 91013.0, 96855.0, 77187.0, 77564.22435775683, 78193.60903195561, 78568.0, 79684.20315796883, 66427.0, 67929.98105028429, 69397.0, 70661.64669176622, 73302.26697733061, 8088.87866682012, 8089.948306720089, 8824.338174637056, 8870.53636150028, 8925.598348074482, 45738.0, 46305.305420418044, 47144.528554714016, 47258.527414726785, 48693.5130648689, 66750.33249667441, 67094.0, 68408.63182736417, 70670.29329706637, 72347.82956511313, 11117.22179447431, 11180.993710566088, 11264.549418023187, 11445.313281203154, 11916.344601047025, 11776.82334764962, 12064.155509114278, 12291.938540307241, 12362.505499780267, 12402.25586464815, 11228.831567526657, 11796.882031179579, 11805.350705710925, 11890.643280701594, 11893.345865977455, 11348.319100853974, 11496.0, 11797.410129493319, 11799.646010619352, 11862.0, 11313.981741643292, 11513.021393181674, 11631.825522617337, 11653.825192622287, 11841.940790295994, 9223.400478968846, 9239.907600923905, 9490.240780737386, 9756.268279878896, 9759.609615615296, 9791.657291994747, 10058.195344372287, 10069.748256293651, 10072.899271007196, 10073.748156296151], "unit": "score", "name": "yui.html", "value": 6873.457208440288}], "name": "dromaeo_css", "value": 7517.344437287869}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 114.0, 159.0, 115.0, 116.0, 128.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 120.8}, {"lowerIsBetter": true, "replicates": [154.0, 147.0, 184.0, 161.0, 123.0, 142.0, 139.0, 121.0, 160.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [189.0, 198.0, 206.0, 278.0, 257.0, 264.0, 267.0, 209.0, 202.0, 199.0], "unit": "score", "name": "audio-dft", "value": 226.9}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 72.0, 111.0, 59.0, 54.0, 59.0, 60.0, 125.0, 86.0], "unit": "score", "name": "audio-fft", "value": 77.3}, {"lowerIsBetter": true, "replicates": [80.0, 86.0, 123.0, 77.0, 67.0, 115.0, 156.0, 85.0, 78.0, 161.0], "unit": "score", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 86.0, 93.0, 87.0, 91.0, 86.0, 91.0, 87.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 93.0, 95.0, 105.0, 140.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 100.4}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 91.0, 136.0, 151.0, 100.0, 99.0, 91.0, 93.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 103.8}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 54.0, 57.0, 54.0, 58.0, 57.0, 65.0, 69.0, 86.0], "unit": "score", "name": "json-parse-financial", "value": 61.3}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 72.0, 68.0, 76.0, 71.0, 71.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 82.0, 86.0, 85.0, 88.0, 92.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [146.0, 121.0, 128.0, 147.0, 132.0, 132.0, 113.0, 134.0, 145.0, 145.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.3}, {"lowerIsBetter": true, "replicates": [139.0, 140.0, 141.0, 142.0, 138.0, 127.0, 136.0, 141.0, 138.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 68.0, 70.0, 69.0, 66.0, 69.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1523.0}]} 03:11:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1523.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7517.34"}}} 03:11:43 INFO - Return code: 0 03:11:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:11:43 INFO - # TBPL SUCCESS # 03:11:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:11:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:11:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:11:43 INFO - 2016-02-10 03:11:43.962 screenresolution[2352:31874] starting screenresolution argv=screenresolution get 03:11:43 INFO - 2016-02-10 03:11:43.965 screenresolution[2352:31874] Display 0: 1600x1200x32@60 03:11:43 INFO - 2016-02-10 03:11:43.971 screenresolution[2353:31877] starting screenresolution argv=screenresolution list 03:11:43 INFO - Available Modes on Display 0 03:11:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:11:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:11:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:11:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:11:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:11:44 INFO - Intel Iris: 03:11:44 INFO - Chipset Model: Intel Iris 03:11:44 INFO - Type: GPU 03:11:44 INFO - Bus: Built-In 03:11:44 INFO - VRAM (Dynamic, Max): 1536 MB 03:11:44 INFO - Vendor: Intel (0x8086) 03:11:44 INFO - Device ID: 0x0a2e 03:11:44 INFO - Revision ID: 0x0009 03:11:44 INFO - Displays: 03:11:44 INFO - Display: 03:11:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:11:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:11:44 INFO - Display Serial Number: 1600x1200 60 03:11:44 INFO - Main Display: Yes 03:11:44 INFO - Mirror: Off 03:11:44 INFO - Online: Yes 03:11:44 INFO - Rotation: Supported 03:11:44 INFO - Return code: 0 03:11:44 INFO - Running post-action listener: _resource_record_post_action 03:11:44 INFO - Running post-run listener: _resource_record_post_run 03:11:45 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 217088; Write bytes: 711481856; Read time: 4; Write time: 2102 03:11:45 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399327744; Write bytes: 393627136; Read time: 30141; Write time: 764 03:11:45 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 217088; Write bytes: 302171136; Read time: 4; Write time: 1296 03:11:45 INFO - Running post-run listener: _upload_blobber_files 03:11:45 INFO - Blob upload gear active. 03:11:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:11:45 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:45 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:45 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:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:11:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:11:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:46 INFO - (blobuploader) - INFO - Done attempting. 03:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:47 INFO - (blobuploader) - INFO - Done attempting. 03:11:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:11:47 INFO - Return code: 0 03:11:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:11:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:11:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79227fbba62d795c8d67acfacf174132026f0935e51e696309254a5cbb54238ed4bfbde0a1120d5df162dea2513f801f62aa5a2d98e5ad4e8c6dcc283d05f8f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711b21cf73e9f5b9eebdb0af9401103e93418aafe19aa4038723aa86665a520f15216edb74c322f883eb5e32b95a26164ea586708f1ec4e47712d39ec619b419"} 03:11:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:11:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:11:47 INFO - Contents: 03:11:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79227fbba62d795c8d67acfacf174132026f0935e51e696309254a5cbb54238ed4bfbde0a1120d5df162dea2513f801f62aa5a2d98e5ad4e8c6dcc283d05f8f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711b21cf73e9f5b9eebdb0af9401103e93418aafe19aa4038723aa86665a520f15216edb74c322f883eb5e32b95a26164ea586708f1ec4e47712d39ec619b419"} 03:11:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:11:47 INFO - Copying logs to upload dir... 03:11:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:11:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.821255 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-10 03:11:47.571373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:11:47.574563) ========= 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.2AqqNJz1DG/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.v0AD30VDOc/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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/79227fbba62d795c8d67acfacf174132026f0935e51e696309254a5cbb54238ed4bfbde0a1120d5df162dea2513f801f62aa5a2d98e5ad4e8c6dcc283d05f8f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711b21cf73e9f5b9eebdb0af9401103e93418aafe19aa4038723aa86665a520f15216edb74c322f883eb5e32b95a26164ea586708f1ec4e47712d39ec619b419"} 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.011515 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/79227fbba62d795c8d67acfacf174132026f0935e51e696309254a5cbb54238ed4bfbde0a1120d5df162dea2513f801f62aa5a2d98e5ad4e8c6dcc283d05f8f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711b21cf73e9f5b9eebdb0af9401103e93418aafe19aa4038723aa86665a520f15216edb74c322f883eb5e32b95a26164ea586708f1ec4e47712d39ec619b419"}' ========= master_lag: 0.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:11:47.973494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:11:47.973824) ========= 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.2AqqNJz1DG/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.v0AD30VDOc/Listeners TMPDIR=/var/folders/7f/xbp6nf893fzgb5qdsf08ft4000000w/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.005355 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:11:47.996363) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:11:47.996685) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:11:47.997180) ========= ========= Total master_lag: 0.61 =========