builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0009 starttime: 1455724604.99 results: success (0) buildid: 20160217060406 builduid: bf1e543d78cd457fafdf0ab59e387e99 revision: 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:44.995220) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:44.995632) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:44.995929) ========= 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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005344 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.021723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.023033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.039038) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.039315) ========= 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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005383 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.087364) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.087649) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.091041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.091349) ========= 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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-17 07:56:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-02-17 07:56:45 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.213762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.217091) ========= 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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.025875 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:45.265306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 07:56:45.265625) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 --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 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-17 07:56:45,345 truncating revision to first 12 chars 2016-02-17 07:56:45,345 Setting DEBUG logging. 2016-02-17 07:56:45,346 attempt 1/10 2016-02-17 07:56:45,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b8c69102f12?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 07:56:46,735 unpacking tar archive at: fx-team-3b8c69102f12/testing/mozharness/ program finished with exit code 0 elapsedTime=1.632215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 07:56:46.919175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:46.919526) ========= echo 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3b8c69102f125cfd6a6e870bfde4c08fb4cfe899'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 program finished with exit code 0 elapsedTime=0.005338 script_repo_revision: '3b8c69102f125cfd6a6e870bfde4c08fb4cfe899' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:46.971223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:46.971509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 07:56:46.986303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-17 07:56:46.986639) ========= /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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:56:47 INFO - MultiFileLogger online at 20160217 07:56:47 in /builds/slave/test 07:56:47 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 07:56:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:47 INFO - {'append_to_log': False, 07:56:47 INFO - 'base_work_dir': '/builds/slave/test', 07:56:47 INFO - 'blob_upload_branch': 'Fx-Team', 07:56:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:47 INFO - 'branch': 'Fx-Team', 07:56:47 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:47 INFO - 'config_files': ('talos/mac_config.py',), 07:56:47 INFO - 'default_actions': ('clobber', 07:56:47 INFO - 'read-buildbot-config', 07:56:47 INFO - 'download-and-extract', 07:56:47 INFO - 'populate-webroot', 07:56:47 INFO - 'create-virtualenv', 07:56:47 INFO - 'install', 07:56:47 INFO - 'run-tests'), 07:56:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:47 INFO - 'download_minidump_stackwalk': True, 07:56:47 INFO - 'download_symbols': 'ondemand', 07:56:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:47 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:47 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:47 INFO - 'installer_path': 'installer.exe', 07:56:47 INFO - 'log_level': 'info', 07:56:47 INFO - 'log_name': 'talos', 07:56:47 INFO - 'log_to_console': True, 07:56:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:56:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:56:47 INFO - 'opt_config_files': (), 07:56:47 INFO - 'pip_index': False, 07:56:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:47 INFO - 'cmd': ('bash', 07:56:47 INFO - '-c', 07:56:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:47 INFO - 'enabled': True, 07:56:47 INFO - 'halt_on_failure': False, 07:56:47 INFO - 'name': 'check_screen_resolution'},), 07:56:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:47 INFO - 'cmd': ('bash', 07:56:47 INFO - '-c', 07:56:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:47 INFO - 'enabled': True, 07:56:47 INFO - 'halt_on_failure': False, 07:56:47 INFO - 'name': 'check_screen_resolution'},), 07:56:47 INFO - 'run_cmd_checks_enabled': True, 07:56:47 INFO - 'sps_profile': False, 07:56:47 INFO - 'sps_profile_interval': 0, 07:56:47 INFO - 'suite': 'dromaeojs', 07:56:47 INFO - 'system_bits': '32', 07:56:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:47 INFO - 'title': 't-yosemite-r7-0009', 07:56:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:47 INFO - 'use_talos_json': True, 07:56:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:47 INFO - 'work_dir': 'build'} 07:56:47 INFO - ##### 07:56:47 INFO - ##### Running clobber step. 07:56:47 INFO - ##### 07:56:47 INFO - Running pre-action listener: _resource_record_pre_action 07:56:47 INFO - Running main action method: clobber 07:56:47 INFO - rmtree: /builds/slave/test/build 07:56:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:48 INFO - Running post-action listener: _resource_record_post_action 07:56:48 INFO - ##### 07:56:48 INFO - ##### Running read-buildbot-config step. 07:56:48 INFO - ##### 07:56:48 INFO - Running pre-action listener: _resource_record_pre_action 07:56:48 INFO - Running main action method: read_buildbot_config 07:56:48 INFO - Using buildbot properties: 07:56:48 INFO - { 07:56:48 INFO - "project": "", 07:56:48 INFO - "product": "firefox", 07:56:48 INFO - "script_repo_revision": "production", 07:56:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:56:48 INFO - "repository": "", 07:56:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:56:48 INFO - "buildid": "20160217060406", 07:56:48 INFO - "pgo_build": "False", 07:56:48 INFO - "basedir": "/builds/slave/test", 07:56:48 INFO - "buildnumber": 380, 07:56:48 INFO - "slavename": "t-yosemite-r7-0009", 07:56:48 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:56:48 INFO - "platform": "yosemite_r7", 07:56:48 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:56:48 INFO - "branch": "fx-team", 07:56:48 INFO - "repo_path": "integration/fx-team", 07:56:48 INFO - "revision": "3b8c69102f125cfd6a6e870bfde4c08fb4cfe899", 07:56:48 INFO - "stage_platform": "macosx64", 07:56:48 INFO - "builduid": "bf1e543d78cd457fafdf0ab59e387e99", 07:56:48 INFO - "slavebuilddir": "test" 07:56:48 INFO - } 07:56:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 07:56:48 INFO - Running post-action listener: _resource_record_post_action 07:56:48 INFO - ##### 07:56:48 INFO - ##### Running download-and-extract step. 07:56:48 INFO - ##### 07:56:48 INFO - Running pre-action listener: _resource_record_pre_action 07:56:48 INFO - Running main action method: download_and_extract 07:56:48 INFO - mkdir: /builds/slave/test/build/tests 07:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:48 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json 07:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json 07:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:56:50 INFO - Downloaded 1277 bytes. 07:56:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:56:50 INFO - Using the following test package requirements: 07:56:50 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:56:50 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:56:50 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 07:56:50 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:56:50 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 07:56:50 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:56:50 INFO - u'jsshell-mac.zip'], 07:56:50 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:56:50 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 07:56:50 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:56:50 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:56:50 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 07:56:50 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:56:50 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 07:56:50 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:56:50 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 07:56:50 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:56:50 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:56:50 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 07:56:50 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:50 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:56:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:56:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:56:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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 07:56:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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 07:56:52 INFO - Downloaded 17806601 bytes. 07:56:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:56:55 INFO - Return code: 0 07:56:55 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:55 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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 07:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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 07:56:56 INFO - Downloaded 17806601 bytes. 07:56:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:56:59 INFO - Return code: 0 07:56: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')]} 07:56:59 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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 07:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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 07:57:00 INFO - Downloaded 10707071 bytes. 07:57:00 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'] 07:57:00 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 07:57:00 INFO - Return code: 0 07:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:00 INFO - https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:57:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:57:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:57:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 07:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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 07:57:04 INFO - Downloaded 111229089 bytes. 07:57:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:57:04 INFO - mkdir: /builds/slave/test/properties 07:57:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:57:04 INFO - Writing to file /builds/slave/test/properties/build_url 07:57:04 INFO - Contents: 07:57:04 INFO - build_url:https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:57:05 INFO - Running post-action listener: _resource_record_post_action 07:57:05 INFO - Running post-action listener: set_extra_try_arguments 07:57:05 INFO - ##### 07:57:05 INFO - ##### Running populate-webroot step. 07:57:05 INFO - ##### 07:57:05 INFO - Running pre-action listener: _resource_record_pre_action 07:57:05 INFO - Running main action method: populate_webroot 07:57:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:57:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:57:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:57:05 INFO - '--tppagecycles', 07:57:05 INFO - '7'], 07:57:05 INFO - 'tests': ['tsvgm']}}, 07:57:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:57:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:57:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:57:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:57:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:57:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:57:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:57:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:57:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:57:05 INFO - 'talos_options': ['--e10s'], 07:57:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:57:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:57:05 INFO - 'tests': ['damp', 'tps']}, 07:57:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:57:05 INFO - 'talos_options': ['--e10s'], 07:57:05 INFO - 'tests': ['damp', 'tps']}, 07:57:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:57:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:57:05 INFO - 'other': {'tests': ['a11yr', 07:57:05 INFO - 'ts_paint', 07:57:05 INFO - 'tpaint', 07:57:05 INFO - 'sessionrestore', 07:57:05 INFO - 'sessionrestore_no_auto_restore']}, 07:57:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:57:05 INFO - 'tests': ['a11yr', 07:57:05 INFO - 'ts_paint', 07:57:05 INFO - 'tpaint', 07:57:05 INFO - 'sessionrestore', 07:57:05 INFO - 'sessionrestore_no_auto_restore']}, 07:57:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:57:05 INFO - 'tests': ['a11yr', 07:57:05 INFO - 'ts_paint', 07:57:05 INFO - 'tpaint', 07:57:05 INFO - 'sessionrestore', 07:57:05 INFO - 'sessionrestore_no_auto_restore']}, 07:57:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:57:05 INFO - 'tests': ['a11yr', 07:57:05 INFO - 'ts_paint', 07:57:05 INFO - 'tpaint', 07:57:05 INFO - 'sessionrestore', 07:57:05 INFO - 'sessionrestore_no_auto_restore']}, 07:57:05 INFO - 'other_l64': {'tests': ['a11yr', 07:57:05 INFO - 'ts_paint', 07:57:05 INFO - 'tpaint', 07:57:05 INFO - 'sessionrestore', 07:57:05 INFO - 'sessionrestore_no_auto_restore']}, 07:57:05 INFO - 'other_nol64': {'tests': ['a11yr', 07:57:05 INFO - 'ts_paint', 07:57:05 INFO - 'tpaint', 07:57:05 INFO - 'sessionrestore', 07:57:05 INFO - 'sessionrestore_no_auto_restore']}, 07:57:05 INFO - 'svgr': {'tests': ['tsvgx', 07:57:05 INFO - 'tsvgr_opacity', 07:57:05 INFO - 'tart', 07:57:05 INFO - 'tscrollx', 07:57:05 INFO - 'cart']}, 07:57:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:57:05 INFO - 'tests': ['tsvgx', 07:57:05 INFO - 'tsvgr_opacity', 07:57:05 INFO - 'tart', 07:57:05 INFO - 'tscrollx', 07:57:05 INFO - 'cart']}, 07:57:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:57:05 INFO - 'tests': ['tp5o']}, 07:57:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:57:05 INFO - 'talos_options': ['--e10s'], 07:57:05 INFO - 'tests': ['tp5o']}, 07:57:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:57:05 INFO - 'talos_options': ['--xperf_path', 07:57:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:57:05 INFO - 'tests': ['tp5n']}, 07:57:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:57:05 INFO - 'talos_options': ['--e10s', 07:57:05 INFO - '--xperf_path', 07:57:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:57:05 INFO - 'tests': ['tp5n']}}, 07:57:05 INFO - 'talos.zip': {'path': '', 07:57:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:57:05 INFO - Running post-action listener: _resource_record_post_action 07:57:05 INFO - ##### 07:57:05 INFO - ##### Running create-virtualenv step. 07:57:05 INFO - ##### 07:57:05 INFO - Running pre-action listener: _resource_record_pre_action 07:57:05 INFO - Running main action method: create_virtualenv 07:57:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:57:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:57:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:57:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:57:05 INFO - Using real prefix '/tools/python27' 07:57:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:57:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:57:09 INFO - Installing pip.................done. 07:57:09 INFO - Return code: 0 07:57:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102feca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda3d87a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, '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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:57:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:57:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:09 INFO - 'HOME': '/Users/cltbld', 07:57:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:09 INFO - 'LOGNAME': 'cltbld', 07:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:09 INFO - 'MOZ_NO_REMOTE': '1', 07:57:09 INFO - 'NO_EM_RESTART': '1', 07:57:09 INFO - 'PAGER': '/bin/cat', 07:57:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:09 INFO - 'PWD': '/builds/slave/test', 07:57:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:09 INFO - 'SHELL': '/bin/bash', 07:57:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:57:09 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:57:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:09 INFO - 'USER': 'cltbld', 07:57:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:09 INFO - 'XPC_FLAGS': '0x0', 07:57:09 INFO - 'XPC_SERVICE_NAME': '0', 07:57:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:57:09 INFO - Cleaning up... 07:57:09 INFO - Return code: 0 07:57:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102feca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda3d87a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, '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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:57:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:57:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:09 INFO - 'HOME': '/Users/cltbld', 07:57:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:09 INFO - 'LOGNAME': 'cltbld', 07:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:09 INFO - 'MOZ_NO_REMOTE': '1', 07:57:09 INFO - 'NO_EM_RESTART': '1', 07:57:09 INFO - 'PAGER': '/bin/cat', 07:57:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:09 INFO - 'PWD': '/builds/slave/test', 07:57:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:09 INFO - 'SHELL': '/bin/bash', 07:57:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:57:09 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:57:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:09 INFO - 'USER': 'cltbld', 07:57:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:09 INFO - 'XPC_FLAGS': '0x0', 07:57:09 INFO - 'XPC_SERVICE_NAME': '0', 07:57:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:10 INFO - Downloading/unpacking psutil>=0.7.1 07:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:57:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:57:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:57:12 INFO - Installing collected packages: psutil 07:57:12 INFO - Running setup.py install for psutil 07:57:13 INFO - building 'psutil._psutil_osx' extension 07:57:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:57:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:57:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:57:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:57:13 INFO - building 'psutil._psutil_posix' extension 07:57:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:57:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:57:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:57:13 INFO - ^ 07:57:14 INFO - 1 warning generated. 07:57:14 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 07:57:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:57:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:57:14 INFO - Successfully installed psutil 07:57:14 INFO - Cleaning up... 07:57:14 INFO - Return code: 0 07:57:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:57:14 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')]} 07:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:14 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')]} 07:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:14 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 0x102feca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda3d87a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, '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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:57:14 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 07:57:14 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 07:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:14 INFO - 'HOME': '/Users/cltbld', 07:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:14 INFO - 'LOGNAME': 'cltbld', 07:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:14 INFO - 'MOZ_NO_REMOTE': '1', 07:57:14 INFO - 'NO_EM_RESTART': '1', 07:57:14 INFO - 'PAGER': '/bin/cat', 07:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:14 INFO - 'PWD': '/builds/slave/test', 07:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:14 INFO - 'SHELL': '/bin/bash', 07:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:57:14 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:14 INFO - 'USER': 'cltbld', 07:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:14 INFO - 'XPC_FLAGS': '0x0', 07:57:14 INFO - 'XPC_SERVICE_NAME': '0', 07:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:57:14 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 07:57:14 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 07:57:14 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 07:57:14 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 07:57:14 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 07:57:14 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 07:57:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:57:16 INFO - Installing collected packages: mozsystemmonitor 07:57:16 INFO - Running setup.py install for mozsystemmonitor 07:57:17 INFO - Successfully installed mozsystemmonitor 07:57:17 INFO - Cleaning up... 07:57:17 INFO - Return code: 0 07:57:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:57:17 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')]} 07:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:17 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')]} 07:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:17 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 0x102feca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda3d87a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, '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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:57:17 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 07:57:17 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 07:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:17 INFO - 'HOME': '/Users/cltbld', 07:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:17 INFO - 'LOGNAME': 'cltbld', 07:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:17 INFO - 'MOZ_NO_REMOTE': '1', 07:57:17 INFO - 'NO_EM_RESTART': '1', 07:57:17 INFO - 'PAGER': '/bin/cat', 07:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:17 INFO - 'PWD': '/builds/slave/test', 07:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:17 INFO - 'SHELL': '/bin/bash', 07:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:57:17 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:17 INFO - 'USER': 'cltbld', 07:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:17 INFO - 'XPC_FLAGS': '0x0', 07:57:17 INFO - 'XPC_SERVICE_NAME': '0', 07:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:17 INFO - Downloading/unpacking blobuploader==1.2.4 07:57:17 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 07:57:17 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 07:57:17 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 07:57:17 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 07:57:17 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 07:57:17 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 07:57:19 INFO - Downloading blobuploader-1.2.4.tar.gz 07:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:57:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:57:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:57: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 07:57: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 07:57: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 07:57: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 07:57: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 07:57: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 07:57:20 INFO - Downloading docopt-0.6.1.tar.gz 07:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:57:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:57:20 INFO - Running setup.py install for blobuploader 07:57:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:57:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:57:21 INFO - Running setup.py install for requests 07:57:21 INFO - Running setup.py install for docopt 07:57:21 INFO - Successfully installed blobuploader requests docopt 07:57:21 INFO - Cleaning up... 07:57:21 INFO - Return code: 0 07:57:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102feca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda3d87a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, '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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:21 INFO - 'HOME': '/Users/cltbld', 07:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:21 INFO - 'LOGNAME': 'cltbld', 07:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:21 INFO - 'MOZ_NO_REMOTE': '1', 07:57:21 INFO - 'NO_EM_RESTART': '1', 07:57:21 INFO - 'PAGER': '/bin/cat', 07:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:21 INFO - 'PWD': '/builds/slave/test', 07:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:21 INFO - 'SHELL': '/bin/bash', 07:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:57:21 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:21 INFO - 'USER': 'cltbld', 07:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:21 INFO - 'XPC_FLAGS': '0x0', 07:57:21 INFO - 'XPC_SERVICE_NAME': '0', 07:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:22 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-cezZt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:22 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-n6aFxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:22 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-A1HAsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:22 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-tcwCep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:22 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-mXIFtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:22 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-N_PpPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:22 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-EErwiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:22 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-RuedOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:22 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-UlvF4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:23 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-BDoVVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:23 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Ax95cU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:23 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-u7zF4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:23 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-lQUNuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:23 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-wHcJp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:23 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-S7j6Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:23 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-JIrG4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:23 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-1or3Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:57:23 INFO - Running setup.py install for manifestparser 07:57:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:57:24 INFO - Running setup.py install for mozcrash 07:57:24 INFO - Running setup.py install for mozdebug 07:57:24 INFO - Running setup.py install for mozdevice 07:57:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:57:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:57:24 INFO - Running setup.py install for mozfile 07:57:24 INFO - Running setup.py install for mozhttpd 07:57:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:57:24 INFO - Running setup.py install for mozinfo 07:57:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:57:24 INFO - Running setup.py install for mozInstall 07:57:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:57:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:57:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:57:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:57:25 INFO - Running setup.py install for mozleak 07:57:25 INFO - Running setup.py install for mozlog 07:57:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:57:25 INFO - Running setup.py install for moznetwork 07:57:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:57:25 INFO - Running setup.py install for mozprocess 07:57:25 INFO - Running setup.py install for mozprofile 07:57:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:57:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:57:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:57:25 INFO - Running setup.py install for mozrunner 07:57:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:57:26 INFO - Running setup.py install for mozscreenshot 07:57:26 INFO - Running setup.py install for moztest 07:57:26 INFO - Running setup.py install for mozversion 07:57:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:57:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:57:26 INFO - Cleaning up... 07:57:26 INFO - Return code: 0 07:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:26 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 0x102feca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda3d87a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, '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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:57:26 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 07:57:26 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 07:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:26 INFO - 'HOME': '/Users/cltbld', 07:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:26 INFO - 'LOGNAME': 'cltbld', 07:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:26 INFO - 'MOZ_NO_REMOTE': '1', 07:57:26 INFO - 'NO_EM_RESTART': '1', 07:57:26 INFO - 'PAGER': '/bin/cat', 07:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:26 INFO - 'PWD': '/builds/slave/test', 07:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:26 INFO - 'SHELL': '/bin/bash', 07:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:57:26 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:26 INFO - 'USER': 'cltbld', 07:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:26 INFO - 'XPC_FLAGS': '0x0', 07:57:26 INFO - 'XPC_SERVICE_NAME': '0', 07:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:26 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-jvd5Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:26 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)) 07:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:26 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-GXaANY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:26 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-1tnchB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:27 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)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-njwgaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:27 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)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-H7Fg3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:27 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)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-7XqnEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:27 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)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-W69dPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:27 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)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-sPc9cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:27 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)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Z194QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:27 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)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-XuXih6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:27 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)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-xITHfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-1goozA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:27 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-FrDu0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:28 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)) 07:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:28 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-En7oLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:28 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)) 07:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:28 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-5WqaUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:28 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)) 07:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:28 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-BXhZfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:28 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)) 07:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:28 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-3P9g0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:28 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)) 07:57:28 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)) 07:57:28 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)) 07:57:28 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)) 07:57:28 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)) 07:57:28 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)) 07:57:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:57: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 07:57: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 07:57: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 07:57: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 07:57: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 07:57: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 07:57:30 INFO - Downloading blessings-1.6.tar.gz 07:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:57:30 INFO - Installing collected packages: blessings 07:57:30 INFO - Running setup.py install for blessings 07:57:31 INFO - Successfully installed blessings 07:57:31 INFO - Cleaning up... 07:57:31 INFO - Return code: 0 07:57:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:31 INFO - Reading from file tmpfile_stdout 07:57:31 INFO - Current package versions: 07:57:31 INFO - blessings == 1.6 07:57:31 INFO - blobuploader == 1.2.4 07:57:31 INFO - docopt == 0.6.1 07:57:31 INFO - manifestparser == 1.1 07:57:31 INFO - mozInstall == 1.12 07:57:31 INFO - mozcrash == 0.16 07:57:31 INFO - mozdebug == 0.1 07:57:31 INFO - mozdevice == 0.48 07:57:31 INFO - mozfile == 1.2 07:57:31 INFO - mozhttpd == 0.7 07:57:31 INFO - mozinfo == 0.9 07:57:31 INFO - mozleak == 0.1 07:57:31 INFO - mozlog == 3.1 07:57:31 INFO - moznetwork == 0.27 07:57:31 INFO - mozprocess == 0.22 07:57:31 INFO - mozprofile == 0.28 07:57:31 INFO - mozrunner == 6.11 07:57:31 INFO - mozscreenshot == 0.1 07:57:31 INFO - mozsystemmonitor == 0.0 07:57:31 INFO - moztest == 0.7 07:57:31 INFO - mozversion == 1.4 07:57:31 INFO - psutil == 3.1.1 07:57:31 INFO - requests == 1.2.3 07:57:31 INFO - wsgiref == 0.1.2 07:57:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:31 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')]} 07:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:31 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')]} 07:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:31 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 0x102feca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda3d87a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, '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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:57:31 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 07:57:31 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 07:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:31 INFO - 'HOME': '/Users/cltbld', 07:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:31 INFO - 'LOGNAME': 'cltbld', 07:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:31 INFO - 'MOZ_NO_REMOTE': '1', 07:57:31 INFO - 'NO_EM_RESTART': '1', 07:57:31 INFO - 'PAGER': '/bin/cat', 07:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:31 INFO - 'PWD': '/builds/slave/test', 07:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:31 INFO - 'SHELL': '/bin/bash', 07:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:57:31 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:31 INFO - 'USER': 'cltbld', 07:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:31 INFO - 'XPC_FLAGS': '0x0', 07:57:31 INFO - 'XPC_SERVICE_NAME': '0', 07:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:31 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)) 07:57:31 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)) 07:57:31 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)) 07:57:31 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)) 07:57:31 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)) 07:57:31 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)) 07:57:31 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)) 07:57:31 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)) 07:57:31 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)) 07:57:31 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)) 07:57:31 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)) 07:57:31 INFO - Cleaning up... 07:57:31 INFO - Return code: 0 07:57:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:57:31 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')]} 07:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:31 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')]} 07:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:31 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 0x102feca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda3d87a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, '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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:57:31 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 07:57:31 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 07:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:31 INFO - 'HOME': '/Users/cltbld', 07:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:31 INFO - 'LOGNAME': 'cltbld', 07:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:31 INFO - 'MOZ_NO_REMOTE': '1', 07:57:31 INFO - 'NO_EM_RESTART': '1', 07:57:31 INFO - 'PAGER': '/bin/cat', 07:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:31 INFO - 'PWD': '/builds/slave/test', 07:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:31 INFO - 'SHELL': '/bin/bash', 07:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:57:31 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:31 INFO - 'USER': 'cltbld', 07:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:31 INFO - 'XPC_FLAGS': '0x0', 07:57:31 INFO - 'XPC_SERVICE_NAME': '0', 07:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:31 INFO - Downloading/unpacking jsonschema 07:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:57:34 INFO - Downloading/unpacking functools32 (from jsonschema) 07:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:57:34 INFO - warning: no files found matching '*.txt' 07:57:34 INFO - no previously-included directories found matching 'build' 07:57:34 INFO - no previously-included directories found matching 'dist' 07:57:34 INFO - no previously-included directories found matching '.git*' 07:57:34 INFO - Installing collected packages: jsonschema, functools32 07:57:34 INFO - Running setup.py install for functools32 07:57:35 INFO - warning: no files found matching '*.txt' 07:57:35 INFO - no previously-included directories found matching 'build' 07:57:35 INFO - no previously-included directories found matching 'dist' 07:57:35 INFO - no previously-included directories found matching '.git*' 07:57:35 INFO - Successfully installed jsonschema functools32 07:57:35 INFO - Cleaning up... 07:57:35 INFO - Return code: 0 07:57:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:35 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 0x102feca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ff44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcda3d87a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, '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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 07:57:35 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 07:57:35 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 07:57:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:57:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:35 INFO - 'HOME': '/Users/cltbld', 07:57:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:35 INFO - 'LOGNAME': 'cltbld', 07:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:35 INFO - 'MOZ_NO_REMOTE': '1', 07:57:35 INFO - 'NO_EM_RESTART': '1', 07:57:35 INFO - 'PAGER': '/bin/cat', 07:57:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:35 INFO - 'PWD': '/builds/slave/test', 07:57:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:35 INFO - 'SHELL': '/bin/bash', 07:57:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:57:35 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:57:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:35 INFO - 'USER': 'cltbld', 07:57:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:35 INFO - 'XPC_FLAGS': '0x0', 07:57:35 INFO - 'XPC_SERVICE_NAME': '0', 07:57:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:35 INFO - Downloading/unpacking flake8 07:57:35 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 07:57:35 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 07:57:35 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 07:57:35 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 07:57:35 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 07:57:35 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 07:57:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:57:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:57:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:57:38 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 07:57:38 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 07:57:38 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 07:57:38 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 07:57:38 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 07:57:38 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 07:57:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:57:38 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 07:57:38 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 07:57:38 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 07:57:38 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 07:57:38 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 07:57:38 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 07:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:57:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:57:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:57:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:57:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:57:39 INFO - no previously-included directories found matching 'docs/_build' 07:57:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:57:39 INFO - Running setup.py install for pep8 07:57:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:57:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:57:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:57:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:57:39 INFO - no previously-included directories found matching 'docs/_build' 07:57:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:57:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:57:39 INFO - Cleaning up... 07:57:39 INFO - Return code: 0 07:57:39 INFO - Running post-action listener: _resource_record_post_action 07:57:39 INFO - Running post-action listener: _start_resource_monitoring 07:57:39 INFO - Starting resource monitoring. 07:57:39 INFO - ##### 07:57:39 INFO - ##### Running install step. 07:57:39 INFO - ##### 07:57:39 INFO - Running pre-action listener: _resource_record_pre_action 07:57:39 INFO - Running main action method: install 07:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:39 INFO - Reading from file tmpfile_stdout 07:57:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:57:39 INFO - Reading from file tmpfile_stdout 07:57:39 INFO - Output received: 07:57:39 INFO - Usage: mozinstall [options] installer 07:57:39 INFO - Options: 07:57:39 INFO - -h, --help show this help message and exit 07:57:39 INFO - -d DEST, --destination=DEST 07:57:39 INFO - Directory to install application into. [default: 07:57:39 INFO - "/builds/slave/test"] 07:57:39 INFO - --app=APP Application being installed. [default: firefox] 07:57:39 INFO - mkdir: /builds/slave/test/build/application 07:57:39 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'] 07:57:39 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 07:58:13 INFO - Reading from file tmpfile_stdout 07:58:13 INFO - Output received: 07:58:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:58:13 INFO - Running post-action listener: _resource_record_post_action 07:58:13 INFO - ##### 07:58:13 INFO - ##### Running run-tests step. 07:58:13 INFO - ##### 07:58:13 INFO - Running pre-action listener: _resource_record_pre_action 07:58:13 INFO - Running main action method: run_tests 07:58:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:58:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:58:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:58:13 INFO - 2016-02-17 07:58:13.899 screenresolution[1655:7406] starting screenresolution argv=screenresolution get 07:58:13 INFO - 2016-02-17 07:58:13.902 screenresolution[1655:7406] Display 0: 1600x1200x32@60 07:58:13 INFO - 2016-02-17 07:58:13.908 screenresolution[1656:7408] starting screenresolution argv=screenresolution list 07:58:13 INFO - Available Modes on Display 0 07:58:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:58:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:58:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:58:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:58:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:58:14 INFO - Intel Iris: 07:58:14 INFO - Chipset Model: Intel Iris 07:58:14 INFO - Type: GPU 07:58:14 INFO - Bus: Built-In 07:58:14 INFO - VRAM (Dynamic, Max): 1536 MB 07:58:14 INFO - Vendor: Intel (0x8086) 07:58:14 INFO - Device ID: 0x0a2e 07:58:14 INFO - Revision ID: 0x0009 07:58:14 INFO - Displays: 07:58:14 INFO - Display: 07:58:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:58:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:58:14 INFO - Display Serial Number: 1600x1200 60 07:58:14 INFO - Main Display: Yes 07:58:14 INFO - Mirror: Off 07:58:14 INFO - Online: Yes 07:58:14 INFO - Rotation: Supported 07:58:14 INFO - Return code: 0 07:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:58:14 INFO - Python 2.7.3 07:58:14 INFO - Return code: 0 07:58:14 INFO - grabbing minidump binary from tooltool 07:58:14 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')]} 07:58:14 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 0x102e90d30>, '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 0x102cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e87b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:58:14 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 07:58:14 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 07:58:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:58:14 INFO - Return code: 0 07:58:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:58:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:58:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:58:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:58:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:58:15 INFO - Return code: 0 07:58:15 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/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 07:58:15 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/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --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 07:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1o5EvmIpNi/Render', 07:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:15 INFO - 'HOME': '/Users/cltbld', 07:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:15 INFO - 'LOGNAME': 'cltbld', 07:58:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:58:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:15 INFO - 'MOZ_NO_REMOTE': '1', 07:58:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:58:15 INFO - 'NO_EM_RESTART': '1', 07:58:15 INFO - 'PAGER': '/bin/cat', 07:58:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:15 INFO - 'PWD': '/builds/slave/test', 07:58:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:15 INFO - 'SHELL': '/bin/bash', 07:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fh5hyzhkJs/Listeners', 07:58:15 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 07:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:15 INFO - 'USER': 'cltbld', 07:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:15 INFO - 'XPC_FLAGS': '0x0', 07:58:15 INFO - 'XPC_SERVICE_NAME': '0', 07:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:15 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/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 07:58:15 INFO - mozversion application_buildid: 20160217060406 07:58:15 INFO - mozversion application_changeset: 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 07:58:15 INFO - mozversion application_display_name: Nightly 07:58:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:58:15 INFO - mozversion application_name: Firefox 07:58:15 INFO - mozversion application_remotingname: firefox 07:58:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:58:15 INFO - mozversion application_vendor: Mozilla 07:58:15 INFO - mozversion application_version: 47.0a1 07:58:15 INFO - mozversion platform_buildid: 20160217060406 07:58:15 INFO - mozversion platform_changeset: 3b8c69102f125cfd6a6e870bfde4c08fb4cfe899 07:58:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:58:15 INFO - mozversion platform_version: 47.0a1 07:58:15 INFO - using testdate: 1455724695 07:58:15 INFO - actual date: 1455724695 07:58:16 INFO - starting webserver on 'localhost:49275' 07:58:16 INFO - SUITE-START | Running 2 tests 07:58:16 INFO - TEST-START | dromaeo_css 07:58:16 INFO - operating with platform_type : mac_ 07:58:16 INFO - Initialising browser for dromaeo_css test... 07:58:16 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpHD3cCA/profile http://localhost:49275/getInfo.html) 07:58:18 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 07:58:18 INFO - PROCESS | 1674 | colorDepth:24 07:58:18 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 07:58:18 INFO - PROCESS | 1674 | __metrics 07:58:18 INFO - PROCESS | 1674 | 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" 07:58:18 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:58:19 INFO - TEST-INFO | 1674: exit 0 07:58:19 INFO - Browser initialized. 07:58:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:58:19 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpHD3cCA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:58:31 INFO - PROCESS | 1677 | RSS: Main: 244305920 07:58:31 INFO - PROCESS | 1677 | 07:59:22 INFO - PROCESS | 1677 | 1455724762599 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:01:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 08:01:34 INFO - PROCESS | 1677 | RSS: Main: 375959552 08:01:34 INFO - PROCESS | 1677 | 08:04:37 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 08:04:37 INFO - PROCESS | 1677 | RSS: Main: 376168448 08:04:37 INFO - PROCESS | 1677 | 08:07:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 08:07:40 INFO - PROCESS | 1677 | RSS: Main: 381607936 08:07:40 INFO - PROCESS | 1677 | 08:10:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 08:10:43 INFO - PROCESS | 1677 | RSS: Main: 339062784 08:10:43 INFO - PROCESS | 1677 | 08:13:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 08:13:47 INFO - PROCESS | 1677 | RSS: Main: 341520384 08:13:47 INFO - PROCESS | 1677 | 08:16:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 08:16:49 INFO - PROCESS | 1677 | RSS: Main: 405860352 08:16:49 INFO - PROCESS | 1677 | 08:16:49 INFO - PROCESS | 1677 | __start_tp_report 08:16:49 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 08:16:49 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 08:16:49 INFO - PROCESS | 1677 | |i|pagename|runs| 08:16:49 INFO - PROCESS | 1677 | |0;dojo.html;3411.09605954422;3466.532018177545;3480.4605286180645;3493.807840568771;3546.2730140321237;5627.6060675752715;5652.4630160134775;5664.886702265957;5677.943220567793;5678.744456499452;5598.216249725042;5668.801591944282;5681.204631351604;5682.801101961432;5689.118186681061;5117.923231151536;5142.0487209866105;5157.174852023677;5170.974145129269;5224.895502089956;5214.348206474191;5230.450802665703;5232.372115346145;5232.398274198478;5234.136367499377;5185.948140518584;5187.351581052369;5190.169572868342;5211.791528338881;5227.869303267411;5181.145111056671;5229.294045303911;5234.031704134747;5239.580833533309;5294.57643388528;5072.873178170538;5127.333446651949;5168.767405466763;5178.637495375326;5180.300659410969;5544.390117087117;5572.637778544382;5582;5635.6055076144685;5648.124540696158;5595.38450770415;5701;6205.22434695663;6214.161088253073;6234.688265586702;6104.4505994460715;6173.2900716417735;6252.749890004395;6264.029075493306;6274.309825919146;5674.602777805555;5751.8562035949435;5781.971090144522;5783.595148339576;5854.356020837747;5218.217267409843;6246.656433896089;6253.437190652772;6259.530535209878;6261.998080307129;5930.169776231331;6090.116933044772;6134.8159555213415;6149.723262453201;6152.446279834747;6160.9383906161265;6213.782517611862;6261.78083767066;6272.5922815016875;6282.968585157045;6167.969160154171;6205.069239614094;6214.751409943642;6216.098665693449;6219.440250377397;6098.481629061579;6144.648177400964;6151.169592105098;6198.504119670415;6200.906986395207;4833.178359678863;4842.491538388489;4883.194272944925;4911.631627627942;4931.90136197274;4350.369196466495;4365.192439398721;4378.146261478981;4392.2094023075515;4418.734875907456;5599.720013999284;5663.745131469093;5673.319201695823;5681.801136960186;5684.34630017545;6078.665673387918;6170.660613666291;6234.064890266496;6259.874802503924;6268.592541484789;5669.121286200563;5669.858253543694;5673.8297851064535;5681.545476361881;5694.003549378925;5330.680159190461;5346.866328341823;5349.170878513759;5352.223927530486;5400.567954563626;6162.26052873649;6192.195014648067;6236.251649802053;6237.752940534455;6286.654234017173;6203.7828675996125;6220.440160385587;6227.906581401192;6262.624242545462;6266.373362663697;5721.914171287517;6275.52933529978;6275.654838983717;6276.466500347339;6285.5600107992;6011.609245399035;6095.922000763747;6110.16388879229;6191;6205.6586887721605;6156.384361563808;6190.133381326708;6202.379762023762;6212.968935155295;6221.346758590464;5893.616914900518;5910.7931222407005;6026.548008899438;6029.125776762257;6031.396860314109;5063.670861393997;5913.46778789911;6038.486728628116;6073.149759033827;6074.967255566653;5773.336066352255;5802.390748971297;5821.476067153807;5825.650460972186;5826.504747096545;5970.343262241063;6007.849803754941;6032.155498230339;6049.092636104443;6084.482818960438;5921.200637913998;6002.7298771554515;6020.337762846171;6025.66858822769;6032.034874420072 08:16:49 INFO - PROCESS | 1677 | |1;ext.html;436.2518281147831;446.415196093118;488.8313531831519;539.8731298144937;553.1371061144615;29992;37352.626473735254;37925.43111853324;38011.23977520455;38171.61828381715;41367.379489307685;41797.7910110449;41903.161936761244;41967.58032419675;42097;9588.041195880425;9819.312648114636;9819.312648114636;9821.459819709913;9825;9590.088941550577;9719.854202186938;9749.95125024374;9750.46372449515;9771.36486128403;9705.466199359033;9780.510974451285;9796.608135674565;9802.803943921117;9808.31341806074;9693.418394896293;9767.413955162641;9769.267304952156;9918.107370336633;9937.453440060794;9650.613975440974;9796.657117000943;9800.65697700577;9802;9803.950980245125;34917.82541087304;40355;40558;40797.38803917944;40839.7958010208;3111.1288839124854;3194.4569423198113;3197.344544368399;3316.1875340541483;3585.587657419404;29183.708162918312;29592.70407295921;29598;29617.407651846843;29697.25756856096;2683.758461738433;2771.2240572639694;2803.2291119941974;2837.704192944003;2851.7861160413054;488686;491690.99999999645;492132;492861;494120;56251.437485625436;57383;63863.04205436922;64307.67846160739;64313;62125;67890.66054669695;70058.29941700518;70620;70970.64514677497;15947.282372293042;16178.514644560682;16217.675646487005;16218.026918384934;16226.837731622769;11256.268342557707;11448.542058317575;11451.427428628702;11474.655760327203;12356.567520136752;17520.561985950455;20061;21023.488255872064;21521.78478215198;21594.56810863774;6340.904886426707;7798.8050298741855;7814.843703125905;7824.217578242244;7883.649448984159;887.5961437545901;938.6151677812064;966.4201479112477;998.5456617239139;1034.8240799064176;29463.852680736458;29485;29936.40127197444;30055;30224.69775302219;931.3154831199063;1038.8416915139564;1064.8615679961556;1096.8080585897435;1177.7055736065984;15421.306041228172;15647.921760391126;15697.450589229551;15892.920535397248;16199.514014579581;538784;552395;552436;552492;554170;49996;59039;59226.81546369049;59543.40456595379;59708.80582388415;1377.7313423882447;1415.4409008441608;1417.8298604167153;1419.09887221615;1547.9783342993571;28280.434391311646;28368.148955531367;28690.713092868806;28739.568906466;28926.276843079093;47616.285755713;48018;48027;48147;48183;437452;440094;440157;440646;441320;31150.53274200934;31557;31580.210494736897;33053.50419743754;33463.996080117635;40731;41732.3740143892;41974.58025419707;42004;42381.788091059345;35270.64729352674;35979.64020359763;36384;36920.81539592285;37279;35941.28117437689;36716.26567468582;36854.26291474209;37821.62178378181;38065.42901856419;36543.45184822177;36767;37572.812135940236;37606;37664.81167594145;30335.502104690484;31638.841805790824;32439.837800810845;32479;32817;22208.66686999664;23709.644355334338;24576.6313505294;24867.378315541533;24995.875185617053 08:16:49 INFO - PROCESS | 1677 | |2;jquery.html;358.7614236532706;363.9308531379038;365.05268827392905;369.68761396619846;372.9160938788771;15005;15106.39574417022;18965.99999999998;19149.42551723449;19956.700649490253;11460.656180314603;12082.456289466973;12087.57693480726;13281;19889.900550497227;5164.251183578379;5339.946600534003;5348.545373643245;5351.197320401951;5369.30866776964;3855.55661098973;4047.1905618876194;4055.3308704063793;4059.127287633158;4061.8375264989363;5559.833205003856;5781.797637082703;5813.796517121901;5821.039528477796;6128.969355153218;6376.872462550769;6378.77674281398;6383.457406120486;6388.520860935449;6395.712192951329;5436;5551.028570000234;5562.554995600382;5565.721713914288;5567.248421463091;9557.90442095577;12850.55023074188;12858.485660573566;13242.271675057867;13847.653808654764;2012.5572374077678;2047.4778931372405;2053.8254248388903;2106.199644135234;2244.753077161511;9351.812963740755;9457.952710236405;9792.706218813448;9951.651692190811;13928.651783705387;1738.8174241704564;1819.8362147406797;1830.1855674224976;1844.6034102667857;1855.3413538194018;88937;98212.017879821;98482.82619236899;100947.48578771325;103720;9067.365284430158;9760.560774765152;11337.036351910016;11348.205625606293;11402.543898243977;13442.990951259915;13534.458621655023;13582.864171358358;13607.931960340135;13684.52104176349;8432.241098301183;8478.660853565789;8489.193526614961;8574.442661227;8577.356698247657;8563.229309362187;8563.657453701906;8586.184312490303;8664.09027052163;8666.350023748244;4079.89800254996;4430.867073987785;4516.503184649686;4533.591976722111;4592.632589392841;1404.676924307415;1760.3398725477946;1799.091458813317;1800.612868233336;1808.9598480873287;387.5968992248087;396.8789519196615;828.9088200297963;890.0076414797584;892.5537231384308;11223.494942727597;11456.656300311004;11521.0207132393;11635.41822908868;11682.649520514398;422.62435771563366;666.5034549260831;768.8961990131261;943.1228957069991;946.3990366117565;10267.845982310271;10458.215633827493;10519.52662130206;10564.094873909737;10614.310069845435;597575;599562;605890;716885;717678;70437;78862.6056869712;103413.96586034044;115364;119174.40412798054;1167.73142177298;1193.8388317577017;1196.7965445874222;1200.6398080575966;1217.2635555488978;18316.81683183151;18657.440276791716;18666.440006799818;18703;18790.624187516445;52501.47498524966;54173.45826541842;55243;55987;56204.43795561992;71129.64435177791;72176.55646887138;72347.27652723405;72630.63684681543;73357;7512.361449276654;7834.608269586384;7845.529268243924;7851;7854.096778870503;8891.91108088911;10745.516451759533;11464.082873369944;11713.297202167898;12342.259464431803;8095.514269143635;10605.363678179334;10647.680569582924;10690.358578485315;10807.459627018774;10448.68653940383;10539.683809485728;10586.841197381891;10712.4155300101;10726.873678263983;10608.098311643596;10843.512041957973;11048;11122.499487522919;11192.496337664987;7717.845643086995;7901.762947111596;7906.446548741533;7916.881246781188;7941.960290198512;9891.307608467338;10347.327423717434;10819.729506762395;10937.671869843918;11012.724681883017 08:16:49 INFO - PROCESS | 1677 | |3;mootools.html;1398.6433459467835;1522.0715363628187;1554.5647218778745;1787.401220591102;1924.2976313645524;7793;8400.41197116202;8654.048054713976;8664.566771661423;8671.86992195116;8364.958175209116;8605.053444121142;8614.870776938335;8647.092055334193;8651.913480865189;2150.161437039556;2210.104907512452;2210.8784016879067;2436.1229957215432;2467.5805113130723;2211.159759291467;2226.209695558078;2231.419830843984;2426.8665223412704;2496.425822060918;2394.4851856850773;2421.927342179729;2442.8656423896678;2444.7433019532873;2448.289995901195;2437.926862194137;2449.7795198432136;2450.0812195426715;2454.104251948044;2457.2628211536467;2375.8099352051795;2445.9510809783706;2446.3150317910836;2449.3876530867283;2449.461118553915;8537.975442946825;8628.482291062493;8650.394472386935;8673.349498787617;8774.956125219333;4053.7973101344814;4751.168545504557;5391.191321301797;5398;5417.295751552312;3496.930061398758;3550.804705741183;3642.162302670374;3652.470391793175;3654.397024490956;907.9105073911333;996.6960077176458;1023.2990401574945;1053.0469924718143;1067.8665166854144;10062.64780732678;11557.537698492135;11766.529338826436;11801.822972655416;11813.586524471602;4772.70015511275;4797.688150270221;4834.347363106006;4848.7090774553635;4871.123197824426;10042.447665378475;10043.548040338203;10049;10056.145227655585;10067.446290454096;5419.187121931742;5447.482489163603;5451;5455.672659640434;5459.481349271813;4914.0171965606305;4915.531443843842;4973.850784476472;4977;4986.326845875833;3594.7483676142942;3828.157805282833;3902.2195560887367;3916.921661566753;3954.406838974177;1008.4907121903392;1271.205496564647;1271.8855303022588;1280.1678908709414;1281.9423125959354;1310.331730817271;1333.041087155779;1335.0854664554618;1355.0853174107438;1374.2853716067789;7919.406044546682;7951.761447156595;7954.960225198837;7972.720954766555;7980.002499687539;1222.7798996180595;1262.1417436143327;1267.461328935199;1292.3990344489669;1302.0820321673198;6056.291374357903;6325.652089135142;6331.778387756406;6333.746650133943;6336.619802811846;10172.542235599416;10387.324823886574;10566.154707623371;10691;10719.356838589709;10341.069303762548;10376.118029967387;10466.895331046744;10467.790644187226;10468.424236667057;8091.39314551411;8148.755537333889;8210;8216;8253.298469630028;7905.960470197842;7944.126146123806;7953.443258972048;7953.483023603448;8037.517748935083;9314.627414903329;9545.856812147684;9554.394621969746;9637.9036209637;9731.756706082404;9052.321075919464;9968.700938971842;10001.699949001542;10078.79842403133;10153.340032897839;7476.364509016795;7609.847803043797;7613.695452181851;7615.581143037186;7622.771316860503;7113.53762005468;7407.407407407287;8075.030996280484;8120.83758324842;8136.349092072502;5615.915761263503;6442.033694945796;7456.440766942393;7532.510386824839;7543.622818858926;6400.199975003125;7448.590327532038;7453.515521491086;7588.27911348421;7602.46782725204;7570.507916985378;7644.12092609357;7647.732329368446;7660.310572048543;7662.770116896502;6796.2524122347495;6833.692483838338;6904.551204171713;6999.790006299819;7022.12223472066;7096;7137.357637812622;7145.857082858418;7158.2841715828;7159.64201789898 08:16:49 INFO - PROCESS | 1677 | |4;prototype.html;312.97965632233905;320.0606220742122;325.05247204399177;329.1146815067468;329.4711987260445;6286.748530058792;6436.967815160923;6453.645049522269;6528.151340325757;6588.538802283842;6419.197600299963;6421.903671444932;6436;6444.130042444269;6455.193100862392;4008.038070863001;4697.812087516495;4780.378550788392;4815.542523460265;4827.493113223114;4590.517995610463;4825.831095911643;4835.371401717772;4845.248986407112;4849.830255941043;4451.62161216297;4699.201135806921;4752.59602933751;4759.262314341283;4775.092732380854;4744.57298843104;4753.809847606091;4756.595689366408;4763.237881938908;4766.285057241442;4077.3883917412627;4077.5922407758985;4084.14233011068;4089.26393249215;4091.9181616367805;6007.549433792483;6173.857836300299;6268.623882567015;6271.184745983039;6282.089097080898;5713.14302854571;5722.313322401297;5725.5419566435;5725.770969161229;5748.367679555246;5550.500454959073;6936.653167341663;6945.166580010431;6947.305269473063;6966.3730264275955;4625.375574297461;4634.976825115853;4647.163510568096;4649.767511624439;4654.906901861944;7118.110236220473;7297.087864016998;7337.963310183468;7406.222346653578;7410.147832999166;4645.233536466513;4715.7877895494785;4719.1033703596895;4728.692634978715;4729.030548737501;4050.10897602527;4587.564181402761;4611.423572053493;4812.951870481321;4825.9758701206265;4865;4880.682755620874;5685.573581981368;5740.450078478787;5755.1367294906095;7001.159860816734;7009.929900700928;7011.824704382431;7013.544119632207;7020.262872398427;1652.7603497492796;1681.747737839334;1683.0070258547516;1683.1752441303918;1684.62938153606;1071.737424331044;1107.3134656513014;1110.1230028277732;1120.081533142815;1122.820348744197;6503.544751867418;6510.576812507266;6510.73957041713;6532.183477065367;6577.309382514863;5877.5591830612875;7167.820804479826;7207.099112610924;7214.458915581353;7231.7107315707835;6265.686715664198;6502.804915852532;6505.577137486048;6507;6512.120863683437;3783.810809459571;3819.7135214858995;3822.10180607557;3830.0999265172663;3833.616638336144;7537.283958023979;7561.357284630758;7566.1298950620285;7574.469787114959;7577.962110189524;5917.615355001911;7153.856922861513;7394.186639469654;7418.814529636695;7427.62861856905;7509.249075092556;7521.360684341892;7521.548707077593;7529.134149572759;7535.284148005931;6446.871062578816;6562.785884611362;7147.428205743632;7172.748953786801;7187.137543494814;6773.89839152423;7011.298870113152;7024.192217894803;7053.682584283617;7071.504994650325;7511.812204694927;7518.173000969779;7518.210587888412;7522.3605993491165;7525.134609519975;4738.218193998089;4766.094442055998;4769.73766442849;4772.379590653193;4779.4742578317055;6875.690593923386;6914;7012.719491220294;7129.536580122275;7260.528065675925;6103.809757097323;7007.6145811978795;7030.086088808423;7031.191412987572;7035.894461582978;6311.179546658905;6776.86446271062;7005.929940700527;7006.843870761268;7013.403860671696;6066.7269972850445;6425.10048593188;6876.724931002704;6880.793576192722;6901;5739.62692424991;6981.5112942093565;7028.367446929801;7033.859322813412;7042.647867606497;6638.435732962752;6878.037074809631;6881.41507971828;6893.20728116253;6903.378695917391 08:16:49 INFO - PROCESS | 1677 | |5;yui.html;673.6699017481434;681.1757773094555;689.383002213019;711.1146622455044;728.0971595221924;14907.627309317259;15113.546593602183;15118.546443606681;15126.243687815606;15135.24323783809;13609.115407498506;13652.590422287323;13952.511662091829;13960.51138210163;13976.371063302151;685.7462738786656;706.6431452116674;861.6036623153341;878.1087196495562;879.8328317619664;765.3188662090744;813.2477458351032;848.4273115646913;870.4255191573562;873.9169778870997;919.8482250428672;921.9907800922006;923.2660035271941;924.2513564013137;924.9861252081224;708.5783958544657;733.8568979049088;891.3804905590617;914.3142643017703;920.1396694091046;676.6379986707088;676.8307923019245;677.2178134254943;677.3192941094218;677.7560078371831;15149.545513634499;15202.087874727442;15207.543773686808;15228.238588070662;15252.313645885963;12240.326782026985;12241.081918856033;12278.324692141929;12354.691132721753;12643.241405515606;9417.529123543864;9548.140667339903;9560.28297877655;9675.516224188763;9882;3483.407820670492;3507.3052271189067;3520.2431477232517;3537.2041290709385;3546.4503002034726;64083.67958160179;84132;84181;85284;85449.57275213646;9148.130927561871;9317.673881414117;9329.860052099224;9359.812803743887;9473.100055494717;20540.17839286412;20542.69185962212;20543.04841040099;20547.38357849267;20551.177952882015;7367.594782286918;7444.069491313586;7534.3595794357;7693.576853273012;7874.8818767717385;4073.837046518106;4089.079957009649;4097.09863829957;4100.630943215125;4118.608732170439;3444.7071998880374;3509.263054758478;3512.2448673535314;3512.631173726773;3518.6481351865123;627.7740013595102;636.1062706896724;648.7080813633884;660.181375094879;660.8447014951482;551.6441894977717;607.2743072028883;614.5882258886556;626.4299487466475;626.589583822597;8597.742067737978;8643.394962352575;8736.91263087361;8746;8872.157145071207;508.61091265182165;545.4055079962859;581.4766709961069;609.0894113300644;613.8588124731336;3872.3997780344093;4047.3119569673227;4124.154548317588;4147.440095587118;4168.353905144708;93404.53297733467;93829.59255611035;95479.56780648296;95729.5213523928;95760.52119739357;72712.63643681853;73532.26467735361;74160.62919685474;75855;76702.6164869172;29345.413091738472;53434;65473;66426;66754.66622666856;8099;8137.674493020213;8257.669693212205;8400.159984001551;8455.02767181782;31542.842285788425;47941.32205372795;48201.27698084462;48745.268820967;49099;64555.35444645681;65495.017574735466;67989.66005169942;68314;68398.65800670965;9895.406275623485;9943.204543636348;10065.647702330676;10121.493925303852;10600.310979786289;11954.342511161969;12367.62897113088;12643.936780316408;12653.936730316289;13039.152455090389;11552.6534203974;11612.419379031184;11664.533418663159;12109.576164834189;12412.75174496487;11448.713782155513;11888.405579720806;11898.107641927063;12035.879641203475;12464.127511074137;11508;11731.530738770354;11756.647300580997;11782.469788859351;12428.316442595744;9266.779554343471;9494.572744226665;9524.428534287965;9589.856152157583;10076.596936122767;9354.345195836226;9661.9033809661;10101.292909496558;10141.138003269805;10162.288639795439 08:16:49 INFO - PROCESS | 1677 | __end_tp_report 08:16:49 INFO - PROCESS | 1677 | __start_cc_report 08:16:49 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1185 08:16:49 INFO - PROCESS | 1677 | __end_cc_report 08:16:49 INFO - PROCESS | 1677 | __startTimestamp1455725809941__endTimestamp 08:16:49 INFO - PROCESS | 1677 | 08:16:49 INFO - PROCESS | 1677 | ------- Summary: start ------- 08:16:49 INFO - PROCESS | 1677 | Number of tests: 6 08:16:49 INFO - PROCESS | 1677 | 08:16:49 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5692.18 Median:5825.65 stddev:615.00 (10.6%) stddev-sans-first:590.28 08:16:49 INFO - PROCESS | 1677 | Values: 3411.1 3466.5 3480.5 3493.8 3546.3 5627.6 5652.5 5664.9 5677.9 5678.7 5598.2 5668.8 5681.2 5682.8 5689.1 5117.9 5142.0 5157.2 5171.0 5224.9 5214.3 5230.5 5232.4 5232.4 5234.1 5185.9 5187.4 5190.2 5211.8 5227.9 5181.1 5229.3 5234.0 5239.6 5294.6 5072.9 5127.3 5168.8 5178.6 5180.3 5544.4 5572.6 5582.0 5635.6 5648.1 5595.4 5701.0 6205.2 6214.2 6234.7 6104.5 6173.3 6252.7 6264.0 6274.3 5674.6 5751.9 5782.0 5783.6 5854.4 5218.2 6246.7 6253.4 6259.5 6262.0 5930.2 6090.1 6134.8 6149.7 6152.4 6160.9 6213.8 6261.8 6272.6 6283.0 6168.0 6205.1 6214.8 6216.1 6219.4 6098.5 6144.6 6151.2 6198.5 6200.9 4833.2 4842.5 4883.2 4911.6 4931.9 4350.4 4365.2 4378.1 4392.2 4418.7 5599.7 5663.7 5673.3 5681.8 5684.3 6078.7 6170.7 6234.1 6259.9 6268.6 5669.1 5669.9 5673.8 5681.5 5694.0 5330.7 5346.9 5349.2 5352.2 5400.6 6162.3 6192.2 6236.3 6237.8 6286.7 6203.8 6220.4 6227.9 6262.6 6266.4 5721.9 6275.5 6275.7 6276.5 6285.6 6011.6 6095.9 6110.2 6191.0 6205.7 6156.4 6190.1 6202.4 6213.0 6221.3 5893.6 5910.8 6026.5 6029.1 6031.4 5063.7 5913.5 6038.5 6073.1 6075.0 5773.3 5802.4 5821.5 5825.7 5826.5 5970.3 6007.8 6032.2 6049.1 6084.5 5921.2 6002.7 6020.3 6025.7 6032.0 08:16:49 INFO - PROCESS | 1677 | 08:16:49 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:63706.44 Median:39263.31 stddev:131956.71 (336.1%) stddev-sans-first:132241.37 08:16:49 INFO - PROCESS | 1677 | Values: 436.3 446.4 488.8 539.9 553.1 29992.0 37352.6 37925.4 38011.2 38171.6 41367.4 41797.8 41903.2 41967.6 42097.0 9588.0 9819.3 9819.3 9821.5 9825.0 9590.1 9719.9 9750.0 9750.5 9771.4 9705.5 9780.5 9796.6 9802.8 9808.3 9693.4 9767.4 9769.3 9918.1 9937.5 9650.6 9796.7 9800.7 9802.0 9804.0 34917.8 40355.0 40558.0 40797.4 40839.8 3111.1 3194.5 3197.3 3316.2 3585.6 29183.7 29592.7 29598.0 29617.4 29697.3 2683.8 2771.2 2803.2 2837.7 2851.8 488686.0 491691.0 492132.0 492861.0 494120.0 56251.4 57383.0 63863.0 64307.7 64313.0 62125.0 67890.7 70058.3 70620.0 70970.6 15947.3 16178.5 16217.7 16218.0 16226.8 11256.3 11448.5 11451.4 11474.7 12356.6 17520.6 20061.0 21023.5 21521.8 21594.6 6340.9 7798.8 7814.8 7824.2 7883.6 887.6 938.6 966.4 998.5 1034.8 29463.9 29485.0 29936.4 30055.0 30224.7 931.3 1038.8 1064.9 1096.8 1177.7 15421.3 15647.9 15697.5 15892.9 16199.5 538784.0 552395.0 552436.0 552492.0 554170.0 49996.0 59039.0 59226.8 59543.4 59708.8 1377.7 1415.4 1417.8 1419.1 1548.0 28280.4 28368.1 28690.7 28739.6 28926.3 47616.3 48018.0 48027.0 48147.0 48183.0 437452.0 440094.0 440157.0 440646.0 441320.0 31150.5 31557.0 31580.2 33053.5 33464.0 40731.0 41732.4 41974.6 42004.0 42381.8 35270.6 35979.6 36384.0 36920.8 37279.0 35941.3 36716.3 36854.3 37821.6 38065.4 36543.5 36767.0 37572.8 37606.0 37664.8 30335.5 31638.8 32439.8 32479.0 32817.0 22208.7 23709.6 24576.6 24867.4 24995.9 08:16:49 INFO - PROCESS | 1677 | 08:16:49 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:33765.98 Median:2121.58 stddev:107269.37 (5056.1%) stddev-sans-first:107540.95 08:16:49 INFO - PROCESS | 1677 | Values: 358.8 363.9 365.1 369.7 372.9 15005.0 15106.4 18966.0 19149.4 19956.7 11460.7 12082.5 12087.6 13281.0 19889.9 5164.3 5339.9 5348.5 5351.2 5369.3 3855.6 4047.2 4055.3 4059.1 4061.8 5559.8 5781.8 5813.8 5821.0 6129.0 6376.9 6378.8 6383.5 6388.5 6395.7 5436.0 5551.0 5562.6 5565.7 5567.2 9557.9 12850.6 12858.5 13242.3 13847.7 2012.6 2047.5 2053.8 2106.2 2244.8 9351.8 9458.0 9792.7 9951.7 13928.7 1738.8 1819.8 1830.2 1844.6 1855.3 88937.0 98212.0 98482.8 100947.5 103720.0 9067.4 9760.6 11337.0 11348.2 11402.5 13443.0 13534.5 13582.9 13607.9 13684.5 8432.2 8478.7 8489.2 8574.4 8577.4 8563.2 8563.7 8586.2 8664.1 8666.4 4079.9 4430.9 4516.5 4533.6 4592.6 1404.7 1760.3 1799.1 1800.6 1809.0 387.6 396.9 828.9 890.0 892.6 11223.5 11456.7 11521.0 11635.4 11682.6 422.6 666.5 768.9 943.1 946.4 10267.8 10458.2 10519.5 10564.1 10614.3 597575.0 599562.0 605890.0 716885.0 717678.0 70437.0 78862.6 103414.0 115364.0 119174.4 1167.7 1193.8 1196.8 1200.6 1217.3 18316.8 18657.4 18666.4 18703.0 18790.6 52501.5 54173.5 55243.0 55987.0 56204.4 71129.6 72176.6 72347.3 72630.6 73357.0 7512.4 7834.6 7845.5 7851.0 7854.1 8891.9 10745.5 11464.1 11713.3 12342.3 8095.5 10605.4 10647.7 10690.4 10807.5 10448.7 10539.7 10586.8 10712.4 10726.9 10608.1 10843.5 11048.0 11122.5 11192.5 7717.8 7901.8 7906.4 7916.9 7942.0 9891.3 10347.3 10819.7 10937.7 11012.7 08:16:49 INFO - PROCESS | 1677 | 08:16:49 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:5976.94 Median:4975.43 stddev:3129.74 (62.9%) stddev-sans-first:3119.60 08:16:49 INFO - PROCESS | 1677 | Values: 1398.6 1522.1 1554.6 1787.4 1924.3 7793.0 8400.4 8654.0 8664.6 8671.9 8365.0 8605.1 8614.9 8647.1 8651.9 2150.2 2210.1 2210.9 2436.1 2467.6 2211.2 2226.2 2231.4 2426.9 2496.4 2394.5 2421.9 2442.9 2444.7 2448.3 2437.9 2449.8 2450.1 2454.1 2457.3 2375.8 2446.0 2446.3 2449.4 2449.5 8538.0 8628.5 8650.4 8673.3 8775.0 4053.8 4751.2 5391.2 5398.0 5417.3 3496.9 3550.8 3642.2 3652.5 3654.4 907.9 996.7 1023.3 1053.0 1067.9 10062.6 11557.5 11766.5 11801.8 11813.6 4772.7 4797.7 4834.3 4848.7 4871.1 10042.4 10043.5 10049.0 10056.1 10067.4 5419.2 5447.5 5451.0 5455.7 5459.5 4914.0 4915.5 4973.9 4977.0 4986.3 3594.7 3828.2 3902.2 3916.9 3954.4 1008.5 1271.2 1271.9 1280.2 1281.9 1310.3 1333.0 1335.1 1355.1 1374.3 7919.4 7951.8 7955.0 7972.7 7980.0 1222.8 1262.1 1267.5 1292.4 1302.1 6056.3 6325.7 6331.8 6333.7 6336.6 10172.5 10387.3 10566.2 10691.0 10719.4 10341.1 10376.1 10466.9 10467.8 10468.4 8091.4 8148.8 8210.0 8216.0 8253.3 7906.0 7944.1 7953.4 7953.5 8037.5 9314.6 9545.9 9554.4 9637.9 9731.8 9052.3 9968.7 10001.7 10078.8 10153.3 7476.4 7609.8 7613.7 7615.6 7622.8 7113.5 7407.4 8075.0 8120.8 8136.3 5615.9 6442.0 7456.4 7532.5 7543.6 6400.2 7448.6 7453.5 7588.3 7602.5 7570.5 7644.1 7647.7 7660.3 7662.8 6796.3 6833.7 6904.6 6999.8 7022.1 7096.0 7137.4 7145.9 7158.3 7159.6 08:16:49 INFO - PROCESS | 1677 | 08:16:49 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5671.77 Median:6423.50 stddev:1790.64 (27.9%) stddev-sans-first:1749.91 08:16:49 INFO - PROCESS | 1677 | Values: 313.0 320.1 325.1 329.1 329.5 6286.7 6437.0 6453.6 6528.2 6588.5 6419.2 6421.9 6436.0 6444.1 6455.2 4008.0 4697.8 4780.4 4815.5 4827.5 4590.5 4825.8 4835.4 4845.2 4849.8 4451.6 4699.2 4752.6 4759.3 4775.1 4744.6 4753.8 4756.6 4763.2 4766.3 4077.4 4077.6 4084.1 4089.3 4091.9 6007.5 6173.9 6268.6 6271.2 6282.1 5713.1 5722.3 5725.5 5725.8 5748.4 5550.5 6936.7 6945.2 6947.3 6966.4 4625.4 4635.0 4647.2 4649.8 4654.9 7118.1 7297.1 7338.0 7406.2 7410.1 4645.2 4715.8 4719.1 4728.7 4729.0 4050.1 4587.6 4611.4 4813.0 4826.0 4865.0 4880.7 5685.6 5740.5 5755.1 7001.2 7009.9 7011.8 7013.5 7020.3 1652.8 1681.7 1683.0 1683.2 1684.6 1071.7 1107.3 1110.1 1120.1 1122.8 6503.5 6510.6 6510.7 6532.2 6577.3 5877.6 7167.8 7207.1 7214.5 7231.7 6265.7 6502.8 6505.6 6507.0 6512.1 3783.8 3819.7 3822.1 3830.1 3833.6 7537.3 7561.4 7566.1 7574.5 7578.0 5917.6 7153.9 7394.2 7418.8 7427.6 7509.2 7521.4 7521.5 7529.1 7535.3 6446.9 6562.8 7147.4 7172.7 7187.1 6773.9 7011.3 7024.2 7053.7 7071.5 7511.8 7518.2 7518.2 7522.4 7525.1 4738.2 4766.1 4769.7 4772.4 4779.5 6875.7 6914.0 7012.7 7129.5 7260.5 6103.8 7007.6 7030.1 7031.2 7035.9 6311.2 6776.9 7005.9 7006.8 7013.4 6066.7 6425.1 6876.7 6880.8 6901.0 5739.6 6981.5 7028.4 7033.9 7042.6 6638.4 6878.0 6881.4 6893.2 6903.4 08:16:49 INFO - PROCESS | 1677 | 08:16:49 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:17736.09 Median:32359.89 stddev:24952.29 (77.1%) stddev-sans-first:24989.40 08:16:49 INFO - PROCESS | 1677 | Values: 673.7 681.2 689.4 711.1 728.1 14907.6 15113.5 15118.5 15126.2 15135.2 13609.1 13652.6 13952.5 13960.5 13976.4 685.7 706.6 861.6 878.1 879.8 765.3 813.2 848.4 870.4 873.9 919.8 922.0 923.3 924.3 925.0 708.6 733.9 891.4 914.3 920.1 676.6 676.8 677.2 677.3 677.8 15149.5 15202.1 15207.5 15228.2 15252.3 12240.3 12241.1 12278.3 12354.7 12643.2 9417.5 9548.1 9560.3 9675.5 9882.0 3483.4 3507.3 3520.2 3537.2 3546.5 64083.7 84132.0 84181.0 85284.0 85449.6 9148.1 9317.7 9329.9 9359.8 9473.1 20540.2 20542.7 20543.0 20547.4 20551.2 7367.6 7444.1 7534.4 7693.6 7874.9 4073.8 4089.1 4097.1 4100.6 4118.6 3444.7 3509.3 3512.2 3512.6 3518.6 627.8 636.1 648.7 660.2 660.8 551.6 607.3 614.6 626.4 626.6 8597.7 8643.4 8736.9 8746.0 8872.2 508.6 545.4 581.5 609.1 613.9 3872.4 4047.3 4124.2 4147.4 4168.4 93404.5 93829.6 95479.6 95729.5 95760.5 72712.6 73532.3 74160.6 75855.0 76702.6 29345.4 53434.0 65473.0 66426.0 66754.7 8099.0 8137.7 8257.7 8400.2 8455.0 31542.8 47941.3 48201.3 48745.3 49099.0 64555.4 65495.0 67989.7 68314.0 68398.7 9895.4 9943.2 10065.6 10121.5 10600.3 11954.3 12367.6 12643.9 12653.9 13039.2 11552.7 11612.4 11664.5 12109.6 12412.8 11448.7 11888.4 11898.1 12035.9 12464.1 11508.0 11731.5 11756.6 11782.5 12428.3 9266.8 9494.6 9524.4 9589.9 10076.6 9354.3 9661.9 10101.3 10141.1 10162.3 08:16:49 INFO - PROCESS | 1677 | -------- Summary: end -------- 08:16:49 INFO - PROCESS | 1677 | 08:16:50 INFO - TEST-INFO | 1677: exit 0 08:16:50 INFO - TEST-OK | dromaeo_css | took 1114412ms 08:16:50 INFO - TEST-START | kraken 08:16:50 INFO - operating with platform_type : mac_ 08:16:50 INFO - Initialising browser for kraken test... 08:16:50 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpDKx3f_/profile http://localhost:49275/getInfo.html) 08:16:52 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 08:16:52 INFO - PROCESS | 1687 | colorDepth:24 08:16:52 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 08:16:52 INFO - PROCESS | 1687 | __metrics 08:16:52 INFO - PROCESS | 1687 | 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:16:52 INFO - PROCESS | 1687 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:53 INFO - TEST-INFO | 1687: exit 0 08:16:53 INFO - Browser initialized. 08:16:53 INFO - Running cycle 1/1 for kraken test... 08:16:53 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpDKx3f_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:05 INFO - PROCESS | 1689 | RSS: Main: 244453376 08:17:05 INFO - PROCESS | 1689 | 08:17:07 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 08:17:08 INFO - PROCESS | 1689 | RSS: Main: 292577280 08:17:08 INFO - PROCESS | 1689 | 08:17:11 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 08:17:11 INFO - PROCESS | 1689 | RSS: Main: 301879296 08:17:11 INFO - PROCESS | 1689 | 08:17:14 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 08:17:15 INFO - PROCESS | 1689 | RSS: Main: 285667328 08:17:15 INFO - PROCESS | 1689 | 08:17:17 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 08:17:18 INFO - PROCESS | 1689 | RSS: Main: 289300480 08:17:18 INFO - PROCESS | 1689 | 08:17:20 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:17:20 INFO - PROCESS | 1689 | RSS: Main: 290041856 08:17:20 INFO - PROCESS | 1689 | 08:17:23 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 08:17:24 INFO - PROCESS | 1689 | RSS: Main: 288956416 08:17:24 INFO - PROCESS | 1689 | 08:17:26 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 08:17:27 INFO - PROCESS | 1689 | RSS: Main: 289615872 08:17:27 INFO - PROCESS | 1689 | 08:17:30 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 08:17:30 INFO - PROCESS | 1689 | RSS: Main: 290156544 08:17:30 INFO - PROCESS | 1689 | 08:17:32 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:17:32 INFO - PROCESS | 1689 | RSS: Main: 325799936 08:17:32 INFO - PROCESS | 1689 | 08:17:34 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:17:35 INFO - PROCESS | 1689 | RSS: Main: 325275648 08:17:35 INFO - PROCESS | 1689 | 08:17:37 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:17:37 INFO - PROCESS | 1689 | RSS: Main: 333660160 08:17:37 INFO - PROCESS | 1689 | 08:17:40 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:17:41 INFO - PROCESS | 1689 | RSS: Main: 334233600 08:17:41 INFO - PROCESS | 1689 | 08:17:43 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:17:44 INFO - PROCESS | 1689 | RSS: Main: 334127104 08:17:44 INFO - PROCESS | 1689 | 08:17:45 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 08:17:46 INFO - PROCESS | 1689 | RSS: Main: 394137600 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | __start_tp_report 08:17:46 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 08:17:46 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 08:17:46 INFO - PROCESS | 1689 | |i|pagename|runs| 08:17:46 INFO - PROCESS | 1689 | |0;ai-astar;109;105;111;109;125;111;113;109;109;109 08:17:46 INFO - PROCESS | 1689 | |1;audio-beat-detection;161;122;149;190;150;141;147;121;159;122 08:17:46 INFO - PROCESS | 1689 | |2;audio-dft;185;183;186;185;182;186;184;184;184;184 08:17:46 INFO - PROCESS | 1689 | |3;audio-fft;74;75;84;77;56;59;61;93;68;56 08:17:46 INFO - PROCESS | 1689 | |4;audio-oscillator;89;103;125;77;80;86;110;77;78;114 08:17:46 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;86;92;87;92;86;92;86;91;86;126 08:17:46 INFO - PROCESS | 1689 | |6;imaging-darkroom;95;94;95;104;143;95;95;94;96;95 08:17:46 INFO - PROCESS | 1689 | |7;imaging-desaturate;85;87;85;88;86;85;85;86;88;88 08:17:46 INFO - PROCESS | 1689 | |8;json-parse-financial;56;52;53;52;53;54;54;64;53;52 08:17:46 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;64;64;71;74;68;66;67;68;66;67 08:17:46 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;82;83;82;82;83;81;81;82;85;82 08:17:46 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;124;130;128;108;118;136;108;128;120;119 08:17:46 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;137;129;138;139;137;125;140;176;135;135 08:17:46 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;66;66;68;66;68;67;67;66;66;67 08:17:46 INFO - PROCESS | 1689 | __end_tp_report 08:17:46 INFO - PROCESS | 1689 | __start_cc_report 08:17:46 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,1164 08:17:46 INFO - PROCESS | 1689 | __end_cc_report 08:17:46 INFO - PROCESS | 1689 | __startTimestamp1455725866169__endTimestamp 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | ------- Summary: start ------- 08:17:46 INFO - PROCESS | 1689 | Number of tests: 14 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:111.00 Median:110.00 stddev:5.33 (4.8%) stddev-sans-first:5.61 08:17:46 INFO - PROCESS | 1689 | Values: 109.0 105.0 111.0 109.0 125.0 111.0 113.0 109.0 109.0 109.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:149.50 stddev:21.49 (14.4%) stddev-sans-first:22.12 08:17:46 INFO - PROCESS | 1689 | Values: 161.0 122.0 149.0 190.0 150.0 141.0 147.0 121.0 159.0 122.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:1.25 (0.7%) stddev-sans-first:1.30 08:17:46 INFO - PROCESS | 1689 | Values: 185.0 183.0 186.0 185.0 182.0 186.0 184.0 184.0 184.0 184.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:70.30 Median:74.50 stddev:12.53 (16.8%) stddev-sans-first:13.21 08:17:46 INFO - PROCESS | 1689 | Values: 74.0 75.0 84.0 77.0 56.0 59.0 61.0 93.0 68.0 56.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:77.50 stddev:17.69 (22.8%) stddev-sans-first:18.68 08:17:46 INFO - PROCESS | 1689 | Values: 89.0 103.0 125.0 77.0 80.0 86.0 110.0 77.0 78.0 114.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:89.00 stddev:12.13 (13.6%) stddev-sans-first:12.64 08:17:46 INFO - PROCESS | 1689 | Values: 86.0 92.0 87.0 92.0 86.0 92.0 86.0 91.0 86.0 126.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:100.60 Median:95.00 stddev:15.18 (16.0%) stddev-sans-first:15.97 08:17:46 INFO - PROCESS | 1689 | Values: 95.0 94.0 95.0 104.0 143.0 95.0 95.0 94.0 96.0 95.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.50 stddev:1.34 (1.5%) stddev-sans-first:1.33 08:17:46 INFO - PROCESS | 1689 | Values: 85.0 87.0 85.0 88.0 86.0 85.0 85.0 86.0 88.0 88.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:3.62 (6.8%) stddev-sans-first:3.79 08:17:46 INFO - PROCESS | 1689 | Values: 56.0 52.0 53.0 52.0 53.0 54.0 54.0 64.0 53.0 52.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:3.06 (4.5%) stddev-sans-first:2.98 08:17:46 INFO - PROCESS | 1689 | Values: 64.0 64.0 71.0 74.0 68.0 66.0 67.0 68.0 66.0 67.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:1.16 (1.4%) stddev-sans-first:1.22 08:17:46 INFO - PROCESS | 1689 | Values: 82.0 83.0 82.0 82.0 83.0 81.0 81.0 82.0 85.0 82.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:126.00 stddev:9.17 (7.3%) stddev-sans-first:9.70 08:17:46 INFO - PROCESS | 1689 | Values: 124.0 130.0 128.0 108.0 118.0 136.0 108.0 128.0 120.0 119.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.10 Median:137.50 stddev:13.77 (10.0%) stddev-sans-first:14.59 08:17:46 INFO - PROCESS | 1689 | Values: 137.0 129.0 138.0 139.0 137.0 125.0 140.0 176.0 135.0 135.0 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 08:17:46 INFO - PROCESS | 1689 | Values: 66.0 66.0 68.0 66.0 68.0 67.0 67.0 66.0 66.0 67.0 08:17:46 INFO - PROCESS | 1689 | -------- Summary: end -------- 08:17:46 INFO - PROCESS | 1689 | 08:17:46 INFO - TEST-INFO | 1689: exit 0 08:17:46 INFO - TEST-OK | kraken | took 56408ms 08:17:46 INFO - SUITE-END | took 1170s 08:17:47 INFO - Completed test suite (00:19:31) 08:17:47 INFO - Working with test: dromaeo_css 08:17:47 INFO - Generating results file: dromaeo_css 08:17:47 INFO - Working with test: kraken 08:17:47 INFO - Generating results file: kraken 08:17:47 INFO - javascript benchmark 08:17:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:17:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 08:17:47 INFO - process_Request line: dromaeo_css 7369.09 graph.html#tests=[[72,64,59]] 08:17:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:17:47 INFO - process_Request line: kraken 1416.80 graph.html#tests=[[232,64,59]] 08:17:47 INFO - RETURN: dromaeo_css: 7369.09 08:17:47 INFO - RETURN: kraken: 1416.80 08:17:47 INFO - javascript benchmark 08:17:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3411.09605954422, 3466.532018177545, 3480.4605286180645, 3493.807840568771, 3546.2730140321237, 5627.6060675752715, 5652.4630160134775, 5664.886702265957, 5677.943220567793, 5678.744456499452, 5598.216249725042, 5668.801591944282, 5681.204631351604, 5682.801101961432, 5689.118186681061, 5117.923231151536, 5142.0487209866105, 5157.174852023677, 5170.974145129269, 5224.895502089956, 5214.348206474191, 5230.450802665703, 5232.372115346145, 5232.398274198478, 5234.136367499377, 5185.948140518584, 5187.351581052369, 5190.169572868342, 5211.791528338881, 5227.869303267411, 5181.145111056671, 5229.294045303911, 5234.031704134747, 5239.580833533309, 5294.57643388528, 5072.873178170538, 5127.333446651949, 5168.767405466763, 5178.637495375326, 5180.300659410969, 5544.390117087117, 5572.637778544382, 5582.0, 5635.6055076144685, 5648.124540696158, 5595.38450770415, 5701.0, 6205.22434695663, 6214.161088253073, 6234.688265586702, 6104.4505994460715, 6173.2900716417735, 6252.749890004395, 6264.029075493306, 6274.309825919146, 5674.602777805555, 5751.8562035949435, 5781.971090144522, 5783.595148339576, 5854.356020837747, 5218.217267409843, 6246.656433896089, 6253.437190652772, 6259.530535209878, 6261.998080307129, 5930.169776231331, 6090.116933044772, 6134.8159555213415, 6149.723262453201, 6152.446279834747, 6160.9383906161265, 6213.782517611862, 6261.78083767066, 6272.5922815016875, 6282.968585157045, 6167.969160154171, 6205.069239614094, 6214.751409943642, 6216.098665693449, 6219.440250377397, 6098.481629061579, 6144.648177400964, 6151.169592105098, 6198.504119670415, 6200.906986395207, 4833.178359678863, 4842.491538388489, 4883.194272944925, 4911.631627627942, 4931.90136197274, 4350.369196466495, 4365.192439398721, 4378.146261478981, 4392.2094023075515, 4418.734875907456, 5599.720013999284, 5663.745131469093, 5673.319201695823, 5681.801136960186, 5684.34630017545, 6078.665673387918, 6170.660613666291, 6234.064890266496, 6259.874802503924, 6268.592541484789, 5669.121286200563, 5669.858253543694, 5673.8297851064535, 5681.545476361881, 5694.003549378925, 5330.680159190461, 5346.866328341823, 5349.170878513759, 5352.223927530486, 5400.567954563626, 6162.26052873649, 6192.195014648067, 6236.251649802053, 6237.752940534455, 6286.654234017173, 6203.7828675996125, 6220.440160385587, 6227.906581401192, 6262.624242545462, 6266.373362663697, 5721.914171287517, 6275.52933529978, 6275.654838983717, 6276.466500347339, 6285.5600107992, 6011.609245399035, 6095.922000763747, 6110.16388879229, 6191.0, 6205.6586887721605, 6156.384361563808, 6190.133381326708, 6202.379762023762, 6212.968935155295, 6221.346758590464, 5893.616914900518, 5910.7931222407005, 6026.548008899438, 6029.125776762257, 6031.396860314109, 5063.670861393997, 5913.46778789911, 6038.486728628116, 6073.149759033827, 6074.967255566653, 5773.336066352255, 5802.390748971297, 5821.476067153807, 5825.650460972186, 5826.504747096545, 5970.343262241063, 6007.849803754941, 6032.155498230339, 6049.092636104443, 6084.482818960438, 5921.200637913998, 6002.7298771554515, 6020.337762846171, 6025.66858822769, 6032.034874420072], "unit": "score", "name": "dojo.html", "value": 5655.004258712237}, {"lowerIsBetter": false, "replicates": [436.2518281147831, 446.415196093118, 488.8313531831519, 539.8731298144937, 553.1371061144615, 29992.0, 37352.626473735254, 37925.43111853324, 38011.23977520455, 38171.61828381715, 41367.379489307685, 41797.7910110449, 41903.161936761244, 41967.58032419675, 42097.0, 9588.041195880425, 9819.312648114636, 9819.312648114636, 9821.459819709913, 9825.0, 9590.088941550577, 9719.854202186938, 9749.95125024374, 9750.46372449515, 9771.36486128403, 9705.466199359033, 9780.510974451285, 9796.608135674565, 9802.803943921117, 9808.31341806074, 9693.418394896293, 9767.413955162641, 9769.267304952156, 9918.107370336633, 9937.453440060794, 9650.613975440974, 9796.657117000943, 9800.65697700577, 9802.0, 9803.950980245125, 34917.82541087304, 40355.0, 40558.0, 40797.38803917944, 40839.7958010208, 3111.1288839124854, 3194.4569423198113, 3197.344544368399, 3316.1875340541483, 3585.587657419404, 29183.708162918312, 29592.70407295921, 29598.0, 29617.407651846843, 29697.25756856096, 2683.758461738433, 2771.2240572639694, 2803.2291119941974, 2837.704192944003, 2851.7861160413054, 488686.0, 491690.99999999645, 492132.0, 492861.0, 494120.0, 56251.437485625436, 57383.0, 63863.04205436922, 64307.67846160739, 64313.0, 62125.0, 67890.66054669695, 70058.29941700518, 70620.0, 70970.64514677497, 15947.282372293042, 16178.514644560682, 16217.675646487005, 16218.026918384934, 16226.837731622769, 11256.268342557707, 11448.542058317575, 11451.427428628702, 11474.655760327203, 12356.567520136752, 17520.561985950455, 20061.0, 21023.488255872064, 21521.78478215198, 21594.56810863774, 6340.904886426707, 7798.8050298741855, 7814.843703125905, 7824.217578242244, 7883.649448984159, 887.5961437545901, 938.6151677812064, 966.4201479112477, 998.5456617239139, 1034.8240799064176, 29463.852680736458, 29485.0, 29936.40127197444, 30055.0, 30224.69775302219, 931.3154831199063, 1038.8416915139564, 1064.8615679961556, 1096.8080585897435, 1177.7055736065984, 15421.306041228172, 15647.921760391126, 15697.450589229551, 15892.920535397248, 16199.514014579581, 538784.0, 552395.0, 552436.0, 552492.0, 554170.0, 49996.0, 59039.0, 59226.81546369049, 59543.40456595379, 59708.80582388415, 1377.7313423882447, 1415.4409008441608, 1417.8298604167153, 1419.09887221615, 1547.9783342993571, 28280.434391311646, 28368.148955531367, 28690.713092868806, 28739.568906466, 28926.276843079093, 47616.285755713, 48018.0, 48027.0, 48147.0, 48183.0, 437452.0, 440094.0, 440157.0, 440646.0, 441320.0, 31150.53274200934, 31557.0, 31580.210494736897, 33053.50419743754, 33463.996080117635, 40731.0, 41732.3740143892, 41974.58025419707, 42004.0, 42381.788091059345, 35270.64729352674, 35979.64020359763, 36384.0, 36920.81539592285, 37279.0, 35941.28117437689, 36716.26567468582, 36854.26291474209, 37821.62178378181, 38065.42901856419, 36543.45184822177, 36767.0, 37572.812135940236, 37606.0, 37664.81167594145, 30335.502104690484, 31638.841805790824, 32439.837800810845, 32479.0, 32817.0, 22208.66686999664, 23709.644355334338, 24576.6313505294, 24867.378315541533, 24995.875185617053], "unit": "score", "name": "ext.html", "value": 19525.997945881176}, {"lowerIsBetter": false, "replicates": [358.7614236532706, 363.9308531379038, 365.05268827392905, 369.68761396619846, 372.9160938788771, 15005.0, 15106.39574417022, 18965.99999999998, 19149.42551723449, 19956.700649490253, 11460.656180314603, 12082.456289466973, 12087.57693480726, 13281.0, 19889.900550497227, 5164.251183578379, 5339.946600534003, 5348.545373643245, 5351.197320401951, 5369.30866776964, 3855.55661098973, 4047.1905618876194, 4055.3308704063793, 4059.127287633158, 4061.8375264989363, 5559.833205003856, 5781.797637082703, 5813.796517121901, 5821.039528477796, 6128.969355153218, 6376.872462550769, 6378.77674281398, 6383.457406120486, 6388.520860935449, 6395.712192951329, 5436.0, 5551.028570000234, 5562.554995600382, 5565.721713914288, 5567.248421463091, 9557.90442095577, 12850.55023074188, 12858.485660573566, 13242.271675057867, 13847.653808654764, 2012.5572374077678, 2047.4778931372405, 2053.8254248388903, 2106.199644135234, 2244.753077161511, 9351.812963740755, 9457.952710236405, 9792.706218813448, 9951.651692190811, 13928.651783705387, 1738.8174241704564, 1819.8362147406797, 1830.1855674224976, 1844.6034102667857, 1855.3413538194018, 88937.0, 98212.017879821, 98482.82619236899, 100947.48578771325, 103720.0, 9067.365284430158, 9760.560774765152, 11337.036351910016, 11348.205625606293, 11402.543898243977, 13442.990951259915, 13534.458621655023, 13582.864171358358, 13607.931960340135, 13684.52104176349, 8432.241098301183, 8478.660853565789, 8489.193526614961, 8574.442661227, 8577.356698247657, 8563.229309362187, 8563.657453701906, 8586.184312490303, 8664.09027052163, 8666.350023748244, 4079.89800254996, 4430.867073987785, 4516.503184649686, 4533.591976722111, 4592.632589392841, 1404.676924307415, 1760.3398725477946, 1799.091458813317, 1800.612868233336, 1808.9598480873287, 387.5968992248087, 396.8789519196615, 828.9088200297963, 890.0076414797584, 892.5537231384308, 11223.494942727597, 11456.656300311004, 11521.0207132393, 11635.41822908868, 11682.649520514398, 422.62435771563366, 666.5034549260831, 768.8961990131261, 943.1228957069991, 946.3990366117565, 10267.845982310271, 10458.215633827493, 10519.52662130206, 10564.094873909737, 10614.310069845435, 597575.0, 599562.0, 605890.0, 716885.0, 717678.0, 70437.0, 78862.6056869712, 103413.96586034044, 115364.0, 119174.40412798054, 1167.73142177298, 1193.8388317577017, 1196.7965445874222, 1200.6398080575966, 1217.2635555488978, 18316.81683183151, 18657.440276791716, 18666.440006799818, 18703.0, 18790.624187516445, 52501.47498524966, 54173.45826541842, 55243.0, 55987.0, 56204.43795561992, 71129.64435177791, 72176.55646887138, 72347.27652723405, 72630.63684681543, 73357.0, 7512.361449276654, 7834.608269586384, 7845.529268243924, 7851.0, 7854.096778870503, 8891.91108088911, 10745.516451759533, 11464.082873369944, 11713.297202167898, 12342.259464431803, 8095.514269143635, 10605.363678179334, 10647.680569582924, 10690.358578485315, 10807.459627018774, 10448.68653940383, 10539.683809485728, 10586.841197381891, 10712.4155300101, 10726.873678263983, 10608.098311643596, 10843.512041957973, 11048.0, 11122.499487522919, 11192.496337664987, 7717.845643086995, 7901.762947111596, 7906.446548741533, 7916.881246781188, 7941.960290198512, 9891.307608467338, 10347.327423717434, 10819.729506762395, 10937.671869843918, 11012.724681883017], "unit": "score", "name": "jquery.html", "value": 8603.160414964459}, {"lowerIsBetter": false, "replicates": [1398.6433459467835, 1522.0715363628187, 1554.5647218778745, 1787.401220591102, 1924.2976313645524, 7793.0, 8400.41197116202, 8654.048054713976, 8664.566771661423, 8671.86992195116, 8364.958175209116, 8605.053444121142, 8614.870776938335, 8647.092055334193, 8651.913480865189, 2150.161437039556, 2210.104907512452, 2210.8784016879067, 2436.1229957215432, 2467.5805113130723, 2211.159759291467, 2226.209695558078, 2231.419830843984, 2426.8665223412704, 2496.425822060918, 2394.4851856850773, 2421.927342179729, 2442.8656423896678, 2444.7433019532873, 2448.289995901195, 2437.926862194137, 2449.7795198432136, 2450.0812195426715, 2454.104251948044, 2457.2628211536467, 2375.8099352051795, 2445.9510809783706, 2446.3150317910836, 2449.3876530867283, 2449.461118553915, 8537.975442946825, 8628.482291062493, 8650.394472386935, 8673.349498787617, 8774.956125219333, 4053.7973101344814, 4751.168545504557, 5391.191321301797, 5398.0, 5417.295751552312, 3496.930061398758, 3550.804705741183, 3642.162302670374, 3652.470391793175, 3654.397024490956, 907.9105073911333, 996.6960077176458, 1023.2990401574945, 1053.0469924718143, 1067.8665166854144, 10062.64780732678, 11557.537698492135, 11766.529338826436, 11801.822972655416, 11813.586524471602, 4772.70015511275, 4797.688150270221, 4834.347363106006, 4848.7090774553635, 4871.123197824426, 10042.447665378475, 10043.548040338203, 10049.0, 10056.145227655585, 10067.446290454096, 5419.187121931742, 5447.482489163603, 5451.0, 5455.672659640434, 5459.481349271813, 4914.0171965606305, 4915.531443843842, 4973.850784476472, 4977.0, 4986.326845875833, 3594.7483676142942, 3828.157805282833, 3902.2195560887367, 3916.921661566753, 3954.406838974177, 1008.4907121903392, 1271.205496564647, 1271.8855303022588, 1280.1678908709414, 1281.9423125959354, 1310.331730817271, 1333.041087155779, 1335.0854664554618, 1355.0853174107438, 1374.2853716067789, 7919.406044546682, 7951.761447156595, 7954.960225198837, 7972.720954766555, 7980.002499687539, 1222.7798996180595, 1262.1417436143327, 1267.461328935199, 1292.3990344489669, 1302.0820321673198, 6056.291374357903, 6325.652089135142, 6331.778387756406, 6333.746650133943, 6336.619802811846, 10172.542235599416, 10387.324823886574, 10566.154707623371, 10691.0, 10719.356838589709, 10341.069303762548, 10376.118029967387, 10466.895331046744, 10467.790644187226, 10468.424236667057, 8091.39314551411, 8148.755537333889, 8210.0, 8216.0, 8253.298469630028, 7905.960470197842, 7944.126146123806, 7953.443258972048, 7953.483023603448, 8037.517748935083, 9314.627414903329, 9545.856812147684, 9554.394621969746, 9637.9036209637, 9731.756706082404, 9052.321075919464, 9968.700938971842, 10001.699949001542, 10078.79842403133, 10153.340032897839, 7476.364509016795, 7609.847803043797, 7613.695452181851, 7615.581143037186, 7622.771316860503, 7113.53762005468, 7407.407407407287, 8075.030996280484, 8120.83758324842, 8136.349092072502, 5615.915761263503, 6442.033694945796, 7456.440766942393, 7532.510386824839, 7543.622818858926, 6400.199975003125, 7448.590327532038, 7453.515521491086, 7588.27911348421, 7602.46782725204, 7570.507916985378, 7644.12092609357, 7647.732329368446, 7660.310572048543, 7662.770116896502, 6796.2524122347495, 6833.692483838338, 6904.551204171713, 6999.790006299819, 7022.12223472066, 7096.0, 7137.357637812622, 7145.857082858418, 7158.2841715828, 7159.64201789898], "unit": "score", "name": "mootools.html", "value": 4888.54219148562}, {"lowerIsBetter": false, "replicates": [312.97965632233905, 320.0606220742122, 325.05247204399177, 329.1146815067468, 329.4711987260445, 6286.748530058792, 6436.967815160923, 6453.645049522269, 6528.151340325757, 6588.538802283842, 6419.197600299963, 6421.903671444932, 6436.0, 6444.130042444269, 6455.193100862392, 4008.038070863001, 4697.812087516495, 4780.378550788392, 4815.542523460265, 4827.493113223114, 4590.517995610463, 4825.831095911643, 4835.371401717772, 4845.248986407112, 4849.830255941043, 4451.62161216297, 4699.201135806921, 4752.59602933751, 4759.262314341283, 4775.092732380854, 4744.57298843104, 4753.809847606091, 4756.595689366408, 4763.237881938908, 4766.285057241442, 4077.3883917412627, 4077.5922407758985, 4084.14233011068, 4089.26393249215, 4091.9181616367805, 6007.549433792483, 6173.857836300299, 6268.623882567015, 6271.184745983039, 6282.089097080898, 5713.14302854571, 5722.313322401297, 5725.5419566435, 5725.770969161229, 5748.367679555246, 5550.500454959073, 6936.653167341663, 6945.166580010431, 6947.305269473063, 6966.3730264275955, 4625.375574297461, 4634.976825115853, 4647.163510568096, 4649.767511624439, 4654.906901861944, 7118.110236220473, 7297.087864016998, 7337.963310183468, 7406.222346653578, 7410.147832999166, 4645.233536466513, 4715.7877895494785, 4719.1033703596895, 4728.692634978715, 4729.030548737501, 4050.10897602527, 4587.564181402761, 4611.423572053493, 4812.951870481321, 4825.9758701206265, 4865.0, 4880.682755620874, 5685.573581981368, 5740.450078478787, 5755.1367294906095, 7001.159860816734, 7009.929900700928, 7011.824704382431, 7013.544119632207, 7020.262872398427, 1652.7603497492796, 1681.747737839334, 1683.0070258547516, 1683.1752441303918, 1684.62938153606, 1071.737424331044, 1107.3134656513014, 1110.1230028277732, 1120.081533142815, 1122.820348744197, 6503.544751867418, 6510.576812507266, 6510.73957041713, 6532.183477065367, 6577.309382514863, 5877.5591830612875, 7167.820804479826, 7207.099112610924, 7214.458915581353, 7231.7107315707835, 6265.686715664198, 6502.804915852532, 6505.577137486048, 6507.0, 6512.120863683437, 3783.810809459571, 3819.7135214858995, 3822.10180607557, 3830.0999265172663, 3833.616638336144, 7537.283958023979, 7561.357284630758, 7566.1298950620285, 7574.469787114959, 7577.962110189524, 5917.615355001911, 7153.856922861513, 7394.186639469654, 7418.814529636695, 7427.62861856905, 7509.249075092556, 7521.360684341892, 7521.548707077593, 7529.134149572759, 7535.284148005931, 6446.871062578816, 6562.785884611362, 7147.428205743632, 7172.748953786801, 7187.137543494814, 6773.89839152423, 7011.298870113152, 7024.192217894803, 7053.682584283617, 7071.504994650325, 7511.812204694927, 7518.173000969779, 7518.210587888412, 7522.3605993491165, 7525.134609519975, 4738.218193998089, 4766.094442055998, 4769.73766442849, 4772.379590653193, 4779.4742578317055, 6875.690593923386, 6914.0, 7012.719491220294, 7129.536580122275, 7260.528065675925, 6103.809757097323, 7007.6145811978795, 7030.086088808423, 7031.191412987572, 7035.894461582978, 6311.179546658905, 6776.86446271062, 7005.929940700527, 7006.843870761268, 7013.403860671696, 6066.7269972850445, 6425.10048593188, 6876.724931002704, 6880.793576192722, 6901.0, 5739.62692424991, 6981.5112942093565, 7028.367446929801, 7033.859322813412, 7042.647867606497, 6638.435732962752, 6878.037074809631, 6881.41507971828, 6893.20728116253, 6903.378695917391], "unit": "score", "name": "prototype.html", "value": 5080.263770984718}, {"lowerIsBetter": false, "replicates": [673.6699017481434, 681.1757773094555, 689.383002213019, 711.1146622455044, 728.0971595221924, 14907.627309317259, 15113.546593602183, 15118.546443606681, 15126.243687815606, 15135.24323783809, 13609.115407498506, 13652.590422287323, 13952.511662091829, 13960.51138210163, 13976.371063302151, 685.7462738786656, 706.6431452116674, 861.6036623153341, 878.1087196495562, 879.8328317619664, 765.3188662090744, 813.2477458351032, 848.4273115646913, 870.4255191573562, 873.9169778870997, 919.8482250428672, 921.9907800922006, 923.2660035271941, 924.2513564013137, 924.9861252081224, 708.5783958544657, 733.8568979049088, 891.3804905590617, 914.3142643017703, 920.1396694091046, 676.6379986707088, 676.8307923019245, 677.2178134254943, 677.3192941094218, 677.7560078371831, 15149.545513634499, 15202.087874727442, 15207.543773686808, 15228.238588070662, 15252.313645885963, 12240.326782026985, 12241.081918856033, 12278.324692141929, 12354.691132721753, 12643.241405515606, 9417.529123543864, 9548.140667339903, 9560.28297877655, 9675.516224188763, 9882.0, 3483.407820670492, 3507.3052271189067, 3520.2431477232517, 3537.2041290709385, 3546.4503002034726, 64083.67958160179, 84132.0, 84181.0, 85284.0, 85449.57275213646, 9148.130927561871, 9317.673881414117, 9329.860052099224, 9359.812803743887, 9473.100055494717, 20540.17839286412, 20542.69185962212, 20543.04841040099, 20547.38357849267, 20551.177952882015, 7367.594782286918, 7444.069491313586, 7534.3595794357, 7693.576853273012, 7874.8818767717385, 4073.837046518106, 4089.079957009649, 4097.09863829957, 4100.630943215125, 4118.608732170439, 3444.7071998880374, 3509.263054758478, 3512.2448673535314, 3512.631173726773, 3518.6481351865123, 627.7740013595102, 636.1062706896724, 648.7080813633884, 660.181375094879, 660.8447014951482, 551.6441894977717, 607.2743072028883, 614.5882258886556, 626.4299487466475, 626.589583822597, 8597.742067737978, 8643.394962352575, 8736.91263087361, 8746.0, 8872.157145071207, 508.61091265182165, 545.4055079962859, 581.4766709961069, 609.0894113300644, 613.8588124731336, 3872.3997780344093, 4047.3119569673227, 4124.154548317588, 4147.440095587118, 4168.353905144708, 93404.53297733467, 93829.59255611035, 95479.56780648296, 95729.5213523928, 95760.52119739357, 72712.63643681853, 73532.26467735361, 74160.62919685474, 75855.0, 76702.6164869172, 29345.413091738472, 53434.0, 65473.0, 66426.0, 66754.66622666856, 8099.0, 8137.674493020213, 8257.669693212205, 8400.159984001551, 8455.02767181782, 31542.842285788425, 47941.32205372795, 48201.27698084462, 48745.268820967, 49099.0, 64555.35444645681, 65495.017574735466, 67989.66005169942, 68314.0, 68398.65800670965, 9895.406275623485, 9943.204543636348, 10065.647702330676, 10121.493925303852, 10600.310979786289, 11954.342511161969, 12367.62897113088, 12643.936780316408, 12653.936730316289, 13039.152455090389, 11552.6534203974, 11612.419379031184, 11664.533418663159, 12109.576164834189, 12412.75174496487, 11448.713782155513, 11888.405579720806, 11898.107641927063, 12035.879641203475, 12464.127511074137, 11508.0, 11731.530738770354, 11756.647300580997, 11782.469788859351, 12428.316442595744, 9266.779554343471, 9494.572744226665, 9524.428534287965, 9589.856152157583, 10076.596936122767, 9354.345195836226, 9661.9033809661, 10101.292909496558, 10141.138003269805, 10162.288639795439], "unit": "score", "name": "yui.html", "value": 6787.009229615077}], "name": "dromaeo_css", "value": 7369.08808078886}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 105.0, 111.0, 109.0, 125.0, 111.0, 113.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [161.0, 122.0, 149.0, 190.0, 150.0, 141.0, 147.0, 121.0, 159.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [185.0, 183.0, 186.0, 185.0, 182.0, 186.0, 184.0, 184.0, 184.0, 184.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 84.0, 77.0, 56.0, 59.0, 61.0, 93.0, 68.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.3}, {"lowerIsBetter": true, "replicates": [89.0, 103.0, 125.0, 77.0, 80.0, 86.0, 110.0, 77.0, 78.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 93.9}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 87.0, 92.0, 86.0, 92.0, 86.0, 91.0, 86.0, 126.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 104.0, 143.0, 95.0, 95.0, 94.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 100.6}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 88.0, 86.0, 85.0, 85.0, 86.0, 88.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 86.3}, {"lowerIsBetter": true, "replicates": [56.0, 52.0, 53.0, 52.0, 53.0, 54.0, 54.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 71.0, 74.0, 68.0, 66.0, 67.0, 68.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 82.0, 82.0, 83.0, 81.0, 81.0, 82.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [124.0, 130.0, 128.0, 108.0, 118.0, 136.0, 108.0, 128.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [137.0, 129.0, 138.0, 139.0, 137.0, 125.0, 140.0, 176.0, 135.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 66.0, 68.0, 67.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1416.8}]} 08:17:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1416.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7369.09"}}} 08:17:48 INFO - Return code: 0 08:17:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:17:48 INFO - # TBPL SUCCESS # 08:17:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:17:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:17:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:17:48 INFO - 2016-02-17 08:17:48.078 screenresolution[1693:9676] starting screenresolution argv=screenresolution get 08:17:48 INFO - 2016-02-17 08:17:48.081 screenresolution[1693:9676] Display 0: 1600x1200x32@60 08:17:48 INFO - 2016-02-17 08:17:48.086 screenresolution[1694:9679] starting screenresolution argv=screenresolution list 08:17:48 INFO - Available Modes on Display 0 08:17:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:17:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:17:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:17:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:17:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:17:48 INFO - Intel Iris: 08:17:48 INFO - Chipset Model: Intel Iris 08:17:48 INFO - Type: GPU 08:17:48 INFO - Bus: Built-In 08:17:48 INFO - VRAM (Dynamic, Max): 1536 MB 08:17:48 INFO - Vendor: Intel (0x8086) 08:17:48 INFO - Device ID: 0x0a2e 08:17:48 INFO - Revision ID: 0x0009 08:17:48 INFO - Displays: 08:17:48 INFO - Display: 08:17:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:17:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:17:48 INFO - Display Serial Number: 1600x1200 60 08:17:48 INFO - Main Display: Yes 08:17:48 INFO - Mirror: Off 08:17:48 INFO - Online: Yes 08:17:48 INFO - Rotation: Supported 08:17:48 INFO - Return code: 0 08:17:48 INFO - Running post-action listener: _resource_record_post_action 08:17:48 INFO - Running post-run listener: _resource_record_post_run 08:17:49 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39409152; Write bytes: 708320256; Read time: 422; Write time: 1872 08:17:49 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395377152; Write bytes: 389138432; Read time: 29828; Write time: 678 08:17:49 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37594624; Write bytes: 301327360; Read time: 402; Write time: 1151 08:17:49 INFO - Running post-run listener: _upload_blobber_files 08:17:49 INFO - Blob upload gear active. 08:17:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:17:49 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 08:17:49 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'] 08:17:49 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 08:17:49 INFO - (blobuploader) - INFO - Open directory for files ... 08:17:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:17:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:51 INFO - (blobuploader) - INFO - Done attempting. 08:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:17:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:52 INFO - (blobuploader) - INFO - Done attempting. 08:17:52 INFO - (blobuploader) - INFO - Iteration through files over. 08:17:52 INFO - Return code: 0 08:17:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:17:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:17:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1eb2623a32b2e0c9870a5cb5a1c0dd76cdeaca95fe27c6e61c49003ba47f2908de36bbc5137f58b411d7ade43d10e280744c326d83b3da01fd65287154fb0aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d71af41b862ffd46afb4f8200bf67a068a4be5d331f10708967260b6f4f6eaecdf645b3adf8b07f07549ed05d23cb28e915d95f636ecfbec3c28e56ff259fda2"} 08:17:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:17:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:17:52 INFO - Contents: 08:17:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1eb2623a32b2e0c9870a5cb5a1c0dd76cdeaca95fe27c6e61c49003ba47f2908de36bbc5137f58b411d7ade43d10e280744c326d83b3da01fd65287154fb0aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d71af41b862ffd46afb4f8200bf67a068a4be5d331f10708967260b6f4f6eaecdf645b3adf8b07f07549ed05d23cb28e915d95f636ecfbec3c28e56ff259fda2"} 08:17:52 INFO - Running post-run listener: copy_logs_to_upload_dir 08:17:52 INFO - Copying logs to upload dir... 08:17:52 INFO - mkdir: /builds/slave/test/build/upload/logs 08:17:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.174828 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-17 08:17:52.214660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 08:17:52.217326) ========= 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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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/1eb2623a32b2e0c9870a5cb5a1c0dd76cdeaca95fe27c6e61c49003ba47f2908de36bbc5137f58b411d7ade43d10e280744c326d83b3da01fd65287154fb0aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d71af41b862ffd46afb4f8200bf67a068a4be5d331f10708967260b6f4f6eaecdf645b3adf8b07f07549ed05d23cb28e915d95f636ecfbec3c28e56ff259fda2"} build_url:https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011031 build_url: 'https://queue.taskcluster.net/v1/task/aZD7DIRJQ1O_tahq3nLVrg/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/1eb2623a32b2e0c9870a5cb5a1c0dd76cdeaca95fe27c6e61c49003ba47f2908de36bbc5137f58b411d7ade43d10e280744c326d83b3da01fd65287154fb0aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d71af41b862ffd46afb4f8200bf67a068a4be5d331f10708967260b6f4f6eaecdf645b3adf8b07f07549ed05d23cb28e915d95f636ecfbec3c28e56ff259fda2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 08:17:52.250134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 08:17:52.250459) ========= 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.1o5EvmIpNi/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.Fh5hyzhkJs/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005008 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 08:17:52.302977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 08:17:52.303319) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 08:17:52.303766) ========= ========= Total master_lag: 0.29 =========