builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0091 starttime: 1455036596.47 results: success (0) buildid: 20160209065855 builduid: b721cbd5fa1f466fa550cebbb6a526bb revision: dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.468997) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.469440) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.469728) ========= 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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.005419 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.495985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.496304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.527263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.527697) ========= 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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.005421 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.576495) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.576778) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.577177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:56.577452) ========= 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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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-09 08:49:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.9M=0.001s 2016-02-09 08:49:57 (10.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.426792 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:57.066055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:57.066357) ========= 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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.019710 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:57.104480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 08:49:57.104796) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0 --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 dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G5epqmnhdm/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.H3gCGpN7Jc/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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-09 08:49:57,180 truncating revision to first 12 chars 2016-02-09 08:49:57,180 Setting DEBUG logging. 2016-02-09 08:49:57,180 attempt 1/10 2016-02-09 08:49:57,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc2c6c1a4fe3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 08:49:58,172 unpacking tar archive at: fx-team-dc2c6c1a4fe3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.430172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 08:49:58.550702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:58.551076) ========= echo dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G5epqmnhdm/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.H3gCGpN7Jc/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0 program finished with exit code 0 elapsedTime=0.004927 script_repo_revision: 'dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:58.600336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:58.600628) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 08:49:58.613318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-09 08:49:58.613605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G5epqmnhdm/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.H3gCGpN7Jc/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:49:58 INFO - MultiFileLogger online at 20160209 08:49:58 in /builds/slave/test 08:49:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:49:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:58 INFO - {'append_to_log': False, 08:49:58 INFO - 'base_work_dir': '/builds/slave/test', 08:49:58 INFO - 'blob_upload_branch': 'Fx-Team', 08:49:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:58 INFO - 'branch': 'Fx-Team', 08:49:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:58 INFO - 'config_files': ('talos/mac_config.py',), 08:49:58 INFO - 'default_actions': ('clobber', 08:49:58 INFO - 'read-buildbot-config', 08:49:58 INFO - 'download-and-extract', 08:49:58 INFO - 'populate-webroot', 08:49:58 INFO - 'create-virtualenv', 08:49:58 INFO - 'install', 08:49:58 INFO - 'run-tests'), 08:49:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:58 INFO - 'download_minidump_stackwalk': True, 08:49:58 INFO - 'download_symbols': 'ondemand', 08:49:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:58 INFO - 'installer_path': 'installer.exe', 08:49:58 INFO - 'log_level': 'info', 08:49:58 INFO - 'log_name': 'talos', 08:49:58 INFO - 'log_to_console': True, 08:49:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:49:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:49:58 INFO - 'opt_config_files': (), 08:49:58 INFO - 'pip_index': False, 08:49:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:58 INFO - 'cmd': ('bash', 08:49:58 INFO - '-c', 08:49:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:58 INFO - 'enabled': True, 08:49:58 INFO - 'halt_on_failure': False, 08:49:58 INFO - 'name': 'check_screen_resolution'},), 08:49:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:58 INFO - 'cmd': ('bash', 08:49:58 INFO - '-c', 08:49:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:58 INFO - 'enabled': True, 08:49:58 INFO - 'halt_on_failure': False, 08:49:58 INFO - 'name': 'check_screen_resolution'},), 08:49:58 INFO - 'run_cmd_checks_enabled': True, 08:49:58 INFO - 'sps_profile': False, 08:49:58 INFO - 'sps_profile_interval': 0, 08:49:58 INFO - 'suite': 'dromaeojs', 08:49:58 INFO - 'system_bits': '32', 08:49:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:58 INFO - 'title': 't-yosemite-r7-0091', 08:49:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:58 INFO - 'use_talos_json': True, 08:49:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:58 INFO - 'work_dir': 'build'} 08:49:58 INFO - ##### 08:49:58 INFO - ##### Running clobber step. 08:49:58 INFO - ##### 08:49:58 INFO - Running pre-action listener: _resource_record_pre_action 08:49:58 INFO - Running main action method: clobber 08:49:58 INFO - rmtree: /builds/slave/test/build 08:49:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:59 INFO - Running post-action listener: _resource_record_post_action 08:49:59 INFO - ##### 08:49:59 INFO - ##### Running read-buildbot-config step. 08:49:59 INFO - ##### 08:49:59 INFO - Running pre-action listener: _resource_record_pre_action 08:49:59 INFO - Running main action method: read_buildbot_config 08:49:59 INFO - Using buildbot properties: 08:49:59 INFO - { 08:49:59 INFO - "project": "", 08:49:59 INFO - "product": "firefox", 08:49:59 INFO - "script_repo_revision": "production", 08:49:59 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:49:59 INFO - "repository": "", 08:49:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:49:59 INFO - "buildid": "20160209065855", 08:49:59 INFO - "pgo_build": "False", 08:49:59 INFO - "basedir": "/builds/slave/test", 08:49:59 INFO - "buildnumber": 348, 08:49:59 INFO - "slavename": "t-yosemite-r7-0091", 08:49:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:49:59 INFO - "platform": "yosemite_r7", 08:49:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:49:59 INFO - "branch": "fx-team", 08:49:59 INFO - "repo_path": "integration/fx-team", 08:49:59 INFO - "revision": "dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0", 08:49:59 INFO - "stage_platform": "macosx64", 08:49:59 INFO - "builduid": "b721cbd5fa1f466fa550cebbb6a526bb", 08:49:59 INFO - "slavebuilddir": "test" 08:49:59 INFO - } 08:49:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:49:59 INFO - Running post-action listener: _resource_record_post_action 08:49:59 INFO - ##### 08:49:59 INFO - ##### Running download-and-extract step. 08:49:59 INFO - ##### 08:49:59 INFO - Running pre-action listener: _resource_record_pre_action 08:49:59 INFO - Running main action method: download_and_extract 08:49:59 INFO - mkdir: /builds/slave/test/build/tests 08:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:59 INFO - https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:49:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/test_packages.json 08:49:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/test_packages.json 08:49:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:49:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:50:02 INFO - Downloaded 1277 bytes. 08:50:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:50:02 INFO - Using the following test package requirements: 08:50:02 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:50:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:50:02 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:50:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:50:02 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:50:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:50:02 INFO - u'jsshell-mac.zip'], 08:50:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:50:02 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:50:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:50:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:50:02 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:50:02 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:50:02 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:50:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:50:02 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:50:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:50:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:50:02 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:50:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:50:02 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')]} 08:50:02 INFO - https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/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 08:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/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 08:50:04 INFO - Downloaded 17747819 bytes. 08:50:04 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'] 08:50:04 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 08:50:07 INFO - Return code: 0 08:50:07 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 08:50: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')]} 08:50:07 INFO - https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:50:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:50:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:50:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/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 08:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/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 08:50:08 INFO - Downloaded 17747819 bytes. 08:50:08 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'] 08:50:08 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 08:50:11 INFO - Return code: 0 08:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:11 INFO - https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:50:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:50:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:50:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/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 08:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/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 08:50:12 INFO - Downloaded 10706547 bytes. 08:50:12 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'] 08:50:12 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 08:50:12 INFO - Return code: 0 08:50:12 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')]} 08:50:12 INFO - https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:50:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:50:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:50:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:50:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKbDpZKGSze4VUgbvvAy3w/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 08:50:15 INFO - Downloaded 111249517 bytes. 08:50:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:50:15 INFO - mkdir: /builds/slave/test/properties 08:50:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:50:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:50:15 INFO - Contents: 08:50:15 INFO - build_url:https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:50:16 INFO - Running post-action listener: _resource_record_post_action 08:50:16 INFO - Running post-action listener: set_extra_try_arguments 08:50:16 INFO - ##### 08:50:16 INFO - ##### Running populate-webroot step. 08:50:16 INFO - ##### 08:50:16 INFO - Running pre-action listener: _resource_record_pre_action 08:50:16 INFO - Running main action method: populate_webroot 08:50:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:50:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:50:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:50:16 INFO - '--tppagecycles', 08:50:16 INFO - '7'], 08:50:16 INFO - 'tests': ['tsvgm']}}, 08:50:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:50:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:50:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:50:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:50:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:50:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:50:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:16 INFO - 'talos_options': ['--e10s'], 08:50:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:16 INFO - 'tests': ['damp', 'tps']}, 08:50:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:16 INFO - 'talos_options': ['--e10s'], 08:50:16 INFO - 'tests': ['damp', 'tps']}, 08:50:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:50:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:50:16 INFO - 'other': {'tests': ['a11yr', 08:50:16 INFO - 'ts_paint', 08:50:16 INFO - 'tpaint', 08:50:16 INFO - 'sessionrestore', 08:50:16 INFO - 'sessionrestore_no_auto_restore']}, 08:50:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:50:16 INFO - 'tests': ['a11yr', 08:50:16 INFO - 'ts_paint', 08:50:16 INFO - 'tpaint', 08:50:16 INFO - 'sessionrestore', 08:50:16 INFO - 'sessionrestore_no_auto_restore']}, 08:50:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:50:16 INFO - 'tests': ['a11yr', 08:50:16 INFO - 'ts_paint', 08:50:16 INFO - 'tpaint', 08:50:16 INFO - 'sessionrestore', 08:50:16 INFO - 'sessionrestore_no_auto_restore']}, 08:50:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:50:16 INFO - 'tests': ['a11yr', 08:50:16 INFO - 'ts_paint', 08:50:16 INFO - 'tpaint', 08:50:16 INFO - 'sessionrestore', 08:50:16 INFO - 'sessionrestore_no_auto_restore']}, 08:50:16 INFO - 'other_l64': {'tests': ['a11yr', 08:50:16 INFO - 'ts_paint', 08:50:16 INFO - 'tpaint', 08:50:16 INFO - 'sessionrestore', 08:50:16 INFO - 'sessionrestore_no_auto_restore']}, 08:50:16 INFO - 'other_nol64': {'tests': ['a11yr', 08:50:16 INFO - 'ts_paint', 08:50:16 INFO - 'tpaint', 08:50:16 INFO - 'sessionrestore', 08:50:16 INFO - 'sessionrestore_no_auto_restore']}, 08:50:16 INFO - 'svgr': {'tests': ['tsvgx', 08:50:16 INFO - 'tsvgr_opacity', 08:50:16 INFO - 'tart', 08:50:16 INFO - 'tscrollx', 08:50:16 INFO - 'cart']}, 08:50:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:50:16 INFO - 'tests': ['tsvgx', 08:50:16 INFO - 'tsvgr_opacity', 08:50:16 INFO - 'tart', 08:50:16 INFO - 'tscrollx', 08:50:16 INFO - 'cart']}, 08:50:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:16 INFO - 'tests': ['tp5o']}, 08:50:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:16 INFO - 'talos_options': ['--e10s'], 08:50:16 INFO - 'tests': ['tp5o']}, 08:50:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:16 INFO - 'talos_options': ['--xperf_path', 08:50:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:16 INFO - 'tests': ['tp5n']}, 08:50:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:16 INFO - 'talos_options': ['--e10s', 08:50:16 INFO - '--xperf_path', 08:50:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:16 INFO - 'tests': ['tp5n']}}, 08:50:16 INFO - 'talos.zip': {'path': '', 08:50:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:50:16 INFO - Running post-action listener: _resource_record_post_action 08:50:16 INFO - ##### 08:50:16 INFO - ##### Running create-virtualenv step. 08:50:16 INFO - ##### 08:50:16 INFO - Running pre-action listener: _resource_record_pre_action 08:50:16 INFO - Running main action method: create_virtualenv 08:50:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:50:16 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 08:50:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:50:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:50:16 INFO - Using real prefix '/tools/python27' 08:50:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:50:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:50:20 INFO - Installing pip.................done. 08:50:20 INFO - Return code: 0 08:50:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:20 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100544c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530c66bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, '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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:50:20 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 08:50:20 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 08:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:20 INFO - 'HOME': '/Users/cltbld', 08:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:20 INFO - 'LOGNAME': 'cltbld', 08:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:20 INFO - 'MOZ_NO_REMOTE': '1', 08:50:20 INFO - 'NO_EM_RESTART': '1', 08:50:20 INFO - 'PAGER': '/bin/cat', 08:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:20 INFO - 'PWD': '/builds/slave/test', 08:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:20 INFO - 'SHELL': '/bin/bash', 08:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:50:20 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:20 INFO - 'USER': 'cltbld', 08:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:20 INFO - 'XPC_FLAGS': '0x0', 08:50:20 INFO - 'XPC_SERVICE_NAME': '0', 08:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:20 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 08:50:20 INFO - Cleaning up... 08:50:20 INFO - Return code: 0 08:50:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:20 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100544c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530c66bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, '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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:50:20 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 08:50:20 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 08:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:20 INFO - 'HOME': '/Users/cltbld', 08:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:20 INFO - 'LOGNAME': 'cltbld', 08:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:20 INFO - 'MOZ_NO_REMOTE': '1', 08:50:20 INFO - 'NO_EM_RESTART': '1', 08:50:20 INFO - 'PAGER': '/bin/cat', 08:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:20 INFO - 'PWD': '/builds/slave/test', 08:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:20 INFO - 'SHELL': '/bin/bash', 08:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:50:20 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:20 INFO - 'USER': 'cltbld', 08:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:20 INFO - 'XPC_FLAGS': '0x0', 08:50:20 INFO - 'XPC_SERVICE_NAME': '0', 08:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:20 INFO - Downloading/unpacking psutil>=0.7.1 08:50:20 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 08:50:20 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 08:50:20 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 08:50:20 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 08:50:20 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 08:50:20 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 08:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:50:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:23 INFO - Installing collected packages: psutil 08:50:23 INFO - Running setup.py install for psutil 08:50:23 INFO - building 'psutil._psutil_osx' extension 08:50:23 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 08:50:23 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 08:50:24 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 08:50:24 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 08:50:24 INFO - building 'psutil._psutil_posix' extension 08:50:24 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 08:50:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:50:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:50:24 INFO - ^ 08:50:24 INFO - 1 warning generated. 08:50:24 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 08:50:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:24 INFO - Successfully installed psutil 08:50:24 INFO - Cleaning up... 08:50:24 INFO - Return code: 0 08:50:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:50:24 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')]} 08:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:24 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')]} 08:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:24 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100544c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530c66bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, '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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:50:24 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 08:50:24 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 08:50:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:50:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:24 INFO - 'HOME': '/Users/cltbld', 08:50:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:24 INFO - 'LOGNAME': 'cltbld', 08:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:24 INFO - 'MOZ_NO_REMOTE': '1', 08:50:24 INFO - 'NO_EM_RESTART': '1', 08:50:24 INFO - 'PAGER': '/bin/cat', 08:50:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:24 INFO - 'PWD': '/builds/slave/test', 08:50:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:24 INFO - 'SHELL': '/bin/bash', 08:50:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:50:24 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:50:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:24 INFO - 'USER': 'cltbld', 08:50:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:24 INFO - 'XPC_FLAGS': '0x0', 08:50:24 INFO - 'XPC_SERVICE_NAME': '0', 08:50:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:50:27 INFO - Installing collected packages: mozsystemmonitor 08:50:27 INFO - Running setup.py install for mozsystemmonitor 08:50:27 INFO - Successfully installed mozsystemmonitor 08:50:27 INFO - Cleaning up... 08:50:27 INFO - Return code: 0 08:50:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:50:27 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')]} 08:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:27 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')]} 08:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:27 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100544c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530c66bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, '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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:50:27 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 08:50:27 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 08:50:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:50:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:27 INFO - 'HOME': '/Users/cltbld', 08:50:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:27 INFO - 'LOGNAME': 'cltbld', 08:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:27 INFO - 'MOZ_NO_REMOTE': '1', 08:50:27 INFO - 'NO_EM_RESTART': '1', 08:50:27 INFO - 'PAGER': '/bin/cat', 08:50:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:27 INFO - 'PWD': '/builds/slave/test', 08:50:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:27 INFO - 'SHELL': '/bin/bash', 08:50:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:50:27 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:50:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:27 INFO - 'USER': 'cltbld', 08:50:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:27 INFO - 'XPC_FLAGS': '0x0', 08:50:27 INFO - 'XPC_SERVICE_NAME': '0', 08:50:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:28 INFO - Downloading/unpacking blobuploader==1.2.4 08:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50:30 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 08:50:30 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 08:50:30 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 08:50:30 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 08:50:30 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 08:50:30 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 08:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50:30 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 08:50:30 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 08:50:30 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 08:50:30 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 08:50:30 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 08:50:30 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 08:50:31 INFO - Downloading docopt-0.6.1.tar.gz 08:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:31 INFO - Running setup.py install for blobuploader 08:50:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:31 INFO - Running setup.py install for requests 08:50:32 INFO - Running setup.py install for docopt 08:50:32 INFO - Successfully installed blobuploader requests docopt 08:50:32 INFO - Cleaning up... 08:50:32 INFO - Return code: 0 08:50:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:32 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')]} 08:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:32 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')]} 08:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:32 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100544c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530c66bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, '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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:50:32 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 08:50:32 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 08:50:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:50:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:32 INFO - 'HOME': '/Users/cltbld', 08:50:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:32 INFO - 'LOGNAME': 'cltbld', 08:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:32 INFO - 'MOZ_NO_REMOTE': '1', 08:50:32 INFO - 'NO_EM_RESTART': '1', 08:50:32 INFO - 'PAGER': '/bin/cat', 08:50:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:32 INFO - 'PWD': '/builds/slave/test', 08:50:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:32 INFO - 'SHELL': '/bin/bash', 08:50:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:50:32 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:50:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:32 INFO - 'USER': 'cltbld', 08:50:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:32 INFO - 'XPC_FLAGS': '0x0', 08:50:32 INFO - 'XPC_SERVICE_NAME': '0', 08:50:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-7cByf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-_UJEBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-JlKqk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-Cz_Xmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:33 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-yLxTo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:33 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-x_dXzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:33 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-_eh4Ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:33 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-82xV1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:33 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-BFua68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:33 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-iKI0mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:33 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-EmjA6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:33 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-J5weVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:33 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-IUG1NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:34 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-DzzzZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:34 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-qNlKn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:34 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-dsT5I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:34 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-pnmaAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:34 INFO - Running setup.py install for manifestparser 08:50:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:34 INFO - Running setup.py install for mozcrash 08:50:34 INFO - Running setup.py install for mozdebug 08:50:34 INFO - Running setup.py install for mozdevice 08:50:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:35 INFO - Running setup.py install for mozfile 08:50:35 INFO - Running setup.py install for mozhttpd 08:50:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:35 INFO - Running setup.py install for mozinfo 08:50:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:35 INFO - Running setup.py install for mozInstall 08:50:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:35 INFO - Running setup.py install for mozleak 08:50:35 INFO - Running setup.py install for mozlog 08:50:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:35 INFO - Running setup.py install for moznetwork 08:50:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:36 INFO - Running setup.py install for mozprocess 08:50:36 INFO - Running setup.py install for mozprofile 08:50:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:36 INFO - Running setup.py install for mozrunner 08:50:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:36 INFO - Running setup.py install for mozscreenshot 08:50:36 INFO - Running setup.py install for moztest 08:50:36 INFO - Running setup.py install for mozversion 08:50:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:36 INFO - Cleaning up... 08:50:36 INFO - Return code: 0 08:50:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:36 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')]} 08:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:36 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')]} 08:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:36 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100544c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530c66bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, '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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:50:36 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 08:50:36 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 08:50:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:50:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:36 INFO - 'HOME': '/Users/cltbld', 08:50:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:36 INFO - 'LOGNAME': 'cltbld', 08:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:36 INFO - 'MOZ_NO_REMOTE': '1', 08:50:36 INFO - 'NO_EM_RESTART': '1', 08:50:36 INFO - 'PAGER': '/bin/cat', 08:50:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:36 INFO - 'PWD': '/builds/slave/test', 08:50:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:36 INFO - 'SHELL': '/bin/bash', 08:50:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:50:36 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:50:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:36 INFO - 'USER': 'cltbld', 08:50:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:36 INFO - 'XPC_FLAGS': '0x0', 08:50:36 INFO - 'XPC_SERVICE_NAME': '0', 08:50:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-fn_LQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:37 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)) 08:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-C_xzaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:37 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)) 08:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-IS4K2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:37 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)) 08:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-Z1YdMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:37 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)) 08:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-e1WxIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:37 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)) 08:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-Dl9VJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:37 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)) 08:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-lQBlVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:37 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)) 08:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-cTI69G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:38 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)) 08:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:38 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-VGJdUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:38 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)) 08:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:38 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-7jXG5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:38 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)) 08:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:38 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-dNoIZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:38 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)) 08:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:38 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-Fh8EBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:38 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)) 08:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:38 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-HZurc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:38 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)) 08:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:38 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-DW6wLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:38 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)) 08:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:38 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-nPwGLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:38 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)) 08:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:38 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-4myIYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:38 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)) 08:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:38 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-r4tUMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:39 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)) 08:50:39 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)) 08:50:39 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)) 08:50:39 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)) 08:50:39 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)) 08:50:39 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)) 08:50:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:41 INFO - Downloading blessings-1.6.tar.gz 08:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:41 INFO - Installing collected packages: blessings 08:50:41 INFO - Running setup.py install for blessings 08:50:41 INFO - Successfully installed blessings 08:50:41 INFO - Cleaning up... 08:50:41 INFO - Return code: 0 08:50:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:42 INFO - Reading from file tmpfile_stdout 08:50:42 INFO - Current package versions: 08:50:42 INFO - blessings == 1.6 08:50:42 INFO - blobuploader == 1.2.4 08:50:42 INFO - docopt == 0.6.1 08:50:42 INFO - manifestparser == 1.1 08:50:42 INFO - mozInstall == 1.12 08:50:42 INFO - mozcrash == 0.16 08:50:42 INFO - mozdebug == 0.1 08:50:42 INFO - mozdevice == 0.48 08:50:42 INFO - mozfile == 1.2 08:50:42 INFO - mozhttpd == 0.7 08:50:42 INFO - mozinfo == 0.9 08:50:42 INFO - mozleak == 0.1 08:50:42 INFO - mozlog == 3.1 08:50:42 INFO - moznetwork == 0.27 08:50:42 INFO - mozprocess == 0.22 08:50:42 INFO - mozprofile == 0.28 08:50:42 INFO - mozrunner == 6.11 08:50:42 INFO - mozscreenshot == 0.1 08:50:42 INFO - mozsystemmonitor == 0.0 08:50:42 INFO - moztest == 0.7 08:50:42 INFO - mozversion == 1.4 08:50:42 INFO - psutil == 3.1.1 08:50:42 INFO - requests == 1.2.3 08:50:42 INFO - wsgiref == 0.1.2 08:50:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:42 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')]} 08:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:42 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')]} 08:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:42 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100544c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530c66bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, '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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:50:42 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 08:50:42 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 08:50:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:50:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:42 INFO - 'HOME': '/Users/cltbld', 08:50:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:42 INFO - 'LOGNAME': 'cltbld', 08:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:42 INFO - 'MOZ_NO_REMOTE': '1', 08:50:42 INFO - 'NO_EM_RESTART': '1', 08:50:42 INFO - 'PAGER': '/bin/cat', 08:50:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:42 INFO - 'PWD': '/builds/slave/test', 08:50:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:42 INFO - 'SHELL': '/bin/bash', 08:50:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:50:42 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:50:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:42 INFO - 'USER': 'cltbld', 08:50:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:42 INFO - 'XPC_FLAGS': '0x0', 08:50:42 INFO - 'XPC_SERVICE_NAME': '0', 08:50:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:42 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)) 08:50:42 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)) 08:50:42 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)) 08:50:42 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)) 08:50:42 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)) 08:50:42 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)) 08:50:42 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)) 08:50:42 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)) 08:50:42 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)) 08:50:42 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)) 08:50:42 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)) 08:50:42 INFO - Cleaning up... 08:50:42 INFO - Return code: 0 08:50:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50:42 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')]} 08:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:42 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')]} 08:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:42 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 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100544c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530c66bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, '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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:50:42 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 08:50:42 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 08:50:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:50:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:42 INFO - 'HOME': '/Users/cltbld', 08:50:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:42 INFO - 'LOGNAME': 'cltbld', 08:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:42 INFO - 'MOZ_NO_REMOTE': '1', 08:50:42 INFO - 'NO_EM_RESTART': '1', 08:50:42 INFO - 'PAGER': '/bin/cat', 08:50:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:42 INFO - 'PWD': '/builds/slave/test', 08:50:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:42 INFO - 'SHELL': '/bin/bash', 08:50:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:50:42 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:50:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:42 INFO - 'USER': 'cltbld', 08:50:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:42 INFO - 'XPC_FLAGS': '0x0', 08:50:42 INFO - 'XPC_SERVICE_NAME': '0', 08:50:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:42 INFO - Downloading/unpacking jsonschema 08:50:42 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 08:50:42 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 08:50:42 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 08:50:42 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 08:50:42 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 08:50:42 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 08:50:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:44 INFO - Downloading/unpacking functools32 (from jsonschema) 08:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:45 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:45 INFO - warning: no files found matching '*.txt' 08:50:45 INFO - no previously-included directories found matching 'build' 08:50:45 INFO - no previously-included directories found matching 'dist' 08:50:45 INFO - no previously-included directories found matching '.git*' 08:50:45 INFO - Installing collected packages: jsonschema, functools32 08:50:45 INFO - Running setup.py install for functools32 08:50:45 INFO - warning: no files found matching '*.txt' 08:50:45 INFO - no previously-included directories found matching 'build' 08:50:45 INFO - no previously-included directories found matching 'dist' 08:50:45 INFO - no previously-included directories found matching '.git*' 08:50:45 INFO - Successfully installed jsonschema functools32 08:50:45 INFO - Cleaning up... 08:50:45 INFO - Return code: 0 08:50:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11004ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100544c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd530c66bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, '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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 08:50: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', 'flake8'] in /builds/slave/test/build 08:50: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 flake8 08:50:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:50:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:45 INFO - 'HOME': '/Users/cltbld', 08:50:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:45 INFO - 'LOGNAME': 'cltbld', 08:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:45 INFO - 'MOZ_NO_REMOTE': '1', 08:50:45 INFO - 'NO_EM_RESTART': '1', 08:50:45 INFO - 'PAGER': '/bin/cat', 08:50:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:45 INFO - 'PWD': '/builds/slave/test', 08:50:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:45 INFO - 'SHELL': '/bin/bash', 08:50:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:50:45 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:50:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:45 INFO - 'USER': 'cltbld', 08:50:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:45 INFO - 'XPC_FLAGS': '0x0', 08:50:45 INFO - 'XPC_SERVICE_NAME': '0', 08:50:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:46 INFO - Downloading/unpacking flake8 08:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:50:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:50:48 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 08:50:48 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 08:50:48 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 08:50:48 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 08:50:48 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 08:50:48 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 08:50:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:50:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:50:48 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 08:50:48 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 08:50:48 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 08:50:48 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 08:50:48 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 08:50:48 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 08:50:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:50:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:50:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:50:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:50:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:50:49 INFO - no previously-included directories found matching 'docs/_build' 08:50:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:50:49 INFO - Running setup.py install for pep8 08:50:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:50:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:50:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:50:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:50:49 INFO - no previously-included directories found matching 'docs/_build' 08:50:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:50:49 INFO - Cleaning up... 08:50:49 INFO - Return code: 0 08:50:49 INFO - Running post-action listener: _resource_record_post_action 08:50:49 INFO - Running post-action listener: _start_resource_monitoring 08:50:49 INFO - Starting resource monitoring. 08:50:49 INFO - ##### 08:50:49 INFO - ##### Running install step. 08:50:49 INFO - ##### 08:50:49 INFO - Running pre-action listener: _resource_record_pre_action 08:50:49 INFO - Running main action method: install 08:50:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:50 INFO - Reading from file tmpfile_stdout 08:50:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:50 INFO - Reading from file tmpfile_stdout 08:50:50 INFO - Output received: 08:50:50 INFO - Usage: mozinstall [options] installer 08:50:50 INFO - Options: 08:50:50 INFO - -h, --help show this help message and exit 08:50:50 INFO - -d DEST, --destination=DEST 08:50:50 INFO - Directory to install application into. [default: 08:50:50 INFO - "/builds/slave/test"] 08:50:50 INFO - --app=APP Application being installed. [default: firefox] 08:50:50 INFO - mkdir: /builds/slave/test/build/application 08:50:50 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'] 08:50:50 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 08:51:25 INFO - Reading from file tmpfile_stdout 08:51:25 INFO - Output received: 08:51:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:51:25 INFO - Running post-action listener: _resource_record_post_action 08:51:25 INFO - ##### 08:51:25 INFO - ##### Running run-tests step. 08:51:25 INFO - ##### 08:51:25 INFO - Running pre-action listener: _resource_record_pre_action 08:51:25 INFO - Running main action method: run_tests 08:51:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:51:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:51:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:51:25 INFO - 2016-02-09 08:51:25.107 screenresolution[2720:20821] starting screenresolution argv=screenresolution get 08:51:25 INFO - 2016-02-09 08:51:25.110 screenresolution[2720:20821] Display 0: 1600x1200x32@60 08:51:25 INFO - 2016-02-09 08:51:25.116 screenresolution[2721:20823] starting screenresolution argv=screenresolution list 08:51:25 INFO - Available Modes on Display 0 08:51:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:51:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:51:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:51:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:51:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:51:25 INFO - Intel Iris: 08:51:25 INFO - Chipset Model: Intel Iris 08:51:25 INFO - Type: GPU 08:51:25 INFO - Bus: Built-In 08:51:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:51:25 INFO - Vendor: Intel (0x8086) 08:51:25 INFO - Device ID: 0x0a2e 08:51:25 INFO - Revision ID: 0x0009 08:51:25 INFO - Displays: 08:51:25 INFO - Display: 08:51:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:51:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:51:25 INFO - Display Serial Number: 1600x1200 60 08:51:25 INFO - Main Display: Yes 08:51:25 INFO - Mirror: Off 08:51:25 INFO - Online: Yes 08:51:25 INFO - Rotation: Supported 08:51:25 INFO - Return code: 0 08:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:51:25 INFO - Python 2.7.3 08:51:25 INFO - Return code: 0 08:51:25 INFO - grabbing minidump binary from tooltool 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:25 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 0x10fef0d30>, '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 0x10fd14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fee7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:51:25 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 08:51:25 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 08:51:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:51:25 INFO - Return code: 0 08:51:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:51:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:51:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:51:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:51:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:51:26 INFO - Return code: 0 08:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0091 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G5epqmnhdm/Render', 08:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:26 INFO - 'HOME': '/Users/cltbld', 08:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:26 INFO - 'LOGNAME': 'cltbld', 08:51:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:51:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:26 INFO - 'MOZ_NO_REMOTE': '1', 08:51:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:51:26 INFO - 'NO_EM_RESTART': '1', 08:51:26 INFO - 'PAGER': '/bin/cat', 08:51:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:26 INFO - 'PWD': '/builds/slave/test', 08:51:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:26 INFO - 'SHELL': '/bin/bash', 08:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3gCGpN7Jc/Listeners', 08:51:26 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 08:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:26 INFO - 'USER': 'cltbld', 08:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:26 INFO - 'XPC_FLAGS': '0x0', 08:51:26 INFO - 'XPC_SERVICE_NAME': '0', 08:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:51:26 INFO - mozversion application_buildid: 20160209065855 08:51:26 INFO - mozversion application_changeset: dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0 08:51:26 INFO - mozversion application_display_name: Nightly 08:51:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:51:26 INFO - mozversion application_name: Firefox 08:51:26 INFO - mozversion application_remotingname: firefox 08:51:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:51:26 INFO - mozversion application_vendor: Mozilla 08:51:26 INFO - mozversion application_version: 47.0a1 08:51:26 INFO - mozversion platform_buildid: 20160209065855 08:51:26 INFO - mozversion platform_changeset: dc2c6c1a4fe3ed7413ce361e1dcf2c556d1384b0 08:51:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:51:26 INFO - mozversion platform_version: 47.0a1 08:51:26 INFO - using testdate: 1455036686 08:51:26 INFO - actual date: 1455036686 08:51:27 INFO - starting webserver on 'localhost:51583' 08:51:27 INFO - SUITE-START | Running 2 tests 08:51:27 INFO - TEST-START | dromaeo_css 08:51:27 INFO - operating with platform_type : mac_ 08:51:27 INFO - Initialising browser for dromaeo_css test... 08:51:27 INFO - TEST-INFO | started process 2739 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpsrYk51/profile http://localhost:51583/getInfo.html) 08:51:29 INFO - PROCESS | 2739 | __metrics Screen width/height:1600/1200 08:51:29 INFO - PROCESS | 2739 | colorDepth:24 08:51:29 INFO - PROCESS | 2739 | Browser inner width/height: 1024/689 08:51:29 INFO - PROCESS | 2739 | __metrics 08:51:29 INFO - PROCESS | 2739 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:51:29 INFO - PROCESS | 2739 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:30 INFO - TEST-INFO | 2739: exit 0 08:51:30 INFO - Browser initialized. 08:51:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:51:30 INFO - TEST-INFO | started process 2742 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpsrYk51/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:42 INFO - PROCESS | 2742 | RSS: Main: 245891072 08:51:42 INFO - PROCESS | 2742 | 08:52:33 INFO - PROCESS | 2742 | 1455036753287 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] 08:54:43 INFO - PROCESS | 2742 | Cycle 1(1): loaded http://localhost:51583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51583/tests/dromaeo/cssquery-ext.html) 08:54:44 INFO - PROCESS | 2742 | RSS: Main: 326160384 08:54:44 INFO - PROCESS | 2742 | 08:57:47 INFO - PROCESS | 2742 | Cycle 1(1): loaded http://localhost:51583/tests/dromaeo/cssquery-ext.html (next: http://localhost:51583/tests/dromaeo/cssquery-jquery.html) 08:57:47 INFO - PROCESS | 2742 | RSS: Main: 370810880 08:57:47 INFO - PROCESS | 2742 | 09:00:50 INFO - PROCESS | 2742 | Cycle 1(1): loaded http://localhost:51583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51583/tests/dromaeo/cssquery-mootools.html) 09:00:50 INFO - PROCESS | 2742 | RSS: Main: 380485632 09:00:50 INFO - PROCESS | 2742 | 09:03:52 INFO - PROCESS | 2742 | Cycle 1(1): loaded http://localhost:51583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51583/tests/dromaeo/cssquery-prototype.html) 09:03:53 INFO - PROCESS | 2742 | RSS: Main: 338485248 09:03:53 INFO - PROCESS | 2742 | 09:06:56 INFO - PROCESS | 2742 | Cycle 1(1): loaded http://localhost:51583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51583/tests/dromaeo/cssquery-yui.html) 09:06:57 INFO - PROCESS | 2742 | RSS: Main: 340860928 09:06:57 INFO - PROCESS | 2742 | 09:10:00 INFO - PROCESS | 2742 | Cycle 1(1): loaded http://localhost:51583/tests/dromaeo/cssquery-yui.html (next: http://localhost:51583/tests/dromaeo/cssquery-dojo.html) 09:10:00 INFO - PROCESS | 2742 | RSS: Main: 391360512 09:10:00 INFO - PROCESS | 2742 | 09:10:00 INFO - PROCESS | 2742 | __start_tp_report 09:10:00 INFO - PROCESS | 2742 | _x_x_mozilla_page_load 09:10:00 INFO - PROCESS | 2742 | _x_x_mozilla_page_load_details 09:10:00 INFO - PROCESS | 2742 | |i|pagename|runs| 09:10:00 INFO - PROCESS | 2742 | |0;dojo.html;3365.1082463147272;3418.8632454701815;3420.1791570023192;3457.4640930655755;3472.9305413891725;5520.585956053292;5571.275734154559;5589.664620122796;5597.944020559798;5625.465580769831;5586.022446071931;5615.943840561593;5757.251557297545;5786.1610066540325;5809.128630705396;5044.218146187329;5101.438841727417;5103.362079740033;5115.641905066647;5194.740262986855;5217.773823151556;5239.240310155025;5258.710770907599;5263.26314315996;5297.417284098746;5069.695818250917;5123.641345105844;5158.716270605115;5173.3533308336455;5189.143791274435;5128.666636668605;5157.510036546522;5170;5185.092608793446;5189.948100518985;5116.744162791845;5123.103456895028;5131.358580177478;5151.639385243035;5175.301334319894;5429.4299098594865;5520.558355331564;5535.225068490415;5541.27963364764;5596.0206963781175;6156.695979524152;6162.691865406712;6177.845553861144;6184.96907515464;6207.782727604512;6183.690815459209;6245.937540624581;6256.74973001084;6268.247810262797;6270.216222972129;5594.776208951637;5664.320281566197;5703.372629010805;5771.826845194651;5778.479936805707;6233;6240.438360547572;6243.188385509855;6248.781292654735;6263.749450022039;5844.240248767633;5965.343812180657;6022.488088512438;6029;6030.517558595302;6102.633841969496;6105.490073363267;6174.938250617436;6178.907316390258;6215.223097112861;6126.050462178369;6155;6156.907646385308;6160.229971253593;6168.660723660152;6028.698565071729;6104.03106711151;6178.5366097542865;6193.38066193377;6209.130721698965;4154.750714957112;4832.081904438145;4881.219004959189;4883.218685010453;4923.950760492421;4310.655147588185;4338.262495375794;4344.239758042393;4349.391085248068;4395.362672412482;4796.25658023007;5531.778728850801;5651.208830763697;5688.431156884279;5700.629459085146;4737.3841400618385;6227.377262273827;6234.2830574484515;6240.812775616739;6265.4361107500545;5679.943200567942;5691.8292451226525;5692.345380281238;5704.229928959538;5736.971315143481;5218.765155568009;5258.106121959276;5306.389765176977;5320.068987927098;5331;5003.2995380646735;6195;6292.18201633803;6293.465055470337;6311.684415779101;6235.314115447388;6255.655938923403;6257.56197066201;6266.310705822447;6275.529335299962;6242.53181011435;6258;6282.591631543935;6315.684215789284;6335.3981371769605;4987.576056035133;5059.822906198266;5193.792248310026;6017.699115044318;6104.246950855989;6180.876382472416;6196.442320191204;6214.9689251553455;6217.502599792097;6228.688565571794;5815.069588865761;5828.883422331614;5923.229980102559;5945.583809133319;5969.582129250911;5953.821385358447;5985.132155837292;5987.491063259672;5990.281166260077;5991.880162396815;5819.330776960704;5831.562632802472;5833.358330583547;5835.44563266489;5869.354371019099;5749.568782341257;5927.555433342603;5947.375525569752;5962.135490353961;6071.058985857199;5803.390643982321;5829.183914251923;5846.6784326862435;5860.501857342174;5862.618929769551 09:10:00 INFO - PROCESS | 2742 | |1;ext.html;457.9033215449;483.94918533554;489.8456986049394;578.3146970839556;579.9130130480428;28676;29233;36624.633753662456;37018.44472332917;37186.62813371865;39661.60338396623;40138;40151.19697606046;40158.19683606333;40160.99597510064;9343.159115679571;9556.092171243756;9562.521873906277;9566.904330956706;9570.234381249484;9319.95340023299;9432.81134377312;9447.149756521912;9450.952745236264;9451.669191578296;9512.286578506604;9594.088561586637;9596.088371604686;9598.328117031811;9611.375260608038;9508.80982380352;9567.90432095684;9575.329726919119;9578.6647467339;9619.759506012335;9441.716748497556;9614.423134611876;9615.903840961571;9615.951920240354;9617;38366.23267534662;38697;38761.8371448857;38764;38848.80575597132;3169.1443310306317;3185.601799775028;3227.774055816094;3597.6042635310355;3906.7655940643654;28055.29861753452;28168.01411950572;28835;28857.56713649297;28911;2329.138218859033;2852.5293326601086;2855.6430446194227;2877.49643812332;2879.1650421377776;473885;473915;475718.62140689424;475858;475918;59445;59657.701711491165;59665.70167149136;59740.40259597435;59769.10346344808;63139.36860631427;63411;63446.68276658587;63575.68212159002;63701.407464813754;16041.59896002586;16243.431479898147;16272.18639068042;16274;16300.266488008068;12433.689157771129;12463.127581069419;12472.563460279029;12481.001519878388;12499.3750312484;15136.924315378574;18051.638967220846;18656.34702785396;18665.44003679892;18666.719999200024;8148.714794982147;8420.326373890073;8439.873401898976;8448;8482.406231563855;958.4824194934657;971.7813491964251;1069.3263244156133;1092.1447291062561;1125.7579620381657;26381.812818423216;28315;28380.71619283822;29104.563431548544;29178.124656260345;961.9326647134633;1050.2858056521486;1055.2349546578823;1059.7874487917811;1136.267107715519;13077.476900924046;14189.574312770426;14361.928190358982;14882;15261.236938153048;524886;528699;528757;528888;531684;56118;56140;56275.437245627836;56314;56397;1293.9288339141438;1321.3657444426537;1421.8507056758892;1429.8212723409574;1452.847451017649;26917.0579029733;26962.865185673945;27342.316442089108;27353;27409;42170.94572635586;42540;42575.574244257165;42616.78691606522;42646.57353426426;490625;493056;508155;509328;510065;23420.531589368456;28445;28694.42611147807;28755.568666470437;28786.28034299159;38686.806565968116;39160.608393915696;40075.599244007186;42631.786841065594;43168.56831431646;32364.514532281562;33813.49279760756;33937.66062339345;34048.82975585205;34051.97844064682;33273.16817079592;34656;34702;34764;34809.8259508711;34570.790022350106;34657.826710866284;35068.47397289094;35073.64926350704;35128;29057.85471072631;29420.558691619215;30130.397392052473;30301.696983029888;30332.24169395783;19056.90179142661;23407.882960585088;23840.64239036381;24061.27816165518;24084.879575602008 09:10:00 INFO - PROCESS | 2742 | |2;jquery.html;360.74567429961877;364.874118429142;366.7652702270547;373.6114440981376;379.4365367429367;15159.393624255044;15287.2356382181;18989.62020759584;19338.936358500276;20225.887576183304;11593.884061159386;11899.7620047599;11915;13826.516071937484;20163.798362016412;5119.257707632391;5318.627696061278;5326.760295786699;5328.094223981932;5336.932613477301;3833.5974722654137;4026.134381108061;5645.379008309083;5884.588078834483;5885.970570147143;5746.425357464262;5850.970745146268;5874.9118763218585;6408.01351581009;6454.838629034288;6360.332165122688;6409;6423.164988551505;6434.356564343551;6436.742530298806;5509.586780991442;5668.631538949955;5676.1769543416385;5679.801206957778;5692.686902220376;13549.254790986492;13553.932230338884;13574.117682350714;14703.926480367636;19116.522086947938;2085.2805782005184;2198.5492973940304;2318.223395162606;2456.496418234258;2621.2398404462683;9790.412575245507;9809.313348065638;9830.90169098307;10174.898251017468;10228.89771102287;1737.400596794104;1775.1390575570838;1803.8286362795645;1844.575747578051;1860.6557786809483;100963;101288.9871101287;101385;102570.92728831549;103726;10887.183461240438;11150.776984460266;11173.776524469466;11190.832137517944;11287.040601548797;13355.599332020054;13455.32723363828;13509.2569908654;13524.12093213938;13556.10214569961;6881;8310.335173186131;8339;8398.622062007224;8435.915640843514;8397.412181147383;8404.327653787805;8419.579021048923;8485.236328730443;8535.487870727777;3479.0606536235073;4015.638592526687;4315.762633055149;4408.933865992013;4451.109778044404;1730.6279149982563;1789.8299661532133;1790.2570433270048;1792.1666425112385;1797.1553369916119;874.9475031498131;896.1799953043023;898.4070513461085;942.6936245720168;994.2493417469764;15853.207339632972;18270.45188644343;19063.61872762537;19067;19185.136668849937;761.3110135327537;926.305271046715;928.5635751196927;954.174638937328;1017.679430979254;7788.337991270805;8260;10433.478326083665;10471.214658900613;10483.318584291997;688174;697674;707381;718328;718351.3483786484;108794;112443;112619;113021.78695975355;120314;1080.9729756755987;1143.857017872766;1203.422357268516;1205.3310412720848;1224.1675660550734;11631.88368116308;17706.203220854833;18016;18217.271309147487;18225.45323640293;46348.80089402926;50268;50807.49192508028;51240.570117333526;51753.22370164375;66015;67199.99200011906;67515;67545.86814951412;68125;6786.473043565158;7673.654685539276;7786.793047077712;7811.453198276066;7836.608169591612;9803.313768036169;11487.8276825846;11861.347625880659;12147.878521214674;12317.260964342167;7016.7544135954995;8197.754067377988;10164.949175254076;10511.10655594283;10609.310394824312;8913.821723565623;9565.091316324939;10285.125764309818;10388.584456621953;10484.423356715453;4034.616711412411;8684.913150868662;10345.586176552853;10560.521526986382;10764.515596798006;7258.528195667264;7544.207858175032;7604.125525564631;7635.847283054419;7643.1974642663945;8175.877361839458;10632.202584806017;10652.254342196282;10686.038256556947;10769.892301076889 09:10:00 INFO - PROCESS | 2742 | |3;mootools.html;1358.3615700620705;1540.2914659256744;1568.2785918477496;1801.6486785076916;1950.9609807803845;7946.84106317874;8605.311575073994;8748.912510874889;8766.430182038162;8771.47371157731;8421.199986001335;8694.47833130011;8713.390062695615;8717.607707653155;8730.257928076122;2157.9568408631817;2226.686255109485;2235.3629215673536;2293.6444851048113;2432.1730611592056;2452.3256104571205;2486.9005239790386;2515.63523289123;2520.7479252074736;2521.2688320387065;2463.5811911975006;2488.315713178881;2494.189388448752;2496.737842526527;2498.7376325485834;2400.015993442689;2468.9259322220364;2469.4814089041142;2471.3203868936007;2471.65396844441;2417.141914620302;2417.528581926525;2429.854208747463;2430.2466235467064;2456.7174774900936;8517;8610.44032137909;8616.483011019296;8625.698100566513;8642.956785216096;4633.25867861144;5412.188171774226;5444.156155795858;5446.972765136149;5483.040467918138;3232.4343239933155;3538.115471132217;3613.8735144269826;3693;3697.205100903319;1015.8723816563609;1051.0908064524208;1054.5307338234488;1059.90990765785;1098.9450527473593;11630.592929247521;11773.646790596296;11808.52765889372;11889.048876089892;11936.880631193751;4846.36997190363;4889.119958407521;4979.57673597741;4981.701097934063;4999.525045120708;10277.691669249934;10278.383297002203;10280.383177009404;10286.27996040285;10291.691249262534;5475.425080366584;5508.862278442991;5511.559075273968;5512.2558454608115;5517;4909.631777616622;4925.926111108336;4978.377702787152;4989.950100499022;4991.276264941564;3815.8473661053804;3821.082940094413;3826.5408151022057;3861.4400911867624;3888.922221555553;1254.5734450286946;1268.8413948256468;1279.3986826191674;1304.1979182802509;1308.3981368570373;1192.9105317101253;1335.4057444437133;1364.0519838712198;1369.3769334952572;1370.328539015875;7966.283034526805;8054.114047454776;8260.545669988209;8302.958485207535;8330.958345208357;1115.548202977779;1152.3258893547202;1207.2816674078908;1211.7576484703095;1230.4278510492663;6270.028145637433;6293.2762732285455;6335.493160547145;6336.271328797156;6374.776882809079;8292.419530632918;10551.84172237417;10572.788544229072;10581.31221470602;10697.411642359744;10383.84424233637;10574.52414641343;10575.312604680672;10584;10590.629327973638;8205.753827385068;8315.542645154454;8316.501009939422;8325.084240733515;8326.542040187727;7718.614069296625;7836.255555722198;7842.725504607311;7855.84288314242;7915.129335773176;9396.342256042284;9417.85873211916;9458.527073646152;9513.619455221713;9603.807923841623;9608.711738647851;9915.950420247853;9918.40489570628;9935.850962235716;9960.750981225237;6262.3111457738705;6441.227052753699;6757.864842703217;6949.722011119498;6959.826004349729;8103.473274237156;8143.6742530298125;8171.101178870201;8173.468724532886;8175.427720059539;6834.316568343126;7402.555846649218;7620.923790762022;7767.1067827200595;7864.977552918084;7487.138979017483;7517;7558.962205188939;7677.155512893689;7703.345215656732;7669.769906902802;7728.884066739116;7730.92269077302;7730.92269077302;7746.4190185737425;6912.516123871482;7045.718171273092;7049.577025378494;7056.400205982343;7061.576305421691;7114.822129446805;7155;7163.892541611775;7172.031775710421;7193.100862392201 09:10:00 INFO - PROCESS | 2742 | |4;prototype.html;317.06149796602057;324.6996528211404;329.0687354785955;329.1934759838397;333.01759808564725;6159.23009623797;6301.495880329574;6321.620702757832;6365.649889256095;6423.0686550450155;5358.678479291245;6012.5791194616395;6080.209572755535;6297.275813281474;6321.810345689637;4757.690750101232;4762.78567464465;4766.142094423002;4768.809247630091;4769.952300477003;4484;4584.174848527264;4596.942703178271;4707.317438971347;4739.952600474003;4662.603678687316;4668.4631267404175;4675.579197872191;4693.577578017977;4700.2009658358165;4722.834700785456;4730.479647238801;4745.976270118662;4749.145153872301;4764.166270902579;4058.634722874926;4073.287174744408;4073.959260407388;4075.816588253536;4085.795710214507;5316.3354580677415;5526.784107496344;6042.607230530001;6069.089636554508;6072.51419886408;5476.2333273341765;5485.067538518461;5493.423190564973;5496.258005169291;5498.560115190815;6377.202849643794;6696;6697.765578204788;6713.697883595201;6722;4185.895352616179;4420.270655341865;4420.734755914656;4422.601965823092;4500.79746411409;6997.685104170325;7040.04959330489;7040.859182816366;7054.188768291609;7057.294270572953;4568.474625418053;4589.770511474413;4591.219492686251;4608.377868987711;4615.538446155358;4536.705114167568;4651.976740116278;4657.3246879202325;4698.8355407560575;4709.3642358281195;4535.63714902807;5437.809676661298;5460.426655201147;5476.945230547723;5484.451554844483;6735.663216839236;6740.359665831738;6746.224184218878;6751;6752.864942701217;1602.054787675277;1630.4537979776671;1631.5023917705214;1632.420490725799;1632.755086736999;883.7613844262141;1083.6430763090248;1087.9238453308192;1094.8521949536869;1097.5061222449929;6265.968670156712;6283.937160628335;6284.654344011032;6288.685565721696;6316.084167795644;6921.169459664872;6930.3762661360715;6934;6948.756793512202;6959.930400695928;6097.062315563411;6252.155958945576;6260.029695397221;6267.1539342189135;6304.558680892385;3585.3725598020765;3664.2488289900507;3670.4310831821113;3672.3573374659327;3681.2821499807283;7220.350168484862;7227.494075414776;7230.638468076575;7231.3130252625915;7233.168185658611;6843.947443104055;7085;7102.254263302279;7111.182214045451;7114.288571142844;6057.1519987200945;7144.535605185646;7210.423166146696;7221.205667376585;7246.49274550787;6743;6913.446924246149;6917.515773895779;6924.134483189601;6930.3762661360715;6528.412442879973;6683.43190828785;6821;6846.041554182319;6863.485238607024;7189.460790440633;7335.816604584928;7356.521826081287;7359.77920662381;7365.926340736524;4637.350770892145;4644.7213167210075;4651.906961860812;4658.510856360169;4664.160451118832;6793.762218322335;6947.617881016593;6971.825704357431;6981.825454363681;6999.650017499002;5472.890542189054;6716.966415167893;6738.696758645775;6743.35938085881;6759.526833121634;6735;6740.258571557223;6741.696623651849;6742.494312926452;6749.190097188369;6399.992146044299;6472.773452929125;6550.541462097607;6563.1796025496815;6571;6713.798586042427;6738.46092312604;6762.188537375349;6762.763303284361;6773.864522709617;4767.261074533453;5767.596268261182;6580.703868325841;6632.403083722488;6636.933630663631 09:10:00 INFO - PROCESS | 2742 | |5;yui.html;568.3407247592792;703.2194264366552;722.090166390348;725.1733024352236;778.926002029807;14684.486042988485;14890.627734306621;14894.851051489482;14904.552863414088;14910.478133265338;13585.52450664227;13658.317084145778;13673.316334183275;13688.65778355539;13699.246541440218;684.2815044203567;692.0795342194893;832.5337810825927;835.1022650650575;860.5697151424288;847.821957388949;859.9355048371366;860.4880096342697;861.6682577207789;861.7845538615346;910.2354022620997;912.1471424218344;912.3704643795793;912.7900582865944;914;718.838261391188;728.3845150847526;760.7603604864505;892.3530440430701;894.7092195036639;664.8271449423137;666.5467482112161;667.1060778556757;667.5894324990096;668.9966550167218;14523;14564.70870582593;14588.927055364655;14590.635234119125;14592.05151665149;12349;12514.3742812859;12660.873391266061;12883.033772467008;13023.088383813138;10036;10061.14480269178;10070.395776253448;10080.949595251977;10082.49587520621;3488.110531814371;3520.806355650438;3525.4006818840858;3527.94708079379;3534.6818786309354;78877.99999999943;80427.39145217121;81226;81339;82997.58501207456;9267.814643707088;9296.209822165056;9367.859482107773;9369.016253293443;9562.856557151648;19707.704384434244;19717.211311547377;19717.704234436496;19734;19754.40736777899;7364.594947277844;7417.443691723142;7566.886496702554;7731.110922244014;7862.606869656494;3887.7667339959694;3978.303796835542;4010.5588385277597;4028.617281358266;4103.220388126247;3506.7895926244505;3553.502509648651;3555.4311310190246;3558.430651095812;3565.4651802229355;660.2275337854721;660.4485254812286;663.2339647706906;664.1498881431775;669.7354544954716;482.6211424032188;516.2127755173391;596.2814808156162;601.8104297146473;611.6574718157846;8119.594020298961;8312.8337433251;8315.708950186714;8438.156184381513;8560.61477233526;499.2934996979306;542.3139728243775;589.9911501327483;605.1104875832519;629.7764293675771;3715.3126671565847;3862.1503269280715;3897.512810898638;3974.6224108709625;4042.43405923171;78739;87057.56471217603;92241.15517689609;92647;93345;61185.776284474065;78122;78767;79001.81497277545;79092.60453697694;64673.3831654203;66798.66600666965;67266;68781.3121868785;69813.65093174603;8018.919810802051;8049.839003219786;8144.714934977247;8228.177182281725;8291.58542072882;48494;48532.02935941332;48847.51152488572;48876.5112348872;49831.501684984134;64837;69026;69643.95534066892;69939;70386.94419583812;9801.656942006995;9995.050470205319;10019.248556358449;10145.137663298703;10326.01902819231;10811.405372704578;10905.01854833037;11130.499127539442;11401.885981140082;11760.411979401168;10646.148308135176;10659.680209593414;10679.946600266949;10690.572377104829;10766.784664306513;10611.469426528796;10790.784184316113;10800.837987430037;10833.29583577065;10910.890891090987;8952.507612081397;9159.587818548049;9509.049095090435;10422.947885260524;10504.42225677595;8050.5169689818795;8157.173590763598;8258.050324212552;8350.83298334042;8453.070162282267;8007.1592482788465;8959.462432254086;9026.68406605792;9027;9290.303227257848 09:10:00 INFO - PROCESS | 2742 | __end_tp_report 09:10:00 INFO - PROCESS | 2742 | __start_cc_report 09:10:00 INFO - PROCESS | 2742 | _x_x_mozilla_cycle_collect,1150 09:10:00 INFO - PROCESS | 2742 | __end_cc_report 09:10:00 INFO - PROCESS | 2742 | __startTimestamp1455037800285__endTimestamp 09:10:00 INFO - PROCESS | 2742 | 09:10:00 INFO - PROCESS | 2742 | ------- Summary: start ------- 09:10:00 INFO - PROCESS | 2742 | Number of tests: 6 09:10:00 INFO - PROCESS | 2742 | 09:10:00 INFO - PROCESS | 2742 | [#0] dojo.html Cycles:165 Average:5638.73 Median:5815.07 stddev:641.26 (11.0%) stddev-sans-first:617.92 09:10:00 INFO - PROCESS | 2742 | Values: 3365.1 3418.9 3420.2 3457.5 3472.9 5520.6 5571.3 5589.7 5597.9 5625.5 5586.0 5615.9 5757.3 5786.2 5809.1 5044.2 5101.4 5103.4 5115.6 5194.7 5217.8 5239.2 5258.7 5263.3 5297.4 5069.7 5123.6 5158.7 5173.4 5189.1 5128.7 5157.5 5170.0 5185.1 5189.9 5116.7 5123.1 5131.4 5151.6 5175.3 5429.4 5520.6 5535.2 5541.3 5596.0 6156.7 6162.7 6177.8 6185.0 6207.8 6183.7 6245.9 6256.7 6268.2 6270.2 5594.8 5664.3 5703.4 5771.8 5778.5 6233.0 6240.4 6243.2 6248.8 6263.7 5844.2 5965.3 6022.5 6029.0 6030.5 6102.6 6105.5 6174.9 6178.9 6215.2 6126.1 6155.0 6156.9 6160.2 6168.7 6028.7 6104.0 6178.5 6193.4 6209.1 4154.8 4832.1 4881.2 4883.2 4924.0 4310.7 4338.3 4344.2 4349.4 4395.4 4796.3 5531.8 5651.2 5688.4 5700.6 4737.4 6227.4 6234.3 6240.8 6265.4 5679.9 5691.8 5692.3 5704.2 5737.0 5218.8 5258.1 5306.4 5320.1 5331.0 5003.3 6195.0 6292.2 6293.5 6311.7 6235.3 6255.7 6257.6 6266.3 6275.5 6242.5 6258.0 6282.6 6315.7 6335.4 4987.6 5059.8 5193.8 6017.7 6104.2 6180.9 6196.4 6215.0 6217.5 6228.7 5815.1 5828.9 5923.2 5945.6 5969.6 5953.8 5985.1 5987.5 5990.3 5991.9 5819.3 5831.6 5833.4 5835.4 5869.4 5749.6 5927.6 5947.4 5962.1 6071.1 5803.4 5829.2 5846.7 5860.5 5862.6 09:10:00 INFO - PROCESS | 2742 | 09:10:00 INFO - PROCESS | 2742 | [#1] ext.html Cycles:180 Average:63208.07 Median:37776.43 stddev:133875.38 (354.4%) stddev-sans-first:134168.03 09:10:00 INFO - PROCESS | 2742 | Values: 457.9 483.9 489.8 578.3 579.9 28676.0 29233.0 36624.6 37018.4 37186.6 39661.6 40138.0 40151.2 40158.2 40161.0 9343.2 9556.1 9562.5 9566.9 9570.2 9320.0 9432.8 9447.1 9451.0 9451.7 9512.3 9594.1 9596.1 9598.3 9611.4 9508.8 9567.9 9575.3 9578.7 9619.8 9441.7 9614.4 9615.9 9616.0 9617.0 38366.2 38697.0 38761.8 38764.0 38848.8 3169.1 3185.6 3227.8 3597.6 3906.8 28055.3 28168.0 28835.0 28857.6 28911.0 2329.1 2852.5 2855.6 2877.5 2879.2 473885.0 473915.0 475718.6 475858.0 475918.0 59445.0 59657.7 59665.7 59740.4 59769.1 63139.4 63411.0 63446.7 63575.7 63701.4 16041.6 16243.4 16272.2 16274.0 16300.3 12433.7 12463.1 12472.6 12481.0 12499.4 15136.9 18051.6 18656.3 18665.4 18666.7 8148.7 8420.3 8439.9 8448.0 8482.4 958.5 971.8 1069.3 1092.1 1125.8 26381.8 28315.0 28380.7 29104.6 29178.1 961.9 1050.3 1055.2 1059.8 1136.3 13077.5 14189.6 14361.9 14882.0 15261.2 524886.0 528699.0 528757.0 528888.0 531684.0 56118.0 56140.0 56275.4 56314.0 56397.0 1293.9 1321.4 1421.9 1429.8 1452.8 26917.1 26962.9 27342.3 27353.0 27409.0 42170.9 42540.0 42575.6 42616.8 42646.6 490625.0 493056.0 508155.0 509328.0 510065.0 23420.5 28445.0 28694.4 28755.6 28786.3 38686.8 39160.6 40075.6 42631.8 43168.6 32364.5 33813.5 33937.7 34048.8 34052.0 33273.2 34656.0 34702.0 34764.0 34809.8 34570.8 34657.8 35068.5 35073.6 35128.0 29057.9 29420.6 30130.4 30301.7 30332.2 19056.9 23407.9 23840.6 24061.3 24084.9 09:10:00 INFO - PROCESS | 2742 | 09:10:00 INFO - PROCESS | 2742 | [#2] jquery.html Cycles:180 Average:35772.76 Median:365.82 stddev:116469.75 (31838.0%) stddev-sans-first:116766.12 09:10:00 INFO - PROCESS | 2742 | Values: 360.7 364.9 366.8 373.6 379.4 15159.4 15287.2 18989.6 19338.9 20225.9 11593.9 11899.8 11915.0 13826.5 20163.8 5119.3 5318.6 5326.8 5328.1 5336.9 3833.6 4026.1 5645.4 5884.6 5886.0 5746.4 5851.0 5874.9 6408.0 6454.8 6360.3 6409.0 6423.2 6434.4 6436.7 5509.6 5668.6 5676.2 5679.8 5692.7 13549.3 13553.9 13574.1 14703.9 19116.5 2085.3 2198.5 2318.2 2456.5 2621.2 9790.4 9809.3 9830.9 10174.9 10228.9 1737.4 1775.1 1803.8 1844.6 1860.7 100963.0 101289.0 101385.0 102570.9 103726.0 10887.2 11150.8 11173.8 11190.8 11287.0 13355.6 13455.3 13509.3 13524.1 13556.1 6881.0 8310.3 8339.0 8398.6 8435.9 8397.4 8404.3 8419.6 8485.2 8535.5 3479.1 4015.6 4315.8 4408.9 4451.1 1730.6 1789.8 1790.3 1792.2 1797.2 874.9 896.2 898.4 942.7 994.2 15853.2 18270.5 19063.6 19067.0 19185.1 761.3 926.3 928.6 954.2 1017.7 7788.3 8260.0 10433.5 10471.2 10483.3 688174.0 697674.0 707381.0 718328.0 718351.3 108794.0 112443.0 112619.0 113021.8 120314.0 1081.0 1143.9 1203.4 1205.3 1224.2 11631.9 17706.2 18016.0 18217.3 18225.5 46348.8 50268.0 50807.5 51240.6 51753.2 66015.0 67200.0 67515.0 67545.9 68125.0 6786.5 7673.7 7786.8 7811.5 7836.6 9803.3 11487.8 11861.3 12147.9 12317.3 7016.8 8197.8 10164.9 10511.1 10609.3 8913.8 9565.1 10285.1 10388.6 10484.4 4034.6 8684.9 10345.6 10560.5 10764.5 7258.5 7544.2 7604.1 7635.8 7643.2 8175.9 10632.2 10652.3 10686.0 10769.9 09:10:00 INFO - PROCESS | 2742 | 09:10:00 INFO - PROCESS | 2742 | [#3] mootools.html Cycles:180 Average:6031.15 Median:5428.17 stddev:3151.59 (58.1%) stddev-sans-first:3140.86 09:10:00 INFO - PROCESS | 2742 | Values: 1358.4 1540.3 1568.3 1801.6 1951.0 7946.8 8605.3 8748.9 8766.4 8771.5 8421.2 8694.5 8713.4 8717.6 8730.3 2158.0 2226.7 2235.4 2293.6 2432.2 2452.3 2486.9 2515.6 2520.7 2521.3 2463.6 2488.3 2494.2 2496.7 2498.7 2400.0 2468.9 2469.5 2471.3 2471.7 2417.1 2417.5 2429.9 2430.2 2456.7 8517.0 8610.4 8616.5 8625.7 8643.0 4633.3 5412.2 5444.2 5447.0 5483.0 3232.4 3538.1 3613.9 3693.0 3697.2 1015.9 1051.1 1054.5 1059.9 1098.9 11630.6 11773.6 11808.5 11889.0 11936.9 4846.4 4889.1 4979.6 4981.7 4999.5 10277.7 10278.4 10280.4 10286.3 10291.7 5475.4 5508.9 5511.6 5512.3 5517.0 4909.6 4925.9 4978.4 4990.0 4991.3 3815.8 3821.1 3826.5 3861.4 3888.9 1254.6 1268.8 1279.4 1304.2 1308.4 1192.9 1335.4 1364.1 1369.4 1370.3 7966.3 8054.1 8260.5 8303.0 8331.0 1115.5 1152.3 1207.3 1211.8 1230.4 6270.0 6293.3 6335.5 6336.3 6374.8 8292.4 10551.8 10572.8 10581.3 10697.4 10383.8 10574.5 10575.3 10584.0 10590.6 8205.8 8315.5 8316.5 8325.1 8326.5 7718.6 7836.3 7842.7 7855.8 7915.1 9396.3 9417.9 9458.5 9513.6 9603.8 9608.7 9916.0 9918.4 9935.9 9960.8 6262.3 6441.2 6757.9 6949.7 6959.8 8103.5 8143.7 8171.1 8173.5 8175.4 6834.3 7402.6 7620.9 7767.1 7865.0 7487.1 7517.0 7559.0 7677.2 7703.3 7669.8 7728.9 7730.9 7730.9 7746.4 6912.5 7045.7 7049.6 7056.4 7061.6 7114.8 7155.0 7163.9 7172.0 7193.1 09:10:00 INFO - PROCESS | 2742 | 09:10:00 INFO - PROCESS | 2742 | [#4] prototype.html Cycles:180 Average:5509.30 Median:6266.56 stddev:1720.25 (27.5%) stddev-sans-first:1680.35 09:10:00 INFO - PROCESS | 2742 | Values: 317.1 324.7 329.1 329.2 333.0 6159.2 6301.5 6321.6 6365.6 6423.1 5358.7 6012.6 6080.2 6297.3 6321.8 4757.7 4762.8 4766.1 4768.8 4770.0 4484.0 4584.2 4596.9 4707.3 4740.0 4662.6 4668.5 4675.6 4693.6 4700.2 4722.8 4730.5 4746.0 4749.1 4764.2 4058.6 4073.3 4074.0 4075.8 4085.8 5316.3 5526.8 6042.6 6069.1 6072.5 5476.2 5485.1 5493.4 5496.3 5498.6 6377.2 6696.0 6697.8 6713.7 6722.0 4185.9 4420.3 4420.7 4422.6 4500.8 6997.7 7040.0 7040.9 7054.2 7057.3 4568.5 4589.8 4591.2 4608.4 4615.5 4536.7 4652.0 4657.3 4698.8 4709.4 4535.6 5437.8 5460.4 5476.9 5484.5 6735.7 6740.4 6746.2 6751.0 6752.9 1602.1 1630.5 1631.5 1632.4 1632.8 883.8 1083.6 1087.9 1094.9 1097.5 6266.0 6283.9 6284.7 6288.7 6316.1 6921.2 6930.4 6934.0 6948.8 6959.9 6097.1 6252.2 6260.0 6267.2 6304.6 3585.4 3664.2 3670.4 3672.4 3681.3 7220.4 7227.5 7230.6 7231.3 7233.2 6843.9 7085.0 7102.3 7111.2 7114.3 6057.2 7144.5 7210.4 7221.2 7246.5 6743.0 6913.4 6917.5 6924.1 6930.4 6528.4 6683.4 6821.0 6846.0 6863.5 7189.5 7335.8 7356.5 7359.8 7365.9 4637.4 4644.7 4651.9 4658.5 4664.2 6793.8 6947.6 6971.8 6981.8 6999.7 5472.9 6717.0 6738.7 6743.4 6759.5 6735.0 6740.3 6741.7 6742.5 6749.2 6400.0 6472.8 6550.5 6563.2 6571.0 6713.8 6738.5 6762.2 6762.8 6773.9 4767.3 5767.6 6580.7 6632.4 6636.9 09:10:00 INFO - PROCESS | 2742 | 09:10:00 INFO - PROCESS | 2742 | [#5] yui.html Cycles:180 Average:17784.30 Median:661.84 stddev:25232.10 (3812.4%) stddev-sans-first:25269.77 09:10:00 INFO - PROCESS | 2742 | Values: 568.3 703.2 722.1 725.2 778.9 14684.5 14890.6 14894.9 14904.6 14910.5 13585.5 13658.3 13673.3 13688.7 13699.2 684.3 692.1 832.5 835.1 860.6 847.8 859.9 860.5 861.7 861.8 910.2 912.1 912.4 912.8 914.0 718.8 728.4 760.8 892.4 894.7 664.8 666.5 667.1 667.6 669.0 14523.0 14564.7 14588.9 14590.6 14592.1 12349.0 12514.4 12660.9 12883.0 13023.1 10036.0 10061.1 10070.4 10080.9 10082.5 3488.1 3520.8 3525.4 3527.9 3534.7 78878.0 80427.4 81226.0 81339.0 82997.6 9267.8 9296.2 9367.9 9369.0 9562.9 19707.7 19717.2 19717.7 19734.0 19754.4 7364.6 7417.4 7566.9 7731.1 7862.6 3887.8 3978.3 4010.6 4028.6 4103.2 3506.8 3553.5 3555.4 3558.4 3565.5 660.2 660.4 663.2 664.1 669.7 482.6 516.2 596.3 601.8 611.7 8119.6 8312.8 8315.7 8438.2 8560.6 499.3 542.3 590.0 605.1 629.8 3715.3 3862.2 3897.5 3974.6 4042.4 78739.0 87057.6 92241.2 92647.0 93345.0 61185.8 78122.0 78767.0 79001.8 79092.6 64673.4 66798.7 67266.0 68781.3 69813.7 8018.9 8049.8 8144.7 8228.2 8291.6 48494.0 48532.0 48847.5 48876.5 49831.5 64837.0 69026.0 69644.0 69939.0 70386.9 9801.7 9995.1 10019.2 10145.1 10326.0 10811.4 10905.0 11130.5 11401.9 11760.4 10646.1 10659.7 10679.9 10690.6 10766.8 10611.5 10790.8 10800.8 10833.3 10910.9 8952.5 9159.6 9509.0 10422.9 10504.4 8050.5 8157.2 8258.1 8350.8 8453.1 8007.2 8959.5 9026.7 9027.0 9290.3 09:10:00 INFO - PROCESS | 2742 | -------- Summary: end -------- 09:10:00 INFO - PROCESS | 2742 | 09:10:00 INFO - TEST-INFO | 2742: exit 0 09:10:00 INFO - TEST-OK | dromaeo_css | took 1113647ms 09:10:00 INFO - TEST-START | kraken 09:10:00 INFO - operating with platform_type : mac_ 09:10:00 INFO - Initialising browser for kraken test... 09:10:00 INFO - TEST-INFO | started process 2744 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpCM4f2g/profile http://localhost:51583/getInfo.html) 09:10:02 INFO - PROCESS | 2744 | __metrics Screen width/height:1600/1200 09:10:02 INFO - PROCESS | 2744 | colorDepth:24 09:10:02 INFO - PROCESS | 2744 | Browser inner width/height: 1024/689 09:10:02 INFO - PROCESS | 2744 | __metrics 09:10:03 INFO - PROCESS | 2744 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:10:03 INFO - PROCESS | 2744 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:03 INFO - TEST-INFO | 2744: exit 0 09:10:03 INFO - Browser initialized. 09:10:03 INFO - Running cycle 1/1 for kraken test... 09:10:03 INFO - TEST-INFO | started process 2746 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpCM4f2g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:15 INFO - PROCESS | 2746 | RSS: Main: 247386112 09:10:15 INFO - PROCESS | 2746 | 09:10:18 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51583/tests/kraken/driver.html?testName=audio-beat-detection) 09:10:18 INFO - PROCESS | 2746 | RSS: Main: 291295232 09:10:18 INFO - PROCESS | 2746 | 09:10:21 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51583/tests/kraken/driver.html?testName=audio-dft) 09:10:21 INFO - PROCESS | 2746 | RSS: Main: 301977600 09:10:21 INFO - PROCESS | 2746 | 09:10:25 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51583/tests/kraken/driver.html?testName=audio-fft) 09:10:25 INFO - PROCESS | 2746 | RSS: Main: 286031872 09:10:25 INFO - PROCESS | 2746 | 09:10:27 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51583/tests/kraken/driver.html?testName=audio-oscillator) 09:10:28 INFO - PROCESS | 2746 | RSS: Main: 289124352 09:10:28 INFO - PROCESS | 2746 | 09:10:30 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:10:30 INFO - PROCESS | 2746 | RSS: Main: 290054144 09:10:30 INFO - PROCESS | 2746 | 09:10:33 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51583/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:34 INFO - PROCESS | 2746 | RSS: Main: 290594816 09:10:34 INFO - PROCESS | 2746 | 09:10:37 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51583/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:37 INFO - PROCESS | 2746 | RSS: Main: 290205696 09:10:37 INFO - PROCESS | 2746 | 09:10:40 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51583/tests/kraken/driver.html?testName=json-parse-financial) 09:10:41 INFO - PROCESS | 2746 | RSS: Main: 290934784 09:10:41 INFO - PROCESS | 2746 | 09:10:42 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:10:43 INFO - PROCESS | 2746 | RSS: Main: 323657728 09:10:43 INFO - PROCESS | 2746 | 09:10:45 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51583/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:10:45 INFO - PROCESS | 2746 | RSS: Main: 324194304 09:10:45 INFO - PROCESS | 2746 | 09:10:47 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:10:48 INFO - PROCESS | 2746 | RSS: Main: 334172160 09:10:48 INFO - PROCESS | 2746 | 09:10:50 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:51 INFO - PROCESS | 2746 | RSS: Main: 335065088 09:10:51 INFO - PROCESS | 2746 | 09:10:54 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:54 INFO - PROCESS | 2746 | RSS: Main: 335196160 09:10:54 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | Cycle 1(1): loaded http://localhost:51583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51583/tests/kraken/driver.html?testName=ai-astar) 09:10:56 INFO - PROCESS | 2746 | RSS: Main: 395005952 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | __start_tp_report 09:10:56 INFO - PROCESS | 2746 | _x_x_mozilla_page_load 09:10:56 INFO - PROCESS | 2746 | _x_x_mozilla_page_load_details 09:10:56 INFO - PROCESS | 2746 | |i|pagename|runs| 09:10:56 INFO - PROCESS | 2746 | |0;ai-astar;111;110;111;111;112;113;119;112;113;112 09:10:56 INFO - PROCESS | 2746 | |1;audio-beat-detection;159;121;145;157;120;143;142;119;158;127 09:10:56 INFO - PROCESS | 2746 | |2;audio-dft;183;187;185;191;188;185;187;188;182;184 09:10:56 INFO - PROCESS | 2746 | |3;audio-fft;77;77;88;77;57;57;58;86;84;70 09:10:56 INFO - PROCESS | 2746 | |4;audio-oscillator;95;94;122;77;81;87;110;76;78;108 09:10:56 INFO - PROCESS | 2746 | |5;imaging-gaussian-blur;74;121;128;133;87;93;88;94;88;96 09:10:56 INFO - PROCESS | 2746 | |6;imaging-darkroom;96;95;96;97;96;95;97;96;96;95 09:10:56 INFO - PROCESS | 2746 | |7;imaging-desaturate;88;85;85;87;85;88;88;86;86;86 09:10:56 INFO - PROCESS | 2746 | |8;json-parse-financial;55;55;53;53;54;53;53;64;53;55 09:10:56 INFO - PROCESS | 2746 | |9;json-stringify-tinderbox;65;62;68;80;70;68;66;66;66;66 09:10:56 INFO - PROCESS | 2746 | |10;stanford-crypto-aes;84;83;83;82;84;82;83;83;83;82 09:10:56 INFO - PROCESS | 2746 | |11;stanford-crypto-ccm;129;134;117;128;158;135;124;123;130;129 09:10:56 INFO - PROCESS | 2746 | |12;stanford-crypto-pbkdf2;137;140;137;138;141;128;139;137;136;135 09:10:56 INFO - PROCESS | 2746 | |13;stanford-crypto-sha256-iterative;68;72;91;93;92;72;66;67;68;68 09:10:56 INFO - PROCESS | 2746 | __end_tp_report 09:10:56 INFO - PROCESS | 2746 | __start_cc_report 09:10:56 INFO - PROCESS | 2746 | _x_x_mozilla_cycle_collect,1205 09:10:56 INFO - PROCESS | 2746 | __end_cc_report 09:10:56 INFO - PROCESS | 2746 | __startTimestamp1455037856743__endTimestamp 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | ------- Summary: start ------- 09:10:56 INFO - PROCESS | 2746 | Number of tests: 14 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:2.60 09:10:56 INFO - PROCESS | 2746 | Values: 111.0 110.0 111.0 111.0 112.0 113.0 119.0 112.0 113.0 112.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:144.00 stddev:16.24 (11.3%) stddev-sans-first:15.55 09:10:56 INFO - PROCESS | 2746 | Values: 159.0 121.0 145.0 157.0 120.0 143.0 142.0 119.0 158.0 127.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#2] audio-dft Cycles:10 Average:186.00 Median:187.00 stddev:2.71 (1.4%) stddev-sans-first:2.65 09:10:56 INFO - PROCESS | 2746 | Values: 183.0 187.0 185.0 191.0 188.0 185.0 187.0 188.0 182.0 184.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#3] audio-fft Cycles:10 Average:73.10 Median:77.00 stddev:12.06 (15.7%) stddev-sans-first:12.71 09:10:56 INFO - PROCESS | 2746 | Values: 77.0 77.0 88.0 77.0 57.0 57.0 58.0 86.0 84.0 70.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:79.50 stddev:16.02 (20.2%) stddev-sans-first:16.97 09:10:56 INFO - PROCESS | 2746 | Values: 95.0 94.0 122.0 77.0 81.0 87.0 110.0 76.0 78.0 108.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#5] imaging-gaussian-blur Cycles:10 Average:100.20 Median:88.00 stddev:19.85 (22.6%) stddev-sans-first:18.66 09:10:56 INFO - PROCESS | 2746 | Values: 74.0 121.0 128.0 133.0 87.0 93.0 88.0 94.0 88.0 96.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 09:10:56 INFO - PROCESS | 2746 | Values: 96.0 95.0 96.0 97.0 96.0 95.0 97.0 96.0 96.0 95.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:86.50 stddev:1.26 (1.5%) stddev-sans-first:1.20 09:10:56 INFO - PROCESS | 2746 | Values: 88.0 85.0 85.0 87.0 85.0 88.0 88.0 86.0 86.0 86.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:3.36 (6.2%) stddev-sans-first:3.56 09:10:56 INFO - PROCESS | 2746 | Values: 55.0 55.0 53.0 53.0 54.0 53.0 53.0 64.0 53.0 55.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:4.81 (7.2%) stddev-sans-first:5.00 09:10:56 INFO - PROCESS | 2746 | Values: 65.0 62.0 68.0 80.0 70.0 68.0 66.0 66.0 66.0 66.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 09:10:56 INFO - PROCESS | 2746 | Values: 84.0 83.0 83.0 82.0 84.0 82.0 83.0 83.0 83.0 82.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:129.50 stddev:10.95 (8.5%) stddev-sans-first:11.60 09:10:56 INFO - PROCESS | 2746 | Values: 129.0 134.0 117.0 128.0 158.0 135.0 124.0 123.0 130.0 129.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.80 Median:137.50 stddev:3.58 (2.6%) stddev-sans-first:3.80 09:10:56 INFO - PROCESS | 2746 | Values: 137.0 140.0 137.0 138.0 141.0 128.0 139.0 137.0 136.0 135.0 09:10:56 INFO - PROCESS | 2746 | 09:10:56 INFO - PROCESS | 2746 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:72.00 stddev:11.42 (15.9%) stddev-sans-first:11.77 09:10:56 INFO - PROCESS | 2746 | Values: 68.0 72.0 91.0 93.0 92.0 72.0 66.0 67.0 68.0 68.0 09:10:56 INFO - PROCESS | 2746 | -------- Summary: end -------- 09:10:56 INFO - PROCESS | 2746 | 09:10:57 INFO - TEST-INFO | 2746: exit 0 09:10:57 INFO - TEST-OK | kraken | took 56533ms 09:10:57 INFO - SUITE-END | took 1170s 09:10:57 INFO - Completed test suite (00:19:30) 09:10:57 INFO - Working with test: dromaeo_css 09:10:57 INFO - Generating results file: dromaeo_css 09:10:57 INFO - Working with test: kraken 09:10:57 INFO - Generating results file: kraken 09:10:57 INFO - javascript benchmark 09:10:57 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:10:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 09:10:58 INFO - process_Request line: dromaeo_css 7303.58 graph.html#tests=[[72,64,59]] 09:10:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:10:58 INFO - process_Request line: kraken 1434.50 graph.html#tests=[[232,64,59]] 09:10:58 INFO - RETURN: dromaeo_css: 7303.58 09:10:58 INFO - RETURN: kraken: 1434.50 09:10:58 INFO - javascript benchmark 09:10:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3365.1082463147272, 3418.8632454701815, 3420.1791570023192, 3457.4640930655755, 3472.9305413891725, 5520.585956053292, 5571.275734154559, 5589.664620122796, 5597.944020559798, 5625.465580769831, 5586.022446071931, 5615.943840561593, 5757.251557297545, 5786.1610066540325, 5809.128630705396, 5044.218146187329, 5101.438841727417, 5103.362079740033, 5115.641905066647, 5194.740262986855, 5217.773823151556, 5239.240310155025, 5258.710770907599, 5263.26314315996, 5297.417284098746, 5069.695818250917, 5123.641345105844, 5158.716270605115, 5173.3533308336455, 5189.143791274435, 5128.666636668605, 5157.510036546522, 5170.0, 5185.092608793446, 5189.948100518985, 5116.744162791845, 5123.103456895028, 5131.358580177478, 5151.639385243035, 5175.301334319894, 5429.4299098594865, 5520.558355331564, 5535.225068490415, 5541.27963364764, 5596.0206963781175, 6156.695979524152, 6162.691865406712, 6177.845553861144, 6184.96907515464, 6207.782727604512, 6183.690815459209, 6245.937540624581, 6256.74973001084, 6268.247810262797, 6270.216222972129, 5594.776208951637, 5664.320281566197, 5703.372629010805, 5771.826845194651, 5778.479936805707, 6233.0, 6240.438360547572, 6243.188385509855, 6248.781292654735, 6263.749450022039, 5844.240248767633, 5965.343812180657, 6022.488088512438, 6029.0, 6030.517558595302, 6102.633841969496, 6105.490073363267, 6174.938250617436, 6178.907316390258, 6215.223097112861, 6126.050462178369, 6155.0, 6156.907646385308, 6160.229971253593, 6168.660723660152, 6028.698565071729, 6104.03106711151, 6178.5366097542865, 6193.38066193377, 6209.130721698965, 4154.750714957112, 4832.081904438145, 4881.219004959189, 4883.218685010453, 4923.950760492421, 4310.655147588185, 4338.262495375794, 4344.239758042393, 4349.391085248068, 4395.362672412482, 4796.25658023007, 5531.778728850801, 5651.208830763697, 5688.431156884279, 5700.629459085146, 4737.3841400618385, 6227.377262273827, 6234.2830574484515, 6240.812775616739, 6265.4361107500545, 5679.943200567942, 5691.8292451226525, 5692.345380281238, 5704.229928959538, 5736.971315143481, 5218.765155568009, 5258.106121959276, 5306.389765176977, 5320.068987927098, 5331.0, 5003.2995380646735, 6195.0, 6292.18201633803, 6293.465055470337, 6311.684415779101, 6235.314115447388, 6255.655938923403, 6257.56197066201, 6266.310705822447, 6275.529335299962, 6242.53181011435, 6258.0, 6282.591631543935, 6315.684215789284, 6335.3981371769605, 4987.576056035133, 5059.822906198266, 5193.792248310026, 6017.699115044318, 6104.246950855989, 6180.876382472416, 6196.442320191204, 6214.9689251553455, 6217.502599792097, 6228.688565571794, 5815.069588865761, 5828.883422331614, 5923.229980102559, 5945.583809133319, 5969.582129250911, 5953.821385358447, 5985.132155837292, 5987.491063259672, 5990.281166260077, 5991.880162396815, 5819.330776960704, 5831.562632802472, 5833.358330583547, 5835.44563266489, 5869.354371019099, 5749.568782341257, 5927.555433342603, 5947.375525569752, 5962.135490353961, 6071.058985857199, 5803.390643982321, 5829.183914251923, 5846.6784326862435, 5860.501857342174, 5862.618929769551], "unit": "score", "name": "dojo.html", "value": 5599.982958954012}, {"lowerIsBetter": false, "replicates": [457.9033215449, 483.94918533554, 489.8456986049394, 578.3146970839556, 579.9130130480428, 28676.0, 29233.0, 36624.633753662456, 37018.44472332917, 37186.62813371865, 39661.60338396623, 40138.0, 40151.19697606046, 40158.19683606333, 40160.99597510064, 9343.159115679571, 9556.092171243756, 9562.521873906277, 9566.904330956706, 9570.234381249484, 9319.95340023299, 9432.81134377312, 9447.149756521912, 9450.952745236264, 9451.669191578296, 9512.286578506604, 9594.088561586637, 9596.088371604686, 9598.328117031811, 9611.375260608038, 9508.80982380352, 9567.90432095684, 9575.329726919119, 9578.6647467339, 9619.759506012335, 9441.716748497556, 9614.423134611876, 9615.903840961571, 9615.951920240354, 9617.0, 38366.23267534662, 38697.0, 38761.8371448857, 38764.0, 38848.80575597132, 3169.1443310306317, 3185.601799775028, 3227.774055816094, 3597.6042635310355, 3906.7655940643654, 28055.29861753452, 28168.01411950572, 28835.0, 28857.56713649297, 28911.0, 2329.138218859033, 2852.5293326601086, 2855.6430446194227, 2877.49643812332, 2879.1650421377776, 473885.0, 473915.0, 475718.62140689424, 475858.0, 475918.0, 59445.0, 59657.701711491165, 59665.70167149136, 59740.40259597435, 59769.10346344808, 63139.36860631427, 63411.0, 63446.68276658587, 63575.68212159002, 63701.407464813754, 16041.59896002586, 16243.431479898147, 16272.18639068042, 16274.0, 16300.266488008068, 12433.689157771129, 12463.127581069419, 12472.563460279029, 12481.001519878388, 12499.3750312484, 15136.924315378574, 18051.638967220846, 18656.34702785396, 18665.44003679892, 18666.719999200024, 8148.714794982147, 8420.326373890073, 8439.873401898976, 8448.0, 8482.406231563855, 958.4824194934657, 971.7813491964251, 1069.3263244156133, 1092.1447291062561, 1125.7579620381657, 26381.812818423216, 28315.0, 28380.71619283822, 29104.563431548544, 29178.124656260345, 961.9326647134633, 1050.2858056521486, 1055.2349546578823, 1059.7874487917811, 1136.267107715519, 13077.476900924046, 14189.574312770426, 14361.928190358982, 14882.0, 15261.236938153048, 524886.0, 528699.0, 528757.0, 528888.0, 531684.0, 56118.0, 56140.0, 56275.437245627836, 56314.0, 56397.0, 1293.9288339141438, 1321.3657444426537, 1421.8507056758892, 1429.8212723409574, 1452.847451017649, 26917.0579029733, 26962.865185673945, 27342.316442089108, 27353.0, 27409.0, 42170.94572635586, 42540.0, 42575.574244257165, 42616.78691606522, 42646.57353426426, 490625.0, 493056.0, 508155.0, 509328.0, 510065.0, 23420.531589368456, 28445.0, 28694.42611147807, 28755.568666470437, 28786.28034299159, 38686.806565968116, 39160.608393915696, 40075.599244007186, 42631.786841065594, 43168.56831431646, 32364.514532281562, 33813.49279760756, 33937.66062339345, 34048.82975585205, 34051.97844064682, 33273.16817079592, 34656.0, 34702.0, 34764.0, 34809.8259508711, 34570.790022350106, 34657.826710866284, 35068.47397289094, 35073.64926350704, 35128.0, 29057.85471072631, 29420.558691619215, 30130.397392052473, 30301.696983029888, 30332.24169395783, 19056.90179142661, 23407.882960585088, 23840.64239036381, 24061.27816165518, 24084.879575602008], "unit": "score", "name": "ext.html", "value": 18978.65740916717}, {"lowerIsBetter": false, "replicates": [360.74567429961877, 364.874118429142, 366.7652702270547, 373.6114440981376, 379.4365367429367, 15159.393624255044, 15287.2356382181, 18989.62020759584, 19338.936358500276, 20225.887576183304, 11593.884061159386, 11899.7620047599, 11915.0, 13826.516071937484, 20163.798362016412, 5119.257707632391, 5318.627696061278, 5326.760295786699, 5328.094223981932, 5336.932613477301, 3833.5974722654137, 4026.134381108061, 5645.379008309083, 5884.588078834483, 5885.970570147143, 5746.425357464262, 5850.970745146268, 5874.9118763218585, 6408.01351581009, 6454.838629034288, 6360.332165122688, 6409.0, 6423.164988551505, 6434.356564343551, 6436.742530298806, 5509.586780991442, 5668.631538949955, 5676.1769543416385, 5679.801206957778, 5692.686902220376, 13549.254790986492, 13553.932230338884, 13574.117682350714, 14703.926480367636, 19116.522086947938, 2085.2805782005184, 2198.5492973940304, 2318.223395162606, 2456.496418234258, 2621.2398404462683, 9790.412575245507, 9809.313348065638, 9830.90169098307, 10174.898251017468, 10228.89771102287, 1737.400596794104, 1775.1390575570838, 1803.8286362795645, 1844.575747578051, 1860.6557786809483, 100963.0, 101288.9871101287, 101385.0, 102570.92728831549, 103726.0, 10887.183461240438, 11150.776984460266, 11173.776524469466, 11190.832137517944, 11287.040601548797, 13355.599332020054, 13455.32723363828, 13509.2569908654, 13524.12093213938, 13556.10214569961, 6881.0, 8310.335173186131, 8339.0, 8398.622062007224, 8435.915640843514, 8397.412181147383, 8404.327653787805, 8419.579021048923, 8485.236328730443, 8535.487870727777, 3479.0606536235073, 4015.638592526687, 4315.762633055149, 4408.933865992013, 4451.109778044404, 1730.6279149982563, 1789.8299661532133, 1790.2570433270048, 1792.1666425112385, 1797.1553369916119, 874.9475031498131, 896.1799953043023, 898.4070513461085, 942.6936245720168, 994.2493417469764, 15853.207339632972, 18270.45188644343, 19063.61872762537, 19067.0, 19185.136668849937, 761.3110135327537, 926.305271046715, 928.5635751196927, 954.174638937328, 1017.679430979254, 7788.337991270805, 8260.0, 10433.478326083665, 10471.214658900613, 10483.318584291997, 688174.0, 697674.0, 707381.0, 718328.0, 718351.3483786484, 108794.0, 112443.0, 112619.0, 113021.78695975355, 120314.0, 1080.9729756755987, 1143.857017872766, 1203.422357268516, 1205.3310412720848, 1224.1675660550734, 11631.88368116308, 17706.203220854833, 18016.0, 18217.271309147487, 18225.45323640293, 46348.80089402926, 50268.0, 50807.49192508028, 51240.570117333526, 51753.22370164375, 66015.0, 67199.99200011906, 67515.0, 67545.86814951412, 68125.0, 6786.473043565158, 7673.654685539276, 7786.793047077712, 7811.453198276066, 7836.608169591612, 9803.313768036169, 11487.8276825846, 11861.347625880659, 12147.878521214674, 12317.260964342167, 7016.7544135954995, 8197.754067377988, 10164.949175254076, 10511.10655594283, 10609.310394824312, 8913.821723565623, 9565.091316324939, 10285.125764309818, 10388.584456621953, 10484.423356715453, 4034.616711412411, 8684.913150868662, 10345.586176552853, 10560.521526986382, 10764.515596798006, 7258.528195667264, 7544.207858175032, 7604.125525564631, 7635.847283054419, 7643.1974642663945, 8175.877361839458, 10632.202584806017, 10652.254342196282, 10686.038256556947, 10769.892301076889], "unit": "score", "name": "jquery.html", "value": 8823.87904239402}, {"lowerIsBetter": false, "replicates": [1358.3615700620705, 1540.2914659256744, 1568.2785918477496, 1801.6486785076916, 1950.9609807803845, 7946.84106317874, 8605.311575073994, 8748.912510874889, 8766.430182038162, 8771.47371157731, 8421.199986001335, 8694.47833130011, 8713.390062695615, 8717.607707653155, 8730.257928076122, 2157.9568408631817, 2226.686255109485, 2235.3629215673536, 2293.6444851048113, 2432.1730611592056, 2452.3256104571205, 2486.9005239790386, 2515.63523289123, 2520.7479252074736, 2521.2688320387065, 2463.5811911975006, 2488.315713178881, 2494.189388448752, 2496.737842526527, 2498.7376325485834, 2400.015993442689, 2468.9259322220364, 2469.4814089041142, 2471.3203868936007, 2471.65396844441, 2417.141914620302, 2417.528581926525, 2429.854208747463, 2430.2466235467064, 2456.7174774900936, 8517.0, 8610.44032137909, 8616.483011019296, 8625.698100566513, 8642.956785216096, 4633.25867861144, 5412.188171774226, 5444.156155795858, 5446.972765136149, 5483.040467918138, 3232.4343239933155, 3538.115471132217, 3613.8735144269826, 3693.0, 3697.205100903319, 1015.8723816563609, 1051.0908064524208, 1054.5307338234488, 1059.90990765785, 1098.9450527473593, 11630.592929247521, 11773.646790596296, 11808.52765889372, 11889.048876089892, 11936.880631193751, 4846.36997190363, 4889.119958407521, 4979.57673597741, 4981.701097934063, 4999.525045120708, 10277.691669249934, 10278.383297002203, 10280.383177009404, 10286.27996040285, 10291.691249262534, 5475.425080366584, 5508.862278442991, 5511.559075273968, 5512.2558454608115, 5517.0, 4909.631777616622, 4925.926111108336, 4978.377702787152, 4989.950100499022, 4991.276264941564, 3815.8473661053804, 3821.082940094413, 3826.5408151022057, 3861.4400911867624, 3888.922221555553, 1254.5734450286946, 1268.8413948256468, 1279.3986826191674, 1304.1979182802509, 1308.3981368570373, 1192.9105317101253, 1335.4057444437133, 1364.0519838712198, 1369.3769334952572, 1370.328539015875, 7966.283034526805, 8054.114047454776, 8260.545669988209, 8302.958485207535, 8330.958345208357, 1115.548202977779, 1152.3258893547202, 1207.2816674078908, 1211.7576484703095, 1230.4278510492663, 6270.028145637433, 6293.2762732285455, 6335.493160547145, 6336.271328797156, 6374.776882809079, 8292.419530632918, 10551.84172237417, 10572.788544229072, 10581.31221470602, 10697.411642359744, 10383.84424233637, 10574.52414641343, 10575.312604680672, 10584.0, 10590.629327973638, 8205.753827385068, 8315.542645154454, 8316.501009939422, 8325.084240733515, 8326.542040187727, 7718.614069296625, 7836.255555722198, 7842.725504607311, 7855.84288314242, 7915.129335773176, 9396.342256042284, 9417.85873211916, 9458.527073646152, 9513.619455221713, 9603.807923841623, 9608.711738647851, 9915.950420247853, 9918.40489570628, 9935.850962235716, 9960.750981225237, 6262.3111457738705, 6441.227052753699, 6757.864842703217, 6949.722011119498, 6959.826004349729, 8103.473274237156, 8143.6742530298125, 8171.101178870201, 8173.468724532886, 8175.427720059539, 6834.316568343126, 7402.555846649218, 7620.923790762022, 7767.1067827200595, 7864.977552918084, 7487.138979017483, 7517.0, 7558.962205188939, 7677.155512893689, 7703.345215656732, 7669.769906902802, 7728.884066739116, 7730.92269077302, 7730.92269077302, 7746.4190185737425, 6912.516123871482, 7045.718171273092, 7049.577025378494, 7056.400205982343, 7061.576305421691, 7114.822129446805, 7155.0, 7163.892541611775, 7172.031775710421, 7193.100862392201], "unit": "score", "name": "mootools.html", "value": 4933.700045945332}, {"lowerIsBetter": false, "replicates": [317.06149796602057, 324.6996528211404, 329.0687354785955, 329.1934759838397, 333.01759808564725, 6159.23009623797, 6301.495880329574, 6321.620702757832, 6365.649889256095, 6423.0686550450155, 5358.678479291245, 6012.5791194616395, 6080.209572755535, 6297.275813281474, 6321.810345689637, 4757.690750101232, 4762.78567464465, 4766.142094423002, 4768.809247630091, 4769.952300477003, 4484.0, 4584.174848527264, 4596.942703178271, 4707.317438971347, 4739.952600474003, 4662.603678687316, 4668.4631267404175, 4675.579197872191, 4693.577578017977, 4700.2009658358165, 4722.834700785456, 4730.479647238801, 4745.976270118662, 4749.145153872301, 4764.166270902579, 4058.634722874926, 4073.287174744408, 4073.959260407388, 4075.816588253536, 4085.795710214507, 5316.3354580677415, 5526.784107496344, 6042.607230530001, 6069.089636554508, 6072.51419886408, 5476.2333273341765, 5485.067538518461, 5493.423190564973, 5496.258005169291, 5498.560115190815, 6377.202849643794, 6696.0, 6697.765578204788, 6713.697883595201, 6722.0, 4185.895352616179, 4420.270655341865, 4420.734755914656, 4422.601965823092, 4500.79746411409, 6997.685104170325, 7040.04959330489, 7040.859182816366, 7054.188768291609, 7057.294270572953, 4568.474625418053, 4589.770511474413, 4591.219492686251, 4608.377868987711, 4615.538446155358, 4536.705114167568, 4651.976740116278, 4657.3246879202325, 4698.8355407560575, 4709.3642358281195, 4535.63714902807, 5437.809676661298, 5460.426655201147, 5476.945230547723, 5484.451554844483, 6735.663216839236, 6740.359665831738, 6746.224184218878, 6751.0, 6752.864942701217, 1602.054787675277, 1630.4537979776671, 1631.5023917705214, 1632.420490725799, 1632.755086736999, 883.7613844262141, 1083.6430763090248, 1087.9238453308192, 1094.8521949536869, 1097.5061222449929, 6265.968670156712, 6283.937160628335, 6284.654344011032, 6288.685565721696, 6316.084167795644, 6921.169459664872, 6930.3762661360715, 6934.0, 6948.756793512202, 6959.930400695928, 6097.062315563411, 6252.155958945576, 6260.029695397221, 6267.1539342189135, 6304.558680892385, 3585.3725598020765, 3664.2488289900507, 3670.4310831821113, 3672.3573374659327, 3681.2821499807283, 7220.350168484862, 7227.494075414776, 7230.638468076575, 7231.3130252625915, 7233.168185658611, 6843.947443104055, 7085.0, 7102.254263302279, 7111.182214045451, 7114.288571142844, 6057.1519987200945, 7144.535605185646, 7210.423166146696, 7221.205667376585, 7246.49274550787, 6743.0, 6913.446924246149, 6917.515773895779, 6924.134483189601, 6930.3762661360715, 6528.412442879973, 6683.43190828785, 6821.0, 6846.041554182319, 6863.485238607024, 7189.460790440633, 7335.816604584928, 7356.521826081287, 7359.77920662381, 7365.926340736524, 4637.350770892145, 4644.7213167210075, 4651.906961860812, 4658.510856360169, 4664.160451118832, 6793.762218322335, 6947.617881016593, 6971.825704357431, 6981.825454363681, 6999.650017499002, 5472.890542189054, 6716.966415167893, 6738.696758645775, 6743.35938085881, 6759.526833121634, 6735.0, 6740.258571557223, 6741.696623651849, 6742.494312926452, 6749.190097188369, 6399.992146044299, 6472.773452929125, 6550.541462097607, 6563.1796025496815, 6571.0, 6713.798586042427, 6738.46092312604, 6762.188537375349, 6762.763303284361, 6773.864522709617, 4767.261074533453, 5767.596268261182, 6580.703868325841, 6632.403083722488, 6636.933630663631], "unit": "score", "name": "prototype.html", "value": 4941.720487115955}, {"lowerIsBetter": false, "replicates": [568.3407247592792, 703.2194264366552, 722.090166390348, 725.1733024352236, 778.926002029807, 14684.486042988485, 14890.627734306621, 14894.851051489482, 14904.552863414088, 14910.478133265338, 13585.52450664227, 13658.317084145778, 13673.316334183275, 13688.65778355539, 13699.246541440218, 684.2815044203567, 692.0795342194893, 832.5337810825927, 835.1022650650575, 860.5697151424288, 847.821957388949, 859.9355048371366, 860.4880096342697, 861.6682577207789, 861.7845538615346, 910.2354022620997, 912.1471424218344, 912.3704643795793, 912.7900582865944, 914.0, 718.838261391188, 728.3845150847526, 760.7603604864505, 892.3530440430701, 894.7092195036639, 664.8271449423137, 666.5467482112161, 667.1060778556757, 667.5894324990096, 668.9966550167218, 14523.0, 14564.70870582593, 14588.927055364655, 14590.635234119125, 14592.05151665149, 12349.0, 12514.3742812859, 12660.873391266061, 12883.033772467008, 13023.088383813138, 10036.0, 10061.14480269178, 10070.395776253448, 10080.949595251977, 10082.49587520621, 3488.110531814371, 3520.806355650438, 3525.4006818840858, 3527.94708079379, 3534.6818786309354, 78877.99999999943, 80427.39145217121, 81226.0, 81339.0, 82997.58501207456, 9267.814643707088, 9296.209822165056, 9367.859482107773, 9369.016253293443, 9562.856557151648, 19707.704384434244, 19717.211311547377, 19717.704234436496, 19734.0, 19754.40736777899, 7364.594947277844, 7417.443691723142, 7566.886496702554, 7731.110922244014, 7862.606869656494, 3887.7667339959694, 3978.303796835542, 4010.5588385277597, 4028.617281358266, 4103.220388126247, 3506.7895926244505, 3553.502509648651, 3555.4311310190246, 3558.430651095812, 3565.4651802229355, 660.2275337854721, 660.4485254812286, 663.2339647706906, 664.1498881431775, 669.7354544954716, 482.6211424032188, 516.2127755173391, 596.2814808156162, 601.8104297146473, 611.6574718157846, 8119.594020298961, 8312.8337433251, 8315.708950186714, 8438.156184381513, 8560.61477233526, 499.2934996979306, 542.3139728243775, 589.9911501327483, 605.1104875832519, 629.7764293675771, 3715.3126671565847, 3862.1503269280715, 3897.512810898638, 3974.6224108709625, 4042.43405923171, 78739.0, 87057.56471217603, 92241.15517689609, 92647.0, 93345.0, 61185.776284474065, 78122.0, 78767.0, 79001.81497277545, 79092.60453697694, 64673.3831654203, 66798.66600666965, 67266.0, 68781.3121868785, 69813.65093174603, 8018.919810802051, 8049.839003219786, 8144.714934977247, 8228.177182281725, 8291.58542072882, 48494.0, 48532.02935941332, 48847.51152488572, 48876.5112348872, 49831.501684984134, 64837.0, 69026.0, 69643.95534066892, 69939.0, 70386.94419583812, 9801.656942006995, 9995.050470205319, 10019.248556358449, 10145.137663298703, 10326.01902819231, 10811.405372704578, 10905.01854833037, 11130.499127539442, 11401.885981140082, 11760.411979401168, 10646.148308135176, 10659.680209593414, 10679.946600266949, 10690.572377104829, 10766.784664306513, 10611.469426528796, 10790.784184316113, 10800.837987430037, 10833.29583577065, 10910.890891090987, 8952.507612081397, 9159.587818548049, 9509.049095090435, 10422.947885260524, 10504.42225677595, 8050.5169689818795, 8157.173590763598, 8258.050324212552, 8350.83298334042, 8453.070162282267, 8007.1592482788465, 8959.462432254086, 9026.68406605792, 9027.0, 9290.303227257848], "unit": "score", "name": "yui.html", "value": 6637.724861118051}], "name": "dromaeo_css", "value": 7303.583822329874}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 111.0, 112.0, 113.0, 119.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [159.0, 121.0, 145.0, 157.0, 120.0, 143.0, 142.0, 119.0, 158.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 139.1}, {"lowerIsBetter": true, "replicates": [183.0, 187.0, 185.0, 191.0, 188.0, 185.0, 187.0, 188.0, 182.0, 184.0], "unit": "score", "name": "audio-dft", "value": 186.0}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 88.0, 77.0, 57.0, 57.0, 58.0, 86.0, 84.0, 70.0], "unit": "score", "name": "audio-fft", "value": 73.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 122.0, 77.0, 81.0, 87.0, 110.0, 76.0, 78.0, 108.0], "unit": "score", "name": "audio-oscillator", "value": 92.8}, {"lowerIsBetter": true, "replicates": [74.0, 121.0, 128.0, 133.0, 87.0, 93.0, 88.0, 94.0, 88.0, 96.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.9}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 85.0, 87.0, 85.0, 88.0, 88.0, 86.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 53.0, 53.0, 54.0, 53.0, 53.0, 64.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [65.0, 62.0, 68.0, 80.0, 70.0, 68.0, 66.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 82.0, 84.0, 82.0, 83.0, 83.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [129.0, 134.0, 117.0, 128.0, 158.0, 135.0, 124.0, 123.0, 130.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.7}, {"lowerIsBetter": true, "replicates": [137.0, 140.0, 137.0, 138.0, 141.0, 128.0, 139.0, 137.0, 136.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.8}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 91.0, 93.0, 92.0, 72.0, 66.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.7}], "name": "kraken", "value": 1434.5}]} 09:10:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1434.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7303.58"}}} 09:10:58 INFO - Return code: 0 09:10:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:10:58 INFO - # TBPL SUCCESS # 09:10:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:58 INFO - 2016-02-09 09:10:58.708 screenresolution[2750:22732] starting screenresolution argv=screenresolution get 09:10:58 INFO - 2016-02-09 09:10:58.711 screenresolution[2750:22732] Display 0: 1600x1200x32@60 09:10:58 INFO - 2016-02-09 09:10:58.717 screenresolution[2751:22735] starting screenresolution argv=screenresolution list 09:10:58 INFO - Available Modes on Display 0 09:10:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:58 INFO - Intel Iris: 09:10:58 INFO - Chipset Model: Intel Iris 09:10:58 INFO - Type: GPU 09:10:58 INFO - Bus: Built-In 09:10:58 INFO - VRAM (Dynamic, Max): 1536 MB 09:10:58 INFO - Vendor: Intel (0x8086) 09:10:58 INFO - Device ID: 0x0a2e 09:10:58 INFO - Revision ID: 0x0009 09:10:58 INFO - Displays: 09:10:58 INFO - Display: 09:10:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:58 INFO - Display Serial Number: 1600x1200 60 09:10:58 INFO - Main Display: Yes 09:10:58 INFO - Mirror: Off 09:10:58 INFO - Online: Yes 09:10:58 INFO - Rotation: Supported 09:10:58 INFO - Return code: 0 09:10:58 INFO - Running post-action listener: _resource_record_post_action 09:10:58 INFO - Running post-run listener: _resource_record_post_run 09:11:00 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 380928; Write bytes: 707444224; Read time: 3; Write time: 2034 09:11:00 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 403945984; Write bytes: 400860672; Read time: 30813; Write time: 719 09:11:00 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 380928; Write bytes: 300341248; Read time: 3; Write time: 1295 09:11:00 INFO - Running post-run listener: _upload_blobber_files 09:11:00 INFO - Blob upload gear active. 09:11:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11:00 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 09:11:00 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'] 09:11:00 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 09:11:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:11:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:11:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:01 INFO - (blobuploader) - INFO - Done attempting. 09:11:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:11:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:11:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:03 INFO - (blobuploader) - INFO - Done attempting. 09:11:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:03 INFO - Return code: 0 09:11:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6ed94d0f9ada573da5ccc0bd9dd55f92b312e8fbe99735f60a05e52c10767d08eb8c58de4f5bbcb3c82217d40ae46470e49d58095837ba1d41ed501dd60ca78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19e9f95ba54a3858700fc786274be921906e93c2f40d4180ca8a43fa10e5ea7c78c73b1cf120f7d10bc2cc674ebbbee7f264c2eefabdc6993dfc005870228b82"} 09:11:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:03 INFO - Contents: 09:11:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6ed94d0f9ada573da5ccc0bd9dd55f92b312e8fbe99735f60a05e52c10767d08eb8c58de4f5bbcb3c82217d40ae46470e49d58095837ba1d41ed501dd60ca78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19e9f95ba54a3858700fc786274be921906e93c2f40d4180ca8a43fa10e5ea7c78c73b1cf120f7d10bc2cc674ebbbee7f264c2eefabdc6993dfc005870228b82"} 09:11:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:03 INFO - Copying logs to upload dir... 09:11:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.466549 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-09 09:11:03.120795) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 09:11:03.124430) ========= 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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6ed94d0f9ada573da5ccc0bd9dd55f92b312e8fbe99735f60a05e52c10767d08eb8c58de4f5bbcb3c82217d40ae46470e49d58095837ba1d41ed501dd60ca78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19e9f95ba54a3858700fc786274be921906e93c2f40d4180ca8a43fa10e5ea7c78c73b1cf120f7d10bc2cc674ebbbee7f264c2eefabdc6993dfc005870228b82"} build_url:https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/KKbDpZKGSze4VUgbvvAy3w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6ed94d0f9ada573da5ccc0bd9dd55f92b312e8fbe99735f60a05e52c10767d08eb8c58de4f5bbcb3c82217d40ae46470e49d58095837ba1d41ed501dd60ca78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19e9f95ba54a3858700fc786274be921906e93c2f40d4180ca8a43fa10e5ea7c78c73b1cf120f7d10bc2cc674ebbbee7f264c2eefabdc6993dfc005870228b82"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 09:11:03.153098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:11:03.153509) ========= 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.G5epqmnhdm/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.H3gCGpN7Jc/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.005132 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:11:03.206868) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 09:11:03.207222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 09:11:03.207703) ========= ========= Total master_lag: 0.31 =========