builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0063 starttime: 1456181297.08 results: success (0) buildid: 20160222134758 builduid: a2c18d1816b14ca58e88780b36217dee revision: 786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.078213) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.078900) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.079247) ========= 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.5StHuhadF9/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.PdQuD1Ovqb/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005431 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.104204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.104953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.121929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.122282) ========= 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.5StHuhadF9/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.PdQuD1Ovqb/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005902 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.171787) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.172128) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.172577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.172899) ========= 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.5StHuhadF9/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.PdQuD1Ovqb/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-22 14:48:17-- 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% 218M=0s 2016-02-22 14:48:17 (218 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.314317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.314686) ========= 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.5StHuhadF9/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.PdQuD1Ovqb/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.027436 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:17.561942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-22 14:48:17.562327) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b --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 786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5StHuhadF9/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.PdQuD1Ovqb/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-22 14:48:17,638 truncating revision to first 12 chars 2016-02-22 14:48:17,638 Setting DEBUG logging. 2016-02-22 14:48:17,638 attempt 1/10 2016-02-22 14:48:17,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/786bf7c76f8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 14:48:18,262 unpacking tar archive at: fx-team-786bf7c76f8a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.868507 ========= master_lag: 1.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-22 14:48:19.568153) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:19.571604) ========= echo 786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5StHuhadF9/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.PdQuD1Ovqb/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b program finished with exit code 0 elapsedTime=0.005888 script_repo_revision: '786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:19.601571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:19.601925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 14:48:20.511985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-22 14:48:20.512319) ========= /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.5StHuhadF9/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.PdQuD1Ovqb/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:48:20 INFO - MultiFileLogger online at 20160222 14:48:20 in /builds/slave/test 14:48:20 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 14:48:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:48:20 INFO - {'append_to_log': False, 14:48:20 INFO - 'base_work_dir': '/builds/slave/test', 14:48:20 INFO - 'blob_upload_branch': 'Fx-Team', 14:48:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:48:20 INFO - 'branch': 'Fx-Team', 14:48:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:48:20 INFO - 'config_files': ('talos/mac_config.py',), 14:48:20 INFO - 'default_actions': ('clobber', 14:48:20 INFO - 'read-buildbot-config', 14:48:20 INFO - 'download-and-extract', 14:48:20 INFO - 'populate-webroot', 14:48:20 INFO - 'create-virtualenv', 14:48:20 INFO - 'install', 14:48:20 INFO - 'run-tests'), 14:48:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:48:20 INFO - 'download_minidump_stackwalk': True, 14:48:20 INFO - 'download_symbols': 'ondemand', 14:48:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:48:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:48:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:48:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:48:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:48:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:48:20 INFO - 'installer_path': 'installer.exe', 14:48:20 INFO - 'log_level': 'info', 14:48:20 INFO - 'log_name': 'talos', 14:48:20 INFO - 'log_to_console': True, 14:48:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:48:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:48:20 INFO - 'opt_config_files': (), 14:48:20 INFO - 'pip_index': False, 14:48:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:48:20 INFO - 'cmd': ('bash', 14:48:20 INFO - '-c', 14:48:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:48:20 INFO - 'enabled': True, 14:48:20 INFO - 'halt_on_failure': False, 14:48:20 INFO - 'name': 'check_screen_resolution'},), 14:48:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:48:20 INFO - 'cmd': ('bash', 14:48:20 INFO - '-c', 14:48:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:48:20 INFO - 'enabled': True, 14:48:20 INFO - 'halt_on_failure': False, 14:48:20 INFO - 'name': 'check_screen_resolution'},), 14:48:20 INFO - 'run_cmd_checks_enabled': True, 14:48:20 INFO - 'sps_profile': False, 14:48:20 INFO - 'sps_profile_interval': 0, 14:48:20 INFO - 'suite': 'dromaeojs-e10s', 14:48:20 INFO - 'system_bits': '32', 14:48:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:48:20 INFO - 'title': 't-yosemite-r7-0063', 14:48:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:48:20 INFO - 'use_talos_json': True, 14:48:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:48:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:48:20 INFO - 'work_dir': 'build'} 14:48:20 INFO - ##### 14:48:20 INFO - ##### Running clobber step. 14:48:20 INFO - ##### 14:48:20 INFO - Running pre-action listener: _resource_record_pre_action 14:48:20 INFO - Running main action method: clobber 14:48:20 INFO - rmtree: /builds/slave/test/build 14:48:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:48:22 INFO - Running post-action listener: _resource_record_post_action 14:48:22 INFO - ##### 14:48:22 INFO - ##### Running read-buildbot-config step. 14:48:22 INFO - ##### 14:48:22 INFO - Running pre-action listener: _resource_record_pre_action 14:48:22 INFO - Running main action method: read_buildbot_config 14:48:22 INFO - Using buildbot properties: 14:48:22 INFO - { 14:48:22 INFO - "project": "", 14:48:22 INFO - "product": "firefox", 14:48:22 INFO - "script_repo_revision": "production", 14:48:22 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:48:22 INFO - "repository": "", 14:48:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:48:22 INFO - "buildid": "20160222134758", 14:48:22 INFO - "pgo_build": "False", 14:48:22 INFO - "basedir": "/builds/slave/test", 14:48:22 INFO - "buildnumber": 482, 14:48:22 INFO - "slavename": "t-yosemite-r7-0063", 14:48:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:48:22 INFO - "platform": "yosemite_r7", 14:48:22 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:48:22 INFO - "branch": "fx-team", 14:48:22 INFO - "repo_path": "integration/fx-team", 14:48:22 INFO - "revision": "786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b", 14:48:22 INFO - "stage_platform": "macosx64", 14:48:22 INFO - "builduid": "a2c18d1816b14ca58e88780b36217dee", 14:48:22 INFO - "slavebuilddir": "test" 14:48:22 INFO - } 14:48:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 14:48:22 INFO - Running post-action listener: _resource_record_post_action 14:48:22 INFO - ##### 14:48:22 INFO - ##### Running download-and-extract step. 14:48:22 INFO - ##### 14:48:22 INFO - Running pre-action listener: _resource_record_pre_action 14:48:22 INFO - Running main action method: download_and_extract 14:48:22 INFO - mkdir: /builds/slave/test/build/tests 14:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:22 INFO - https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/test_packages.json 14:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/test_packages.json 14:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:48:23 INFO - Downloaded 1277 bytes. 14:48:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:48:23 INFO - Using the following test package requirements: 14:48:23 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:48:23 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:48:23 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 14:48:23 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:48:23 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 14:48:23 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:48:23 INFO - u'jsshell-mac.zip'], 14:48:23 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:48:23 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 14:48:23 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:48:23 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:48:23 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 14:48:23 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:48:23 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 14:48:23 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:48:23 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 14:48:23 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:48:23 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:48:23 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 14:48:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:23 INFO - https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:48:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:48:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:48:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/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 14:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/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 14:48:26 INFO - Downloaded 17825429 bytes. 14:48:26 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'] 14:48:26 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 14:48:29 INFO - Return code: 0 14:48:29 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 14:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:29 INFO - https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/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 14:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/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 14:48:30 INFO - Downloaded 17825429 bytes. 14:48:30 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'] 14:48:30 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 14:48:34 INFO - Return code: 0 14:48: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')]} 14:48:34 INFO - https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:48:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:48:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:48:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/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 14:48:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/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 14:48:35 INFO - Downloaded 10707015 bytes. 14:48:35 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'] 14:48:35 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 14:48:35 INFO - Return code: 0 14:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:35 INFO - https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 14:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArEa2R0WT12_0VNOEPY9Jg/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 14:48:40 INFO - Downloaded 111278838 bytes. 14:48:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:48:40 INFO - mkdir: /builds/slave/test/properties 14:48:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:48:40 INFO - Writing to file /builds/slave/test/properties/build_url 14:48:40 INFO - Contents: 14:48:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:48:41 INFO - Running post-action listener: _resource_record_post_action 14:48:41 INFO - Running post-action listener: set_extra_try_arguments 14:48:41 INFO - ##### 14:48:41 INFO - ##### Running populate-webroot step. 14:48:41 INFO - ##### 14:48:41 INFO - Running pre-action listener: _resource_record_pre_action 14:48:41 INFO - Running main action method: populate_webroot 14:48:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:48:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:48:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:48:41 INFO - '--tppagecycles', 14:48:41 INFO - '7'], 14:48:41 INFO - 'tests': ['tsvgm']}}, 14:48:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:48:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:48:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:48:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:48:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:48:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:48:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:41 INFO - 'talos_options': ['--e10s'], 14:48:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:41 INFO - 'tests': ['damp', 'tps']}, 14:48:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:41 INFO - 'talos_options': ['--e10s'], 14:48:41 INFO - 'tests': ['damp', 'tps']}, 14:48:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:48:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:48:41 INFO - 'other': {'tests': ['a11yr', 14:48:41 INFO - 'ts_paint', 14:48:41 INFO - 'tpaint', 14:48:41 INFO - 'sessionrestore', 14:48:41 INFO - 'sessionrestore_no_auto_restore']}, 14:48:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:48:41 INFO - 'tests': ['a11yr', 14:48:41 INFO - 'ts_paint', 14:48:41 INFO - 'tpaint', 14:48:41 INFO - 'sessionrestore', 14:48:41 INFO - 'sessionrestore_no_auto_restore']}, 14:48:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:48:41 INFO - 'tests': ['a11yr', 14:48:41 INFO - 'ts_paint', 14:48:41 INFO - 'tpaint', 14:48:41 INFO - 'sessionrestore', 14:48:41 INFO - 'sessionrestore_no_auto_restore']}, 14:48:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:48:41 INFO - 'tests': ['a11yr', 14:48:41 INFO - 'ts_paint', 14:48:41 INFO - 'tpaint', 14:48:41 INFO - 'sessionrestore', 14:48:41 INFO - 'sessionrestore_no_auto_restore']}, 14:48:41 INFO - 'other_l64': {'tests': ['a11yr', 14:48:41 INFO - 'ts_paint', 14:48:41 INFO - 'tpaint', 14:48:41 INFO - 'sessionrestore', 14:48:41 INFO - 'sessionrestore_no_auto_restore']}, 14:48:41 INFO - 'other_nol64': {'tests': ['a11yr', 14:48:41 INFO - 'ts_paint', 14:48:41 INFO - 'tpaint', 14:48:41 INFO - 'sessionrestore', 14:48:41 INFO - 'sessionrestore_no_auto_restore']}, 14:48:41 INFO - 'svgr': {'tests': ['tsvgx', 14:48:41 INFO - 'tsvgr_opacity', 14:48:41 INFO - 'tart', 14:48:41 INFO - 'tscrollx', 14:48:41 INFO - 'cart']}, 14:48:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:48:41 INFO - 'tests': ['tsvgx', 14:48:41 INFO - 'tsvgr_opacity', 14:48:41 INFO - 'tart', 14:48:41 INFO - 'tscrollx', 14:48:41 INFO - 'cart']}, 14:48:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:41 INFO - 'tests': ['tp5o']}, 14:48:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:41 INFO - 'talos_options': ['--e10s'], 14:48:41 INFO - 'tests': ['tp5o']}, 14:48:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:41 INFO - 'talos_options': ['--xperf_path', 14:48:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:41 INFO - 'tests': ['tp5n']}, 14:48:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:41 INFO - 'talos_options': ['--e10s', 14:48:41 INFO - '--xperf_path', 14:48:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:41 INFO - 'tests': ['tp5n']}}, 14:48:41 INFO - 'talos.zip': {'path': '', 14:48:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:48:41 INFO - Running post-action listener: _resource_record_post_action 14:48:41 INFO - ##### 14:48:41 INFO - ##### Running create-virtualenv step. 14:48:41 INFO - ##### 14:48:41 INFO - Running pre-action listener: _resource_record_pre_action 14:48:41 INFO - Running main action method: create_virtualenv 14:48:41 INFO - Creating virtualenv /builds/slave/test/build/venv 14:48:41 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 14:48:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:48:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:48:41 INFO - Using real prefix '/tools/python27' 14:48:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:48:42 INFO - Installing distribute.............................................................................................................................................................................................done. 14:48:45 INFO - Installing pip.................done. 14:48:45 INFO - Return code: 0 14:48:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:45 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 0x10db78a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72acb2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, '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.5StHuhadF9/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.PdQuD1Ovqb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:48:45 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 14:48:45 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 14:48:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:48:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:45 INFO - 'HOME': '/Users/cltbld', 14:48:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:45 INFO - 'LOGNAME': 'cltbld', 14:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:45 INFO - 'MOZ_NO_REMOTE': '1', 14:48:45 INFO - 'NO_EM_RESTART': '1', 14:48:45 INFO - 'PAGER': '/bin/cat', 14:48:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:45 INFO - 'PWD': '/builds/slave/test', 14:48:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:45 INFO - 'SHELL': '/bin/bash', 14:48:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:48:45 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:48:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:45 INFO - 'USER': 'cltbld', 14:48:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:45 INFO - 'XPC_FLAGS': '0x0', 14:48:45 INFO - 'XPC_SERVICE_NAME': '0', 14:48:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:45 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 14:48:45 INFO - Cleaning up... 14:48:45 INFO - Return code: 0 14:48:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:45 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 0x10db78a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72acb2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, '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.5StHuhadF9/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.PdQuD1Ovqb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:48:45 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 14:48:45 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 14:48:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:48:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:45 INFO - 'HOME': '/Users/cltbld', 14:48:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:45 INFO - 'LOGNAME': 'cltbld', 14:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:45 INFO - 'MOZ_NO_REMOTE': '1', 14:48:45 INFO - 'NO_EM_RESTART': '1', 14:48:45 INFO - 'PAGER': '/bin/cat', 14:48:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:45 INFO - 'PWD': '/builds/slave/test', 14:48:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:45 INFO - 'SHELL': '/bin/bash', 14:48:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:48:45 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:48:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:45 INFO - 'USER': 'cltbld', 14:48:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:45 INFO - 'XPC_FLAGS': '0x0', 14:48:45 INFO - 'XPC_SERVICE_NAME': '0', 14:48:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:45 INFO - Downloading/unpacking psutil>=0.7.1 14:48:45 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 14:48:45 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 14:48:45 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 14:48:45 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 14:48:45 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 14:48:45 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 14:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:48:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:48 INFO - Installing collected packages: psutil 14:48:48 INFO - Running setup.py install for psutil 14:48:48 INFO - building 'psutil._psutil_osx' extension 14:48:48 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 14:48:49 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 14:48:49 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 14:48:49 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 14:48:49 INFO - building 'psutil._psutil_posix' extension 14:48:49 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 14:48:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:48:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:48:49 INFO - ^ 14:48:49 INFO - 1 warning generated. 14:48:49 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 14:48:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:49 INFO - Successfully installed psutil 14:48:49 INFO - Cleaning up... 14:48:49 INFO - Return code: 0 14:48:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10db78a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72acb2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, '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.5StHuhadF9/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.PdQuD1Ovqb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:49 INFO - 'HOME': '/Users/cltbld', 14:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:49 INFO - 'LOGNAME': 'cltbld', 14:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:49 INFO - 'MOZ_NO_REMOTE': '1', 14:48:49 INFO - 'NO_EM_RESTART': '1', 14:48:49 INFO - 'PAGER': '/bin/cat', 14:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:49 INFO - 'PWD': '/builds/slave/test', 14:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:49 INFO - 'SHELL': '/bin/bash', 14:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:48:49 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:49 INFO - 'USER': 'cltbld', 14:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:49 INFO - 'XPC_FLAGS': '0x0', 14:48:49 INFO - 'XPC_SERVICE_NAME': '0', 14:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:48:50 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 14:48:50 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 14:48:50 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 14:48:50 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 14:48:50 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 14:48:50 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 14:48:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:48:52 INFO - Installing collected packages: mozsystemmonitor 14:48:52 INFO - Running setup.py install for mozsystemmonitor 14:48:52 INFO - Successfully installed mozsystemmonitor 14:48:52 INFO - Cleaning up... 14:48:52 INFO - Return code: 0 14:48:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:48:52 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')]} 14:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:52 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')]} 14:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:52 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 0x10db78a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72acb2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, '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.5StHuhadF9/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.PdQuD1Ovqb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:48:52 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 14:48:52 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 14:48:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:48:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:52 INFO - 'HOME': '/Users/cltbld', 14:48:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:52 INFO - 'LOGNAME': 'cltbld', 14:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:52 INFO - 'MOZ_NO_REMOTE': '1', 14:48:52 INFO - 'NO_EM_RESTART': '1', 14:48:52 INFO - 'PAGER': '/bin/cat', 14:48:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:52 INFO - 'PWD': '/builds/slave/test', 14:48:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:52 INFO - 'SHELL': '/bin/bash', 14:48:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:48:52 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:48:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:52 INFO - 'USER': 'cltbld', 14:48:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:52 INFO - 'XPC_FLAGS': '0x0', 14:48:52 INFO - 'XPC_SERVICE_NAME': '0', 14:48:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:52 INFO - Downloading/unpacking blobuploader==1.2.4 14:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:55 INFO - Downloading blobuploader-1.2.4.tar.gz 14:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:48:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:48:55 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 14:48:55 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 14:48:55 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 14:48:55 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 14:48:55 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 14:48:55 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 14:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:48:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:48:55 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 14:48:55 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 14:48:55 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 14:48:55 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 14:48:55 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 14:48:55 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 14:48:56 INFO - Downloading docopt-0.6.1.tar.gz 14:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:48:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:48:56 INFO - Running setup.py install for blobuploader 14:48:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:48:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:48:56 INFO - Running setup.py install for requests 14:48:57 INFO - Running setup.py install for docopt 14:48:57 INFO - Successfully installed blobuploader requests docopt 14:48:57 INFO - Cleaning up... 14:48:57 INFO - Return code: 0 14:48:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:57 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')]} 14:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:57 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')]} 14:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:57 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 0x10db78a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72acb2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, '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.5StHuhadF9/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.PdQuD1Ovqb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:48:57 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 14:48:57 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 14:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:57 INFO - 'HOME': '/Users/cltbld', 14:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:57 INFO - 'LOGNAME': 'cltbld', 14:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:57 INFO - 'MOZ_NO_REMOTE': '1', 14:48:57 INFO - 'NO_EM_RESTART': '1', 14:48:57 INFO - 'PAGER': '/bin/cat', 14:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:57 INFO - 'PWD': '/builds/slave/test', 14:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:57 INFO - 'SHELL': '/bin/bash', 14:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:48:57 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:57 INFO - 'USER': 'cltbld', 14:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:57 INFO - 'XPC_FLAGS': '0x0', 14:48:57 INFO - 'XPC_SERVICE_NAME': '0', 14:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-CaB8d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-0rk8z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-aDc58y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-iJ49tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-N4IEyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-pvOIYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-yaviqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ZbNQL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-FgmWdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ljR29I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-i8wsRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-FWkFaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-XkigBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-SSXzRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-3hw6sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:59 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-zqS6vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:59 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-8f_vbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:48:59 INFO - Running setup.py install for manifestparser 14:48:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:48:59 INFO - Running setup.py install for mozcrash 14:48:59 INFO - Running setup.py install for mozdebug 14:48:59 INFO - Running setup.py install for mozdevice 14:48:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:48:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:48:59 INFO - Running setup.py install for mozfile 14:49:00 INFO - Running setup.py install for mozhttpd 14:49:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:49:00 INFO - Running setup.py install for mozinfo 14:49:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:49:00 INFO - Running setup.py install for mozInstall 14:49:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:49:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:49:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:49:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:49:00 INFO - Running setup.py install for mozleak 14:49:00 INFO - Running setup.py install for mozlog 14:49:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:49:00 INFO - Running setup.py install for moznetwork 14:49:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:49:00 INFO - Running setup.py install for mozprocess 14:49:01 INFO - Running setup.py install for mozprofile 14:49:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:49:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:49:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:49:01 INFO - Running setup.py install for mozrunner 14:49:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:49:01 INFO - Running setup.py install for mozscreenshot 14:49:01 INFO - Running setup.py install for moztest 14:49:01 INFO - Running setup.py install for mozversion 14:49:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:49:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:49:01 INFO - Cleaning up... 14:49:01 INFO - Return code: 0 14:49:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49: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')]} 14:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:01 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 0x10db78a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72acb2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, '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.5StHuhadF9/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.PdQuD1Ovqb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:49:01 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 14:49:01 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 14:49:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:49:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:01 INFO - 'HOME': '/Users/cltbld', 14:49:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:01 INFO - 'LOGNAME': 'cltbld', 14:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:01 INFO - 'MOZ_NO_REMOTE': '1', 14:49:01 INFO - 'NO_EM_RESTART': '1', 14:49:01 INFO - 'PAGER': '/bin/cat', 14:49:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:01 INFO - 'PWD': '/builds/slave/test', 14:49:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:01 INFO - 'SHELL': '/bin/bash', 14:49:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:49:01 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:49:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:01 INFO - 'USER': 'cltbld', 14:49:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:01 INFO - 'XPC_FLAGS': '0x0', 14:49:01 INFO - 'XPC_SERVICE_NAME': '0', 14:49:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ASwJje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:02 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)) 14:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-GUUgBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:02 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)) 14:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-BXgLbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:02 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)) 14:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-IJMAht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:02 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)) 14:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ZR4OPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:02 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)) 14:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-dRIElP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:02 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)) 14:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-WAud_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:02 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)) 14:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-PCoPGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:02 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)) 14:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-J5YfbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-vo93fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-oXDlZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-q6O59V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-mzuE4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-71scwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-dSNwIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-G65ArN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:03 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)) 14:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-QM_zWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:03 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)) 14:49:03 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)) 14:49:03 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)) 14:49:03 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)) 14:49:03 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)) 14:49:03 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)) 14:49:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:06 INFO - Downloading blessings-1.6.tar.gz 14:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:49:06 INFO - Installing collected packages: blessings 14:49:06 INFO - Running setup.py install for blessings 14:49:06 INFO - Successfully installed blessings 14:49:06 INFO - Cleaning up... 14:49:06 INFO - Return code: 0 14:49:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:49:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:06 INFO - Reading from file tmpfile_stdout 14:49:06 INFO - Current package versions: 14:49:06 INFO - blessings == 1.6 14:49:06 INFO - blobuploader == 1.2.4 14:49:06 INFO - docopt == 0.6.1 14:49:06 INFO - manifestparser == 1.1 14:49:06 INFO - mozInstall == 1.12 14:49:06 INFO - mozcrash == 0.16 14:49:06 INFO - mozdebug == 0.1 14:49:06 INFO - mozdevice == 0.48 14:49:06 INFO - mozfile == 1.2 14:49:06 INFO - mozhttpd == 0.7 14:49:06 INFO - mozinfo == 0.9 14:49:06 INFO - mozleak == 0.1 14:49:06 INFO - mozlog == 3.1 14:49:06 INFO - moznetwork == 0.27 14:49:06 INFO - mozprocess == 0.22 14:49:06 INFO - mozprofile == 0.28 14:49:06 INFO - mozrunner == 6.11 14:49:06 INFO - mozscreenshot == 0.1 14:49:06 INFO - mozsystemmonitor == 0.0 14:49:06 INFO - moztest == 0.7 14:49:06 INFO - mozversion == 1.4 14:49:06 INFO - psutil == 3.1.1 14:49:06 INFO - requests == 1.2.3 14:49:06 INFO - wsgiref == 0.1.2 14:49:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:06 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')]} 14:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:06 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')]} 14:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:06 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 0x10db78a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72acb2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, '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.5StHuhadF9/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.PdQuD1Ovqb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:49:06 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 14:49:06 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 14:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:06 INFO - 'HOME': '/Users/cltbld', 14:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:06 INFO - 'LOGNAME': 'cltbld', 14:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:06 INFO - 'MOZ_NO_REMOTE': '1', 14:49:06 INFO - 'NO_EM_RESTART': '1', 14:49:06 INFO - 'PAGER': '/bin/cat', 14:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:06 INFO - 'PWD': '/builds/slave/test', 14:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:06 INFO - 'SHELL': '/bin/bash', 14:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:49:06 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:06 INFO - 'USER': 'cltbld', 14:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:06 INFO - 'XPC_FLAGS': '0x0', 14:49:06 INFO - 'XPC_SERVICE_NAME': '0', 14:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:07 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)) 14:49:07 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)) 14:49:07 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)) 14:49:07 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)) 14:49:07 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)) 14:49:07 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)) 14:49:07 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)) 14:49:07 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)) 14:49:07 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)) 14:49:07 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)) 14:49:07 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)) 14:49:07 INFO - Cleaning up... 14:49:07 INFO - Return code: 0 14:49:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db78a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72acb2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, '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.5StHuhadF9/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.PdQuD1Ovqb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:49:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:49:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:07 INFO - 'HOME': '/Users/cltbld', 14:49:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:07 INFO - 'LOGNAME': 'cltbld', 14:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:07 INFO - 'MOZ_NO_REMOTE': '1', 14:49:07 INFO - 'NO_EM_RESTART': '1', 14:49:07 INFO - 'PAGER': '/bin/cat', 14:49:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:07 INFO - 'PWD': '/builds/slave/test', 14:49:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:07 INFO - 'SHELL': '/bin/bash', 14:49:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:49:07 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:49:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:07 INFO - 'USER': 'cltbld', 14:49:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:07 INFO - 'XPC_FLAGS': '0x0', 14:49:07 INFO - 'XPC_SERVICE_NAME': '0', 14:49:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:07 INFO - Downloading/unpacking jsonschema 14:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:49:09 INFO - Downloading/unpacking functools32 (from jsonschema) 14:49: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 14:49: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 14:49: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 14:49: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 14:49: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 14:49: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 14:49:10 INFO - Downloading functools32-3.2.3-2.tar.gz 14:49:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:49:10 INFO - warning: no files found matching '*.txt' 14:49:10 INFO - no previously-included directories found matching 'build' 14:49:10 INFO - no previously-included directories found matching 'dist' 14:49:10 INFO - no previously-included directories found matching '.git*' 14:49:10 INFO - Installing collected packages: jsonschema, functools32 14:49:10 INFO - Running setup.py install for functools32 14:49:10 INFO - warning: no files found matching '*.txt' 14:49:10 INFO - no previously-included directories found matching 'build' 14:49:10 INFO - no previously-included directories found matching 'dist' 14:49:10 INFO - no previously-included directories found matching '.git*' 14:49:10 INFO - Successfully installed jsonschema functools32 14:49:10 INFO - Cleaning up... 14:49:10 INFO - Return code: 0 14:49:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:10 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 0x10db78a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72acb2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, '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.5StHuhadF9/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.PdQuD1Ovqb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 14:49:10 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 14:49:10 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 14:49:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:49:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:10 INFO - 'HOME': '/Users/cltbld', 14:49:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:10 INFO - 'LOGNAME': 'cltbld', 14:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:10 INFO - 'MOZ_NO_REMOTE': '1', 14:49:10 INFO - 'NO_EM_RESTART': '1', 14:49:10 INFO - 'PAGER': '/bin/cat', 14:49:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:10 INFO - 'PWD': '/builds/slave/test', 14:49:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:10 INFO - 'SHELL': '/bin/bash', 14:49:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:49:10 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:49:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:10 INFO - 'USER': 'cltbld', 14:49:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:10 INFO - 'XPC_FLAGS': '0x0', 14:49:10 INFO - 'XPC_SERVICE_NAME': '0', 14:49:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:10 INFO - Downloading/unpacking flake8 14:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:49:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:49:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:49: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 14:49: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 14:49: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 14:49: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 14:49: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 14:49: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 14:49:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:49: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 14:49: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 14:49: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 14:49: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 14:49: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 14:49: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 14:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:49:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:49:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:49:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:49:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:49:14 INFO - no previously-included directories found matching 'docs/_build' 14:49:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:49:14 INFO - Running setup.py install for pep8 14:49:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:49:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:49:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:49:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:49:14 INFO - no previously-included directories found matching 'docs/_build' 14:49:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:49:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:49:14 INFO - Cleaning up... 14:49:14 INFO - Return code: 0 14:49:14 INFO - Running post-action listener: _resource_record_post_action 14:49:14 INFO - Running post-action listener: _start_resource_monitoring 14:49:14 INFO - Starting resource monitoring. 14:49:14 INFO - ##### 14:49:14 INFO - ##### Running install step. 14:49:14 INFO - ##### 14:49:14 INFO - Running pre-action listener: _resource_record_pre_action 14:49:14 INFO - Running main action method: install 14:49:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:14 INFO - Reading from file tmpfile_stdout 14:49:14 INFO - Detecting whether we're running mozinstall >=1.0... 14:49:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:49:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:49:14 INFO - Reading from file tmpfile_stdout 14:49:14 INFO - Output received: 14:49:14 INFO - Usage: mozinstall [options] installer 14:49:14 INFO - Options: 14:49:14 INFO - -h, --help show this help message and exit 14:49:14 INFO - -d DEST, --destination=DEST 14:49:14 INFO - Directory to install application into. [default: 14:49:14 INFO - "/builds/slave/test"] 14:49:14 INFO - --app=APP Application being installed. [default: firefox] 14:49:14 INFO - mkdir: /builds/slave/test/build/application 14:49:14 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'] 14:49:14 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 14:49:48 INFO - Reading from file tmpfile_stdout 14:49:48 INFO - Output received: 14:49:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:49:48 INFO - Running post-action listener: _resource_record_post_action 14:49:48 INFO - ##### 14:49:48 INFO - ##### Running run-tests step. 14:49:48 INFO - ##### 14:49:48 INFO - Running pre-action listener: _resource_record_pre_action 14:49:48 INFO - Running main action method: run_tests 14:49:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:49:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:49:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:49:48 INFO - 2016-02-22 14:49:48.627 screenresolution[1672:7398] starting screenresolution argv=screenresolution get 14:49:48 INFO - 2016-02-22 14:49:48.630 screenresolution[1672:7398] Display 0: 1600x1200x32@60 14:49:48 INFO - 2016-02-22 14:49:48.635 screenresolution[1673:7400] starting screenresolution argv=screenresolution list 14:49:48 INFO - Available Modes on Display 0 14:49:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:49:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:49:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:49:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:49:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:49:48 INFO - Intel Iris: 14:49:48 INFO - Chipset Model: Intel Iris 14:49:48 INFO - Type: GPU 14:49:48 INFO - Bus: Built-In 14:49:48 INFO - VRAM (Dynamic, Max): 1536 MB 14:49:48 INFO - Vendor: Intel (0x8086) 14:49:48 INFO - Device ID: 0x0a2e 14:49:48 INFO - Revision ID: 0x0009 14:49:48 INFO - Displays: 14:49:48 INFO - Display: 14:49:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:49:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:49:48 INFO - Display Serial Number: 1600x1200 60 14:49:48 INFO - Main Display: Yes 14:49:48 INFO - Mirror: Off 14:49:48 INFO - Online: Yes 14:49:48 INFO - Rotation: Supported 14:49:48 INFO - Return code: 0 14:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:49:48 INFO - Python 2.7.3 14:49:48 INFO - Return code: 0 14:49:48 INFO - grabbing minidump binary from tooltool 14:49:48 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')]} 14:49:48 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 0x10da1cd30>, '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 0x10d840db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da13b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:49:48 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 14:49:48 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 14:49:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:49:48 INFO - Return code: 0 14:49:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:49:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:49:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:49:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:49:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:49:50 INFO - Return code: 0 14:49:50 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/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--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 14:49:50 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/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0063 --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 14:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5StHuhadF9/Render', 14:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:50 INFO - 'HOME': '/Users/cltbld', 14:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:50 INFO - 'LOGNAME': 'cltbld', 14:49:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:49:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:50 INFO - 'MOZ_NO_REMOTE': '1', 14:49:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:49:50 INFO - 'NO_EM_RESTART': '1', 14:49:50 INFO - 'PAGER': '/bin/cat', 14:49:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:50 INFO - 'PWD': '/builds/slave/test', 14:49:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:50 INFO - 'SHELL': '/bin/bash', 14:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PdQuD1Ovqb/Listeners', 14:49:50 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 14:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:50 INFO - 'USER': 'cltbld', 14:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:50 INFO - 'XPC_FLAGS': '0x0', 14:49:50 INFO - 'XPC_SERVICE_NAME': '0', 14:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:50 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/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--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 14:49:50 INFO - mozversion application_buildid: 20160222134758 14:49:50 INFO - mozversion application_changeset: 786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b 14:49:50 INFO - mozversion application_display_name: Nightly 14:49:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:49:50 INFO - mozversion application_name: Firefox 14:49:50 INFO - mozversion application_remotingname: firefox 14:49:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:49:50 INFO - mozversion application_vendor: Mozilla 14:49:50 INFO - mozversion application_version: 47.0a1 14:49:50 INFO - mozversion platform_buildid: 20160222134758 14:49:50 INFO - mozversion platform_changeset: 786bf7c76f8a5dd2802c14dc69b9a18defcf6d2b 14:49:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:49:50 INFO - mozversion platform_version: 47.0a1 14:49:50 INFO - using testdate: 1456181390 14:49:50 INFO - actual date: 1456181390 14:49:50 INFO - starting webserver on 'localhost:49276' 14:49:50 INFO - SUITE-START | Running 2 tests 14:49:50 INFO - TEST-START | dromaeo_css 14:49:50 INFO - operating with platform_type : mac_ 14:49:50 INFO - Initialising browser for dromaeo_css test... 14:49:50 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp4XjZ1I/profile http://localhost:49276/getInfo.html) 14:49:53 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 14:49:53 INFO - PROCESS | 1691 | colorDepth:24 14:49:53 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 14:49:53 INFO - PROCESS | 1691 | __metrics 14:49:53 ERROR - PROCESS | 1691 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 14:49:54 INFO - TEST-INFO | 1691: exit 0 14:49:54 INFO - Browser initialized. 14:49:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:49:54 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp4XjZ1I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:06 INFO - PROCESS | 1696 | RSS: Main: 255467520 14:50:06 INFO - PROCESS | 1696 | 14:50:56 INFO - PROCESS | 1696 | 1456181456124 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] 14:53:07 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 14:53:08 INFO - PROCESS | 1696 | RSS: Main: 269021184 14:53:08 INFO - PROCESS | 1696 | 14:56:10 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 14:56:10 INFO - PROCESS | 1696 | RSS: Main: 280666112 14:56:10 INFO - PROCESS | 1696 | 14:59:12 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 14:59:13 INFO - PROCESS | 1696 | RSS: Main: 281681920 14:59:13 INFO - PROCESS | 1696 | 15:02:14 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 15:02:15 INFO - PROCESS | 1696 | RSS: Main: 283451392 15:02:15 INFO - PROCESS | 1696 | 15:05:17 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 15:05:18 INFO - PROCESS | 1696 | RSS: Main: 285990912 15:05:18 INFO - PROCESS | 1696 | 15:08:20 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 15:08:21 INFO - PROCESS | 1696 | RSS: Main: 289050624 15:08:21 INFO - PROCESS | 1696 | 15:08:21 INFO - PROCESS | 1696 | __start_tp_report 15:08:21 INFO - PROCESS | 1696 | _x_x_mozilla_page_load 15:08:21 INFO - PROCESS | 1696 | _x_x_mozilla_page_load_details 15:08:21 INFO - PROCESS | 1696 | |i|pagename|runs| 15:08:21 INFO - PROCESS | 1696 | |0;dojo.html;3106.316610345724;3162.8892988745397;3417.897463076107;3497.8251087445637;3589.0489020409595;5690.7723691052415;5727.369989301179;5739.942600573993;5747.109198074305;5763.798267060653;5723.341815691197;5797.188393624896;5805.36141024488;5871.765129394819;5880.852978675535;5160.019596276705;5216.374035115791;5240.633155679104;5270.947290527103;5286.3392075990505;5078.162103252959;5144.8713782155555;5207.869803254911;5226.712530810804;5353.741870660392;5167.664101833388;5176.767045482962;5188.584913206934;5190.792368305263;5199.220116982445;5187.04039752647;5203.323567936182;5208.5312321891215;5251.264822924793;5266.1837415200325;5080.77136528857;5110.897782044375;5129.307543481619;5219.138842091051;5220.686758794484;5448.700321482317;5570.108782594765;5577.721113944286;5601.215829783833;5656.660600363992;6100.217864923763;6272.498200143978;6273.278572964122;6299.307076221612;6303.653299068549;6189.009758438673;6259.436650701458;6260.311365749764;6287.088372186053;6290.339514351019;5854.707264636793;5908.8002557748905;5910.438508341701;5931.110333450017;5951.58338916276;6185.721642526097;6220.222472190976;6305.5901366411035;6311.96844015777;6313.084602732578;6199.28708198563;6208.689565521706;6214.627122372582;6218.533609979179;6250.4374606285655;6248.375162483806;6282.308946015934;6288.811335659938;6288.9056664150075;6310.211223597051;6066;6170.845728856814;6238.563300568917;6244.968775156186;6264.9373506265265;6112.777056696867;6133.1413602095745;6250.906236406367;6262.843428914313;6281.277653069864;4818.7831547580445;4873.951260487421;4914.434839993375;4928.48250933654;4931.630127740362;4351.108022855307;4400.69195156336;4412.4043254160915;4428.557144285545;4452.5992660660695;5741.224934633771;5758.222639943638;5809.9832529307205;5814.534837213013;5822.243108395966;4826.469088400273;6007.038873780174;6149.108379284979;6187.041008643668;6240.906386404207;5800.738966746507;5831.446012628793;5837;5840.8247752567495;5870.354261031283;5462.426445223274;5478.753456094406;5483.903219356144;5484.808031718871;5486.725663716878;6144.9553575892205;6367.3314301997625;6436.549441539141;6479.5788273762055;6518.445932095825;5536.141898005815;6192.721327540362;6206.968965155145;6241.344658810759;6252;6208.751649934133;6285.842853928505;6337.112804207507;6354.841128971812;6392.424681778476;6227.595206311576;6236.158118654105;6239.937600623935;6255.562110652393;6275.717592708248;6231.158793562811;6254.3745625437095;6260.7495700171485;6278.215223097113;6278.560500764903;5977.581569290282;6119.68535298207;6187.350328215653;6196.535259855619;6227.719752611053;6003.729832157476;6004.099385092271;6141.7543298267565;6153.969230153821;6179.3820617937845;5956.702164891652;6098.176746139215;6108.11432342299;6113.052476866093;6114.449699526886;6053.697315134314;6113.841195312599;6186.721597528032;6208.875822483616;6216.44052035319;6081.239845019372;6112.663803490851;6122.724477398617;6129.233845769279;6138.693065346625 15:08:21 INFO - PROCESS | 1696 | |1;ext.html;455.45800497408084;462.7986825730805;473.26407436436347;492.1264755059768;601.3205078261564;30110.397792044147;32669.019929402126;36891.07772305694;37033;37199.628003719954;39788.403173952414;40353.58762443315;40645.57740479084;40714.59285407145;40742.388864167064;9381.405161122608;9536.332456728032;9567.952160239223;9631.422114673107;9633.421994680306;9560.56977436017;9652.227821774277;9703.805923881519;9715.805683886318;9720.854187187198;9635.373700709466;9699.951500242525;9722.708318750449;9731.36746111504;9738.756531086708;9616.90383096167;9680.854787178198;9696.224302055854;9704;9704.70885873425;9413;9475.715728528156;9476.526173691356;9510.239180865514;9570.138687518087;37628;37691.81154094212;37944;37983.8100809497;38081;3267.7712560120563;3414.6585341465902;3560.9109772255642;3563.322968635951;3737.215184811193;27825.721742782516;27849.303767405774;28060.298492537644;28252.293692657644;29332.41335173306;2758.2690586994463;2781.9443611127867;2783.4293969736154;2794.552871540564;2835.957460638092;500771;503002;505464;508259;508628;35349.46975795365;44432.77783611061;44717.55282447199;44750.552494474636;57480;43622.909427263934;43665.34501982473;43710;43846.68459946207;43959.340609890874;15229.771553426708;15356.232188390535;15425.845741542666;15455;15569.766453503207;12046.75906481883;12468.501259949682;12499.312537810325;12561.748765024648;12737.554185603645;14389.424423022961;14393;14405.207713575644;14436.133831970115;14449.277536123362;5377.7580008899695;6283.59156654816;6375.2987171411105;6380.3619638035825;6395.968020159869;952.3428834104445;988.7231575158967;1058.5342449322275;1062.85651437055;1120.6638008597388;21889;24906.750932490806;28186.85906570495;29167.708322916922;30270.940517082236;1019.1490105761624;1043.7599352149048;1064.8722153341648;1122.2144498850837;1141.57191053355;13757.79363309551;13775.862241377457;13897.374618142208;14053.78919316211;14096.577102686935;523017;532650;535829;537817.310913443;540323;49515.75242123767;50006.74983125451;50093.74953125211;50199.498005020214;50323.24515132276;1411.8941079419085;1416.9302176856409;1434.3760464198108;1453.4476898778396;1453.4694836384645;27225.31936701598;27247.591286130326;27813.721862781113;27871.72128278691;27874.30314242079;45690.85772855705;45948.310775339065;46365;46420.7678961603;46637.53362466468;514391.7121657621;519030;522438;522556;524418;26718.465630687668;31038.22404439907;31481.685183147874;31902;32024.67975320217;41161.38257926074;41360;41901.58098419099;41985.79007104945;42359.15281694411;34986.12534686653;35364.64635353613;35665.82167089252;35698.82150589334;36023;35016.12459688528;35652.46521302235;35773;36047;36075.819620901726;34116.658833412344;34817;35090.473642895886;35202;35275.64724352724;23743.881280593487;27581.724182758717;27629.894804207608;27683.72316276892;31838;24002.27993160208;24024.75975240295;24460;24615.38461538476;24795.380115496537 15:08:21 INFO - PROCESS | 1696 | |2;jquery.html;326.41082845463944;363.68722898307436;364.42966757025255;369.2264705442098;369.85390770645614;13683.726325473484;15009.699806003873;15606.765898511518;19578;20707.689384659225;16738;19800.70298945517;20206.494837629067;20347;20662.17351305946;5427.375851777047;5482.835514934538;5713.857153571153;5725.227094342252;5741.052726300156;5569.916451253234;5617.241672374218;5646.378898321182;5672.602917795756;5681.517071048966;5463.289772329612;5625.578081643873;5627.6060675752715;5631.0708733059;5697.857553561153;5585.664860108406;5628.465295796893;5690.57320700947;5698.8005419810315;5724.313082430135;4474.642028637733;5014.924776128361;5268.92096618551;5317.202419637047;5322.121849894763;10837.83743243852;12792.296423696693;12914.225146491146;13173.934130329382;13299.335033248395;2083.2187929526426;2121.755998060212;2160.82713382929;2489.3776555861036;2694;9318.254539636813;10477.952204779538;14071.71856562863;14357.712845743132;14611.926940365336;1671.515260574432;1744.9879070139289;1776.8578513718871;1777.3779177287975;1797.613513094678;96692.51653741686;98897.5055124727;100166.99833001723;100593.49703251437;101992.98007019909;10749.516271767789;10965.890341096647;11128.443577821077;11188.832167517494;11349.773004539862;12232.694182645506;13021.088523803242;13622.318884055758;13634;13682.589522314347;8297.792555186168;8316.958415208006;8428.704995325133;8460.830783384421;8463.788405289793;8567.014793298851;8603.870941935877;8608.182222688834;8613.48319100856;8645;4019.693599580148;4306.784660766949;4403.097365040223;4411.073674528321;4441.178381999341;1797.5595978985232;1894.1571000904742;1896.2415033986515;1934.861977514854;1938.3603410874377;839.5298632765671;889.3863234368265;920.4778905798198;983.233078199006;991.4299277915228;13849.86150138506;19975.400737977885;20487;20595.794042059686;21205.78794212069;880.1594477274188;918.4305730447165;942.4580866002076;950.7860731335394;1019.5819713917407;10394.948025259826;10901.618443354444;11069.280496767684;11176.217664763552;11329.320240785415;570221;654478;670666;679832;681638;76233;94157.5292123535;126263;128711;130316.04525932118;1019.4444028004755;1025.9281850270559;1036.5542816588788;1039.4698703661036;1044.6970378590277;18238.72641910346;18280.268789248283;18487.81512184861;18997.335093271668;19138.617227655646;41174;43269.78365108154;52597.68505787386;53783;55123;60734;66687.66656166688;72620.27379726346;73661.8950715729;78477.21522784699;8027.237412445808;8116.715914942949;8169.836603268021;8213.055498617736;8224.3831712623;10510.369377837354;13380.732385352043;13494.797578036141;13614.727705446034;13729.519466818614;9229.307801914749;9273.953630231807;11615.24500907472;11776.764464710486;11848.111391645489;9842.803143936939;11359.454109596;11570.016548593127;11625.825612615648;11862.40687965581;11783.646490605295;11924.83524312786;11988.76022479563;12004.979576736076;12023.45894434735;7558.773236802685;7869.960650196713;8142.7557173284895;8168.305694016075;8248.587570621325;10824.24230303871;11727.41362931833;12000.939995299968;12087.456064476944;12129.454174562343 15:08:21 INFO - PROCESS | 1696 | |3;mootools.html;1550.844915508449;1565.4364428805632;1813.2837529175977;1911.2546107018256;1931.5074655962728;7886.802829929255;8578.571071446419;8670.219680228778;8881.245094166996;8903.332250081245;8540.91459085409;8610.741677749678;8713;8753.299736021103;8762.036176020632;2478.851268923866;2481.7642323979194;2485.7762801347876;2492.526419980207;2494.5135698538793;2438.6951631046118;2504.8121390895662;2513.296277042431;2513.5852584323657;2516.8741562921873;2177.7277840269967;2431.805455563551;2453.815963802722;2494.3140636325065;2516.5721827289403;2435.5372479228977;2455.742147074567;2475.3687809608614;2483.4784695214025;2490.203134996802;2439.926802195937;2465.6424818401233;2474.443250268675;2484.4410007748293;2484.8942220711792;8622.396432249745;8669.869951950726;8708.477491350539;8709.477431354077;8719.171678690514;5339.119045357511;5451.236826844245;5463.453654634544;5472.398036216013;5503.449655034505;3587.228745819635;3626;3721.0511319613597;3733.626637336272;3743.0642339415144;944.8803168245582;1050.8844027157006;1057.0275346681071;1082.2965072702727;1089.5641743302742;11597.942010289895;11670.183087183901;11801.645950621494;11860.762784744256;11937.761244775056;4847.563719265283;4912.95087049125;4917.557419832232;4921.753912304371;4998.700077995332;9961.252906032076;10048.191325561324;10115.696529104138;10116.393016419039;10174.4912754362;5373.704446255415;5380.354357477127;5386.461353864661;5459.590530710213;5534.557235421156;4965.255211718271;4979.775910084055;4991.875203119878;5026.472220416877;5028.84913452597;3965.730966090823;4003;4006.338954072604;4006.59934006597;4009.91980160401;1158.212415557429;1177.193622368663;1329.355262697591;1336.565616174747;1350.7973803929292;1001.9829872679236;1103.3931337764197;1136.335243882338;1226.0253098786486;1340.9731805363838;7062.788116356517;7955.4828936118965;8017.839643207103;8093.959530202429;8185.795355116051;1099.3184225780067;1124.2130508643818;1187.109667749188;1193.8806119387991;1205.7709035283267;5167.22491626259;5185.83318753285;6162.969185154046;6213.347598502182;6224.937750622526;9254.86117708235;9413.341066125306;10642.521086550969;10701.464926753632;10731.248812583044;9279.118483744034;9360;9866.358686685342;10395.32430392022;10561.366318020944;8005.479643823133;8221.876671849926;8284.92296001528;8338.374621903382;8349.66601335952;7863.370930325675;7897.881531777143;7963.243491868263;7992.760217193493;8015.6392962318005;9348.345615806827;9477.289203309641;9591.376560523544;9689.757756055873;9727.221822254343;9745.805083898424;10073.496325183565;10123.898761012295;10303.072723454925;10345.793084138426;7533.6233188339265;7610.391168706601;7663.8850417242675;7694.615269236628;7707.267809558083;8221.17788221173;8264.710735124241;8285.461445006296;8314.293285070837;8348.998120225611;6727.865442691216;7521.7743467696055;7555.320021198118;7693.153753087044;7693.422993275639;7162.498625096193;7267.890981635174;7270.854582908207;7286.906963955449;7343.669534871051;7665.69337226527;7686.615669216405;7697.6151192441275;7725.613719313899;7737.264959828807;6900.6204658742245;6961.8860982242595;7000.19497757744;7027.964860175871;7042.366187043191;7130.679119439534;7184.676689549087;7191.892121618075;7197.82005449847;7221.458390620619 15:08:21 INFO - PROCESS | 1696 | |4;prototype.html;285.4362633798249;330.78829549088584;334.4264586234607;337.65727786296895;340.180165800421;6045.425684559966;6449.193850768654;6617.139771829668;6633.170853643294;6686.89969650455;5532.97639936611;5591.3569939456975;6275.843103922404;6418.390252925976;6553.377429144236;4876.537038888337;4882.389701287339;4883.267509873512;4886.828960986366;4908.607311415079;4153;4700.741459219742;4902.720235090682;4911.5088491150955;4917.680350777206;4824.565789078983;4837.685550439228;4843.346148269991;4857.858403275245;4873.610111191114;4022.3363145081025;4565.52062033485;4775.164346239411;4862.9787744573505;4867.756612169395;3326.251593391492;3638.5088013118157;4025.416314634391;4047.97976010121;4054.432379466877;5391.946080539184;6249.843753906143;6261.812145635638;6275.780347687809;6290.056491526262;5631.465010824006;5634.211210430543;5655.208270842086;5673;5676.148577713335;7043.190033146203;7047.295270472911;7053.576785392893;7053.576785392893;7088.043114179572;3781.829817658212;3811.4854494643423;4568.862934111982;4571.885702857422;4593.6095431888;7209.387202087829;7439.8140046499275;7446.404287657028;7451.366633836131;7499.812504687372;4560.543945605413;4631.054956918102;4643.141018911512;4666.953330466652;4682.4381074271305;4745.786439610226;4753.073150735573;4754.120487709784;4756.857294281177;4770.045990801854;5706.429357064343;5721.342045664802;5741.88516229673;5743.741531631086;5767.480926716532;6141.815745527641;6826.965865170741;7175.533590316717;7197.4961752677855;7203.89194162088;1611.1782990674606;1634.7874776279007;1635.0026483844845;1643.589102724319;1645.6050547868426;927.4945154890601;984.640606178754;1040.245821779204;1041.1982773264544;1063.3088492479794;6496.415322620986;6591.571547849375;6612.173478315211;6621;6646.401823835878;6685.899711504331;7416.666250018762;7449.292317229854;7494.737684181027;7526.397888168934;6668.833279167962;6684.197896252481;6687.866242675119;6695.46436285096;6696.665166741644;3119.9704097647723;3945.9013524662114;3969.6030396960073;3985.6612187964347;3995.62041606047;6237.189165408558;7563.773086807405;7900.249476299742;7902.510709126606;7910.881336779953;7778.416618753616;7783.571903545359;7787.649555770004;7792.259735325135;7820.413468989848;7078.221395646475;7149.463790215755;7898.526088434713;7902.841943161219;7920.762377128695;6182.381761823782;7518.98493703365;7525.6989720410575;7561.432892532972;7569.886451703339;5933.673647949404;7325.597092159983;7354.595497247703;7364.77905662831;7381.261873812576;7818.569978651229;7824.439879854539;7853.725119620786;7860.646270917708;7867.213278672087;4611.400517932647;4673.929891051569;4679.578837904605;4681.227597446383;4691.50739172382;7246.384057355184;7489.887651685338;7493.138289096823;7506;7544.0192774938905;5708.571857110816;5875.706214689334;6524.151860258136;7235.095613048369;7281.235470275545;6099.908501372394;6909.1018167637885;7188.5327453715345;7194.748183813542;7211.098612673416;5704.3154821421695;6982.546134501241;7017.017617533447;7019.4033507150425;7030.121234845645;6946.097007389007;7145.1425828900865;7177.712891484491;7178.748743793943;7196.568205907663;5551.916721249266;6735.393814556714;7094.858102837811;7101.7159313628945;7106.360427561544 15:08:21 INFO - PROCESS | 1696 | |5;yui.html;668.866226754649;703.7290643102405;715.1489727224603;727.7598392530465;728.2862794461424;14697.926510367433;14702.191379474138;14785.817134629231;14812.481563145293;14843.257837108129;13791.310434478286;13870.514531991357;13945.302734863268;13982.091164074329;13989.860101398983;688.5730846874944;848.4018766769443;863.7667829685981;868.6047848229073;883.730462209026;843.0473564871717;867.7830542364409;869.7260362985671;870.6996086350199;878.6748902905933;930.9394889332206;933.9533023348839;936.3960245641557;936.3960245641591;939.7791518993065;902.5893218585528;908.8273228086675;921.4471317209687;925.7454200094994;928.5867788833938;680.3060877904559;680.8059702984675;688.3598253624127;689.810302166903;689.8792711275557;13435.731285374335;13441.596752097355;13467.730645387037;13501.122427042212;13560;12995;13051.21692698441;13057.412416441282;13097.738045239137;13185.604431866963;10065.295429319951;10074.294799364048;10108.140808031327;10111.39331640104;10173.186145108373;3379.695827375548;3429.4341433663417;3444.9827750861336;3449.741269404805;3450.723942084627;79978.80031799528;82274.58862705648;84206.57896710538;85147;85632;9673.806523869483;9695.66065187715;9776.810885521376;9806.65676701312;10215.846762298572;21457.78542214589;21536.461588460414;21816.89091554564;21943.451413714465;21963.011664475136;6164.7842325518395;7248.238934911864;7255.52839065459;7464.477486575996;7666.616669166519;4054.1688953764406;4123.587641235852;4141.958580414218;4177.373393990925;4322.286822674287;3544.7518673692593;3552.0764601203873;3584.318979393907;3586.55168103987;3595.8741444049856;610.4414460768436;617.2716194889983;632.0582332324803;637.3403527349265;646.0438550944534;562.445990699161;570.6262398129232;588.2176704982363;609.7103875659116;620.1782638004662;7098.609576473344;8183.32892510847;8716.605343145193;8716.997545282373;8844.646214151491;517.3972322244618;584.3396961433552;595.1905408644241;596.9373215812277;614.2598169206096;3971.205758848242;3975.900602484961;4016.9598304016586;4105.035316700573;4129.922769348705;69195;92600.53699731459;95332.52333738287;95512;95892.52053739686;70185.59628807395;81007;81800;82512.17487825165;82699;68177.31822681808;69962.65018674874;70631;73959.63020184865;74460.25539744533;6799.694013769491;7986.960065199637;8207.097219305751;8283.83432331362;8306.252437280433;49378.75310623424;49871.75064124656;50095;50181;50913.745431272604;68833;69011.65494172498;69450;70173.64913175402;70631;9683.852454532534;9749.756256093655;9795.412275263507;9991.800163996824;10065.986802639354;9560.378575392577;9568.4737339447;11126.88873111291;11902.166848320534;13070.80393794113;11239.494222760159;11276.9436152822;11321.490532926204;11599.130065244972;11747.530098795953;10295.639652612123;11163.218574699693;11409.3724845131;11522.827157592475;11556.826647600124;11431.828522572334;11437.656870293904;11439.771204576029;11475.368854713071;11543.36511491876;9493.57278922464;9588.952055239679;9872.974070077138;9943.552540135566;10024.599016039278;9748.171405430618;10016.499175041365;10031.648892289028;10032.930627467098;10042.191567671016 15:08:21 INFO - PROCESS | 1696 | __end_tp_report 15:08:21 INFO - PROCESS | 1696 | __start_cc_report 15:08:21 INFO - PROCESS | 1696 | _x_x_mozilla_cycle_collect,343 15:08:21 INFO - PROCESS | 1696 | __end_cc_report 15:08:21 INFO - PROCESS | 1696 | __startTimestamp1456182501111__endTimestamp 15:08:21 INFO - PROCESS | 1696 | 15:08:21 INFO - PROCESS | 1696 | ------- Summary: start ------- 15:08:21 INFO - PROCESS | 1696 | Number of tests: 6 15:08:21 INFO - PROCESS | 1696 | 15:08:21 INFO - PROCESS | 1696 | [#0] dojo.html Cycles:165 Average:5764.92 Median:6053.70 stddev:656.87 (10.9%) stddev-sans-first:624.90 15:08:21 INFO - PROCESS | 1696 | Values: 3106.3 3162.9 3417.9 3497.8 3589.0 5690.8 5727.4 5739.9 5747.1 5763.8 5723.3 5797.2 5805.4 5871.8 5880.9 5160.0 5216.4 5240.6 5270.9 5286.3 5078.2 5144.9 5207.9 5226.7 5353.7 5167.7 5176.8 5188.6 5190.8 5199.2 5187.0 5203.3 5208.5 5251.3 5266.2 5080.8 5110.9 5129.3 5219.1 5220.7 5448.7 5570.1 5577.7 5601.2 5656.7 6100.2 6272.5 6273.3 6299.3 6303.7 6189.0 6259.4 6260.3 6287.1 6290.3 5854.7 5908.8 5910.4 5931.1 5951.6 6185.7 6220.2 6305.6 6312.0 6313.1 6199.3 6208.7 6214.6 6218.5 6250.4 6248.4 6282.3 6288.8 6288.9 6310.2 6066.0 6170.8 6238.6 6245.0 6264.9 6112.8 6133.1 6250.9 6262.8 6281.3 4818.8 4874.0 4914.4 4928.5 4931.6 4351.1 4400.7 4412.4 4428.6 4452.6 5741.2 5758.2 5810.0 5814.5 5822.2 4826.5 6007.0 6149.1 6187.0 6240.9 5800.7 5831.4 5837.0 5840.8 5870.4 5462.4 5478.8 5483.9 5484.8 5486.7 6145.0 6367.3 6436.5 6479.6 6518.4 5536.1 6192.7 6207.0 6241.3 6252.0 6208.8 6285.8 6337.1 6354.8 6392.4 6227.6 6236.2 6239.9 6255.6 6275.7 6231.2 6254.4 6260.7 6278.2 6278.6 5977.6 6119.7 6187.4 6196.5 6227.7 6003.7 6004.1 6141.8 6154.0 6179.4 5956.7 6098.2 6108.1 6113.1 6114.4 6053.7 6113.8 6186.7 6208.9 6216.4 6081.2 6112.7 6122.7 6129.2 6138.7 15:08:21 INFO - PROCESS | 1696 | 15:08:21 INFO - PROCESS | 1696 | [#1] ext.html Cycles:180 Average:63676.22 Median:36962.04 stddev:138808.04 (375.5%) stddev-sans-first:139116.27 15:08:21 INFO - PROCESS | 1696 | Values: 455.5 462.8 473.3 492.1 601.3 30110.4 32669.0 36891.1 37033.0 37199.6 39788.4 40353.6 40645.6 40714.6 40742.4 9381.4 9536.3 9568.0 9631.4 9633.4 9560.6 9652.2 9703.8 9715.8 9720.9 9635.4 9700.0 9722.7 9731.4 9738.8 9616.9 9680.9 9696.2 9704.0 9704.7 9413.0 9475.7 9476.5 9510.2 9570.1 37628.0 37691.8 37944.0 37983.8 38081.0 3267.8 3414.7 3560.9 3563.3 3737.2 27825.7 27849.3 28060.3 28252.3 29332.4 2758.3 2781.9 2783.4 2794.6 2836.0 500771.0 503002.0 505464.0 508259.0 508628.0 35349.5 44432.8 44717.6 44750.6 57480.0 43622.9 43665.3 43710.0 43846.7 43959.3 15229.8 15356.2 15425.8 15455.0 15569.8 12046.8 12468.5 12499.3 12561.7 12737.6 14389.4 14393.0 14405.2 14436.1 14449.3 5377.8 6283.6 6375.3 6380.4 6396.0 952.3 988.7 1058.5 1062.9 1120.7 21889.0 24906.8 28186.9 29167.7 30270.9 1019.1 1043.8 1064.9 1122.2 1141.6 13757.8 13775.9 13897.4 14053.8 14096.6 523017.0 532650.0 535829.0 537817.3 540323.0 49515.8 50006.7 50093.7 50199.5 50323.2 1411.9 1416.9 1434.4 1453.4 1453.5 27225.3 27247.6 27813.7 27871.7 27874.3 45690.9 45948.3 46365.0 46420.8 46637.5 514391.7 519030.0 522438.0 522556.0 524418.0 26718.5 31038.2 31481.7 31902.0 32024.7 41161.4 41360.0 41901.6 41985.8 42359.2 34986.1 35364.6 35665.8 35698.8 36023.0 35016.1 35652.5 35773.0 36047.0 36075.8 34116.7 34817.0 35090.5 35202.0 35275.6 23743.9 27581.7 27629.9 27683.7 31838.0 24002.3 24024.8 24460.0 24615.4 24795.4 15:08:21 INFO - PROCESS | 1696 | 15:08:21 INFO - PROCESS | 1696 | [#2] jquery.html Cycles:180 Average:34708.70 Median:2325.10 stddev:107818.71 (4637.2%) stddev-sans-first:108090.25 15:08:21 INFO - PROCESS | 1696 | Values: 326.4 363.7 364.4 369.2 369.9 13683.7 15009.7 15606.8 19578.0 20707.7 16738.0 19800.7 20206.5 20347.0 20662.2 5427.4 5482.8 5713.9 5725.2 5741.1 5569.9 5617.2 5646.4 5672.6 5681.5 5463.3 5625.6 5627.6 5631.1 5697.9 5585.7 5628.5 5690.6 5698.8 5724.3 4474.6 5014.9 5268.9 5317.2 5322.1 10837.8 12792.3 12914.2 13173.9 13299.3 2083.2 2121.8 2160.8 2489.4 2694.0 9318.3 10478.0 14071.7 14357.7 14611.9 1671.5 1745.0 1776.9 1777.4 1797.6 96692.5 98897.5 100167.0 100593.5 101993.0 10749.5 10965.9 11128.4 11188.8 11349.8 12232.7 13021.1 13622.3 13634.0 13682.6 8297.8 8317.0 8428.7 8460.8 8463.8 8567.0 8603.9 8608.2 8613.5 8645.0 4019.7 4306.8 4403.1 4411.1 4441.2 1797.6 1894.2 1896.2 1934.9 1938.4 839.5 889.4 920.5 983.2 991.4 13849.9 19975.4 20487.0 20595.8 21205.8 880.2 918.4 942.5 950.8 1019.6 10394.9 10901.6 11069.3 11176.2 11329.3 570221.0 654478.0 670666.0 679832.0 681638.0 76233.0 94157.5 126263.0 128711.0 130316.0 1019.4 1025.9 1036.6 1039.5 1044.7 18238.7 18280.3 18487.8 18997.3 19138.6 41174.0 43269.8 52597.7 53783.0 55123.0 60734.0 66687.7 72620.3 73661.9 78477.2 8027.2 8116.7 8169.8 8213.1 8224.4 10510.4 13380.7 13494.8 13614.7 13729.5 9229.3 9274.0 11615.2 11776.8 11848.1 9842.8 11359.5 11570.0 11625.8 11862.4 11783.6 11924.8 11988.8 12005.0 12023.5 7558.8 7870.0 8142.8 8168.3 8248.6 10824.2 11727.4 12000.9 12087.5 12129.5 15:08:21 INFO - PROCESS | 1696 | 15:08:21 INFO - PROCESS | 1696 | [#3] mootools.html Cycles:180 Average:6030.00 Median:5377.03 stddev:3127.78 (58.2%) stddev-sans-first:3118.43 15:08:21 INFO - PROCESS | 1696 | Values: 1550.8 1565.4 1813.3 1911.3 1931.5 7886.8 8578.6 8670.2 8881.2 8903.3 8540.9 8610.7 8713.0 8753.3 8762.0 2478.9 2481.8 2485.8 2492.5 2494.5 2438.7 2504.8 2513.3 2513.6 2516.9 2177.7 2431.8 2453.8 2494.3 2516.6 2435.5 2455.7 2475.4 2483.5 2490.2 2439.9 2465.6 2474.4 2484.4 2484.9 8622.4 8669.9 8708.5 8709.5 8719.2 5339.1 5451.2 5463.5 5472.4 5503.4 3587.2 3626.0 3721.1 3733.6 3743.1 944.9 1050.9 1057.0 1082.3 1089.6 11597.9 11670.2 11801.6 11860.8 11937.8 4847.6 4913.0 4917.6 4921.8 4998.7 9961.3 10048.2 10115.7 10116.4 10174.5 5373.7 5380.4 5386.5 5459.6 5534.6 4965.3 4979.8 4991.9 5026.5 5028.8 3965.7 4003.0 4006.3 4006.6 4009.9 1158.2 1177.2 1329.4 1336.6 1350.8 1002.0 1103.4 1136.3 1226.0 1341.0 7062.8 7955.5 8017.8 8094.0 8185.8 1099.3 1124.2 1187.1 1193.9 1205.8 5167.2 5185.8 6163.0 6213.3 6224.9 9254.9 9413.3 10642.5 10701.5 10731.2 9279.1 9360.0 9866.4 10395.3 10561.4 8005.5 8221.9 8284.9 8338.4 8349.7 7863.4 7897.9 7963.2 7992.8 8015.6 9348.3 9477.3 9591.4 9689.8 9727.2 9745.8 10073.5 10123.9 10303.1 10345.8 7533.6 7610.4 7663.9 7694.6 7707.3 8221.2 8264.7 8285.5 8314.3 8349.0 6727.9 7521.8 7555.3 7693.2 7693.4 7162.5 7267.9 7270.9 7286.9 7343.7 7665.7 7686.6 7697.6 7725.6 7737.3 6900.6 6961.9 7000.2 7028.0 7042.4 7130.7 7184.7 7191.9 7197.8 7221.5 15:08:21 INFO - PROCESS | 1696 | 15:08:21 INFO - PROCESS | 1696 | [#4] prototype.html Cycles:180 Average:5738.27 Median:6354.22 stddev:1890.18 (29.7%) stddev-sans-first:1850.65 15:08:21 INFO - PROCESS | 1696 | Values: 285.4 330.8 334.4 337.7 340.2 6045.4 6449.2 6617.1 6633.2 6686.9 5533.0 5591.4 6275.8 6418.4 6553.4 4876.5 4882.4 4883.3 4886.8 4908.6 4153.0 4700.7 4902.7 4911.5 4917.7 4824.6 4837.7 4843.3 4857.9 4873.6 4022.3 4565.5 4775.2 4863.0 4867.8 3326.3 3638.5 4025.4 4048.0 4054.4 5391.9 6249.8 6261.8 6275.8 6290.1 5631.5 5634.2 5655.2 5673.0 5676.1 7043.2 7047.3 7053.6 7053.6 7088.0 3781.8 3811.5 4568.9 4571.9 4593.6 7209.4 7439.8 7446.4 7451.4 7499.8 4560.5 4631.1 4643.1 4667.0 4682.4 4745.8 4753.1 4754.1 4756.9 4770.0 5706.4 5721.3 5741.9 5743.7 5767.5 6141.8 6827.0 7175.5 7197.5 7203.9 1611.2 1634.8 1635.0 1643.6 1645.6 927.5 984.6 1040.2 1041.2 1063.3 6496.4 6591.6 6612.2 6621.0 6646.4 6685.9 7416.7 7449.3 7494.7 7526.4 6668.8 6684.2 6687.9 6695.5 6696.7 3120.0 3945.9 3969.6 3985.7 3995.6 6237.2 7563.8 7900.2 7902.5 7910.9 7778.4 7783.6 7787.6 7792.3 7820.4 7078.2 7149.5 7898.5 7902.8 7920.8 6182.4 7519.0 7525.7 7561.4 7569.9 5933.7 7325.6 7354.6 7364.8 7381.3 7818.6 7824.4 7853.7 7860.6 7867.2 4611.4 4673.9 4679.6 4681.2 4691.5 7246.4 7489.9 7493.1 7506.0 7544.0 5708.6 5875.7 6524.2 7235.1 7281.2 6099.9 6909.1 7188.5 7194.7 7211.1 5704.3 6982.5 7017.0 7019.4 7030.1 6946.1 7145.1 7177.7 7178.7 7196.6 5551.9 6735.4 7094.9 7101.7 7106.4 15:08:21 INFO - PROCESS | 1696 | 15:08:21 INFO - PROCESS | 1696 | [#5] yui.html Cycles:180 Average:18360.07 Median:3391.03 stddev:26055.98 (768.4%) stddev-sans-first:26095.21 15:08:21 INFO - PROCESS | 1696 | Values: 668.9 703.7 715.1 727.8 728.3 14697.9 14702.2 14785.8 14812.5 14843.3 13791.3 13870.5 13945.3 13982.1 13989.9 688.6 848.4 863.8 868.6 883.7 843.0 867.8 869.7 870.7 878.7 930.9 934.0 936.4 936.4 939.8 902.6 908.8 921.4 925.7 928.6 680.3 680.8 688.4 689.8 689.9 13435.7 13441.6 13467.7 13501.1 13560.0 12995.0 13051.2 13057.4 13097.7 13185.6 10065.3 10074.3 10108.1 10111.4 10173.2 3379.7 3429.4 3445.0 3449.7 3450.7 79978.8 82274.6 84206.6 85147.0 85632.0 9673.8 9695.7 9776.8 9806.7 10215.8 21457.8 21536.5 21816.9 21943.5 21963.0 6164.8 7248.2 7255.5 7464.5 7666.6 4054.2 4123.6 4142.0 4177.4 4322.3 3544.8 3552.1 3584.3 3586.6 3595.9 610.4 617.3 632.1 637.3 646.0 562.4 570.6 588.2 609.7 620.2 7098.6 8183.3 8716.6 8717.0 8844.6 517.4 584.3 595.2 596.9 614.3 3971.2 3975.9 4017.0 4105.0 4129.9 69195.0 92600.5 95332.5 95512.0 95892.5 70185.6 81007.0 81800.0 82512.2 82699.0 68177.3 69962.7 70631.0 73959.6 74460.3 6799.7 7987.0 8207.1 8283.8 8306.3 49378.8 49871.8 50095.0 50181.0 50913.7 68833.0 69011.7 69450.0 70173.6 70631.0 9683.9 9749.8 9795.4 9991.8 10066.0 9560.4 9568.5 11126.9 11902.2 13070.8 11239.5 11276.9 11321.5 11599.1 11747.5 10295.6 11163.2 11409.4 11522.8 11556.8 11431.8 11437.7 11439.8 11475.4 11543.4 9493.6 9589.0 9873.0 9943.6 10024.6 9748.2 10016.5 10031.6 10032.9 10042.2 15:08:21 INFO - PROCESS | 1696 | -------- Summary: end -------- 15:08:21 INFO - PROCESS | 1696 | 15:08:21 INFO - TEST-INFO | 1696: exit 0 15:08:21 INFO - TEST-OK | dromaeo_css | took 1110874ms 15:08:21 INFO - TEST-START | kraken 15:08:21 INFO - operating with platform_type : mac_ 15:08:21 INFO - Initialising browser for kraken test... 15:08:21 INFO - TEST-INFO | started process 1818 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp9Epx9T/profile http://localhost:49276/getInfo.html) 15:08:24 INFO - PROCESS | 1818 | __metrics Screen width/height:1600/1200 15:08:24 INFO - PROCESS | 1818 | colorDepth:24 15:08:24 INFO - PROCESS | 1818 | Browser inner width/height: 1024/689 15:08:24 INFO - PROCESS | 1818 | __metrics 15:08:24 ERROR - PROCESS | 1818 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 15:08:25 INFO - TEST-INFO | 1818: exit 0 15:08:25 INFO - Browser initialized. 15:08:25 INFO - Running cycle 1/1 for kraken test... 15:08:25 INFO - TEST-INFO | started process 1822 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp9Epx9T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:08:37 INFO - PROCESS | 1822 | RSS: Main: 255488000 15:08:37 INFO - PROCESS | 1822 | 15:08:39 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 15:08:40 INFO - PROCESS | 1822 | RSS: Main: 267616256 15:08:40 INFO - PROCESS | 1822 | 15:08:43 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 15:08:43 INFO - PROCESS | 1822 | RSS: Main: 278081536 15:08:43 INFO - PROCESS | 1822 | 15:08:46 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 15:08:47 INFO - PROCESS | 1822 | RSS: Main: 280481792 15:08:47 INFO - PROCESS | 1822 | 15:08:55 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 15:08:56 INFO - PROCESS | 1822 | RSS: Main: 281444352 15:08:56 INFO - PROCESS | 1822 | 15:08:58 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:08:58 INFO - PROCESS | 1822 | RSS: Main: 281919488 15:08:58 INFO - PROCESS | 1822 | 15:09:01 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 15:09:02 INFO - PROCESS | 1822 | RSS: Main: 283021312 15:09:02 INFO - PROCESS | 1822 | 15:09:04 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 15:09:05 INFO - PROCESS | 1822 | RSS: Main: 282664960 15:09:05 INFO - PROCESS | 1822 | 15:09:08 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 15:09:08 INFO - PROCESS | 1822 | RSS: Main: 282750976 15:09:08 INFO - PROCESS | 1822 | 15:09:10 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:09:11 INFO - PROCESS | 1822 | RSS: Main: 282865664 15:09:11 INFO - PROCESS | 1822 | 15:09:12 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:09:13 INFO - PROCESS | 1822 | RSS: Main: 283205632 15:09:13 INFO - PROCESS | 1822 | 15:09:15 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:09:16 INFO - PROCESS | 1822 | RSS: Main: 283570176 15:09:16 INFO - PROCESS | 1822 | 15:09:18 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:09:19 INFO - PROCESS | 1822 | RSS: Main: 283811840 15:09:19 INFO - PROCESS | 1822 | 15:09:21 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:09:22 INFO - PROCESS | 1822 | RSS: Main: 282918912 15:09:22 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 15:09:24 INFO - PROCESS | 1822 | RSS: Main: 285372416 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | __start_tp_report 15:09:24 INFO - PROCESS | 1822 | _x_x_mozilla_page_load 15:09:24 INFO - PROCESS | 1822 | _x_x_mozilla_page_load_details 15:09:24 INFO - PROCESS | 1822 | |i|pagename|runs| 15:09:24 INFO - PROCESS | 1822 | |0;ai-astar;147;153;133;112;115;125;114;116;113;114 15:09:24 INFO - PROCESS | 1822 | |1;audio-beat-detection;162;125;144;154;124;143;145;122;154;122 15:09:24 INFO - PROCESS | 1822 | |2;audio-dft;199;196;195;207;204;222;196;199;198;197 15:09:24 INFO - PROCESS | 1822 | |3;audio-fft;74;73;68;107;59;56;60;59;116;59 15:09:24 INFO - PROCESS | 1822 | |4;audio-oscillator;82;83;123;80;81;83;118;93;117;100 15:09:24 INFO - PROCESS | 1822 | |5;imaging-gaussian-blur;85;91;87;91;85;111;131;92;86;92 15:09:24 INFO - PROCESS | 1822 | |6;imaging-darkroom;94;95;128;95;96;94;94;96;94;94 15:09:24 INFO - PROCESS | 1822 | |7;imaging-desaturate;110;127;92;96;93;91;91;93;91;126 15:09:24 INFO - PROCESS | 1822 | |8;json-parse-financial;56;59;58;55;58;56;57;65;57;54 15:09:24 INFO - PROCESS | 1822 | |9;json-stringify-tinderbox;65;66;68;68;69;72;69;67;66;68 15:09:24 INFO - PROCESS | 1822 | |10;stanford-crypto-aes;83;85;85;87;88;87;86;72;99;106 15:09:24 INFO - PROCESS | 1822 | |11;stanford-crypto-ccm;123;154;132;116;126;137;134;114;133;132 15:09:24 INFO - PROCESS | 1822 | |12;stanford-crypto-pbkdf2;137;176;184;185;143;140;145;143;153;170 15:09:24 INFO - PROCESS | 1822 | |13;stanford-crypto-sha256-iterative;68;69;69;66;68;70;92;58;82;96 15:09:24 INFO - PROCESS | 1822 | __end_tp_report 15:09:24 INFO - PROCESS | 1822 | __start_cc_report 15:09:24 INFO - PROCESS | 1822 | _x_x_mozilla_cycle_collect,877 15:09:24 INFO - PROCESS | 1822 | __end_cc_report 15:09:24 INFO - PROCESS | 1822 | __startTimestamp1456182564541__endTimestamp 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | ------- Summary: start ------- 15:09:24 INFO - PROCESS | 1822 | Number of tests: 14 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#0] ai-astar Cycles:10 Average:124.20 Median:120.50 stddev:15.13 (12.6%) stddev-sans-first:13.62 15:09:24 INFO - PROCESS | 1822 | Values: 147.0 153.0 133.0 112.0 115.0 125.0 114.0 116.0 113.0 114.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:144.50 stddev:15.10 (10.5%) stddev-sans-first:13.65 15:09:24 INFO - PROCESS | 1822 | Values: 162.0 125.0 144.0 154.0 124.0 143.0 145.0 122.0 154.0 122.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#2] audio-dft Cycles:10 Average:201.30 Median:199.00 stddev:8.19 (4.1%) stddev-sans-first:8.65 15:09:24 INFO - PROCESS | 1822 | Values: 199.0 196.0 195.0 207.0 204.0 222.0 196.0 199.0 198.0 197.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#3] audio-fft Cycles:10 Average:73.10 Median:59.50 stddev:21.28 (35.8%) stddev-sans-first:22.57 15:09:24 INFO - PROCESS | 1822 | Values: 74.0 73.0 68.0 107.0 59.0 56.0 60.0 59.0 116.0 59.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:81.50 stddev:17.30 (21.2%) stddev-sans-first:17.59 15:09:24 INFO - PROCESS | 1822 | Values: 82.0 83.0 123.0 80.0 81.0 83.0 118.0 93.0 117.0 100.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:89.00 stddev:14.71 (16.5%) stddev-sans-first:15.14 15:09:24 INFO - PROCESS | 1822 | Values: 85.0 91.0 87.0 91.0 85.0 111.0 131.0 92.0 86.0 92.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#6] imaging-darkroom Cycles:10 Average:98.00 Median:94.50 stddev:10.57 (11.2%) stddev-sans-first:11.11 15:09:24 INFO - PROCESS | 1822 | Values: 94.0 95.0 128.0 95.0 96.0 94.0 94.0 96.0 94.0 94.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#7] imaging-desaturate Cycles:10 Average:101.00 Median:91.50 stddev:14.59 (15.9%) stddev-sans-first:15.11 15:09:24 INFO - PROCESS | 1822 | Values: 110.0 127.0 92.0 96.0 93.0 91.0 91.0 93.0 91.0 126.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:3.03 (5.3%) stddev-sans-first:3.16 15:09:24 INFO - PROCESS | 1822 | Values: 56.0 59.0 58.0 55.0 58.0 56.0 57.0 65.0 57.0 54.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:1.99 (2.9%) stddev-sans-first:1.83 15:09:24 INFO - PROCESS | 1822 | Values: 65.0 66.0 68.0 68.0 69.0 72.0 69.0 67.0 66.0 68.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:86.50 stddev:9.13 (10.6%) stddev-sans-first:9.51 15:09:24 INFO - PROCESS | 1822 | Values: 83.0 85.0 85.0 87.0 88.0 87.0 86.0 72.0 99.0 106.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:132.50 stddev:11.43 (8.6%) stddev-sans-first:11.83 15:09:24 INFO - PROCESS | 1822 | Values: 123.0 154.0 132.0 116.0 126.0 137.0 134.0 114.0 133.0 132.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:161.50 stddev:19.09 (11.8%) stddev-sans-first:18.74 15:09:24 INFO - PROCESS | 1822 | Values: 137.0 176.0 184.0 185.0 143.0 140.0 145.0 143.0 153.0 170.0 15:09:24 INFO - PROCESS | 1822 | 15:09:24 INFO - PROCESS | 1822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:69.50 stddev:12.15 (17.5%) stddev-sans-first:12.71 15:09:24 INFO - PROCESS | 1822 | Values: 68.0 69.0 69.0 66.0 68.0 70.0 92.0 58.0 82.0 96.0 15:09:24 INFO - PROCESS | 1822 | -------- Summary: end -------- 15:09:24 INFO - PROCESS | 1822 | 15:09:25 INFO - TEST-INFO | 1822: exit 0 15:09:25 INFO - TEST-OK | kraken | took 63668ms 15:09:25 INFO - SUITE-END | took 1174s 15:09:25 INFO - Completed test suite (00:19:34) 15:09:25 INFO - Working with test: dromaeo_css 15:09:25 INFO - Generating results file: dromaeo_css 15:09:25 INFO - Working with test: kraken 15:09:25 INFO - Generating results file: kraken 15:09:25 INFO - javascript benchmark 15:09:25 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:09:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 15:09:26 INFO - process_Request line: dromaeo_css 7423.21 graph.html#tests=[[72,64,61]] 15:09:26 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:09:26 INFO - process_Request line: kraken 1502.80 graph.html#tests=[[232,64,61]] 15:09:26 INFO - RETURN: dromaeo_css: 7423.21 15:09:26 INFO - RETURN: kraken: 1502.80 15:09:26 INFO - javascript benchmark 15:09:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3106.316610345724, 3162.8892988745397, 3417.897463076107, 3497.8251087445637, 3589.0489020409595, 5690.7723691052415, 5727.369989301179, 5739.942600573993, 5747.109198074305, 5763.798267060653, 5723.341815691197, 5797.188393624896, 5805.36141024488, 5871.765129394819, 5880.852978675535, 5160.019596276705, 5216.374035115791, 5240.633155679104, 5270.947290527103, 5286.3392075990505, 5078.162103252959, 5144.8713782155555, 5207.869803254911, 5226.712530810804, 5353.741870660392, 5167.664101833388, 5176.767045482962, 5188.584913206934, 5190.792368305263, 5199.220116982445, 5187.04039752647, 5203.323567936182, 5208.5312321891215, 5251.264822924793, 5266.1837415200325, 5080.77136528857, 5110.897782044375, 5129.307543481619, 5219.138842091051, 5220.686758794484, 5448.700321482317, 5570.108782594765, 5577.721113944286, 5601.215829783833, 5656.660600363992, 6100.217864923763, 6272.498200143978, 6273.278572964122, 6299.307076221612, 6303.653299068549, 6189.009758438673, 6259.436650701458, 6260.311365749764, 6287.088372186053, 6290.339514351019, 5854.707264636793, 5908.8002557748905, 5910.438508341701, 5931.110333450017, 5951.58338916276, 6185.721642526097, 6220.222472190976, 6305.5901366411035, 6311.96844015777, 6313.084602732578, 6199.28708198563, 6208.689565521706, 6214.627122372582, 6218.533609979179, 6250.4374606285655, 6248.375162483806, 6282.308946015934, 6288.811335659938, 6288.9056664150075, 6310.211223597051, 6066.0, 6170.845728856814, 6238.563300568917, 6244.968775156186, 6264.9373506265265, 6112.777056696867, 6133.1413602095745, 6250.906236406367, 6262.843428914313, 6281.277653069864, 4818.7831547580445, 4873.951260487421, 4914.434839993375, 4928.48250933654, 4931.630127740362, 4351.108022855307, 4400.69195156336, 4412.4043254160915, 4428.557144285545, 4452.5992660660695, 5741.224934633771, 5758.222639943638, 5809.9832529307205, 5814.534837213013, 5822.243108395966, 4826.469088400273, 6007.038873780174, 6149.108379284979, 6187.041008643668, 6240.906386404207, 5800.738966746507, 5831.446012628793, 5837.0, 5840.8247752567495, 5870.354261031283, 5462.426445223274, 5478.753456094406, 5483.903219356144, 5484.808031718871, 5486.725663716878, 6144.9553575892205, 6367.3314301997625, 6436.549441539141, 6479.5788273762055, 6518.445932095825, 5536.141898005815, 6192.721327540362, 6206.968965155145, 6241.344658810759, 6252.0, 6208.751649934133, 6285.842853928505, 6337.112804207507, 6354.841128971812, 6392.424681778476, 6227.595206311576, 6236.158118654105, 6239.937600623935, 6255.562110652393, 6275.717592708248, 6231.158793562811, 6254.3745625437095, 6260.7495700171485, 6278.215223097113, 6278.560500764903, 5977.581569290282, 6119.68535298207, 6187.350328215653, 6196.535259855619, 6227.719752611053, 6003.729832157476, 6004.099385092271, 6141.7543298267565, 6153.969230153821, 6179.3820617937845, 5956.702164891652, 6098.176746139215, 6108.11432342299, 6113.052476866093, 6114.449699526886, 6053.697315134314, 6113.841195312599, 6186.721597528032, 6208.875822483616, 6216.44052035319, 6081.239845019372, 6112.663803490851, 6122.724477398617, 6129.233845769279, 6138.693065346625], "unit": "score", "name": "dojo.html", "value": 5721.925243531184}, {"lowerIsBetter": false, "replicates": [455.45800497408084, 462.7986825730805, 473.26407436436347, 492.1264755059768, 601.3205078261564, 30110.397792044147, 32669.019929402126, 36891.07772305694, 37033.0, 37199.628003719954, 39788.403173952414, 40353.58762443315, 40645.57740479084, 40714.59285407145, 40742.388864167064, 9381.405161122608, 9536.332456728032, 9567.952160239223, 9631.422114673107, 9633.421994680306, 9560.56977436017, 9652.227821774277, 9703.805923881519, 9715.805683886318, 9720.854187187198, 9635.373700709466, 9699.951500242525, 9722.708318750449, 9731.36746111504, 9738.756531086708, 9616.90383096167, 9680.854787178198, 9696.224302055854, 9704.0, 9704.70885873425, 9413.0, 9475.715728528156, 9476.526173691356, 9510.239180865514, 9570.138687518087, 37628.0, 37691.81154094212, 37944.0, 37983.8100809497, 38081.0, 3267.7712560120563, 3414.6585341465902, 3560.9109772255642, 3563.322968635951, 3737.215184811193, 27825.721742782516, 27849.303767405774, 28060.298492537644, 28252.293692657644, 29332.41335173306, 2758.2690586994463, 2781.9443611127867, 2783.4293969736154, 2794.552871540564, 2835.957460638092, 500771.0, 503002.0, 505464.0, 508259.0, 508628.0, 35349.46975795365, 44432.77783611061, 44717.55282447199, 44750.552494474636, 57480.0, 43622.909427263934, 43665.34501982473, 43710.0, 43846.68459946207, 43959.340609890874, 15229.771553426708, 15356.232188390535, 15425.845741542666, 15455.0, 15569.766453503207, 12046.75906481883, 12468.501259949682, 12499.312537810325, 12561.748765024648, 12737.554185603645, 14389.424423022961, 14393.0, 14405.207713575644, 14436.133831970115, 14449.277536123362, 5377.7580008899695, 6283.59156654816, 6375.2987171411105, 6380.3619638035825, 6395.968020159869, 952.3428834104445, 988.7231575158967, 1058.5342449322275, 1062.85651437055, 1120.6638008597388, 21889.0, 24906.750932490806, 28186.85906570495, 29167.708322916922, 30270.940517082236, 1019.1490105761624, 1043.7599352149048, 1064.8722153341648, 1122.2144498850837, 1141.57191053355, 13757.79363309551, 13775.862241377457, 13897.374618142208, 14053.78919316211, 14096.577102686935, 523017.0, 532650.0, 535829.0, 537817.310913443, 540323.0, 49515.75242123767, 50006.74983125451, 50093.74953125211, 50199.498005020214, 50323.24515132276, 1411.8941079419085, 1416.9302176856409, 1434.3760464198108, 1453.4476898778396, 1453.4694836384645, 27225.31936701598, 27247.591286130326, 27813.721862781113, 27871.72128278691, 27874.30314242079, 45690.85772855705, 45948.310775339065, 46365.0, 46420.7678961603, 46637.53362466468, 514391.7121657621, 519030.0, 522438.0, 522556.0, 524418.0, 26718.465630687668, 31038.22404439907, 31481.685183147874, 31902.0, 32024.67975320217, 41161.38257926074, 41360.0, 41901.58098419099, 41985.79007104945, 42359.15281694411, 34986.12534686653, 35364.64635353613, 35665.82167089252, 35698.82150589334, 36023.0, 35016.12459688528, 35652.46521302235, 35773.0, 36047.0, 36075.819620901726, 34116.658833412344, 34817.0, 35090.473642895886, 35202.0, 35275.64724352724, 23743.881280593487, 27581.724182758717, 27629.894804207608, 27683.72316276892, 31838.0, 24002.27993160208, 24024.75975240295, 24460.0, 24615.38461538476, 24795.380115496537], "unit": "score", "name": "ext.html", "value": 18508.464243475562}, {"lowerIsBetter": false, "replicates": [326.41082845463944, 363.68722898307436, 364.42966757025255, 369.2264705442098, 369.85390770645614, 13683.726325473484, 15009.699806003873, 15606.765898511518, 19578.0, 20707.689384659225, 16738.0, 19800.70298945517, 20206.494837629067, 20347.0, 20662.17351305946, 5427.375851777047, 5482.835514934538, 5713.857153571153, 5725.227094342252, 5741.052726300156, 5569.916451253234, 5617.241672374218, 5646.378898321182, 5672.602917795756, 5681.517071048966, 5463.289772329612, 5625.578081643873, 5627.6060675752715, 5631.0708733059, 5697.857553561153, 5585.664860108406, 5628.465295796893, 5690.57320700947, 5698.8005419810315, 5724.313082430135, 4474.642028637733, 5014.924776128361, 5268.92096618551, 5317.202419637047, 5322.121849894763, 10837.83743243852, 12792.296423696693, 12914.225146491146, 13173.934130329382, 13299.335033248395, 2083.2187929526426, 2121.755998060212, 2160.82713382929, 2489.3776555861036, 2694.0, 9318.254539636813, 10477.952204779538, 14071.71856562863, 14357.712845743132, 14611.926940365336, 1671.515260574432, 1744.9879070139289, 1776.8578513718871, 1777.3779177287975, 1797.613513094678, 96692.51653741686, 98897.5055124727, 100166.99833001723, 100593.49703251437, 101992.98007019909, 10749.516271767789, 10965.890341096647, 11128.443577821077, 11188.832167517494, 11349.773004539862, 12232.694182645506, 13021.088523803242, 13622.318884055758, 13634.0, 13682.589522314347, 8297.792555186168, 8316.958415208006, 8428.704995325133, 8460.830783384421, 8463.788405289793, 8567.014793298851, 8603.870941935877, 8608.182222688834, 8613.48319100856, 8645.0, 4019.693599580148, 4306.784660766949, 4403.097365040223, 4411.073674528321, 4441.178381999341, 1797.5595978985232, 1894.1571000904742, 1896.2415033986515, 1934.861977514854, 1938.3603410874377, 839.5298632765671, 889.3863234368265, 920.4778905798198, 983.233078199006, 991.4299277915228, 13849.86150138506, 19975.400737977885, 20487.0, 20595.794042059686, 21205.78794212069, 880.1594477274188, 918.4305730447165, 942.4580866002076, 950.7860731335394, 1019.5819713917407, 10394.948025259826, 10901.618443354444, 11069.280496767684, 11176.217664763552, 11329.320240785415, 570221.0, 654478.0, 670666.0, 679832.0, 681638.0, 76233.0, 94157.5292123535, 126263.0, 128711.0, 130316.04525932118, 1019.4444028004755, 1025.9281850270559, 1036.5542816588788, 1039.4698703661036, 1044.6970378590277, 18238.72641910346, 18280.268789248283, 18487.81512184861, 18997.335093271668, 19138.617227655646, 41174.0, 43269.78365108154, 52597.68505787386, 53783.0, 55123.0, 60734.0, 66687.66656166688, 72620.27379726346, 73661.8950715729, 78477.21522784699, 8027.237412445808, 8116.715914942949, 8169.836603268021, 8213.055498617736, 8224.3831712623, 10510.369377837354, 13380.732385352043, 13494.797578036141, 13614.727705446034, 13729.519466818614, 9229.307801914749, 9273.953630231807, 11615.24500907472, 11776.764464710486, 11848.111391645489, 9842.803143936939, 11359.454109596, 11570.016548593127, 11625.825612615648, 11862.40687965581, 11783.646490605295, 11924.83524312786, 11988.76022479563, 12004.979576736076, 12023.45894434735, 7558.773236802685, 7869.960650196713, 8142.7557173284895, 8168.305694016075, 8248.587570621325, 10824.24230303871, 11727.41362931833, 12000.939995299968, 12087.456064476944, 12129.454174562343], "unit": "score", "name": "jquery.html", "value": 9162.771518809983}, {"lowerIsBetter": false, "replicates": [1550.844915508449, 1565.4364428805632, 1813.2837529175977, 1911.2546107018256, 1931.5074655962728, 7886.802829929255, 8578.571071446419, 8670.219680228778, 8881.245094166996, 8903.332250081245, 8540.91459085409, 8610.741677749678, 8713.0, 8753.299736021103, 8762.036176020632, 2478.851268923866, 2481.7642323979194, 2485.7762801347876, 2492.526419980207, 2494.5135698538793, 2438.6951631046118, 2504.8121390895662, 2513.296277042431, 2513.5852584323657, 2516.8741562921873, 2177.7277840269967, 2431.805455563551, 2453.815963802722, 2494.3140636325065, 2516.5721827289403, 2435.5372479228977, 2455.742147074567, 2475.3687809608614, 2483.4784695214025, 2490.203134996802, 2439.926802195937, 2465.6424818401233, 2474.443250268675, 2484.4410007748293, 2484.8942220711792, 8622.396432249745, 8669.869951950726, 8708.477491350539, 8709.477431354077, 8719.171678690514, 5339.119045357511, 5451.236826844245, 5463.453654634544, 5472.398036216013, 5503.449655034505, 3587.228745819635, 3626.0, 3721.0511319613597, 3733.626637336272, 3743.0642339415144, 944.8803168245582, 1050.8844027157006, 1057.0275346681071, 1082.2965072702727, 1089.5641743302742, 11597.942010289895, 11670.183087183901, 11801.645950621494, 11860.762784744256, 11937.761244775056, 4847.563719265283, 4912.95087049125, 4917.557419832232, 4921.753912304371, 4998.700077995332, 9961.252906032076, 10048.191325561324, 10115.696529104138, 10116.393016419039, 10174.4912754362, 5373.704446255415, 5380.354357477127, 5386.461353864661, 5459.590530710213, 5534.557235421156, 4965.255211718271, 4979.775910084055, 4991.875203119878, 5026.472220416877, 5028.84913452597, 3965.730966090823, 4003.0, 4006.338954072604, 4006.59934006597, 4009.91980160401, 1158.212415557429, 1177.193622368663, 1329.355262697591, 1336.565616174747, 1350.7973803929292, 1001.9829872679236, 1103.3931337764197, 1136.335243882338, 1226.0253098786486, 1340.9731805363838, 7062.788116356517, 7955.4828936118965, 8017.839643207103, 8093.959530202429, 8185.795355116051, 1099.3184225780067, 1124.2130508643818, 1187.109667749188, 1193.8806119387991, 1205.7709035283267, 5167.22491626259, 5185.83318753285, 6162.969185154046, 6213.347598502182, 6224.937750622526, 9254.86117708235, 9413.341066125306, 10642.521086550969, 10701.464926753632, 10731.248812583044, 9279.118483744034, 9360.0, 9866.358686685342, 10395.32430392022, 10561.366318020944, 8005.479643823133, 8221.876671849926, 8284.92296001528, 8338.374621903382, 8349.66601335952, 7863.370930325675, 7897.881531777143, 7963.243491868263, 7992.760217193493, 8015.6392962318005, 9348.345615806827, 9477.289203309641, 9591.376560523544, 9689.757756055873, 9727.221822254343, 9745.805083898424, 10073.496325183565, 10123.898761012295, 10303.072723454925, 10345.793084138426, 7533.6233188339265, 7610.391168706601, 7663.8850417242675, 7694.615269236628, 7707.267809558083, 8221.17788221173, 8264.710735124241, 8285.461445006296, 8314.293285070837, 8348.998120225611, 6727.865442691216, 7521.7743467696055, 7555.320021198118, 7693.153753087044, 7693.422993275639, 7162.498625096193, 7267.890981635174, 7270.854582908207, 7286.906963955449, 7343.669534871051, 7665.69337226527, 7686.615669216405, 7697.6151192441275, 7725.613719313899, 7737.264959828807, 6900.6204658742245, 6961.8860982242595, 7000.19497757744, 7027.964860175871, 7042.366187043191, 7130.679119439534, 7184.676689549087, 7191.892121618075, 7197.82005449847, 7221.458390620619], "unit": "score", "name": "mootools.html", "value": 4934.935082759086}, {"lowerIsBetter": false, "replicates": [285.4362633798249, 330.78829549088584, 334.4264586234607, 337.65727786296895, 340.180165800421, 6045.425684559966, 6449.193850768654, 6617.139771829668, 6633.170853643294, 6686.89969650455, 5532.97639936611, 5591.3569939456975, 6275.843103922404, 6418.390252925976, 6553.377429144236, 4876.537038888337, 4882.389701287339, 4883.267509873512, 4886.828960986366, 4908.607311415079, 4153.0, 4700.741459219742, 4902.720235090682, 4911.5088491150955, 4917.680350777206, 4824.565789078983, 4837.685550439228, 4843.346148269991, 4857.858403275245, 4873.610111191114, 4022.3363145081025, 4565.52062033485, 4775.164346239411, 4862.9787744573505, 4867.756612169395, 3326.251593391492, 3638.5088013118157, 4025.416314634391, 4047.97976010121, 4054.432379466877, 5391.946080539184, 6249.843753906143, 6261.812145635638, 6275.780347687809, 6290.056491526262, 5631.465010824006, 5634.211210430543, 5655.208270842086, 5673.0, 5676.148577713335, 7043.190033146203, 7047.295270472911, 7053.576785392893, 7053.576785392893, 7088.043114179572, 3781.829817658212, 3811.4854494643423, 4568.862934111982, 4571.885702857422, 4593.6095431888, 7209.387202087829, 7439.8140046499275, 7446.404287657028, 7451.366633836131, 7499.812504687372, 4560.543945605413, 4631.054956918102, 4643.141018911512, 4666.953330466652, 4682.4381074271305, 4745.786439610226, 4753.073150735573, 4754.120487709784, 4756.857294281177, 4770.045990801854, 5706.429357064343, 5721.342045664802, 5741.88516229673, 5743.741531631086, 5767.480926716532, 6141.815745527641, 6826.965865170741, 7175.533590316717, 7197.4961752677855, 7203.89194162088, 1611.1782990674606, 1634.7874776279007, 1635.0026483844845, 1643.589102724319, 1645.6050547868426, 927.4945154890601, 984.640606178754, 1040.245821779204, 1041.1982773264544, 1063.3088492479794, 6496.415322620986, 6591.571547849375, 6612.173478315211, 6621.0, 6646.401823835878, 6685.899711504331, 7416.666250018762, 7449.292317229854, 7494.737684181027, 7526.397888168934, 6668.833279167962, 6684.197896252481, 6687.866242675119, 6695.46436285096, 6696.665166741644, 3119.9704097647723, 3945.9013524662114, 3969.6030396960073, 3985.6612187964347, 3995.62041606047, 6237.189165408558, 7563.773086807405, 7900.249476299742, 7902.510709126606, 7910.881336779953, 7778.416618753616, 7783.571903545359, 7787.649555770004, 7792.259735325135, 7820.413468989848, 7078.221395646475, 7149.463790215755, 7898.526088434713, 7902.841943161219, 7920.762377128695, 6182.381761823782, 7518.98493703365, 7525.6989720410575, 7561.432892532972, 7569.886451703339, 5933.673647949404, 7325.597092159983, 7354.595497247703, 7364.77905662831, 7381.261873812576, 7818.569978651229, 7824.439879854539, 7853.725119620786, 7860.646270917708, 7867.213278672087, 4611.400517932647, 4673.929891051569, 4679.578837904605, 4681.227597446383, 4691.50739172382, 7246.384057355184, 7489.887651685338, 7493.138289096823, 7506.0, 7544.0192774938905, 5708.571857110816, 5875.706214689334, 6524.151860258136, 7235.095613048369, 7281.235470275545, 6099.908501372394, 6909.1018167637885, 7188.5327453715345, 7194.748183813542, 7211.098612673416, 5704.3154821421695, 6982.546134501241, 7017.017617533447, 7019.4033507150425, 7030.121234845645, 6946.097007389007, 7145.1425828900865, 7177.712891484491, 7178.748743793943, 7196.568205907663, 5551.916721249266, 6735.393814556714, 7094.858102837811, 7101.7159313628945, 7106.360427561544], "unit": "score", "name": "prototype.html", "value": 5108.067508936215}, {"lowerIsBetter": false, "replicates": [668.866226754649, 703.7290643102405, 715.1489727224603, 727.7598392530465, 728.2862794461424, 14697.926510367433, 14702.191379474138, 14785.817134629231, 14812.481563145293, 14843.257837108129, 13791.310434478286, 13870.514531991357, 13945.302734863268, 13982.091164074329, 13989.860101398983, 688.5730846874944, 848.4018766769443, 863.7667829685981, 868.6047848229073, 883.730462209026, 843.0473564871717, 867.7830542364409, 869.7260362985671, 870.6996086350199, 878.6748902905933, 930.9394889332206, 933.9533023348839, 936.3960245641557, 936.3960245641591, 939.7791518993065, 902.5893218585528, 908.8273228086675, 921.4471317209687, 925.7454200094994, 928.5867788833938, 680.3060877904559, 680.8059702984675, 688.3598253624127, 689.810302166903, 689.8792711275557, 13435.731285374335, 13441.596752097355, 13467.730645387037, 13501.122427042212, 13560.0, 12995.0, 13051.21692698441, 13057.412416441282, 13097.738045239137, 13185.604431866963, 10065.295429319951, 10074.294799364048, 10108.140808031327, 10111.39331640104, 10173.186145108373, 3379.695827375548, 3429.4341433663417, 3444.9827750861336, 3449.741269404805, 3450.723942084627, 79978.80031799528, 82274.58862705648, 84206.57896710538, 85147.0, 85632.0, 9673.806523869483, 9695.66065187715, 9776.810885521376, 9806.65676701312, 10215.846762298572, 21457.78542214589, 21536.461588460414, 21816.89091554564, 21943.451413714465, 21963.011664475136, 6164.7842325518395, 7248.238934911864, 7255.52839065459, 7464.477486575996, 7666.616669166519, 4054.1688953764406, 4123.587641235852, 4141.958580414218, 4177.373393990925, 4322.286822674287, 3544.7518673692593, 3552.0764601203873, 3584.318979393907, 3586.55168103987, 3595.8741444049856, 610.4414460768436, 617.2716194889983, 632.0582332324803, 637.3403527349265, 646.0438550944534, 562.445990699161, 570.6262398129232, 588.2176704982363, 609.7103875659116, 620.1782638004662, 7098.609576473344, 8183.32892510847, 8716.605343145193, 8716.997545282373, 8844.646214151491, 517.3972322244618, 584.3396961433552, 595.1905408644241, 596.9373215812277, 614.2598169206096, 3971.205758848242, 3975.900602484961, 4016.9598304016586, 4105.035316700573, 4129.922769348705, 69195.0, 92600.53699731459, 95332.52333738287, 95512.0, 95892.52053739686, 70185.59628807395, 81007.0, 81800.0, 82512.17487825165, 82699.0, 68177.31822681808, 69962.65018674874, 70631.0, 73959.63020184865, 74460.25539744533, 6799.694013769491, 7986.960065199637, 8207.097219305751, 8283.83432331362, 8306.252437280433, 49378.75310623424, 49871.75064124656, 50095.0, 50181.0, 50913.745431272604, 68833.0, 69011.65494172498, 69450.0, 70173.64913175402, 70631.0, 9683.852454532534, 9749.756256093655, 9795.412275263507, 9991.800163996824, 10065.986802639354, 9560.378575392577, 9568.4737339447, 11126.88873111291, 11902.166848320534, 13070.80393794113, 11239.494222760159, 11276.9436152822, 11321.490532926204, 11599.130065244972, 11747.530098795953, 10295.639652612123, 11163.218574699693, 11409.3724845131, 11522.827157592475, 11556.826647600124, 11431.828522572334, 11437.656870293904, 11439.771204576029, 11475.368854713071, 11543.36511491876, 9493.57278922464, 9588.952055239679, 9872.974070077138, 9943.552540135566, 10024.599016039278, 9748.171405430618, 10016.499175041365, 10031.648892289028, 10032.930627467098, 10042.191567671016], "unit": "score", "name": "yui.html", "value": 6839.742788352657}], "name": "dromaeo_css", "value": 7423.207232746798}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [147.0, 153.0, 133.0, 112.0, 115.0, 125.0, 114.0, 116.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 124.2}, {"lowerIsBetter": true, "replicates": [162.0, 125.0, 144.0, 154.0, 124.0, 143.0, 145.0, 122.0, 154.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 139.5}, {"lowerIsBetter": true, "replicates": [199.0, 196.0, 195.0, 207.0, 204.0, 222.0, 196.0, 199.0, 198.0, 197.0], "unit": "score", "name": "audio-dft", "value": 201.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 68.0, 107.0, 59.0, 56.0, 60.0, 59.0, 116.0, 59.0], "unit": "score", "name": "audio-fft", "value": 73.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 123.0, 80.0, 81.0, 83.0, 118.0, 93.0, 117.0, 100.0], "unit": "score", "name": "audio-oscillator", "value": 96.0}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 87.0, 91.0, 85.0, 111.0, 131.0, 92.0, 86.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 128.0, 95.0, 96.0, 94.0, 94.0, 96.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 98.0}, {"lowerIsBetter": true, "replicates": [110.0, 127.0, 92.0, 96.0, 93.0, 91.0, 91.0, 93.0, 91.0, 126.0], "unit": "score", "name": "imaging-desaturate", "value": 101.0}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 58.0, 55.0, 58.0, 56.0, 57.0, 65.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 68.0, 68.0, 69.0, 72.0, 69.0, 67.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 87.0, 88.0, 87.0, 86.0, 72.0, 99.0, 106.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [123.0, 154.0, 132.0, 116.0, 126.0, 137.0, 134.0, 114.0, 133.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.1}, {"lowerIsBetter": true, "replicates": [137.0, 176.0, 184.0, 185.0, 143.0, 140.0, 145.0, 143.0, 153.0, 170.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 157.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 66.0, 68.0, 70.0, 92.0, 58.0, 82.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.8}], "name": "kraken", "value": 1502.7999999999997}]} 15:09:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1502.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7423.21"}}} 15:09:26 INFO - Return code: 0 15:09:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:09:26 ERROR - # TBPL SUCCESS # 15:09:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:09:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:09:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:09:26 INFO - 2016-02-22 15:09:26.229 screenresolution[1833:10540] starting screenresolution argv=screenresolution get 15:09:26 INFO - 2016-02-22 15:09:26.232 screenresolution[1833:10540] Display 0: 1600x1200x32@60 15:09:26 INFO - 2016-02-22 15:09:26.238 screenresolution[1834:10544] starting screenresolution argv=screenresolution list 15:09:26 INFO - Available Modes on Display 0 15:09:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:09:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:09:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:09:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:09:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:09:26 INFO - Intel Iris: 15:09:26 INFO - Chipset Model: Intel Iris 15:09:26 INFO - Type: GPU 15:09:26 INFO - Bus: Built-In 15:09:26 INFO - VRAM (Dynamic, Max): 1536 MB 15:09:26 INFO - Vendor: Intel (0x8086) 15:09:26 INFO - Device ID: 0x0a2e 15:09:26 INFO - Revision ID: 0x0009 15:09:26 INFO - Displays: 15:09:26 INFO - Display: 15:09:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:09:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:09:26 INFO - Display Serial Number: 1600x1200 60 15:09:26 INFO - Main Display: Yes 15:09:26 INFO - Mirror: Off 15:09:26 INFO - Online: Yes 15:09:26 INFO - Rotation: Supported 15:09:26 INFO - Return code: 0 15:09:26 INFO - Running post-action listener: _resource_record_post_action 15:09:26 INFO - Running post-run listener: _resource_record_post_run 15:09:27 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 39540224; Write bytes: 713048576; Read time: 428; Write time: 1868 15:09:27 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 262144; Write bytes: 405689856; Read time: 7; Write time: 689 15:09:27 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37733888; Write bytes: 306510848; Read time: 406; Write time: 1177 15:09:27 INFO - Running post-run listener: _upload_blobber_files 15:09:27 INFO - Blob upload gear active. 15:09:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:09:27 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 15:09:27 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'] 15:09:27 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 15:09:27 INFO - (blobuploader) - INFO - Open directory for files ... 15:09:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:09:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:09:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:29 INFO - (blobuploader) - INFO - Done attempting. 15:09:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:09:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:09:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:29 INFO - (blobuploader) - INFO - Done attempting. 15:09:29 INFO - (blobuploader) - INFO - Iteration through files over. 15:09:29 INFO - Return code: 0 15:09:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:09:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:09:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03ad0c9543b95069fd11c2c7f75b5b80092964f38d9615438c4a30ae06e4dfa225e27009a43cbce67b0d2c33032d7b9a479d23284233158523830ff0da57dfb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c05c0305d31e8cb61b76b22662084c0c7a3f25b0ba2eda815b06fef70291ed530b34fc1db9088e20b492f4de30d30f7e2ecf38ff55fd088b1efea5ef7abe617"} 15:09:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:09:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:09:29 INFO - Contents: 15:09:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03ad0c9543b95069fd11c2c7f75b5b80092964f38d9615438c4a30ae06e4dfa225e27009a43cbce67b0d2c33032d7b9a479d23284233158523830ff0da57dfb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c05c0305d31e8cb61b76b22662084c0c7a3f25b0ba2eda815b06fef70291ed530b34fc1db9088e20b492f4de30d30f7e2ecf38ff55fd088b1efea5ef7abe617"} 15:09:29 INFO - Running post-run listener: copy_logs_to_upload_dir 15:09:29 INFO - Copying logs to upload dir... 15:09:29 INFO - mkdir: /builds/slave/test/build/upload/logs 15:09:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.511416 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-22 15:09:30.059996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 15:09:30.064046) ========= 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.5StHuhadF9/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.PdQuD1Ovqb/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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/03ad0c9543b95069fd11c2c7f75b5b80092964f38d9615438c4a30ae06e4dfa225e27009a43cbce67b0d2c33032d7b9a479d23284233158523830ff0da57dfb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c05c0305d31e8cb61b76b22662084c0c7a3f25b0ba2eda815b06fef70291ed530b34fc1db9088e20b492f4de30d30f7e2ecf38ff55fd088b1efea5ef7abe617"} build_url:https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/ArEa2R0WT12_0VNOEPY9Jg/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/03ad0c9543b95069fd11c2c7f75b5b80092964f38d9615438c4a30ae06e4dfa225e27009a43cbce67b0d2c33032d7b9a479d23284233158523830ff0da57dfb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c05c0305d31e8cb61b76b22662084c0c7a3f25b0ba2eda815b06fef70291ed530b34fc1db9088e20b492f4de30d30f7e2ecf38ff55fd088b1efea5ef7abe617"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 15:09:30.091025) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:09:30.091395) ========= 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.5StHuhadF9/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.PdQuD1Ovqb/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005112 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:09:30.141005) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 15:09:30.141476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 15:09:30.142018) ========= ========= Total master_lag: 1.56 =========