builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0159 starttime: 1458233708.82 results: success (0) buildid: 20160317080522 builduid: f04e63de2cd942819cd8294830360cea revision: 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.825770) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.839211) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.839593) ========= 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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005436 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.872020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.872329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.890015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.890276) ========= 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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005775 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.938283) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.938545) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.938873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:08.939150) ========= 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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-03-17 09:55:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.6M=0.001s 2016-03-17 09:55:09 (12.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106940 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:09.059822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:09.060153) ========= 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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.024505 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:09.108519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 09:55:09.109787) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ey3SI7BBl/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.CKSUBhzb2e/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-03-17 09:55:09,182 truncating revision to first 12 chars 2016-03-17 09:55:09,182 Setting DEBUG logging. 2016-03-17 09:55:09,182 attempt 1/10 2016-03-17 09:55:09,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e04659fdf6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 09:55:10,357 unpacking tar archive at: mozilla-central-3e04659fdf6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.416697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 09:55:10.542718) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:10.543081) ========= echo 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3e04659fdf6aef792f7cf9840189c6c38d08d1e8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ey3SI7BBl/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.CKSUBhzb2e/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 program finished with exit code 0 elapsedTime=0.005416 script_repo_revision: '3e04659fdf6aef792f7cf9840189c6c38d08d1e8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:10.595332) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:10.595685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 09:55:10.607313) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-17 09:55:10.607591) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ey3SI7BBl/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.CKSUBhzb2e/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:10 INFO - MultiFileLogger online at 20160317 09:55:10 in /builds/slave/test 09:55:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:55:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:55:10 INFO - {'append_to_log': False, 09:55:10 INFO - 'base_work_dir': '/builds/slave/test', 09:55:10 INFO - 'blob_upload_branch': 'Firefox', 09:55:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:55:10 INFO - 'branch': 'Firefox', 09:55:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:55:10 INFO - 'config_files': ('talos/mac_config.py',), 09:55:10 INFO - 'default_actions': ('clobber', 09:55:10 INFO - 'read-buildbot-config', 09:55:10 INFO - 'download-and-extract', 09:55:10 INFO - 'populate-webroot', 09:55:10 INFO - 'create-virtualenv', 09:55:10 INFO - 'install', 09:55:10 INFO - 'run-tests'), 09:55:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:55:10 INFO - 'download_minidump_stackwalk': True, 09:55:10 INFO - 'download_symbols': 'ondemand', 09:55:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:55:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:55:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:55:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:55:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:55:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:55:10 INFO - 'installer_path': 'installer.exe', 09:55:10 INFO - 'log_level': 'info', 09:55:10 INFO - 'log_name': 'talos', 09:55:10 INFO - 'log_to_console': True, 09:55:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:55:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:55:10 INFO - 'opt_config_files': (), 09:55:10 INFO - 'pip_index': False, 09:55:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:10 INFO - 'cmd': ('bash', 09:55:10 INFO - '-c', 09:55:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:10 INFO - 'enabled': True, 09:55:10 INFO - 'halt_on_failure': False, 09:55:10 INFO - 'name': 'check_screen_resolution'},), 09:55:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:10 INFO - 'cmd': ('bash', 09:55:10 INFO - '-c', 09:55:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:10 INFO - 'enabled': True, 09:55:10 INFO - 'halt_on_failure': False, 09:55:10 INFO - 'name': 'check_screen_resolution'},), 09:55:10 INFO - 'run_cmd_checks_enabled': True, 09:55:10 INFO - 'sps_profile': False, 09:55:10 INFO - 'sps_profile_interval': 0, 09:55:10 INFO - 'suite': 'dromaeojs', 09:55:10 INFO - 'system_bits': '32', 09:55:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:55:10 INFO - 'title': 't-yosemite-r7-0159', 09:55:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:55:10 INFO - 'use_talos_json': True, 09:55:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:55:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:55:10 INFO - 'work_dir': 'build'} 09:55:10 INFO - ##### 09:55:10 INFO - ##### Running clobber step. 09:55:10 INFO - ##### 09:55:10 INFO - Running pre-action listener: _resource_record_pre_action 09:55:10 INFO - Running main action method: clobber 09:55:10 INFO - rmtree: /builds/slave/test/build 09:55:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:55:12 INFO - Running post-action listener: _resource_record_post_action 09:55:12 INFO - ##### 09:55:12 INFO - ##### Running read-buildbot-config step. 09:55:12 INFO - ##### 09:55:12 INFO - Running pre-action listener: _resource_record_pre_action 09:55:12 INFO - Running main action method: read_buildbot_config 09:55:12 INFO - Using buildbot properties: 09:55:12 INFO - { 09:55:12 INFO - "project": "", 09:55:12 INFO - "product": "firefox", 09:55:12 INFO - "script_repo_revision": "production", 09:55:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:55:12 INFO - "repository": "", 09:55:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:55:12 INFO - "buildid": "20160317080522", 09:55:12 INFO - "pgo_build": "False", 09:55:12 INFO - "basedir": "/builds/slave/test", 09:55:12 INFO - "buildnumber": 172, 09:55:12 INFO - "slavename": "t-yosemite-r7-0159", 09:55:12 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:55:12 INFO - "platform": "yosemite_r7", 09:55:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:55:12 INFO - "branch": "mozilla-central", 09:55:12 INFO - "repo_path": "mozilla-central", 09:55:12 INFO - "revision": "3e04659fdf6aef792f7cf9840189c6c38d08d1e8", 09:55:12 INFO - "stage_platform": "macosx64", 09:55:12 INFO - "builduid": "f04e63de2cd942819cd8294830360cea", 09:55:12 INFO - "slavebuilddir": "test" 09:55:12 INFO - } 09:55:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:55:12 INFO - Running post-action listener: _resource_record_post_action 09:55:12 INFO - ##### 09:55:12 INFO - ##### Running download-and-extract step. 09:55:12 INFO - ##### 09:55:12 INFO - Running pre-action listener: _resource_record_pre_action 09:55:12 INFO - Running main action method: download_and_extract 09:55:12 INFO - mkdir: /builds/slave/test/build/tests 09:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:12 INFO - https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:55:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:55:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:55:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:55:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 09:55:13 INFO - Downloaded 1199 bytes. 09:55:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:55:13 INFO - Using the following test package requirements: 09:55:13 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:55:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:13 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:55:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:13 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:55:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:13 INFO - u'jsshell-mac.zip'], 09:55:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:13 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:55:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:55:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:13 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:55:13 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:13 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:55:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:13 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:55:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:55:13 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:55:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:13 INFO - https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:55:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:55:14 INFO - Downloaded 17870541 bytes. 09:55:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:55:17 INFO - Return code: 0 09:55:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:55: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')]} 09:55:17 INFO - https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:55:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:55:19 INFO - Downloaded 17870541 bytes. 09:55:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:55:22 INFO - Return code: 0 09:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:22 INFO - https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:55:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:55:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:55:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:55:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:55:23 INFO - Downloaded 10846565 bytes. 09:55:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:55:23 INFO - Return code: 0 09:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:23 INFO - https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:55:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:55:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:55:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:55:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:55:26 INFO - Downloaded 111214117 bytes. 09:55:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:55:26 INFO - mkdir: /builds/slave/test/properties 09:55:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:55:26 INFO - Writing to file /builds/slave/test/properties/build_url 09:55:26 INFO - Contents: 09:55:26 INFO - build_url:https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:55:28 INFO - Running post-action listener: _resource_record_post_action 09:55:28 INFO - Running post-action listener: set_extra_try_arguments 09:55:28 INFO - ##### 09:55:28 INFO - ##### Running populate-webroot step. 09:55:28 INFO - ##### 09:55:28 INFO - Running pre-action listener: _resource_record_pre_action 09:55:28 INFO - Running main action method: populate_webroot 09:55:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:55:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:55:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:55:28 INFO - '--tppagecycles', 09:55:28 INFO - '7'], 09:55:28 INFO - 'tests': ['tsvgm']}}, 09:55:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:55:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:55:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:55:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:55:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:55:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:55:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:28 INFO - 'talos_options': ['--e10s'], 09:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:28 INFO - 'tests': ['damp', 'tps']}, 09:55:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:28 INFO - 'talos_options': ['--e10s'], 09:55:28 INFO - 'tests': ['damp', 'tps']}, 09:55:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:55:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:55:28 INFO - 'other': {'tests': ['a11yr', 09:55:28 INFO - 'ts_paint', 09:55:28 INFO - 'tpaint', 09:55:28 INFO - 'sessionrestore', 09:55:28 INFO - 'sessionrestore_no_auto_restore', 09:55:28 INFO - 'tabpaint']}, 09:55:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:55:28 INFO - 'tests': ['a11yr', 09:55:28 INFO - 'ts_paint', 09:55:28 INFO - 'tpaint', 09:55:28 INFO - 'sessionrestore', 09:55:28 INFO - 'sessionrestore_no_auto_restore', 09:55:28 INFO - 'tabpaint']}, 09:55:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:55:28 INFO - 'tests': ['a11yr', 09:55:28 INFO - 'ts_paint', 09:55:28 INFO - 'tpaint', 09:55:28 INFO - 'sessionrestore', 09:55:28 INFO - 'sessionrestore_no_auto_restore', 09:55:28 INFO - 'tabpaint']}, 09:55:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:55:28 INFO - 'tests': ['a11yr', 09:55:28 INFO - 'ts_paint', 09:55:28 INFO - 'tpaint', 09:55:28 INFO - 'sessionrestore', 09:55:28 INFO - 'sessionrestore_no_auto_restore', 09:55:28 INFO - 'tabpaint']}, 09:55:28 INFO - 'other_l64': {'tests': ['a11yr', 09:55:28 INFO - 'ts_paint', 09:55:28 INFO - 'tpaint', 09:55:28 INFO - 'sessionrestore', 09:55:28 INFO - 'sessionrestore_no_auto_restore', 09:55:28 INFO - 'tabpaint']}, 09:55:28 INFO - 'other_nol64': {'tests': ['a11yr', 09:55:28 INFO - 'ts_paint', 09:55:28 INFO - 'tpaint', 09:55:28 INFO - 'sessionrestore', 09:55:28 INFO - 'sessionrestore_no_auto_restore', 09:55:28 INFO - 'tabpaint']}, 09:55:28 INFO - 'svgr': {'tests': ['tsvgx', 09:55:28 INFO - 'tsvgr_opacity', 09:55:28 INFO - 'tart', 09:55:28 INFO - 'tscrollx', 09:55:28 INFO - 'cart']}, 09:55:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:55:28 INFO - 'tests': ['tsvgx', 09:55:28 INFO - 'tsvgr_opacity', 09:55:28 INFO - 'tart', 09:55:28 INFO - 'tscrollx', 09:55:28 INFO - 'cart']}, 09:55:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:28 INFO - 'tests': ['tp5o']}, 09:55:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:28 INFO - 'talos_options': ['--e10s'], 09:55:28 INFO - 'tests': ['tp5o']}, 09:55:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:28 INFO - 'talos_options': ['--xperf_path', 09:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:28 INFO - 'tests': ['tp5n']}, 09:55:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:28 INFO - 'talos_options': ['--e10s', 09:55:28 INFO - '--xperf_path', 09:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:28 INFO - 'tests': ['tp5n']}}, 09:55:28 INFO - 'talos.zip': {'path': '', 09:55:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:55:28 INFO - Running post-action listener: _resource_record_post_action 09:55:28 INFO - ##### 09:55:28 INFO - ##### Running create-virtualenv step. 09:55:28 INFO - ##### 09:55:28 INFO - Running pre-action listener: _resource_record_pre_action 09:55:28 INFO - Running main action method: create_virtualenv 09:55:28 INFO - Creating virtualenv /builds/slave/test/build/venv 09:55:28 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 09:55:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:55:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:55:28 INFO - Using real prefix '/tools/python27' 09:55:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:55:29 INFO - Installing distribute.............................................................................................................................................................................................done. 09:55:32 INFO - Installing pip.................done. 09:55:32 INFO - Return code: 0 09:55:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:32 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 0x10081ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb619578c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, '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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:32 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 09:55:32 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 09:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:32 INFO - 'HOME': '/Users/cltbld', 09:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:32 INFO - 'LOGNAME': 'cltbld', 09:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:32 INFO - 'MOZ_NO_REMOTE': '1', 09:55:32 INFO - 'NO_EM_RESTART': '1', 09:55:32 INFO - 'PAGER': '/bin/cat', 09:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:32 INFO - 'PWD': '/builds/slave/test', 09:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:32 INFO - 'SHELL': '/bin/bash', 09:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:55:32 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:32 INFO - 'USER': 'cltbld', 09:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:32 INFO - 'XPC_FLAGS': '0x0', 09:55:32 INFO - 'XPC_SERVICE_NAME': '0', 09:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:32 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 09:55:32 INFO - Cleaning up... 09:55:32 INFO - Return code: 0 09:55:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:32 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 0x10081ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb619578c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, '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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:32 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 09:55:32 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 09:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:32 INFO - 'HOME': '/Users/cltbld', 09:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:32 INFO - 'LOGNAME': 'cltbld', 09:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:32 INFO - 'MOZ_NO_REMOTE': '1', 09:55:32 INFO - 'NO_EM_RESTART': '1', 09:55:32 INFO - 'PAGER': '/bin/cat', 09:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:32 INFO - 'PWD': '/builds/slave/test', 09:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:32 INFO - 'SHELL': '/bin/bash', 09:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:55:32 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:32 INFO - 'USER': 'cltbld', 09:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:32 INFO - 'XPC_FLAGS': '0x0', 09:55:32 INFO - 'XPC_SERVICE_NAME': '0', 09:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:32 INFO - Downloading/unpacking psutil>=0.7.1 09:55:32 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 09:55:32 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 09:55:32 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 09:55:32 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 09:55:32 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 09:55:32 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 09:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:55:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:35 INFO - Installing collected packages: psutil 09:55:35 INFO - Running setup.py install for psutil 09:55:35 INFO - building 'psutil._psutil_osx' extension 09:55:35 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 09:55:36 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 09:55:36 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 09:55:36 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 09:55:36 INFO - building 'psutil._psutil_posix' extension 09:55:36 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 09:55:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:55:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:55:36 INFO - ^ 09:55:36 INFO - 1 warning generated. 09:55:36 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 09:55:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:36 INFO - Successfully installed psutil 09:55:36 INFO - Cleaning up... 09:55:36 INFO - Return code: 0 09:55:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:36 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 0x10081ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb619578c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, '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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:36 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 09:55:36 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 09:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:36 INFO - 'HOME': '/Users/cltbld', 09:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:36 INFO - 'LOGNAME': 'cltbld', 09:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:36 INFO - 'MOZ_NO_REMOTE': '1', 09:55:36 INFO - 'NO_EM_RESTART': '1', 09:55:36 INFO - 'PAGER': '/bin/cat', 09:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:36 INFO - 'PWD': '/builds/slave/test', 09:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:36 INFO - 'SHELL': '/bin/bash', 09:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:55:36 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:36 INFO - 'USER': 'cltbld', 09:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:36 INFO - 'XPC_FLAGS': '0x0', 09:55:36 INFO - 'XPC_SERVICE_NAME': '0', 09:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:55:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:55:39 INFO - Installing collected packages: mozsystemmonitor 09:55:39 INFO - Running setup.py install for mozsystemmonitor 09:55:39 INFO - Successfully installed mozsystemmonitor 09:55:39 INFO - Cleaning up... 09:55:39 INFO - Return code: 0 09:55:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:55:39 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')]} 09:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:39 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')]} 09:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:39 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 0x10081ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb619578c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, '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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:39 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 09:55:39 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 09:55:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:55:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:39 INFO - 'HOME': '/Users/cltbld', 09:55:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:39 INFO - 'LOGNAME': 'cltbld', 09:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:39 INFO - 'MOZ_NO_REMOTE': '1', 09:55:39 INFO - 'NO_EM_RESTART': '1', 09:55:39 INFO - 'PAGER': '/bin/cat', 09:55:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:39 INFO - 'PWD': '/builds/slave/test', 09:55:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:39 INFO - 'SHELL': '/bin/bash', 09:55:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:55:39 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:55:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:39 INFO - 'USER': 'cltbld', 09:55:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:39 INFO - 'XPC_FLAGS': '0x0', 09:55:39 INFO - 'XPC_SERVICE_NAME': '0', 09:55:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:55:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:55:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:43 INFO - Downloading docopt-0.6.1.tar.gz 09:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:55:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:55:43 INFO - Running setup.py install for blobuploader 09:55:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:55:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:55:43 INFO - Running setup.py install for requests 09:55:44 INFO - Running setup.py install for docopt 09:55:44 INFO - Successfully installed blobuploader requests docopt 09:55:44 INFO - Cleaning up... 09:55:44 INFO - Return code: 0 09:55:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:44 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')]} 09:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:44 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')]} 09:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:44 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 0x10081ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb619578c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, '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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:44 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 09:55:44 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 09:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:44 INFO - 'HOME': '/Users/cltbld', 09:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:44 INFO - 'LOGNAME': 'cltbld', 09:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:44 INFO - 'MOZ_NO_REMOTE': '1', 09:55:44 INFO - 'NO_EM_RESTART': '1', 09:55:44 INFO - 'PAGER': '/bin/cat', 09:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:44 INFO - 'PWD': '/builds/slave/test', 09:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:44 INFO - 'SHELL': '/bin/bash', 09:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:55:44 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:44 INFO - 'USER': 'cltbld', 09:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:44 INFO - 'XPC_FLAGS': '0x0', 09:55:44 INFO - 'XPC_SERVICE_NAME': '0', 09:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-qWUbFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-SgG9hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:45 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-4HHy0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:45 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-yJeeE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:45 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vCf9tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:45 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-2OMBEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:45 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-5IBwBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:45 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-FjQlh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:45 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-27Sneo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:45 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ix_zzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:45 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-V5WieT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:46 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-zG7Jxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:46 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Z87n8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:46 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-1k9pW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:46 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-PtgUiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:46 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ki4qkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:46 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Mp88DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:55:46 INFO - Running setup.py install for manifestparser 09:55:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:55:46 INFO - Running setup.py install for mozcrash 09:55:46 INFO - Running setup.py install for mozdebug 09:55:47 INFO - Running setup.py install for mozdevice 09:55:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:55:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:55:47 INFO - Running setup.py install for mozfile 09:55:47 INFO - Running setup.py install for mozhttpd 09:55:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:55:47 INFO - Running setup.py install for mozinfo 09:55:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:55:47 INFO - Running setup.py install for mozInstall 09:55:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:55:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:55:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:55:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:55:47 INFO - Running setup.py install for mozleak 09:55:47 INFO - Running setup.py install for mozlog 09:55:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:55:48 INFO - Running setup.py install for moznetwork 09:55:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:55:48 INFO - Running setup.py install for mozprocess 09:55:48 INFO - Running setup.py install for mozprofile 09:55:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:55:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:55:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:55:48 INFO - Running setup.py install for mozrunner 09:55:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:55:48 INFO - Running setup.py install for mozscreenshot 09:55:48 INFO - Running setup.py install for moztest 09:55:49 INFO - Running setup.py install for mozversion 09:55:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:55:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:55:49 INFO - Cleaning up... 09:55:49 INFO - Return code: 0 09:55:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:49 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 0x10081ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb619578c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, '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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:49 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 09:55:49 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 09:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:49 INFO - 'HOME': '/Users/cltbld', 09:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:49 INFO - 'LOGNAME': 'cltbld', 09:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:49 INFO - 'MOZ_NO_REMOTE': '1', 09:55:49 INFO - 'NO_EM_RESTART': '1', 09:55:49 INFO - 'PAGER': '/bin/cat', 09:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:49 INFO - 'PWD': '/builds/slave/test', 09:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:49 INFO - 'SHELL': '/bin/bash', 09:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:55:49 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:49 INFO - 'USER': 'cltbld', 09:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:49 INFO - 'XPC_FLAGS': '0x0', 09:55:49 INFO - 'XPC_SERVICE_NAME': '0', 09:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-UV2vGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:49 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)) 09:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Az50AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-StikIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:49 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)) 09:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-pzT4R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:49 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)) 09:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-iQxfhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Wd8Gvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-E1IePc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-WcltoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-uyKr03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-jBIecc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-4xsCxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-38bPHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-cvrD0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vbEtwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:50 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)) 09:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:50 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vytSYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:51 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)) 09:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:51 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-7nByTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:51 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)) 09:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:51 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-t7cilc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:51 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)) 09:55:51 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:55:51 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:55:51 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)) 09:55:51 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)) 09:55:51 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)) 09:55:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:55:51 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 09:55:51 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 09:55:51 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 09:55:51 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 09:55:51 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 09:55:51 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 09:55:53 INFO - Downloading blessings-1.6.tar.gz 09:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:55:53 INFO - Installing collected packages: blessings 09:55:53 INFO - Running setup.py install for blessings 09:55:53 INFO - Successfully installed blessings 09:55:53 INFO - Cleaning up... 09:55:53 INFO - Return code: 0 09:55:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:55:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:54 INFO - Reading from file tmpfile_stdout 09:55:54 INFO - Current package versions: 09:55:54 INFO - blessings == 1.6 09:55:54 INFO - blobuploader == 1.2.4 09:55:54 INFO - docopt == 0.6.1 09:55:54 INFO - manifestparser == 1.1 09:55:54 INFO - mozInstall == 1.12 09:55:54 INFO - mozcrash == 0.17 09:55:54 INFO - mozdebug == 0.1 09:55:54 INFO - mozdevice == 0.48 09:55:54 INFO - mozfile == 1.2 09:55:54 INFO - mozhttpd == 0.7 09:55:54 INFO - mozinfo == 0.9 09:55:54 INFO - mozleak == 0.1 09:55:54 INFO - mozlog == 3.1 09:55:54 INFO - moznetwork == 0.27 09:55:54 INFO - mozprocess == 0.22 09:55:54 INFO - mozprofile == 0.28 09:55:54 INFO - mozrunner == 6.11 09:55:54 INFO - mozscreenshot == 0.1 09:55:54 INFO - mozsystemmonitor == 0.0 09:55:54 INFO - moztest == 0.7 09:55:54 INFO - mozversion == 1.4 09:55:54 INFO - psutil == 3.1.1 09:55:54 INFO - requests == 1.2.3 09:55:54 INFO - wsgiref == 0.1.2 09:55:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:54 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')]} 09:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:54 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')]} 09:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:54 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 0x10081ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb619578c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, '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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:54 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 09:55:54 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 09:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:54 INFO - 'HOME': '/Users/cltbld', 09:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:54 INFO - 'LOGNAME': 'cltbld', 09:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:54 INFO - 'MOZ_NO_REMOTE': '1', 09:55:54 INFO - 'NO_EM_RESTART': '1', 09:55:54 INFO - 'PAGER': '/bin/cat', 09:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:54 INFO - 'PWD': '/builds/slave/test', 09:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:54 INFO - 'SHELL': '/bin/bash', 09:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:55:54 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:54 INFO - 'USER': 'cltbld', 09:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:54 INFO - 'XPC_FLAGS': '0x0', 09:55:54 INFO - 'XPC_SERVICE_NAME': '0', 09:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:54 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)) 09:55:54 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)) 09:55:54 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)) 09:55:54 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)) 09:55:54 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)) 09:55:54 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)) 09:55:54 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)) 09:55:54 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)) 09:55:54 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)) 09:55:54 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)) 09:55:54 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)) 09:55:54 INFO - Cleaning up... 09:55:54 INFO - Return code: 0 09:55:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:55:54 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')]} 09:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:54 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')]} 09:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:54 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 0x10081ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb619578c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, '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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:54 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 09:55:54 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 09:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:54 INFO - 'HOME': '/Users/cltbld', 09:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:54 INFO - 'LOGNAME': 'cltbld', 09:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:54 INFO - 'MOZ_NO_REMOTE': '1', 09:55:54 INFO - 'NO_EM_RESTART': '1', 09:55:54 INFO - 'PAGER': '/bin/cat', 09:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:54 INFO - 'PWD': '/builds/slave/test', 09:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:54 INFO - 'SHELL': '/bin/bash', 09:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:55:54 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:54 INFO - 'USER': 'cltbld', 09:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:54 INFO - 'XPC_FLAGS': '0x0', 09:55:54 INFO - 'XPC_SERVICE_NAME': '0', 09:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:54 INFO - Downloading/unpacking jsonschema 09:55:54 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 09:55:54 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 09:55:54 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 09:55:54 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 09:55:54 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 09:55:54 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 09:55:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:55:57 INFO - Downloading/unpacking functools32 (from jsonschema) 09:55:57 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 09:55:57 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 09:55:57 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 09:55:57 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 09:55:57 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 09:55:57 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 09:55:57 INFO - Downloading functools32-3.2.3-2.tar.gz 09:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:55:57 INFO - warning: no files found matching '*.txt' 09:55:57 INFO - no previously-included directories found matching 'build' 09:55:57 INFO - no previously-included directories found matching 'dist' 09:55:57 INFO - no previously-included directories found matching '.git*' 09:55:57 INFO - Installing collected packages: jsonschema, functools32 09:55:57 INFO - Running setup.py install for functools32 09:55:57 INFO - warning: no files found matching '*.txt' 09:55:57 INFO - no previously-included directories found matching 'build' 09:55:57 INFO - no previously-included directories found matching 'dist' 09:55:57 INFO - no previously-included directories found matching '.git*' 09:55:57 INFO - Successfully installed jsonschema functools32 09:55:57 INFO - Cleaning up... 09:55:58 INFO - Return code: 0 09:55:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:55:58 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')]} 09:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:58 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')]} 09:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:58 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 0x10081ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb619578c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, '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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 09:55:58 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 09:55:58 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 09:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:58 INFO - 'HOME': '/Users/cltbld', 09:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:58 INFO - 'LOGNAME': 'cltbld', 09:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:58 INFO - 'MOZ_NO_REMOTE': '1', 09:55:58 INFO - 'NO_EM_RESTART': '1', 09:55:58 INFO - 'PAGER': '/bin/cat', 09:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:58 INFO - 'PWD': '/builds/slave/test', 09:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:58 INFO - 'SHELL': '/bin/bash', 09:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:55:58 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:58 INFO - 'USER': 'cltbld', 09:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:58 INFO - 'XPC_FLAGS': '0x0', 09:55:58 INFO - 'XPC_SERVICE_NAME': '0', 09:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:58 INFO - Downloading/unpacking flake8 09:55:58 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 09:55:58 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 09:55:58 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 09:55:58 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 09:55:58 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 09:55:58 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 09:56:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:56:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:56:00 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 09:56:00 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 09:56:00 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 09:56:00 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 09:56:00 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 09:56:00 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 09:56:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:56:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 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 09:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:01 INFO - no previously-included directories found matching 'docs/_build' 09:56:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:56:02 INFO - Running setup.py install for pep8 09:56:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:02 INFO - no previously-included directories found matching 'docs/_build' 09:56:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:56:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:56:02 INFO - Cleaning up... 09:56:02 INFO - Return code: 0 09:56:02 INFO - Running post-action listener: _resource_record_post_action 09:56:02 INFO - Running post-action listener: _start_resource_monitoring 09:56:02 INFO - Starting resource monitoring. 09:56:02 INFO - ##### 09:56:02 INFO - ##### Running install step. 09:56:02 INFO - ##### 09:56:02 INFO - Running pre-action listener: _resource_record_pre_action 09:56:02 INFO - Running main action method: install 09:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:02 INFO - Reading from file tmpfile_stdout 09:56:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:56:02 INFO - Reading from file tmpfile_stdout 09:56:02 INFO - Output received: 09:56:02 INFO - Usage: mozinstall [options] installer 09:56:02 INFO - Options: 09:56:02 INFO - -h, --help show this help message and exit 09:56:02 INFO - -d DEST, --destination=DEST 09:56:02 INFO - Directory to install application into. [default: 09:56:02 INFO - "/builds/slave/test"] 09:56:02 INFO - --app=APP Application being installed. [default: firefox] 09:56:02 INFO - mkdir: /builds/slave/test/build/application 09:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:56:36 INFO - Reading from file tmpfile_stdout 09:56:36 INFO - Output received: 09:56:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:56:36 INFO - Running post-action listener: _resource_record_post_action 09:56:36 INFO - ##### 09:56:36 INFO - ##### Running run-tests step. 09:56:36 INFO - ##### 09:56:36 INFO - Running pre-action listener: _resource_record_pre_action 09:56:36 INFO - Running main action method: run_tests 09:56:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:56:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:56:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:56:36 INFO - 2016-03-17 09:56:36.458 screenresolution[1646:7529] starting screenresolution argv=screenresolution get 09:56:36 INFO - 2016-03-17 09:56:36.461 screenresolution[1646:7529] Display 0: 1600x1200x32@60 09:56:36 INFO - 2016-03-17 09:56:36.467 screenresolution[1647:7532] starting screenresolution argv=screenresolution list 09:56:36 INFO - Available Modes on Display 0 09:56:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:56:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:56:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:56:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:56:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:56:36 INFO - Intel Iris: 09:56:36 INFO - Chipset Model: Intel Iris 09:56:36 INFO - Type: GPU 09:56:36 INFO - Bus: Built-In 09:56:36 INFO - VRAM (Dynamic, Max): 1536 MB 09:56:36 INFO - Vendor: Intel (0x8086) 09:56:36 INFO - Device ID: 0x0a2e 09:56:36 INFO - Revision ID: 0x0009 09:56:36 INFO - Displays: 09:56:36 INFO - Display: 09:56:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:56:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:56:36 INFO - Display Serial Number: 1600x1200 60 09:56:36 INFO - Main Display: Yes 09:56:36 INFO - Mirror: Off 09:56:36 INFO - Online: Yes 09:56:36 INFO - Rotation: Supported 09:56:36 INFO - Return code: 0 09:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:56:36 INFO - Python 2.7.3 09:56:36 INFO - Return code: 0 09:56:36 INFO - grabbing minidump binary from tooltool 09:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:36 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 0x1006bae00>, '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 0x1004e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006b5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:56:36 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 09:56:36 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 09:56:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:36 INFO - Return code: 0 09:56:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:56:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:56:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:56:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:56:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:56:37 INFO - Return code: 0 09:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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 09:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --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 09:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ey3SI7BBl/Render', 09:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:37 INFO - 'HOME': '/Users/cltbld', 09:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:37 INFO - 'LOGNAME': 'cltbld', 09:56:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:56:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:37 INFO - 'MOZ_NO_REMOTE': '1', 09:56:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:56:37 INFO - 'NO_EM_RESTART': '1', 09:56:37 INFO - 'PAGER': '/bin/cat', 09:56:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:37 INFO - 'PWD': '/builds/slave/test', 09:56:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:37 INFO - 'SHELL': '/bin/bash', 09:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CKSUBhzb2e/Listeners', 09:56:37 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:37 INFO - 'USER': 'cltbld', 09:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:37 INFO - 'XPC_FLAGS': '0x0', 09:56:37 INFO - 'XPC_SERVICE_NAME': '0', 09:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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 09:56:38 INFO - mozversion application_buildid: 20160317080522 09:56:38 INFO - mozversion application_changeset: 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 09:56:38 INFO - mozversion application_display_name: Nightly 09:56:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:38 INFO - mozversion application_name: Firefox 09:56:38 INFO - mozversion application_remotingname: firefox 09:56:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:56:38 INFO - mozversion application_vendor: Mozilla 09:56:38 INFO - mozversion application_version: 48.0a1 09:56:38 INFO - mozversion platform_buildid: 20160317080522 09:56:38 INFO - mozversion platform_changeset: 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 09:56:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:56:38 INFO - mozversion platform_version: 48.0a1 09:56:38 INFO - using testdate: 1458233798 09:56:38 INFO - actual date: 1458233798 09:56:38 INFO - starting webserver on 'localhost:49270' 09:56:38 INFO - SUITE-START | Running 2 tests 09:56:38 INFO - TEST-START | dromaeo_css 09:56:38 INFO - operating with platform_type : mac_ 09:56:38 INFO - Initialising browser for dromaeo_css test... 09:56:38 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpXXEIHY/profile http://localhost:49270/getInfo.html) 09:56:40 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 09:56:40 INFO - PROCESS | 1665 | colorDepth:24 09:56:40 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 09:56:40 INFO - PROCESS | 1665 | __metrics 09:56:40 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:56:40 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:56:41 INFO - TEST-INFO | 1665: exit 0 09:56:41 INFO - Browser initialized. 09:56:41 INFO - Running cycle 1/1 for dromaeo_css test... 09:56:41 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpXXEIHY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:53 INFO - PROCESS | 1668 | RSS: Main: 243367936 09:56:53 INFO - PROCESS | 1668 | 09:57:44 INFO - PROCESS | 1668 | 1458233864513 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] 09:59:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 09:59:55 INFO - PROCESS | 1668 | RSS: Main: 337440768 09:59:55 INFO - PROCESS | 1668 | 10:02:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 10:02:58 INFO - PROCESS | 1668 | RSS: Main: 371417088 10:02:58 INFO - PROCESS | 1668 | 10:06:00 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 10:06:01 INFO - PROCESS | 1668 | RSS: Main: 374005760 10:06:01 INFO - PROCESS | 1668 | 10:09:03 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 10:09:03 INFO - PROCESS | 1668 | RSS: Main: 332947456 10:09:03 INFO - PROCESS | 1668 | 10:12:07 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 10:12:07 INFO - PROCESS | 1668 | RSS: Main: 333430784 10:12:07 INFO - PROCESS | 1668 | 10:15:10 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 10:15:10 INFO - PROCESS | 1668 | RSS: Main: 448618496 10:15:10 INFO - PROCESS | 1668 | 10:15:10 INFO - PROCESS | 1668 | __start_tp_report 10:15:10 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 10:15:10 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 10:15:10 INFO - PROCESS | 1668 | |i|pagename|runs| 10:15:10 INFO - PROCESS | 1668 | |0;dojo.html;3365.781224220426;3396.541466901969;3458.308338332334;3479.0432631026474;3512.3326567952085;5493.7802487900535;5556.9444305556935;5570.554355651549;5570.610057295991;5598.1322894951245;5527.613067085305;5578.665280083198;5579.05156123459;5579.414161513044;5588.972055139729;5054.039732450841;5064.468230835764;5083.3391659084455;5102.974485127587;5150.716710580917;5140.640155189139;5152.665076770017;5154.175331946889;5155.974220128913;5166.715830629314;5068.46781087986;5109.029284435946;5135.460776618457;5139.177731562951;5156.974215128919;5081.339425874631;5128;5129.999650068238;5138.845834624967;5175.560077393426;4917.114919314522;5008.323876276729;5019.498050194988;5047.545720885101;5058.949410505885;5422.593305502063;5458.890822183574;5469.589780766459;5476.342838859362;5577.247071645357;6021.668808215546;6083.30042045166;6084.817455476343;6108.205933228696;6115.4190351916495;5089.236614507817;5766.106253530709;6000.939990600082;6039.456448919618;6142.069075791497;5586.581006424493;5590.664560126405;5595;5610.579206559524;5652.830415087554;6169.784057558054;6210.658413787195;6227.782027629102;6235.532335074888;6249.000159974382;5749.108888122348;5852.590318677737;5941.940580594225;5984.102384642251;6037.00389435747;6121.133381598927;6148.354422785633;6154.046122850965;6180.6291622502795;6189.721462534197;6072.240969878765;6072.939270607326;6091.208142941389;6106.267247930188;6122;5050.9494905051215;5923.851903702442;6014.939850601438;6073.757049717962;6142;4138.52406973202;4832.855014349575;4834.879128021757;4836.758162091952;4845.055214233191;3939.665128464055;4237.512686041083;4379.9781001095425;4382.517923028464;4409.3606427068535;5471.972640136773;5490.313710786152;5575.052241118939;5582.24639673647;5606.1590761385305;6122.66325352101;6159.81520554384;6162.075688646739;6166.1983942087245;6205.6586887720705;5483.75323110461;5522.144067669517;5531.529819965348;5531.557475401958;5549.1676248563035;5158.38099428071;5205.765740541685;5241.318628578337;5276.261323414725;5311.521963023347;6273.0094204740935;6296.968515157487;6315.179026726496;6317.5893566918;6337;6149.2313460817395;6152.261728592419;6165.321814600301;6183.134361189347;6201.56589038781;6108.0688921796145;6232.937670623236;6309;6337.904931426125;6346.809595712136;5895.64626122434;5900.616459930091;5911.113333000085;5917.881642367042;5960.552958528041;5760;5972.671503067199;6039;6047.909281360695;6052.546059045501;5894.115882617471;5944.940550594439;5956.821295361146;5959.791407300723;6023.909641355295;5870.471657550841;5895.616784908967;5898.616589921641;5901.468867801918;5903.970480147572;5625.296837895263;5701.945140149086;5754.251947246831;5756.165356023437;5769.567282453749;5858.794942177004;5869.119632055226;5882.794102206402;5904.586678932434;5941.405859414024;4776.546228108324;5754.309482862083;5757.65454072757;5759.596828221985;5761.48146666802 10:15:10 INFO - PROCESS | 1668 | |1;ext.html;497.14242930944147;515.3120584020332;537.6344086021505;575.2435547255359;607.7389416959808;31192.22019449515;38299.42550861736;38607.420888686625;38615.8415247543;38658.42012369817;40997.18005639885;41389;41441.792791036;41462.792686036606;41481.792591037;8538.402311838174;9744.171745401614;9752.609895604168;9778.07108324708;9812.852807207897;9454.90545094547;9603.567839447207;9610.327277090606;9618.567164477581;9748.610055597768;9712.174465170468;9778.168855647244;9790.90209097907;9807.215422766198;9818.803623927553;9676.516174191298;9758.024197580256;9759.975202603766;9771.071748183911;9801.852972205423;9559.426434413888;9676.225901927828;9681.322307438482;9690.563924623339;9696.61213551464;39180.60819391798;39759.8012009941;39805.20389592192;39896;39956.600433995576;3230.1924518870283;3241.38413701396;3293.176705823544;3304.454764963778;3510.1926556891804;27359.316017099532;27703.86148069267;27982.580261296098;28378.716212837815;28495.57256641152;2660.255128564005;2702.9053983110693;2786.7770578353684;2829.8585070746585;2920.0217926994483;387540.0622996895;390677.0466147679;391091.0445447783;391916;393074;45130.77434612872;63782.36217637764;64096.03855942165;67952.30119247058;68103.97844032344;36890;44511.55488445139;44600.776996114815;44715.329270060975;44771;15965.600859978362;16178;16209.67580648404;16213.756793648105;16219.35122595083;12964.416601252966;12965.870341296466;12969.157004794659;12972.416241269166;12974.35128243584;13435.596932092052;14599.635009124857;14620.342084606218;14633.560993170222;14643.267836608127;6327.145835312266;6415.967920160369;6425.485961123099;6439.388258115471;6470.935290647033;950.7718147644515;1007.0533698323552;1024.3751311699857;1047.570496096612;1048.2819268800743;28904.98832540893;29212.707872920997;29439.678231063433;29665;29669.703302967126;1102.6030628973563;1116.5980247111033;1127.6278827986744;1226.1233218248994;1246.731952630189;12463.252204867737;14768.704625907421;14776.749115194854;15092.320845561977;15122.848771512365;523933;526662;529139;529194;529498;56492.43507564954;58596;58681;58756.824863502494;58818.41181588215;1252.4489224741085;1372.540199033335;1433.4696162419764;1456.7741999989807;1475.2181343887758;26759.866200668872;28387.71612283851;28510.42979140364;29143.7085629141;29353.55969660414;44457.11085778331;44548.33177502275;44765.77617111894;44796;44839.103217936114;306449;307974;308532;308681;309047;28131.859340703166;32235.838820805748;32530;33139.005829825146;33259.66961321617;40901.18197635971;41545;41728.791356043024;42072.94817629584;42442.5755742451;33831.4925276126;34166.487502686985;34363.65636343705;34929.65070349366;35068.64931350756;34510.96467105991;34532.48201277033;35076.82461587676;35272;35391.11522211965;34949.65050349464;35188.82405587956;35569.28861422705;35918.640813591526;36194;31289.687103128676;31920.8403957988;32020.039398818073;32214.83892580522;32357.35285294328;23659;24000.159994400114;24098.15656452016;24285;24368.02527898935 10:15:10 INFO - PROCESS | 1668 | |2;jquery.html;338.3976521791211;361.13868423809225;361.91856832212756;365.76773748669586;373.5592001438302;19298.622741020317;19359.516012099688;20458.48853778656;20485.18059277631;20485.590288194227;12020.27878327301;19125;20389.694154587694;20405.795942040575;20412.59174816503;5245.082110630634;5372.489613486732;5416.837494875141;5417.6478528895495;5421.051316019701;3950;4137.338025915854;5564.693941833198;5618.943810561904;5868;5842.737076831553;5852.268466441695;5857.824265272027;5857.912131318034;5864.912026319587;5584.720763961806;5816.360200377976;5831.271091113611;5837.912431313492;5841.182234487154;5566.888662226774;5573.749181286852;5584.888302233973;5585.162225666142;5605.159226116074;16884.324627014903;24008;24776.132835350858;24782.752172478224;25374.492510149877;2068.800095944364;2086.7704552499213;2276.112316196668;2346.77705617966;2675.0102462089153;9657.71026869195;9782.070703283247;9931.304808663397;9946.452945088018;10179.03299186576;1627.3653275222673;1754.1580041579984;1762.5505496098542;1790.64187162568;1845.7508236388185;97713.51143244309;101840.98159018389;102204.48897755537;103016.48491757568;104235.9152816947;11269.323840569592;11286.66140015801;11390.943045284886;11447.484863181176;11575.652730418102;13734.519291824738;13799.586012419644;13819.723605527834;13830.962677799003;13839.861601383856;8355.206255405727;8516.06323304436;8535.317174626016;8618;8651;8669.869951950726;8685.913140868637;8728.214460698568;8817.250533704579;8825.955870220736;4427.6236519896165;4554.908901821945;4565.9954809941755;4567.862964111016;4575.839845605387;1505.9472918447802;1757.9912100439417;1809.194908265809;1862.4598866328613;1913.2920819296949;842.6713581703141;896.2829736211005;981.5779214937645;982.2829334585792;1007.5415685863061;15078.849211507964;15568.455104071303;19239.711404328948;19269.940153291704;19434.70847937282;958.4105774948496;963.349738926222;1004.914582260516;1005.527402121002;1015.9992407478628;10700.78598428027;10987.011168994828;11056.87331267872;11156.330620162817;11495.77008459843;493602;526079;529403;601654;657037;118814.21778673326;121286;122917;125636;126361;840.4663038970176;1017.1913328903539;1020.3724709303725;1062.2511129653576;1064.297563608015;14595.635109122357;17453.066488108827;17500.649986999935;17958.10209489494;18046.1879215433;51516.74241628918;52511;54165;54234.45765542452;54851.17723234234;64063.03905441329;67981.64036719337;71786;71827.28172718205;74768.25231747613;7424.814379640552;7521.435892308208;7671.808204794702;7755.883661745192;8021.27808497238;9990.700278991642;12359.62921112368;12468.688282793002;12567.617562067982;12608.621741347773;8897.777555561162;10818.404987725751;10998;11031.72420689457;11259.831102533304;10781.460926953465;10800.567977280822;10833.620823271147;10835.620753273597;10972.890271097505;10833.945830270799;10938.070264027647;10969.835452468378;11145.108391328837;11481.36852473122;7678.424118191269;7840.411969102454;7873.448858579844;7901.525908445512;8095.392845536726;9262.39794413361;10087.848682269918;10660.933906609587;10748.516316765921;10897.237193396386 10:15:10 INFO - PROCESS | 1668 | |3;mootools.html;1468.067776961629;1602.5112340736077;1640.745684418915;1925.499370163757;2043.0397713074858;8096.6761329546825;8674.739757807269;8830.646774129043;8843.823123537526;8864.290856731463;8567.357448191395;8777.429467084636;8787.868181977276;8790.6923257686;8792.120787921205;2407.9398015049633;2429.6112621980487;2434.1237154624323;2435.305937807725;2435.7320694723653;2448.192096608124;2462.9261122166363;2493.551160791057;2495.7753802157804;2515.1448507507444;2443.9389015274674;2444.559979203743;2455.373879660684;2465.1125594785863;2493.364192131013;2472.134752836511;2489.962650560243;2501.162110692911;2504.211173480366;2508.184839927031;2336.19401306549;2365.113082594027;2373.738888722239;2373.8338316317863;2488.8382255153356;8524.8721269181;8853.468791872443;8912.287017038621;8942.329325300563;8948.328875334311;5357.276767636358;5551.1118221084835;5554.222408862763;5555.749991250404;5556.91664625031;3139.780215384924;3576.8032758198287;3644.344018076745;3713.2733279025383;3731.869384571527;1048.1457612046158;1071.4482041748506;1073.812082885492;1079.4171147580298;1080.9891901081046;10006.349587276804;11932.821007684892;12233.449494772756;12242.75514489714;12255.75488490234;3837.9232415351535;4653.767311634405;4784.091022705675;4793.808247670054;4803.879903002453;9449.244060475283;9452.669156579486;9455.29085318604;9473.005334439784;9512.001239869853;5434.646747961449;5434.8913021739345;5439.830436456181;5445.564354851603;5445.992491389105;4415.249407600716;4603.700759450625;4796.400449943757;5003.574696150795;5063.417706963673;3228.4834426491648;3735.9626403736156;3812.637799409107;3819.25524522721;3853.2293541291856;1191.8212268159673;1202.7834989701762;1204.6867814368327;1210.7699537087924;1215.3740823475916;1043.7547176413536;1060.9628662996759;1190.743990042145;1300.1029289790015;1419.9858001419855;8073.7577872663915;8167.509949403055;8180.509169449852;8201.30288925436;8444.746657600283;1129.949152288149;1170.3680012792997;1215.7933151364289;1221.5968730318973;1243;6337.207849018872;6370.299267080617;6416.13382193398;6427.421532062137;6434.517411194179;9041.77395565116;10402.427866467417;10775.94612026935;10782.73043173927;10813.56745730162;10063.19494440443;10665.200109991627;10785.78428431427;10911.454427278604;10913.945430272797;8189.26296633294;8321.417500774887;8328.125546817497;8349.33205343571;8395.454295470774;8066.516009039477;8096;8153.673853046049;8172.550509721785;8224.547649879314;9401.153896149106;9528.523573821143;9561.282903782105;9608.66369677058;9652.662156824477;8816.647334106821;9791.853122203314;10012.499375031364;10104.84842727345;10114.797704046025;7602.885956710543;7647.044119485065;7660;7750.0699916010435;7789.805254868447;8332.541710205996;8398.916010839814;8416.158384161536;8418.705345312885;8435.367347448842;6363.268224154096;7426.2945020223;7553.282438168365;7639.197884222077;7760.146383897654;7289.161746399232;7315.939188817698;7373.262673732798;7393.408527317694;7416.221296763762;7711.460197786101;7752.7674169775;7786.883196752166;7800.765977020698;7801.9857418537495;6810.523263371517;7014.158301003912;7074.257202993817;7076.398506126831;7077.469189810888;7096.219415864148;7161.57030578167;7161.928380716126;7164.426845852424;7170.139583250043 10:15:10 INFO - PROCESS | 1668 | |4;prototype.html;281.2280290602297;324.79537891128587;329.69503209531194;335.7968429100394;338.14786737421684;6555.541112122153;6601.207855057394;6637.900431493532;6666.566673166247;6730.158730158731;6608.074869518271;6636.402723754861;6640.904250798612;6648.800535983928;6655.90016149757;3760.52993375828;4748.857534273978;4760.880977975544;4922.753862306889;4928.531789479994;4832.565069143777;4857.198562237244;4859.975700121495;4872.196087645534;4875.536824001714;4346.109047645241;4369.6285815705705;4797.160496913044;4811.687240329367;4814.1575224335775;4638.628909687234;4703.764811759433;4730.101280756645;4736.7631618418945;4811.951880481203;4065.26825171469;4138.979305103485;4160.063985603245;4165.271077561445;4166.541680415152;6247.094171345129;6335.144755458;6338.397852204033;6341.460975817061;6375.489960803125;5742.569307301927;5746.310442746855;5747.195392645033;5752.424757524256;5758.42415758425;7008.404285635676;7009.509334346598;7013.473989450812;7028.367446929749;7043.471739619497;4578.633709303248;4747.8575642730775;4749.26386410107;4757.78589963449;4757.857264282077;5872.941270587282;7564.886526702104;7576.204498527631;7578.545287282725;7601.011868457121;4864.246041863446;4870.488598697157;4873.415190177201;4874.073925954058;4882.218844984785;4939.75301234944;4941.2835138905375;4941.579965702884;4947.381577302837;4958.256261560723;5219.269302297681;5402.730358365781;5859.912101318484;5870.207521984477;5880.26496687914;5862.443067908542;6391.58454700443;6802.421794147553;6824.727010919607;7068.646567671596;1688.72136097545;1711.2213942656062;1717.4246627379719;1720.9741853872201;1722.6554689062239;961.6345788600287;1117.8546788917552;1130.112861403794;1136.86926003509;1145.8624965004253;5260.342457192851;6354.618722876642;6556.27880933097;6580.276169621337;6616.503762217853;7390.6674199660065;7421.777346679608;7443.404527637776;7446.925530744732;7451.3293803557945;6647;6654.068430419745;6662.167229096363;6669.599824010575;6670.166229221348;3875.147467557133;3917.138229589486;3927.4697915781576;3929.724919255682;3932.311845427039;7407.407407407394;7706.921031055656;7772.067351917806;7780.377569794403;7787.06555213378;7611.65747541362;7661.004069471044;7667.846643067108;7668.578228197391;7691;7750.883736743954;7751.224877512316;7751.689932402641;7755.185705500954;7758.456908016385;7379.483436159418;7395.112586489656;7397.482176247611;7400.222976587381;7400.740974065882;7007.649617519206;7243.348098671145;7279.672414741455;7291.979122922901;7299.598522081336;6214.875702485834;6218.253809542884;7674.53952762836;7719.845603088019;7725.613719313899;4611.815527378867;4667.836625718083;4672.135654903717;4673.883152921204;4675.789589468414;7336.486445948733;7346.302101300368;7347.19180890091;7350.77947661571;7371.778846634395;6790.898136527857;7051.612161330971;7055.823604409931;7057.470689698396;7099.396551293198;6962.3037696231995;7026.754063607749;7030.50786444944;7035.648217589202;7112.786616401516;6949.131358580177;6954.617496037564;6956.930430695628;6963.1644202696;6966.79099627012;6868.107146070979;7044.894326585208;7089.113860767404;7101.644917754195;7130.18002929649;6699.196096468455;6875.209350924508;6955.095837541289;6980.127484064492;6988.930110698828 10:15:10 INFO - PROCESS | 1668 | |5;yui.html;693.882040053191;705.4708968273794;735.393300527065;758.0865057605586;809.3929552835372;14919.403223871032;15116.546503604883;15144.621384465394;15157.924210378946;15160.317785699643;12472.563460278892;13873.930630346835;13927.164370137798;13932.373043213054;13932.791008134885;897.5646811296516;938.6104766521885;939.0843927171022;941.0636416765294;941.6515889121035;925.7176561148847;937.1471960515931;938.0713094036888;939.4269495607674;940.407543247753;785.8114052627385;985.0543478260843;985.8373368394207;986.4673076538696;986.5264672956985;945.3902233059672;979.603260679426;980.1374790184664;980.7253968888723;981.7349315684761;728.2862794461457;728.8032231297573;730.2441972558377;730.6346826586706;731.3125661877817;14620.853791462161;14726.779098313535;14737.336819843133;14741.189234592093;14741.926290368587;12781.16922400041;12782.744345113138;12889.291088990101;13017.15388499754;13135.408906599227;10058.748531286703;10269.435181065039;10295.536700848479;10379.273450858444;10855.348679079281;3302.3230237801195;3494.196334842975;3511.0520159556777;3553.6446355364515;3557.7509574329806;85572.57213713892;86746;86969.56515217383;86993.56503217507;88160.55919720425;8174.754757357289;9552.188064014637;9610.807783844424;9759.902400976041;9864.161546268648;21244;21383.144674213167;21407.571848563253;21434.78565214328;21453.249136280156;6732.966335168293;6834.931650683429;7381.335679788737;7540.396768258526;7566.31903128721;3927.430522574268;4056.8782936511952;4113.259613269581;4154.584541545822;4159.292920203573;3476.0788391076385;3532.593751718534;3535.2045789697113;3536.734744894143;3541.327147841902;512.2469969145351;647.9449246813979;663.3797399431547;664.727461740684;668.6155460610169;557.2310211907542;593.5281451246269;595.779561562216;603.4508597176548;605.9363766804511;7414.147373052168;7880.64537095832;7961.203879612109;8170;8188.836223275501;519.5531842615347;522.3314157877923;548.2516365161525;572.1275055540251;607.7963882099458;3400.432673331619;3467.202543414978;3795.905102372463;3808.067023579241;3905.2384784966657;95704.08591828124;96163.51918240504;96750.54874176893;96830;97074.51462742641;81202.37595248062;83078.16921830825;83177.16822831816;83257.16742832615;83777;55843.162352564745;71160.93258601124;71838.2816171842;71962.28037719765;73640.63179684067;7651.502652327581;7797.337226335825;7821.296083352298;7892.250236227549;8025.761950434245;46612.53387466218;50234.24648630201;51349.48650513597;51719;51900.74049629728;56999.43000569941;59778;71280.64359678168;71587;71974;10095.697129086138;10175.694729158136;10491.68524944253;10748.140148787921;10899.836502452628;12061.155719099579;12189.75620487603;12244.142909996215;12263.26420414778;12356.320402377956;11196.776064478829;11366.943165284121;11439.499304589643;11667.76664466689;11755.412229388325;11454.656360309204;11495.080393568662;11725.648230553097;11901.583444579399;12131.454084566392;11446.599369022044;11595.8260626089;11733.00269477104;12375.257484550955;12377.195482293622;9462.621495140118;9651;9688.806223875343;9737.707868763948;9803.950980245338;8867.911320886966;9534.618615255313;9555.140037396668;9596.568154432927;9706.9029309706 10:15:10 INFO - PROCESS | 1668 | __end_tp_report 10:15:10 INFO - PROCESS | 1668 | __start_cc_report 10:15:10 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,944 10:15:10 INFO - PROCESS | 1668 | __end_cc_report 10:15:10 INFO - PROCESS | 1668 | __startTimestamp1458234910933__endTimestamp 10:15:10 INFO - PROCESS | 1668 | 10:15:10 INFO - PROCESS | 1668 | ------- Summary: start ------- 10:15:10 INFO - PROCESS | 1668 | Number of tests: 6 10:15:10 INFO - PROCESS | 1668 | 10:15:10 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5587.31 Median:5754.31 stddev:624.38 (10.9%) stddev-sans-first:601.48 10:15:10 INFO - PROCESS | 1668 | Values: 3365.8 3396.5 3458.3 3479.0 3512.3 5493.8 5556.9 5570.6 5570.6 5598.1 5527.6 5578.7 5579.1 5579.4 5589.0 5054.0 5064.5 5083.3 5103.0 5150.7 5140.6 5152.7 5154.2 5156.0 5166.7 5068.5 5109.0 5135.5 5139.2 5157.0 5081.3 5128.0 5130.0 5138.8 5175.6 4917.1 5008.3 5019.5 5047.5 5058.9 5422.6 5458.9 5469.6 5476.3 5577.2 6021.7 6083.3 6084.8 6108.2 6115.4 5089.2 5766.1 6000.9 6039.5 6142.1 5586.6 5590.7 5595.0 5610.6 5652.8 6169.8 6210.7 6227.8 6235.5 6249.0 5749.1 5852.6 5941.9 5984.1 6037.0 6121.1 6148.4 6154.0 6180.6 6189.7 6072.2 6072.9 6091.2 6106.3 6122.0 5050.9 5923.9 6014.9 6073.8 6142.0 4138.5 4832.9 4834.9 4836.8 4845.1 3939.7 4237.5 4380.0 4382.5 4409.4 5472.0 5490.3 5575.1 5582.2 5606.2 6122.7 6159.8 6162.1 6166.2 6205.7 5483.8 5522.1 5531.5 5531.6 5549.2 5158.4 5205.8 5241.3 5276.3 5311.5 6273.0 6297.0 6315.2 6317.6 6337.0 6149.2 6152.3 6165.3 6183.1 6201.6 6108.1 6232.9 6309.0 6337.9 6346.8 5895.6 5900.6 5911.1 5917.9 5960.6 5760.0 5972.7 6039.0 6047.9 6052.5 5894.1 5944.9 5956.8 5959.8 6023.9 5870.5 5895.6 5898.6 5901.5 5904.0 5625.3 5701.9 5754.3 5756.2 5769.6 5858.8 5869.1 5882.8 5904.6 5941.4 4776.5 5754.3 5757.7 5759.6 5761.5 10:15:10 INFO - PROCESS | 1668 | 10:15:10 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:55445.54 Median:35331.56 stddev:111265.56 (314.9%) stddev-sans-first:111501.20 10:15:10 INFO - PROCESS | 1668 | Values: 497.1 515.3 537.6 575.2 607.7 31192.2 38299.4 38607.4 38615.8 38658.4 40997.2 41389.0 41441.8 41462.8 41481.8 8538.4 9744.2 9752.6 9778.1 9812.9 9454.9 9603.6 9610.3 9618.6 9748.6 9712.2 9778.2 9790.9 9807.2 9818.8 9676.5 9758.0 9760.0 9771.1 9801.9 9559.4 9676.2 9681.3 9690.6 9696.6 39180.6 39759.8 39805.2 39896.0 39956.6 3230.2 3241.4 3293.2 3304.5 3510.2 27359.3 27703.9 27982.6 28378.7 28495.6 2660.3 2702.9 2786.8 2829.9 2920.0 387540.1 390677.0 391091.0 391916.0 393074.0 45130.8 63782.4 64096.0 67952.3 68104.0 36890.0 44511.6 44600.8 44715.3 44771.0 15965.6 16178.0 16209.7 16213.8 16219.4 12964.4 12965.9 12969.2 12972.4 12974.4 13435.6 14599.6 14620.3 14633.6 14643.3 6327.1 6416.0 6425.5 6439.4 6470.9 950.8 1007.1 1024.4 1047.6 1048.3 28905.0 29212.7 29439.7 29665.0 29669.7 1102.6 1116.6 1127.6 1226.1 1246.7 12463.3 14768.7 14776.7 15092.3 15122.8 523933.0 526662.0 529139.0 529194.0 529498.0 56492.4 58596.0 58681.0 58756.8 58818.4 1252.4 1372.5 1433.5 1456.8 1475.2 26759.9 28387.7 28510.4 29143.7 29353.6 44457.1 44548.3 44765.8 44796.0 44839.1 306449.0 307974.0 308532.0 308681.0 309047.0 28131.9 32235.8 32530.0 33139.0 33259.7 40901.2 41545.0 41728.8 42072.9 42442.6 33831.5 34166.5 34363.7 34929.7 35068.6 34511.0 34532.5 35076.8 35272.0 35391.1 34949.7 35188.8 35569.3 35918.6 36194.0 31289.7 31920.8 32020.0 32214.8 32357.4 23659.0 24000.2 24098.2 24285.0 24368.0 10:15:10 INFO - PROCESS | 1668 | 10:15:10 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:32819.98 Median:24392.07 stddev:94085.13 (385.7%) stddev-sans-first:94317.45 10:15:10 INFO - PROCESS | 1668 | Values: 338.4 361.1 361.9 365.8 373.6 19298.6 19359.5 20458.5 20485.2 20485.6 12020.3 19125.0 20389.7 20405.8 20412.6 5245.1 5372.5 5416.8 5417.6 5421.1 3950.0 4137.3 5564.7 5618.9 5868.0 5842.7 5852.3 5857.8 5857.9 5864.9 5584.7 5816.4 5831.3 5837.9 5841.2 5566.9 5573.7 5584.9 5585.2 5605.2 16884.3 24008.0 24776.1 24782.8 25374.5 2068.8 2086.8 2276.1 2346.8 2675.0 9657.7 9782.1 9931.3 9946.5 10179.0 1627.4 1754.2 1762.6 1790.6 1845.8 97713.5 101841.0 102204.5 103016.5 104235.9 11269.3 11286.7 11390.9 11447.5 11575.7 13734.5 13799.6 13819.7 13831.0 13839.9 8355.2 8516.1 8535.3 8618.0 8651.0 8669.9 8685.9 8728.2 8817.3 8826.0 4427.6 4554.9 4566.0 4567.9 4575.8 1505.9 1758.0 1809.2 1862.5 1913.3 842.7 896.3 981.6 982.3 1007.5 15078.8 15568.5 19239.7 19269.9 19434.7 958.4 963.3 1004.9 1005.5 1016.0 10700.8 10987.0 11056.9 11156.3 11495.8 493602.0 526079.0 529403.0 601654.0 657037.0 118814.2 121286.0 122917.0 125636.0 126361.0 840.5 1017.2 1020.4 1062.3 1064.3 14595.6 17453.1 17500.6 17958.1 18046.2 51516.7 52511.0 54165.0 54234.5 54851.2 64063.0 67981.6 71786.0 71827.3 74768.3 7424.8 7521.4 7671.8 7755.9 8021.3 9990.7 12359.6 12468.7 12567.6 12608.6 8897.8 10818.4 10998.0 11031.7 11259.8 10781.5 10800.6 10833.6 10835.6 10972.9 10833.9 10938.1 10969.8 11145.1 11481.4 7678.4 7840.4 7873.4 7901.5 8095.4 9262.4 10087.8 10660.9 10748.5 10897.2 10:15:10 INFO - PROCESS | 1668 | 10:15:10 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6050.44 Median:5442.70 stddev:3171.77 (58.3%) stddev-sans-first:3161.96 10:15:10 INFO - PROCESS | 1668 | Values: 1468.1 1602.5 1640.7 1925.5 2043.0 8096.7 8674.7 8830.6 8843.8 8864.3 8567.4 8777.4 8787.9 8790.7 8792.1 2407.9 2429.6 2434.1 2435.3 2435.7 2448.2 2462.9 2493.6 2495.8 2515.1 2443.9 2444.6 2455.4 2465.1 2493.4 2472.1 2490.0 2501.2 2504.2 2508.2 2336.2 2365.1 2373.7 2373.8 2488.8 8524.9 8853.5 8912.3 8942.3 8948.3 5357.3 5551.1 5554.2 5555.7 5556.9 3139.8 3576.8 3644.3 3713.3 3731.9 1048.1 1071.4 1073.8 1079.4 1081.0 10006.3 11932.8 12233.4 12242.8 12255.8 3837.9 4653.8 4784.1 4793.8 4803.9 9449.2 9452.7 9455.3 9473.0 9512.0 5434.6 5434.9 5439.8 5445.6 5446.0 4415.2 4603.7 4796.4 5003.6 5063.4 3228.5 3736.0 3812.6 3819.3 3853.2 1191.8 1202.8 1204.7 1210.8 1215.4 1043.8 1061.0 1190.7 1300.1 1420.0 8073.8 8167.5 8180.5 8201.3 8444.7 1129.9 1170.4 1215.8 1221.6 1243.0 6337.2 6370.3 6416.1 6427.4 6434.5 9041.8 10402.4 10775.9 10782.7 10813.6 10063.2 10665.2 10785.8 10911.5 10913.9 8189.3 8321.4 8328.1 8349.3 8395.5 8066.5 8096.0 8153.7 8172.6 8224.5 9401.2 9528.5 9561.3 9608.7 9652.7 8816.6 9791.9 10012.5 10104.8 10114.8 7602.9 7647.0 7660.0 7750.1 7789.8 8332.5 8398.9 8416.2 8418.7 8435.4 6363.3 7426.3 7553.3 7639.2 7760.1 7289.2 7315.9 7373.3 7393.4 7416.2 7711.5 7752.8 7786.9 7800.8 7802.0 6810.5 7014.2 7074.3 7076.4 7077.5 7096.2 7161.6 7161.9 7164.4 7170.1 10:15:10 INFO - PROCESS | 1668 | 10:15:10 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5793.58 Median:6612.29 stddev:1846.00 (27.9%) stddev-sans-first:1804.22 10:15:10 INFO - PROCESS | 1668 | Values: 281.2 324.8 329.7 335.8 338.1 6555.5 6601.2 6637.9 6666.6 6730.2 6608.1 6636.4 6640.9 6648.8 6655.9 3760.5 4748.9 4760.9 4922.8 4928.5 4832.6 4857.2 4860.0 4872.2 4875.5 4346.1 4369.6 4797.2 4811.7 4814.2 4638.6 4703.8 4730.1 4736.8 4812.0 4065.3 4139.0 4160.1 4165.3 4166.5 6247.1 6335.1 6338.4 6341.5 6375.5 5742.6 5746.3 5747.2 5752.4 5758.4 7008.4 7009.5 7013.5 7028.4 7043.5 4578.6 4747.9 4749.3 4757.8 4757.9 5872.9 7564.9 7576.2 7578.5 7601.0 4864.2 4870.5 4873.4 4874.1 4882.2 4939.8 4941.3 4941.6 4947.4 4958.3 5219.3 5402.7 5859.9 5870.2 5880.3 5862.4 6391.6 6802.4 6824.7 7068.6 1688.7 1711.2 1717.4 1721.0 1722.7 961.6 1117.9 1130.1 1136.9 1145.9 5260.3 6354.6 6556.3 6580.3 6616.5 7390.7 7421.8 7443.4 7446.9 7451.3 6647.0 6654.1 6662.2 6669.6 6670.2 3875.1 3917.1 3927.5 3929.7 3932.3 7407.4 7706.9 7772.1 7780.4 7787.1 7611.7 7661.0 7667.8 7668.6 7691.0 7750.9 7751.2 7751.7 7755.2 7758.5 7379.5 7395.1 7397.5 7400.2 7400.7 7007.6 7243.3 7279.7 7292.0 7299.6 6214.9 6218.3 7674.5 7719.8 7725.6 4611.8 4667.8 4672.1 4673.9 4675.8 7336.5 7346.3 7347.2 7350.8 7371.8 6790.9 7051.6 7055.8 7057.5 7099.4 6962.3 7026.8 7030.5 7035.6 7112.8 6949.1 6954.6 6956.9 6963.2 6966.8 6868.1 7044.9 7089.1 7101.6 7130.2 6699.2 6875.2 6955.1 6980.1 6988.9 10:15:10 INFO - PROCESS | 1668 | 10:15:10 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18641.91 Median:30190.73 stddev:26709.08 (88.5%) stddev-sans-first:26750.00 10:15:10 INFO - PROCESS | 1668 | Values: 693.9 705.5 735.4 758.1 809.4 14919.4 15116.5 15144.6 15157.9 15160.3 12472.6 13873.9 13927.2 13932.4 13932.8 897.6 938.6 939.1 941.1 941.7 925.7 937.1 938.1 939.4 940.4 785.8 985.1 985.8 986.5 986.5 945.4 979.6 980.1 980.7 981.7 728.3 728.8 730.2 730.6 731.3 14620.9 14726.8 14737.3 14741.2 14741.9 12781.2 12782.7 12889.3 13017.2 13135.4 10058.7 10269.4 10295.5 10379.3 10855.3 3302.3 3494.2 3511.1 3553.6 3557.8 85572.6 86746.0 86969.6 86993.6 88160.6 8174.8 9552.2 9610.8 9759.9 9864.2 21244.0 21383.1 21407.6 21434.8 21453.2 6733.0 6834.9 7381.3 7540.4 7566.3 3927.4 4056.9 4113.3 4154.6 4159.3 3476.1 3532.6 3535.2 3536.7 3541.3 512.2 647.9 663.4 664.7 668.6 557.2 593.5 595.8 603.5 605.9 7414.1 7880.6 7961.2 8170.0 8188.8 519.6 522.3 548.3 572.1 607.8 3400.4 3467.2 3795.9 3808.1 3905.2 95704.1 96163.5 96750.5 96830.0 97074.5 81202.4 83078.2 83177.2 83257.2 83777.0 55843.2 71160.9 71838.3 71962.3 73640.6 7651.5 7797.3 7821.3 7892.3 8025.8 46612.5 50234.2 51349.5 51719.0 51900.7 56999.4 59778.0 71280.6 71587.0 71974.0 10095.7 10175.7 10491.7 10748.1 10899.8 12061.2 12189.8 12244.1 12263.3 12356.3 11196.8 11366.9 11439.5 11667.8 11755.4 11454.7 11495.1 11725.6 11901.6 12131.5 11446.6 11595.8 11733.0 12375.3 12377.2 9462.6 9651.0 9688.8 9737.7 9804.0 8867.9 9534.6 9555.1 9596.6 9706.9 10:15:10 INFO - PROCESS | 1668 | -------- Summary: end -------- 10:15:10 INFO - PROCESS | 1668 | 10:15:11 INFO - TEST-INFO | 1668: exit 0 10:15:11 INFO - TEST-OK | dromaeo_css | took 1113312ms 10:15:11 INFO - TEST-START | kraken 10:15:11 INFO - operating with platform_type : mac_ 10:15:11 INFO - Initialising browser for kraken test... 10:15:11 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpwxab1m/profile http://localhost:49270/getInfo.html) 10:15:13 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 10:15:13 INFO - PROCESS | 1677 | colorDepth:24 10:15:13 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 10:15:13 INFO - PROCESS | 1677 | __metrics 10:15:13 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:15:13 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:15:14 INFO - TEST-INFO | 1677: exit 0 10:15:14 INFO - Browser initialized. 10:15:14 INFO - Running cycle 1/1 for kraken test... 10:15:14 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpwxab1m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:26 INFO - PROCESS | 1679 | RSS: Main: 244101120 10:15:26 INFO - PROCESS | 1679 | 10:15:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:29 INFO - PROCESS | 1679 | RSS: Main: 290693120 10:15:29 INFO - PROCESS | 1679 | 10:15:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 10:15:32 INFO - PROCESS | 1679 | RSS: Main: 300564480 10:15:32 INFO - PROCESS | 1679 | 10:15:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 10:15:36 INFO - PROCESS | 1679 | RSS: Main: 288296960 10:15:36 INFO - PROCESS | 1679 | 10:15:38 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 10:15:39 INFO - PROCESS | 1679 | RSS: Main: 289972224 10:15:39 INFO - PROCESS | 1679 | 10:15:41 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:15:41 INFO - PROCESS | 1679 | RSS: Main: 290353152 10:15:41 INFO - PROCESS | 1679 | 10:15:44 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 10:15:45 INFO - PROCESS | 1679 | RSS: Main: 290619392 10:15:45 INFO - PROCESS | 1679 | 10:15:47 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 10:15:48 INFO - PROCESS | 1679 | RSS: Main: 290451456 10:15:48 INFO - PROCESS | 1679 | 10:15:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 10:15:51 INFO - PROCESS | 1679 | RSS: Main: 291168256 10:15:51 INFO - PROCESS | 1679 | 10:15:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:15:53 INFO - PROCESS | 1679 | RSS: Main: 322850816 10:15:53 INFO - PROCESS | 1679 | 10:15:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:15:56 INFO - PROCESS | 1679 | RSS: Main: 322772992 10:15:56 INFO - PROCESS | 1679 | 10:15:58 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:15:59 INFO - PROCESS | 1679 | RSS: Main: 331796480 10:15:59 INFO - PROCESS | 1679 | 10:16:01 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:02 INFO - PROCESS | 1679 | RSS: Main: 334778368 10:16:02 INFO - PROCESS | 1679 | 10:16:04 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:05 INFO - PROCESS | 1679 | RSS: Main: 333164544 10:16:05 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 10:16:07 INFO - PROCESS | 1679 | RSS: Main: 394301440 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | __start_tp_report 10:16:07 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 10:16:07 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 10:16:07 INFO - PROCESS | 1679 | |i|pagename|runs| 10:16:07 INFO - PROCESS | 1679 | |0;ai-astar;114;108;111;111;111;112;116;108;111;111 10:16:07 INFO - PROCESS | 1679 | |1;audio-beat-detection;156;119;150;195;152;141;139;122;194;147 10:16:07 INFO - PROCESS | 1679 | |2;audio-dft;184;183;184;184;198;232;182;185;179;182 10:16:07 INFO - PROCESS | 1679 | |3;audio-fft;73;76;100;76;55;56;56;76;76;54 10:16:07 INFO - PROCESS | 1679 | |4;audio-oscillator;96;92;130;81;78;86;112;78;79;110 10:16:07 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;89;86;88;86;88;85;89;85;88;84 10:16:07 INFO - PROCESS | 1679 | |6;imaging-darkroom;92;93;93;93;94;93;93;94;94;92 10:16:07 INFO - PROCESS | 1679 | |7;imaging-desaturate;87;87;88;85;87;87;89;87;87;87 10:16:07 INFO - PROCESS | 1679 | |8;json-parse-financial;56;55;53;51;52;53;54;62;55;51 10:16:07 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;63;64;74;75;70;66;66;66;68;68 10:16:07 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;83;83;83;84;80;80;82;85;85 10:16:07 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;130;138;134;119;122;121;128;128;108;133 10:16:07 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;139;127;136;138;136;119;136;138;137;138 10:16:07 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;67;70;66;67;67;67;68;67;66 10:16:07 INFO - PROCESS | 1679 | __end_tp_report 10:16:07 INFO - PROCESS | 1679 | __start_cc_report 10:16:07 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1219 10:16:07 INFO - PROCESS | 1679 | __end_cc_report 10:16:07 INFO - PROCESS | 1679 | __startTimestamp1458234967270__endTimestamp 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | ------- Summary: start ------- 10:16:07 INFO - PROCESS | 1679 | Number of tests: 14 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:2.41 (2.2%) stddev-sans-first:2.35 10:16:07 INFO - PROCESS | 1679 | Values: 114.0 108.0 111.0 111.0 111.0 112.0 116.0 108.0 111.0 111.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:151.00 stddev:25.68 (17.0%) stddev-sans-first:27.18 10:16:07 INFO - PROCESS | 1679 | Values: 156.0 119.0 150.0 195.0 152.0 141.0 139.0 122.0 194.0 147.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:189.30 Median:184.00 stddev:15.83 (8.6%) stddev-sans-first:16.67 10:16:07 INFO - PROCESS | 1679 | Values: 184.0 183.0 184.0 184.0 198.0 232.0 182.0 185.0 179.0 182.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:69.80 Median:74.50 stddev:14.63 (19.6%) stddev-sans-first:15.47 10:16:07 INFO - PROCESS | 1679 | Values: 73.0 76.0 100.0 76.0 55.0 56.0 56.0 76.0 76.0 54.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:80.00 stddev:17.81 (22.3%) stddev-sans-first:18.87 10:16:07 INFO - PROCESS | 1679 | Values: 96.0 92.0 130.0 81.0 78.0 86.0 112.0 78.0 79.0 110.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:88.00 stddev:1.81 (2.1%) stddev-sans-first:1.74 10:16:07 INFO - PROCESS | 1679 | Values: 89.0 86.0 88.0 86.0 88.0 85.0 89.0 85.0 88.0 84.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 10:16:07 INFO - PROCESS | 1679 | Values: 92.0 93.0 93.0 93.0 94.0 93.0 93.0 94.0 94.0 92.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:87.10 Median:87.00 stddev:0.99 (1.1%) stddev-sans-first:1.05 10:16:07 INFO - PROCESS | 1679 | Values: 87.0 87.0 88.0 85.0 87.0 87.0 89.0 87.0 87.0 87.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:3.22 (5.9%) stddev-sans-first:3.35 10:16:07 INFO - PROCESS | 1679 | Values: 56.0 55.0 53.0 51.0 52.0 53.0 54.0 62.0 55.0 51.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:3.97 (5.8%) stddev-sans-first:3.78 10:16:07 INFO - PROCESS | 1679 | Values: 63.0 64.0 74.0 75.0 70.0 66.0 66.0 66.0 68.0 68.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.75 (2.1%) stddev-sans-first:1.86 10:16:07 INFO - PROCESS | 1679 | Values: 83.0 83.0 83.0 83.0 84.0 80.0 80.0 82.0 85.0 85.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:129.00 stddev:8.79 (6.8%) stddev-sans-first:9.21 10:16:07 INFO - PROCESS | 1679 | Values: 130.0 138.0 134.0 119.0 122.0 121.0 128.0 128.0 108.0 133.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.40 Median:137.50 stddev:6.38 (4.6%) stddev-sans-first:6.55 10:16:07 INFO - PROCESS | 1679 | Values: 139.0 127.0 136.0 138.0 136.0 119.0 136.0 138.0 137.0 138.0 10:16:07 INFO - PROCESS | 1679 | 10:16:07 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 10:16:07 INFO - PROCESS | 1679 | Values: 68.0 67.0 70.0 66.0 67.0 67.0 67.0 68.0 67.0 66.0 10:16:07 INFO - PROCESS | 1679 | -------- Summary: end -------- 10:16:07 INFO - PROCESS | 1679 | 10:16:08 INFO - TEST-INFO | 1679: exit 0 10:16:08 INFO - TEST-OK | kraken | took 56591ms 10:16:08 INFO - SUITE-END | took 1169s 10:16:08 INFO - Completed test suite (00:19:30) 10:16:08 INFO - javascript benchmark 10:16:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3365.781224220426, 3396.541466901969, 3458.308338332334, 3479.0432631026474, 3512.3326567952085, 5493.7802487900535, 5556.9444305556935, 5570.554355651549, 5570.610057295991, 5598.1322894951245, 5527.613067085305, 5578.665280083198, 5579.05156123459, 5579.414161513044, 5588.972055139729, 5054.039732450841, 5064.468230835764, 5083.3391659084455, 5102.974485127587, 5150.716710580917, 5140.640155189139, 5152.665076770017, 5154.175331946889, 5155.974220128913, 5166.715830629314, 5068.46781087986, 5109.029284435946, 5135.460776618457, 5139.177731562951, 5156.974215128919, 5081.339425874631, 5128.0, 5129.999650068238, 5138.845834624967, 5175.560077393426, 4917.114919314522, 5008.323876276729, 5019.498050194988, 5047.545720885101, 5058.949410505885, 5422.593305502063, 5458.890822183574, 5469.589780766459, 5476.342838859362, 5577.247071645357, 6021.668808215546, 6083.30042045166, 6084.817455476343, 6108.205933228696, 6115.4190351916495, 5089.236614507817, 5766.106253530709, 6000.939990600082, 6039.456448919618, 6142.069075791497, 5586.581006424493, 5590.664560126405, 5595.0, 5610.579206559524, 5652.830415087554, 6169.784057558054, 6210.658413787195, 6227.782027629102, 6235.532335074888, 6249.000159974382, 5749.108888122348, 5852.590318677737, 5941.940580594225, 5984.102384642251, 6037.00389435747, 6121.133381598927, 6148.354422785633, 6154.046122850965, 6180.6291622502795, 6189.721462534197, 6072.240969878765, 6072.939270607326, 6091.208142941389, 6106.267247930188, 6122.0, 5050.9494905051215, 5923.851903702442, 6014.939850601438, 6073.757049717962, 6142.0, 4138.52406973202, 4832.855014349575, 4834.879128021757, 4836.758162091952, 4845.055214233191, 3939.665128464055, 4237.512686041083, 4379.9781001095425, 4382.517923028464, 4409.3606427068535, 5471.972640136773, 5490.313710786152, 5575.052241118939, 5582.24639673647, 5606.1590761385305, 6122.66325352101, 6159.81520554384, 6162.075688646739, 6166.1983942087245, 6205.6586887720705, 5483.75323110461, 5522.144067669517, 5531.529819965348, 5531.557475401958, 5549.1676248563035, 5158.38099428071, 5205.765740541685, 5241.318628578337, 5276.261323414725, 5311.521963023347, 6273.0094204740935, 6296.968515157487, 6315.179026726496, 6317.5893566918, 6337.0, 6149.2313460817395, 6152.261728592419, 6165.321814600301, 6183.134361189347, 6201.56589038781, 6108.0688921796145, 6232.937670623236, 6309.0, 6337.904931426125, 6346.809595712136, 5895.64626122434, 5900.616459930091, 5911.113333000085, 5917.881642367042, 5960.552958528041, 5760.0, 5972.671503067199, 6039.0, 6047.909281360695, 6052.546059045501, 5894.115882617471, 5944.940550594439, 5956.821295361146, 5959.791407300723, 6023.909641355295, 5870.471657550841, 5895.616784908967, 5898.616589921641, 5901.468867801918, 5903.970480147572, 5625.296837895263, 5701.945140149086, 5754.251947246831, 5756.165356023437, 5769.567282453749, 5858.794942177004, 5869.119632055226, 5882.794102206402, 5904.586678932434, 5941.405859414024, 4776.546228108324, 5754.309482862083, 5757.65454072757, 5759.596828221985, 5761.48146666802], "unit": "score", "name": "dojo.html", "value": 5549.18159374943}, {"lowerIsBetter": false, "replicates": [497.14242930944147, 515.3120584020332, 537.6344086021505, 575.2435547255359, 607.7389416959808, 31192.22019449515, 38299.42550861736, 38607.420888686625, 38615.8415247543, 38658.42012369817, 40997.18005639885, 41389.0, 41441.792791036, 41462.792686036606, 41481.792591037, 8538.402311838174, 9744.171745401614, 9752.609895604168, 9778.07108324708, 9812.852807207897, 9454.90545094547, 9603.567839447207, 9610.327277090606, 9618.567164477581, 9748.610055597768, 9712.174465170468, 9778.168855647244, 9790.90209097907, 9807.215422766198, 9818.803623927553, 9676.516174191298, 9758.024197580256, 9759.975202603766, 9771.071748183911, 9801.852972205423, 9559.426434413888, 9676.225901927828, 9681.322307438482, 9690.563924623339, 9696.61213551464, 39180.60819391798, 39759.8012009941, 39805.20389592192, 39896.0, 39956.600433995576, 3230.1924518870283, 3241.38413701396, 3293.176705823544, 3304.454764963778, 3510.1926556891804, 27359.316017099532, 27703.86148069267, 27982.580261296098, 28378.716212837815, 28495.57256641152, 2660.255128564005, 2702.9053983110693, 2786.7770578353684, 2829.8585070746585, 2920.0217926994483, 387540.0622996895, 390677.0466147679, 391091.0445447783, 391916.0, 393074.0, 45130.77434612872, 63782.36217637764, 64096.03855942165, 67952.30119247058, 68103.97844032344, 36890.0, 44511.55488445139, 44600.776996114815, 44715.329270060975, 44771.0, 15965.600859978362, 16178.0, 16209.67580648404, 16213.756793648105, 16219.35122595083, 12964.416601252966, 12965.870341296466, 12969.157004794659, 12972.416241269166, 12974.35128243584, 13435.596932092052, 14599.635009124857, 14620.342084606218, 14633.560993170222, 14643.267836608127, 6327.145835312266, 6415.967920160369, 6425.485961123099, 6439.388258115471, 6470.935290647033, 950.7718147644515, 1007.0533698323552, 1024.3751311699857, 1047.570496096612, 1048.2819268800743, 28904.98832540893, 29212.707872920997, 29439.678231063433, 29665.0, 29669.703302967126, 1102.6030628973563, 1116.5980247111033, 1127.6278827986744, 1226.1233218248994, 1246.731952630189, 12463.252204867737, 14768.704625907421, 14776.749115194854, 15092.320845561977, 15122.848771512365, 523933.0, 526662.0, 529139.0, 529194.0, 529498.0, 56492.43507564954, 58596.0, 58681.0, 58756.824863502494, 58818.41181588215, 1252.4489224741085, 1372.540199033335, 1433.4696162419764, 1456.7741999989807, 1475.2181343887758, 26759.866200668872, 28387.71612283851, 28510.42979140364, 29143.7085629141, 29353.55969660414, 44457.11085778331, 44548.33177502275, 44765.77617111894, 44796.0, 44839.103217936114, 306449.0, 307974.0, 308532.0, 308681.0, 309047.0, 28131.859340703166, 32235.838820805748, 32530.0, 33139.005829825146, 33259.66961321617, 40901.18197635971, 41545.0, 41728.791356043024, 42072.94817629584, 42442.5755742451, 33831.4925276126, 34166.487502686985, 34363.65636343705, 34929.65070349366, 35068.64931350756, 34510.96467105991, 34532.48201277033, 35076.82461587676, 35272.0, 35391.11522211965, 34949.65050349464, 35188.82405587956, 35569.28861422705, 35918.640813591526, 36194.0, 31289.687103128676, 31920.8403957988, 32020.039398818073, 32214.83892580522, 32357.35285294328, 23659.0, 24000.159994400114, 24098.15656452016, 24285.0, 24368.02527898935], "unit": "score", "name": "ext.html", "value": 18638.01920576459}, {"lowerIsBetter": false, "replicates": [338.3976521791211, 361.13868423809225, 361.91856832212756, 365.76773748669586, 373.5592001438302, 19298.622741020317, 19359.516012099688, 20458.48853778656, 20485.18059277631, 20485.590288194227, 12020.27878327301, 19125.0, 20389.694154587694, 20405.795942040575, 20412.59174816503, 5245.082110630634, 5372.489613486732, 5416.837494875141, 5417.6478528895495, 5421.051316019701, 3950.0, 4137.338025915854, 5564.693941833198, 5618.943810561904, 5868.0, 5842.737076831553, 5852.268466441695, 5857.824265272027, 5857.912131318034, 5864.912026319587, 5584.720763961806, 5816.360200377976, 5831.271091113611, 5837.912431313492, 5841.182234487154, 5566.888662226774, 5573.749181286852, 5584.888302233973, 5585.162225666142, 5605.159226116074, 16884.324627014903, 24008.0, 24776.132835350858, 24782.752172478224, 25374.492510149877, 2068.800095944364, 2086.7704552499213, 2276.112316196668, 2346.77705617966, 2675.0102462089153, 9657.71026869195, 9782.070703283247, 9931.304808663397, 9946.452945088018, 10179.03299186576, 1627.3653275222673, 1754.1580041579984, 1762.5505496098542, 1790.64187162568, 1845.7508236388185, 97713.51143244309, 101840.98159018389, 102204.48897755537, 103016.48491757568, 104235.9152816947, 11269.323840569592, 11286.66140015801, 11390.943045284886, 11447.484863181176, 11575.652730418102, 13734.519291824738, 13799.586012419644, 13819.723605527834, 13830.962677799003, 13839.861601383856, 8355.206255405727, 8516.06323304436, 8535.317174626016, 8618.0, 8651.0, 8669.869951950726, 8685.913140868637, 8728.214460698568, 8817.250533704579, 8825.955870220736, 4427.6236519896165, 4554.908901821945, 4565.9954809941755, 4567.862964111016, 4575.839845605387, 1505.9472918447802, 1757.9912100439417, 1809.194908265809, 1862.4598866328613, 1913.2920819296949, 842.6713581703141, 896.2829736211005, 981.5779214937645, 982.2829334585792, 1007.5415685863061, 15078.849211507964, 15568.455104071303, 19239.711404328948, 19269.940153291704, 19434.70847937282, 958.4105774948496, 963.349738926222, 1004.914582260516, 1005.527402121002, 1015.9992407478628, 10700.78598428027, 10987.011168994828, 11056.87331267872, 11156.330620162817, 11495.77008459843, 493602.0, 526079.0, 529403.0, 601654.0, 657037.0, 118814.21778673326, 121286.0, 122917.0, 125636.0, 126361.0, 840.4663038970176, 1017.1913328903539, 1020.3724709303725, 1062.2511129653576, 1064.297563608015, 14595.635109122357, 17453.066488108827, 17500.649986999935, 17958.10209489494, 18046.1879215433, 51516.74241628918, 52511.0, 54165.0, 54234.45765542452, 54851.17723234234, 64063.03905441329, 67981.64036719337, 71786.0, 71827.28172718205, 74768.25231747613, 7424.814379640552, 7521.435892308208, 7671.808204794702, 7755.883661745192, 8021.27808497238, 9990.700278991642, 12359.62921112368, 12468.688282793002, 12567.617562067982, 12608.621741347773, 8897.777555561162, 10818.404987725751, 10998.0, 11031.72420689457, 11259.831102533304, 10781.460926953465, 10800.567977280822, 10833.620823271147, 10835.620753273597, 10972.890271097505, 10833.945830270799, 10938.070264027647, 10969.835452468378, 11145.108391328837, 11481.36852473122, 7678.424118191269, 7840.411969102454, 7873.448858579844, 7901.525908445512, 8095.392845536726, 9262.39794413361, 10087.848682269918, 10660.933906609587, 10748.516316765921, 10897.237193396386], "unit": "score", "name": "jquery.html", "value": 9185.412929285814}, {"lowerIsBetter": false, "replicates": [1468.067776961629, 1602.5112340736077, 1640.745684418915, 1925.499370163757, 2043.0397713074858, 8096.6761329546825, 8674.739757807269, 8830.646774129043, 8843.823123537526, 8864.290856731463, 8567.357448191395, 8777.429467084636, 8787.868181977276, 8790.6923257686, 8792.120787921205, 2407.9398015049633, 2429.6112621980487, 2434.1237154624323, 2435.305937807725, 2435.7320694723653, 2448.192096608124, 2462.9261122166363, 2493.551160791057, 2495.7753802157804, 2515.1448507507444, 2443.9389015274674, 2444.559979203743, 2455.373879660684, 2465.1125594785863, 2493.364192131013, 2472.134752836511, 2489.962650560243, 2501.162110692911, 2504.211173480366, 2508.184839927031, 2336.19401306549, 2365.113082594027, 2373.738888722239, 2373.8338316317863, 2488.8382255153356, 8524.8721269181, 8853.468791872443, 8912.287017038621, 8942.329325300563, 8948.328875334311, 5357.276767636358, 5551.1118221084835, 5554.222408862763, 5555.749991250404, 5556.91664625031, 3139.780215384924, 3576.8032758198287, 3644.344018076745, 3713.2733279025383, 3731.869384571527, 1048.1457612046158, 1071.4482041748506, 1073.812082885492, 1079.4171147580298, 1080.9891901081046, 10006.349587276804, 11932.821007684892, 12233.449494772756, 12242.75514489714, 12255.75488490234, 3837.9232415351535, 4653.767311634405, 4784.091022705675, 4793.808247670054, 4803.879903002453, 9449.244060475283, 9452.669156579486, 9455.29085318604, 9473.005334439784, 9512.001239869853, 5434.646747961449, 5434.8913021739345, 5439.830436456181, 5445.564354851603, 5445.992491389105, 4415.249407600716, 4603.700759450625, 4796.400449943757, 5003.574696150795, 5063.417706963673, 3228.4834426491648, 3735.9626403736156, 3812.637799409107, 3819.25524522721, 3853.2293541291856, 1191.8212268159673, 1202.7834989701762, 1204.6867814368327, 1210.7699537087924, 1215.3740823475916, 1043.7547176413536, 1060.9628662996759, 1190.743990042145, 1300.1029289790015, 1419.9858001419855, 8073.7577872663915, 8167.509949403055, 8180.509169449852, 8201.30288925436, 8444.746657600283, 1129.949152288149, 1170.3680012792997, 1215.7933151364289, 1221.5968730318973, 1243.0, 6337.207849018872, 6370.299267080617, 6416.13382193398, 6427.421532062137, 6434.517411194179, 9041.77395565116, 10402.427866467417, 10775.94612026935, 10782.73043173927, 10813.56745730162, 10063.19494440443, 10665.200109991627, 10785.78428431427, 10911.454427278604, 10913.945430272797, 8189.26296633294, 8321.417500774887, 8328.125546817497, 8349.33205343571, 8395.454295470774, 8066.516009039477, 8096.0, 8153.673853046049, 8172.550509721785, 8224.547649879314, 9401.153896149106, 9528.523573821143, 9561.282903782105, 9608.66369677058, 9652.662156824477, 8816.647334106821, 9791.853122203314, 10012.499375031364, 10104.84842727345, 10114.797704046025, 7602.885956710543, 7647.044119485065, 7660.0, 7750.0699916010435, 7789.805254868447, 8332.541710205996, 8398.916010839814, 8416.158384161536, 8418.705345312885, 8435.367347448842, 6363.268224154096, 7426.2945020223, 7553.282438168365, 7639.197884222077, 7760.146383897654, 7289.161746399232, 7315.939188817698, 7373.262673732798, 7393.408527317694, 7416.221296763762, 7711.460197786101, 7752.7674169775, 7786.883196752166, 7800.765977020698, 7801.9857418537495, 6810.523263371517, 7014.158301003912, 7074.257202993817, 7076.398506126831, 7077.469189810888, 7096.219415864148, 7161.57030578167, 7161.928380716126, 7164.426845852424, 7170.139583250043], "unit": "score", "name": "mootools.html", "value": 4935.756179952304}, {"lowerIsBetter": false, "replicates": [281.2280290602297, 324.79537891128587, 329.69503209531194, 335.7968429100394, 338.14786737421684, 6555.541112122153, 6601.207855057394, 6637.900431493532, 6666.566673166247, 6730.158730158731, 6608.074869518271, 6636.402723754861, 6640.904250798612, 6648.800535983928, 6655.90016149757, 3760.52993375828, 4748.857534273978, 4760.880977975544, 4922.753862306889, 4928.531789479994, 4832.565069143777, 4857.198562237244, 4859.975700121495, 4872.196087645534, 4875.536824001714, 4346.109047645241, 4369.6285815705705, 4797.160496913044, 4811.687240329367, 4814.1575224335775, 4638.628909687234, 4703.764811759433, 4730.101280756645, 4736.7631618418945, 4811.951880481203, 4065.26825171469, 4138.979305103485, 4160.063985603245, 4165.271077561445, 4166.541680415152, 6247.094171345129, 6335.144755458, 6338.397852204033, 6341.460975817061, 6375.489960803125, 5742.569307301927, 5746.310442746855, 5747.195392645033, 5752.424757524256, 5758.42415758425, 7008.404285635676, 7009.509334346598, 7013.473989450812, 7028.367446929749, 7043.471739619497, 4578.633709303248, 4747.8575642730775, 4749.26386410107, 4757.78589963449, 4757.857264282077, 5872.941270587282, 7564.886526702104, 7576.204498527631, 7578.545287282725, 7601.011868457121, 4864.246041863446, 4870.488598697157, 4873.415190177201, 4874.073925954058, 4882.218844984785, 4939.75301234944, 4941.2835138905375, 4941.579965702884, 4947.381577302837, 4958.256261560723, 5219.269302297681, 5402.730358365781, 5859.912101318484, 5870.207521984477, 5880.26496687914, 5862.443067908542, 6391.58454700443, 6802.421794147553, 6824.727010919607, 7068.646567671596, 1688.72136097545, 1711.2213942656062, 1717.4246627379719, 1720.9741853872201, 1722.6554689062239, 961.6345788600287, 1117.8546788917552, 1130.112861403794, 1136.86926003509, 1145.8624965004253, 5260.342457192851, 6354.618722876642, 6556.27880933097, 6580.276169621337, 6616.503762217853, 7390.6674199660065, 7421.777346679608, 7443.404527637776, 7446.925530744732, 7451.3293803557945, 6647.0, 6654.068430419745, 6662.167229096363, 6669.599824010575, 6670.166229221348, 3875.147467557133, 3917.138229589486, 3927.4697915781576, 3929.724919255682, 3932.311845427039, 7407.407407407394, 7706.921031055656, 7772.067351917806, 7780.377569794403, 7787.06555213378, 7611.65747541362, 7661.004069471044, 7667.846643067108, 7668.578228197391, 7691.0, 7750.883736743954, 7751.224877512316, 7751.689932402641, 7755.185705500954, 7758.456908016385, 7379.483436159418, 7395.112586489656, 7397.482176247611, 7400.222976587381, 7400.740974065882, 7007.649617519206, 7243.348098671145, 7279.672414741455, 7291.979122922901, 7299.598522081336, 6214.875702485834, 6218.253809542884, 7674.53952762836, 7719.845603088019, 7725.613719313899, 4611.815527378867, 4667.836625718083, 4672.135654903717, 4673.883152921204, 4675.789589468414, 7336.486445948733, 7346.302101300368, 7347.19180890091, 7350.77947661571, 7371.778846634395, 6790.898136527857, 7051.612161330971, 7055.823604409931, 7057.470689698396, 7099.396551293198, 6962.3037696231995, 7026.754063607749, 7030.50786444944, 7035.648217589202, 7112.786616401516, 6949.131358580177, 6954.617496037564, 6956.930430695628, 6963.1644202696, 6966.79099627012, 6868.107146070979, 7044.894326585208, 7089.113860767404, 7101.644917754195, 7130.18002929649, 6699.196096468455, 6875.209350924508, 6955.095837541289, 6980.127484064492, 6988.930110698828], "unit": "score", "name": "prototype.html", "value": 5178.207646408419}, {"lowerIsBetter": false, "replicates": [693.882040053191, 705.4708968273794, 735.393300527065, 758.0865057605586, 809.3929552835372, 14919.403223871032, 15116.546503604883, 15144.621384465394, 15157.924210378946, 15160.317785699643, 12472.563460278892, 13873.930630346835, 13927.164370137798, 13932.373043213054, 13932.791008134885, 897.5646811296516, 938.6104766521885, 939.0843927171022, 941.0636416765294, 941.6515889121035, 925.7176561148847, 937.1471960515931, 938.0713094036888, 939.4269495607674, 940.407543247753, 785.8114052627385, 985.0543478260843, 985.8373368394207, 986.4673076538696, 986.5264672956985, 945.3902233059672, 979.603260679426, 980.1374790184664, 980.7253968888723, 981.7349315684761, 728.2862794461457, 728.8032231297573, 730.2441972558377, 730.6346826586706, 731.3125661877817, 14620.853791462161, 14726.779098313535, 14737.336819843133, 14741.189234592093, 14741.926290368587, 12781.16922400041, 12782.744345113138, 12889.291088990101, 13017.15388499754, 13135.408906599227, 10058.748531286703, 10269.435181065039, 10295.536700848479, 10379.273450858444, 10855.348679079281, 3302.3230237801195, 3494.196334842975, 3511.0520159556777, 3553.6446355364515, 3557.7509574329806, 85572.57213713892, 86746.0, 86969.56515217383, 86993.56503217507, 88160.55919720425, 8174.754757357289, 9552.188064014637, 9610.807783844424, 9759.902400976041, 9864.161546268648, 21244.0, 21383.144674213167, 21407.571848563253, 21434.78565214328, 21453.249136280156, 6732.966335168293, 6834.931650683429, 7381.335679788737, 7540.396768258526, 7566.31903128721, 3927.430522574268, 4056.8782936511952, 4113.259613269581, 4154.584541545822, 4159.292920203573, 3476.0788391076385, 3532.593751718534, 3535.2045789697113, 3536.734744894143, 3541.327147841902, 512.2469969145351, 647.9449246813979, 663.3797399431547, 664.727461740684, 668.6155460610169, 557.2310211907542, 593.5281451246269, 595.779561562216, 603.4508597176548, 605.9363766804511, 7414.147373052168, 7880.64537095832, 7961.203879612109, 8170.0, 8188.836223275501, 519.5531842615347, 522.3314157877923, 548.2516365161525, 572.1275055540251, 607.7963882099458, 3400.432673331619, 3467.202543414978, 3795.905102372463, 3808.067023579241, 3905.2384784966657, 95704.08591828124, 96163.51918240504, 96750.54874176893, 96830.0, 97074.51462742641, 81202.37595248062, 83078.16921830825, 83177.16822831816, 83257.16742832615, 83777.0, 55843.162352564745, 71160.93258601124, 71838.2816171842, 71962.28037719765, 73640.63179684067, 7651.502652327581, 7797.337226335825, 7821.296083352298, 7892.250236227549, 8025.761950434245, 46612.53387466218, 50234.24648630201, 51349.48650513597, 51719.0, 51900.74049629728, 56999.43000569941, 59778.0, 71280.64359678168, 71587.0, 71974.0, 10095.697129086138, 10175.694729158136, 10491.68524944253, 10748.140148787921, 10899.836502452628, 12061.155719099579, 12189.75620487603, 12244.142909996215, 12263.26420414778, 12356.320402377956, 11196.776064478829, 11366.943165284121, 11439.499304589643, 11667.76664466689, 11755.412229388325, 11454.656360309204, 11495.080393568662, 11725.648230553097, 11901.583444579399, 12131.454084566392, 11446.599369022044, 11595.8260626089, 11733.00269477104, 12375.257484550955, 12377.195482293622, 9462.621495140118, 9651.0, 9688.806223875343, 9737.707868763948, 9803.950980245338, 8867.911320886966, 9534.618615255313, 9555.140037396668, 9596.568154432927, 9706.9029309706], "unit": "score", "name": "yui.html", "value": 6928.453702307832}], "name": "dromaeo_css", "value": 7429.990426940357}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 111.0, 111.0, 111.0, 112.0, 116.0, 108.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [156.0, 119.0, 150.0, 195.0, 152.0, 141.0, 139.0, 122.0, 194.0, 147.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [184.0, 183.0, 184.0, 184.0, 198.0, 232.0, 182.0, 185.0, 179.0, 182.0], "unit": "score", "name": "audio-dft", "value": 189.3}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 100.0, 76.0, 55.0, 56.0, 56.0, 76.0, 76.0, 54.0], "unit": "score", "name": "audio-fft", "value": 69.8}, {"lowerIsBetter": true, "replicates": [96.0, 92.0, 130.0, 81.0, 78.0, 86.0, 112.0, 78.0, 79.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 88.0, 86.0, 88.0, 85.0, 89.0, 85.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 88.0, 85.0, 87.0, 87.0, 89.0, 87.0, 87.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 87.1}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 53.0, 51.0, 52.0, 53.0, 54.0, 62.0, 55.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 74.0, 75.0, 70.0, 66.0, 66.0, 66.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 84.0, 80.0, 80.0, 82.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [130.0, 138.0, 134.0, 119.0, 122.0, 121.0, 128.0, 128.0, 108.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [139.0, 127.0, 136.0, 138.0, 136.0, 119.0, 136.0, 138.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1415.9}]} 10:16:08 INFO - Return code: 0 10:16:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:16:08 ERROR - # TBPL SUCCESS # 10:16:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:08 INFO - 2016-03-17 10:16:08.588 screenresolution[1683:9922] starting screenresolution argv=screenresolution get 10:16:08 INFO - 2016-03-17 10:16:08.590 screenresolution[1683:9922] Display 0: 1600x1200x32@60 10:16:08 INFO - 2016-03-17 10:16:08.596 screenresolution[1684:9925] starting screenresolution argv=screenresolution list 10:16:08 INFO - Available Modes on Display 0 10:16:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:08 INFO - Intel Iris: 10:16:08 INFO - Chipset Model: Intel Iris 10:16:08 INFO - Type: GPU 10:16:08 INFO - Bus: Built-In 10:16:08 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:08 INFO - Vendor: Intel (0x8086) 10:16:08 INFO - Device ID: 0x0a2e 10:16:08 INFO - Revision ID: 0x0009 10:16:08 INFO - Displays: 10:16:08 INFO - Display: 10:16:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:08 INFO - Display Serial Number: 1600x1200 60 10:16:08 INFO - Main Display: Yes 10:16:08 INFO - Mirror: Off 10:16:08 INFO - Online: Yes 10:16:08 INFO - Rotation: Supported 10:16:08 INFO - Return code: 0 10:16:08 INFO - Running post-action listener: _resource_record_post_action 10:16:08 INFO - Running post-run listener: _resource_record_post_run 10:16:09 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39056896; Write bytes: 704390144; Read time: 423; Write time: 2159 10:16:09 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402534912; Write bytes: 403920384; Read time: 30362; Write time: 951 10:16:09 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37242368; Write bytes: 299462144; Read time: 403; Write time: 1204 10:16:09 INFO - Running post-run listener: _upload_blobber_files 10:16:09 INFO - Blob upload gear active. 10:16:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:09 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 10:16:09 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:16:09 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:16:10 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:11 INFO - (blobuploader) - INFO - Done attempting. 10:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:12 INFO - (blobuploader) - INFO - Done attempting. 10:16:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:16:12 INFO - Return code: 0 10:16:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:16:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:16:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f41d72d47805aa9621f30661847c97b2bdfcff4c9462ce7f6fc84ae3cadbe35d6ccd409abe6986c4459b3ca4308ee2b92fd3184bf385f23a503dd85a7664a78e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/358e79c2edaee3e06e6cae23fd825950b342578fefcb1e81a094f107e40b4730947fc4975dad257e7a64a3252b273ac337113b3d91cad032e3a10e05cc61ecc2"} 10:16:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:16:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:16:12 INFO - Contents: 10:16:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f41d72d47805aa9621f30661847c97b2bdfcff4c9462ce7f6fc84ae3cadbe35d6ccd409abe6986c4459b3ca4308ee2b92fd3184bf385f23a503dd85a7664a78e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/358e79c2edaee3e06e6cae23fd825950b342578fefcb1e81a094f107e40b4730947fc4975dad257e7a64a3252b273ac337113b3d91cad032e3a10e05cc61ecc2"} 10:16:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:16:12 INFO - Copying logs to upload dir... 10:16:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:16:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.547067 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-17 10:16:12.190703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 10:16:12.194236) ========= 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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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/Firefox/sha512/f41d72d47805aa9621f30661847c97b2bdfcff4c9462ce7f6fc84ae3cadbe35d6ccd409abe6986c4459b3ca4308ee2b92fd3184bf385f23a503dd85a7664a78e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/358e79c2edaee3e06e6cae23fd825950b342578fefcb1e81a094f107e40b4730947fc4975dad257e7a64a3252b273ac337113b3d91cad032e3a10e05cc61ecc2"} build_url:https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/b4JL2iMHR5iZIwZMTWrHAw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f41d72d47805aa9621f30661847c97b2bdfcff4c9462ce7f6fc84ae3cadbe35d6ccd409abe6986c4459b3ca4308ee2b92fd3184bf385f23a503dd85a7664a78e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/358e79c2edaee3e06e6cae23fd825950b342578fefcb1e81a094f107e40b4730947fc4975dad257e7a64a3252b273ac337113b3d91cad032e3a10e05cc61ecc2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 10:16:12.229765) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:16:12.234991) ========= 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.4ey3SI7BBl/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.CKSUBhzb2e/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005116 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:16:12.283481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 10:16:12.283777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 10:16:12.284119) ========= ========= Total master_lag: 0.27 =========