builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0086 starttime: 1454954843.18 results: success (0) buildid: 20160208081603 builduid: cd87b512e33d4ac8ba0d6d38e2f5eecf revision: c57d2020f884e9bfe19a626329faa7da3bd92d79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:23.176759) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:23.177118) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:23.177395) ========= 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.w0BTe3cpRR/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.2jB91Vei3B/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005755 basedir: '/builds/slave/test' ========= master_lag: 0.58 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:23.763671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-02-08 10:07:23.763957) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-02-08 10:07:30.189075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:30.189364) ========= 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.w0BTe3cpRR/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.2jB91Vei3B/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005583 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:30.383161) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:30.383449) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:30.383790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-08 10:07:30.384076) ========= 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.w0BTe3cpRR/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.2jB91Vei3B/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-08 10:07:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 218M=0s 2016-02-08 10:07:31 (218 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.540678 ========= master_lag: 0.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-08 10:07:31.475782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:31.476071) ========= 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.w0BTe3cpRR/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.2jB91Vei3B/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.019803 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:31.526025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-08 10:07:31.526344) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c57d2020f884e9bfe19a626329faa7da3bd92d79 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c57d2020f884e9bfe19a626329faa7da3bd92d79 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w0BTe3cpRR/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.2jB91Vei3B/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-08 10:07:31,596 truncating revision to first 12 chars 2016-02-08 10:07:31,596 Setting DEBUG logging. 2016-02-08 10:07:31,596 attempt 1/10 2016-02-08 10:07:31,596 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c57d2020f884?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 10:07:32,386 unpacking tar archive at: fx-team-c57d2020f884/testing/mozharness/ program finished with exit code 0 elapsedTime=1.096274 ========= master_lag: 4.61 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-08 10:07:37.230863) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:37.231213) ========= echo c57d2020f884e9bfe19a626329faa7da3bd92d79 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c57d2020f884e9bfe19a626329faa7da3bd92d79'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w0BTe3cpRR/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.2jB91Vei3B/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 c57d2020f884e9bfe19a626329faa7da3bd92d79 program finished with exit code 0 elapsedTime=0.005184 script_repo_revision: 'c57d2020f884e9bfe19a626329faa7da3bd92d79' ========= master_lag: 0.83 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:38.063242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:38.063574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 10:07:38.291308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-08 10:07:38.291605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w0BTe3cpRR/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.2jB91Vei3B/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:07:38 INFO - MultiFileLogger online at 20160208 10:07:38 in /builds/slave/test 10:07:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:07:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:38 INFO - {'append_to_log': False, 10:07:38 INFO - 'base_work_dir': '/builds/slave/test', 10:07:38 INFO - 'blob_upload_branch': 'Fx-Team', 10:07:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:38 INFO - 'branch': 'Fx-Team', 10:07:38 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:38 INFO - 'config_files': ('talos/mac_config.py',), 10:07:38 INFO - 'default_actions': ('clobber', 10:07:38 INFO - 'read-buildbot-config', 10:07:38 INFO - 'download-and-extract', 10:07:38 INFO - 'populate-webroot', 10:07:38 INFO - 'create-virtualenv', 10:07:38 INFO - 'install', 10:07:38 INFO - 'run-tests'), 10:07:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:38 INFO - 'download_minidump_stackwalk': True, 10:07:38 INFO - 'download_symbols': 'ondemand', 10:07:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:38 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:38 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:38 INFO - 'installer_path': 'installer.exe', 10:07:38 INFO - 'log_level': 'info', 10:07:38 INFO - 'log_name': 'talos', 10:07:38 INFO - 'log_to_console': True, 10:07:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:07:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:07:38 INFO - 'opt_config_files': (), 10:07:38 INFO - 'pip_index': False, 10:07:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:38 INFO - 'cmd': ('bash', 10:07:38 INFO - '-c', 10:07:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:38 INFO - 'enabled': True, 10:07:38 INFO - 'halt_on_failure': False, 10:07:38 INFO - 'name': 'check_screen_resolution'},), 10:07:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:38 INFO - 'cmd': ('bash', 10:07:38 INFO - '-c', 10:07:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:38 INFO - 'enabled': True, 10:07:38 INFO - 'halt_on_failure': False, 10:07:38 INFO - 'name': 'check_screen_resolution'},), 10:07:38 INFO - 'run_cmd_checks_enabled': True, 10:07:38 INFO - 'sps_profile': False, 10:07:38 INFO - 'sps_profile_interval': 0, 10:07:38 INFO - 'suite': 'dromaeojs', 10:07:38 INFO - 'system_bits': '32', 10:07:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:38 INFO - 'title': 't-yosemite-r7-0086', 10:07:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:38 INFO - 'use_talos_json': True, 10:07:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:38 INFO - 'work_dir': 'build'} 10:07:38 INFO - ##### 10:07:38 INFO - ##### Running clobber step. 10:07:38 INFO - ##### 10:07:38 INFO - Running pre-action listener: _resource_record_pre_action 10:07:38 INFO - Running main action method: clobber 10:07:38 INFO - rmtree: /builds/slave/test/build 10:07:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:39 INFO - Running post-action listener: _resource_record_post_action 10:07:39 INFO - ##### 10:07:39 INFO - ##### Running read-buildbot-config step. 10:07:39 INFO - ##### 10:07:39 INFO - Running pre-action listener: _resource_record_pre_action 10:07:39 INFO - Running main action method: read_buildbot_config 10:07:39 INFO - Using buildbot properties: 10:07:39 INFO - { 10:07:39 INFO - "project": "", 10:07:39 INFO - "product": "firefox", 10:07:39 INFO - "script_repo_revision": "production", 10:07:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:07:39 INFO - "repository": "", 10:07:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:07:39 INFO - "buildid": "20160208081603", 10:07:39 INFO - "pgo_build": "False", 10:07:39 INFO - "basedir": "/builds/slave/test", 10:07:39 INFO - "buildnumber": 344, 10:07:39 INFO - "slavename": "t-yosemite-r7-0086", 10:07:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:07:39 INFO - "platform": "yosemite_r7", 10:07:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:07:39 INFO - "branch": "fx-team", 10:07:39 INFO - "repo_path": "integration/fx-team", 10:07:39 INFO - "revision": "c57d2020f884e9bfe19a626329faa7da3bd92d79", 10:07:39 INFO - "stage_platform": "macosx64", 10:07:39 INFO - "builduid": "cd87b512e33d4ac8ba0d6d38e2f5eecf", 10:07:39 INFO - "slavebuilddir": "test" 10:07:39 INFO - } 10:07:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:07:39 INFO - Running post-action listener: _resource_record_post_action 10:07:39 INFO - ##### 10:07:39 INFO - ##### Running download-and-extract step. 10:07:39 INFO - ##### 10:07:39 INFO - Running pre-action listener: _resource_record_pre_action 10:07:39 INFO - Running main action method: download_and_extract 10:07:39 INFO - mkdir: /builds/slave/test/build/tests 10:07: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')]} 10:07:39 INFO - https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/test_packages.json 10:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/test_packages.json 10:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:07:43 INFO - Downloaded 1277 bytes. 10:07:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:07:43 INFO - Using the following test package requirements: 10:07:43 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:07:43 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:07:43 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:07:43 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:07:43 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:07:43 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:07:43 INFO - u'jsshell-mac.zip'], 10:07:43 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:07:43 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:07:43 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:07:43 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:07:43 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:07:43 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:07:43 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:07:43 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:07:43 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:07:43 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:07:43 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:07:43 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:07:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:07:43 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')]} 10:07:43 INFO - https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:07:44 INFO - Downloaded 17753559 bytes. 10:07:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:07:47 INFO - Return code: 0 10:07:47 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:07:47 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')]} 10:07:47 INFO - https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:07:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:07:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:07:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:07:49 INFO - Downloaded 17753559 bytes. 10:07:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:07:52 INFO - Return code: 0 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:07:53 INFO - Downloaded 10706547 bytes. 10:07:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:07:53 INFO - Return code: 0 10:07:53 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')]} 10:07:53 INFO - https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:07:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:07:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:07:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 10:07:57 INFO - Downloaded 111839639 bytes. 10:07:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:07:57 INFO - mkdir: /builds/slave/test/properties 10:07:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:57 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:57 INFO - Contents: 10:07:57 INFO - build_url:https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:07:59 INFO - Running post-action listener: _resource_record_post_action 10:07:59 INFO - Running post-action listener: set_extra_try_arguments 10:07:59 INFO - ##### 10:07:59 INFO - ##### Running populate-webroot step. 10:07:59 INFO - ##### 10:07:59 INFO - Running pre-action listener: _resource_record_pre_action 10:07:59 INFO - Running main action method: populate_webroot 10:07:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:59 INFO - '--tppagecycles', 10:07:59 INFO - '7'], 10:07:59 INFO - 'tests': ['tsvgm']}}, 10:07:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:07:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:07:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:07:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:07:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:59 INFO - 'talos_options': ['--e10s'], 10:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:59 INFO - 'tests': ['damp', 'tps']}, 10:07:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:59 INFO - 'talos_options': ['--e10s'], 10:07:59 INFO - 'tests': ['damp', 'tps']}, 10:07:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:07:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:59 INFO - 'other': {'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore']}, 10:07:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:07:59 INFO - 'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore']}, 10:07:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:07:59 INFO - 'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore']}, 10:07:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:07:59 INFO - 'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore']}, 10:07:59 INFO - 'other_l64': {'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore']}, 10:07:59 INFO - 'other_nol64': {'tests': ['a11yr', 10:07:59 INFO - 'ts_paint', 10:07:59 INFO - 'tpaint', 10:07:59 INFO - 'sessionrestore', 10:07:59 INFO - 'sessionrestore_no_auto_restore']}, 10:07:59 INFO - 'svgr': {'tests': ['tsvgx', 10:07:59 INFO - 'tsvgr_opacity', 10:07:59 INFO - 'tart', 10:07:59 INFO - 'tscrollx', 10:07:59 INFO - 'cart']}, 10:07:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:07:59 INFO - 'tests': ['tsvgx', 10:07:59 INFO - 'tsvgr_opacity', 10:07:59 INFO - 'tart', 10:07:59 INFO - 'tscrollx', 10:07:59 INFO - 'cart']}, 10:07:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:59 INFO - 'tests': ['tp5o']}, 10:07:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:59 INFO - 'talos_options': ['--e10s'], 10:07:59 INFO - 'tests': ['tp5o']}, 10:07:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:59 INFO - 'talos_options': ['--xperf_path', 10:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:59 INFO - 'tests': ['tp5n']}, 10:07:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:59 INFO - 'talos_options': ['--e10s', 10:07:59 INFO - '--xperf_path', 10:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:59 INFO - 'tests': ['tp5n']}}, 10:07:59 INFO - 'talos.zip': {'path': '', 10:07:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:59 INFO - Running post-action listener: _resource_record_post_action 10:07:59 INFO - ##### 10:07:59 INFO - ##### Running create-virtualenv step. 10:07:59 INFO - ##### 10:07:59 INFO - Running pre-action listener: _resource_record_pre_action 10:07:59 INFO - Running main action method: create_virtualenv 10:07:59 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:59 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 10:07:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:59 INFO - Using real prefix '/tools/python27' 10:07:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:08:00 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:03 INFO - Installing pip.................done. 10:08:03 INFO - Return code: 0 10:08:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08:03 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')]} 10:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:03 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')]} 10:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:03 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 0x106d7ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d834c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4225807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, '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.w0BTe3cpRR/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.2jB91Vei3B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:08:03 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 10:08:03 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 10:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:03 INFO - 'HOME': '/Users/cltbld', 10:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:03 INFO - 'LOGNAME': 'cltbld', 10:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:03 INFO - 'MOZ_NO_REMOTE': '1', 10:08:03 INFO - 'NO_EM_RESTART': '1', 10:08:03 INFO - 'PAGER': '/bin/cat', 10:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:03 INFO - 'PWD': '/builds/slave/test', 10:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:03 INFO - 'SHELL': '/bin/bash', 10:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:08:03 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:03 INFO - 'USER': 'cltbld', 10:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:03 INFO - 'XPC_FLAGS': '0x0', 10:08:03 INFO - 'XPC_SERVICE_NAME': '0', 10:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:03 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 10:08:03 INFO - Cleaning up... 10:08:03 INFO - Return code: 0 10:08:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:08:03 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')]} 10:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:03 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')]} 10:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:03 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 0x106d7ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d834c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4225807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, '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.w0BTe3cpRR/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.2jB91Vei3B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:08:03 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 10:08:03 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 10:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:03 INFO - 'HOME': '/Users/cltbld', 10:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:03 INFO - 'LOGNAME': 'cltbld', 10:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:03 INFO - 'MOZ_NO_REMOTE': '1', 10:08:03 INFO - 'NO_EM_RESTART': '1', 10:08:03 INFO - 'PAGER': '/bin/cat', 10:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:03 INFO - 'PWD': '/builds/slave/test', 10:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:03 INFO - 'SHELL': '/bin/bash', 10:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:08:03 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:03 INFO - 'USER': 'cltbld', 10:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:03 INFO - 'XPC_FLAGS': '0x0', 10:08:03 INFO - 'XPC_SERVICE_NAME': '0', 10:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:03 INFO - Downloading/unpacking psutil>=0.7.1 10:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:06 INFO - Installing collected packages: psutil 10:08:06 INFO - Running setup.py install for psutil 10:08:06 INFO - building 'psutil._psutil_osx' extension 10:08:06 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 10:08:07 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 10:08:07 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 10:08:07 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 10:08:07 INFO - building 'psutil._psutil_posix' extension 10:08:07 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 10:08:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:08:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:08:07 INFO - ^ 10:08:07 INFO - 1 warning generated. 10:08:07 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 10:08:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:07 INFO - Successfully installed psutil 10:08:07 INFO - Cleaning up... 10:08:07 INFO - Return code: 0 10:08:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d7ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d834c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4225807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, '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.w0BTe3cpRR/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.2jB91Vei3B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:07 INFO - 'HOME': '/Users/cltbld', 10:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:07 INFO - 'LOGNAME': 'cltbld', 10:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:07 INFO - 'MOZ_NO_REMOTE': '1', 10:08:07 INFO - 'NO_EM_RESTART': '1', 10:08:07 INFO - 'PAGER': '/bin/cat', 10:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:07 INFO - 'PWD': '/builds/slave/test', 10:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:07 INFO - 'SHELL': '/bin/bash', 10:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:08:07 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:07 INFO - 'USER': 'cltbld', 10:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:07 INFO - 'XPC_FLAGS': '0x0', 10:08:07 INFO - 'XPC_SERVICE_NAME': '0', 10:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:08:10 INFO - Installing collected packages: mozsystemmonitor 10:08:10 INFO - Running setup.py install for mozsystemmonitor 10:08:10 INFO - Successfully installed mozsystemmonitor 10:08:10 INFO - Cleaning up... 10:08:10 INFO - Return code: 0 10:08:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d7ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d834c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4225807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, '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.w0BTe3cpRR/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.2jB91Vei3B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:08:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:08:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:08:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:10 INFO - 'HOME': '/Users/cltbld', 10:08:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:10 INFO - 'LOGNAME': 'cltbld', 10:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:10 INFO - 'MOZ_NO_REMOTE': '1', 10:08:10 INFO - 'NO_EM_RESTART': '1', 10:08:10 INFO - 'PAGER': '/bin/cat', 10:08:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:10 INFO - 'PWD': '/builds/slave/test', 10:08:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:10 INFO - 'SHELL': '/bin/bash', 10:08:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:08:10 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:08:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:10 INFO - 'USER': 'cltbld', 10:08:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:10 INFO - 'XPC_FLAGS': '0x0', 10:08:10 INFO - 'XPC_SERVICE_NAME': '0', 10:08:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:10 INFO - Downloading/unpacking blobuploader==1.2.4 10:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:13 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:14 INFO - Downloading docopt-0.6.1.tar.gz 10:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:14 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:14 INFO - Running setup.py install for blobuploader 10:08:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:14 INFO - Running setup.py install for requests 10:08:14 INFO - Running setup.py install for docopt 10:08:15 INFO - Successfully installed blobuploader requests docopt 10:08:15 INFO - Cleaning up... 10:08:15 INFO - Return code: 0 10:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:15 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')]} 10:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:15 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')]} 10:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:15 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 0x106d7ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d834c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4225807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, '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.w0BTe3cpRR/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.2jB91Vei3B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:08:15 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 10:08:15 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 10:08:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:08:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:15 INFO - 'HOME': '/Users/cltbld', 10:08:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:15 INFO - 'LOGNAME': 'cltbld', 10:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:15 INFO - 'MOZ_NO_REMOTE': '1', 10:08:15 INFO - 'NO_EM_RESTART': '1', 10:08:15 INFO - 'PAGER': '/bin/cat', 10:08:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:15 INFO - 'PWD': '/builds/slave/test', 10:08:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:15 INFO - 'SHELL': '/bin/bash', 10:08:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:08:15 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:08:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:15 INFO - 'USER': 'cltbld', 10:08:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:15 INFO - 'XPC_FLAGS': '0x0', 10:08:15 INFO - 'XPC_SERVICE_NAME': '0', 10:08:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:15 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-pAW_lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:15 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-KMSTi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:15 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-cHHWPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:15 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-thmjkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:15 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-N5mWPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:16 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-5Hvl1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:16 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-_0Atsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:16 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-q7e5sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:16 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-CJNndz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:16 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-_dcaJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:16 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-7ds3ZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:16 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-bWuhkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:16 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-WRaBXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:16 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-jHisMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:17 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-IVEGx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:17 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-TYeHc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:17 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Tjsc0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:17 INFO - Running setup.py install for manifestparser 10:08:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Running setup.py install for mozcrash 10:08:17 INFO - Running setup.py install for mozdebug 10:08:17 INFO - Running setup.py install for mozdevice 10:08:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Running setup.py install for mozfile 10:08:18 INFO - Running setup.py install for mozhttpd 10:08:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Running setup.py install for mozinfo 10:08:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Running setup.py install for mozInstall 10:08:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Running setup.py install for mozleak 10:08:18 INFO - Running setup.py install for mozlog 10:08:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Running setup.py install for moznetwork 10:08:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Running setup.py install for mozprocess 10:08:19 INFO - Running setup.py install for mozprofile 10:08:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:19 INFO - Running setup.py install for mozrunner 10:08:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:19 INFO - Running setup.py install for mozscreenshot 10:08:19 INFO - Running setup.py install for moztest 10:08:19 INFO - Running setup.py install for mozversion 10:08:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:19 INFO - Cleaning up... 10:08:19 INFO - Return code: 0 10:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:19 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')]} 10:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:19 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')]} 10:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:19 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 0x106d7ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d834c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4225807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, '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.w0BTe3cpRR/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.2jB91Vei3B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:08:19 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 10:08:19 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 10:08:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:08:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:19 INFO - 'HOME': '/Users/cltbld', 10:08:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:19 INFO - 'LOGNAME': 'cltbld', 10:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:19 INFO - 'MOZ_NO_REMOTE': '1', 10:08:19 INFO - 'NO_EM_RESTART': '1', 10:08:19 INFO - 'PAGER': '/bin/cat', 10:08:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:19 INFO - 'PWD': '/builds/slave/test', 10:08:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:19 INFO - 'SHELL': '/bin/bash', 10:08:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:08:19 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:08:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:19 INFO - 'USER': 'cltbld', 10:08:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:19 INFO - 'XPC_FLAGS': '0x0', 10:08:19 INFO - 'XPC_SERVICE_NAME': '0', 10:08:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:20 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-KPZMh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:20 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-wP5jBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:20 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-I7asTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:20 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-nF87av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:20 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-QgJCMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:20 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-OwN8WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:20 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-njuUxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:20 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-YOYbSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:21 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)) 10:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:21 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0snyHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:21 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)) 10:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:21 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-p0NbGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:21 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)) 10:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:21 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-FB3WyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:21 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)) 10:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:21 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2iK7Ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:21 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)) 10:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:21 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-SCfpvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:21 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)) 10:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:21 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-HphfIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:21 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)) 10:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:21 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-bwGKgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:21 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)) 10:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:21 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ChTHez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:21 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)) 10:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:21 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-tZI5LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:21 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)) 10:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:21 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)) 10:08:21 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)) 10:08:21 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)) 10:08:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08:21 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 10:08:21 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 10:08:21 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 10:08:22 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 10:08:22 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 10:08:22 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 10:08:24 INFO - Downloading blessings-1.6.tar.gz 10:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:24 INFO - Installing collected packages: blessings 10:08:24 INFO - Running setup.py install for blessings 10:08:24 INFO - Successfully installed blessings 10:08:24 INFO - Cleaning up... 10:08:24 INFO - Return code: 0 10:08:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:24 INFO - Reading from file tmpfile_stdout 10:08:24 INFO - Current package versions: 10:08:24 INFO - blessings == 1.6 10:08:24 INFO - blobuploader == 1.2.4 10:08:24 INFO - docopt == 0.6.1 10:08:24 INFO - manifestparser == 1.1 10:08:24 INFO - mozInstall == 1.12 10:08:24 INFO - mozcrash == 0.16 10:08:24 INFO - mozdebug == 0.1 10:08:24 INFO - mozdevice == 0.48 10:08:24 INFO - mozfile == 1.2 10:08:24 INFO - mozhttpd == 0.7 10:08:24 INFO - mozinfo == 0.9 10:08:24 INFO - mozleak == 0.1 10:08:24 INFO - mozlog == 3.1 10:08:24 INFO - moznetwork == 0.27 10:08:24 INFO - mozprocess == 0.22 10:08:24 INFO - mozprofile == 0.28 10:08:24 INFO - mozrunner == 6.11 10:08:24 INFO - mozscreenshot == 0.1 10:08:24 INFO - mozsystemmonitor == 0.0 10:08:24 INFO - moztest == 0.7 10:08:24 INFO - mozversion == 1.4 10:08:24 INFO - psutil == 3.1.1 10:08:24 INFO - requests == 1.2.3 10:08:24 INFO - wsgiref == 0.1.2 10:08:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:24 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 0x106d7ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d834c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4225807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, '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.w0BTe3cpRR/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.2jB91Vei3B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:08:24 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 10:08:24 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 10:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:24 INFO - 'HOME': '/Users/cltbld', 10:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:24 INFO - 'LOGNAME': 'cltbld', 10:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:24 INFO - 'MOZ_NO_REMOTE': '1', 10:08:24 INFO - 'NO_EM_RESTART': '1', 10:08:24 INFO - 'PAGER': '/bin/cat', 10:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:24 INFO - 'PWD': '/builds/slave/test', 10:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:24 INFO - 'SHELL': '/bin/bash', 10:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:08:24 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:24 INFO - 'USER': 'cltbld', 10:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:24 INFO - 'XPC_FLAGS': '0x0', 10:08:24 INFO - 'XPC_SERVICE_NAME': '0', 10:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:25 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)) 10:08:25 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)) 10:08:25 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)) 10:08:25 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)) 10:08:25 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)) 10:08:25 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)) 10:08:25 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)) 10:08:25 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)) 10:08:25 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)) 10:08:25 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)) 10:08:25 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)) 10:08:25 INFO - Cleaning up... 10:08:25 INFO - Return code: 0 10:08:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:25 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 0x106d7ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d834c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4225807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, '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.w0BTe3cpRR/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.2jB91Vei3B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:08:25 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 10:08:25 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 10:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:25 INFO - 'HOME': '/Users/cltbld', 10:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:25 INFO - 'LOGNAME': 'cltbld', 10:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:25 INFO - 'MOZ_NO_REMOTE': '1', 10:08:25 INFO - 'NO_EM_RESTART': '1', 10:08:25 INFO - 'PAGER': '/bin/cat', 10:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:25 INFO - 'PWD': '/builds/slave/test', 10:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:25 INFO - 'SHELL': '/bin/bash', 10:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:08:25 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:25 INFO - 'USER': 'cltbld', 10:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:25 INFO - 'XPC_FLAGS': '0x0', 10:08:25 INFO - 'XPC_SERVICE_NAME': '0', 10:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:25 INFO - Downloading/unpacking jsonschema 10:08:25 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 10:08:25 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 10:08:25 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 10:08:25 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 10:08:25 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 10:08:25 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 10:08:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:08:27 INFO - Downloading/unpacking functools32 (from jsonschema) 10:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:28 INFO - Downloading functools32-3.2.3-2.tar.gz 10:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:08:28 INFO - warning: no files found matching '*.txt' 10:08:28 INFO - no previously-included directories found matching 'build' 10:08:28 INFO - no previously-included directories found matching 'dist' 10:08:28 INFO - no previously-included directories found matching '.git*' 10:08:28 INFO - Installing collected packages: jsonschema, functools32 10:08:28 INFO - Running setup.py install for functools32 10:08:28 INFO - warning: no files found matching '*.txt' 10:08:28 INFO - no previously-included directories found matching 'build' 10:08:28 INFO - no previously-included directories found matching 'dist' 10:08:28 INFO - no previously-included directories found matching '.git*' 10:08:28 INFO - Successfully installed jsonschema functools32 10:08:28 INFO - Cleaning up... 10:08:28 INFO - Return code: 0 10:08:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:08:28 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')]} 10:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:28 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')]} 10:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:28 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 0x106d7ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d834c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4225807d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, '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.w0BTe3cpRR/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.2jB91Vei3B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:08:28 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 10:08:28 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 10:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:28 INFO - 'HOME': '/Users/cltbld', 10:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:28 INFO - 'LOGNAME': 'cltbld', 10:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:28 INFO - 'MOZ_NO_REMOTE': '1', 10:08:28 INFO - 'NO_EM_RESTART': '1', 10:08:28 INFO - 'PAGER': '/bin/cat', 10:08:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:28 INFO - 'PWD': '/builds/slave/test', 10:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:28 INFO - 'SHELL': '/bin/bash', 10:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:08:28 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:28 INFO - 'USER': 'cltbld', 10:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:28 INFO - 'XPC_FLAGS': '0x0', 10:08:28 INFO - 'XPC_SERVICE_NAME': '0', 10:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:28 INFO - Downloading/unpacking flake8 10:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:08:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:08:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:08:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:32 INFO - no previously-included directories found matching 'docs/_build' 10:08:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:08:32 INFO - Running setup.py install for pep8 10:08:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:32 INFO - no previously-included directories found matching 'docs/_build' 10:08:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:08:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:08:32 INFO - Cleaning up... 10:08:32 INFO - Return code: 0 10:08:32 INFO - Running post-action listener: _resource_record_post_action 10:08:32 INFO - Running post-action listener: _start_resource_monitoring 10:08:32 INFO - Starting resource monitoring. 10:08:32 INFO - ##### 10:08:32 INFO - ##### Running install step. 10:08:32 INFO - ##### 10:08:32 INFO - Running pre-action listener: _resource_record_pre_action 10:08:32 INFO - Running main action method: install 10:08:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:32 INFO - Reading from file tmpfile_stdout 10:08:32 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:33 INFO - Reading from file tmpfile_stdout 10:08:33 INFO - Output received: 10:08:33 INFO - Usage: mozinstall [options] installer 10:08:33 INFO - Options: 10:08:33 INFO - -h, --help show this help message and exit 10:08:33 INFO - -d DEST, --destination=DEST 10:08:33 INFO - Directory to install application into. [default: 10:08:33 INFO - "/builds/slave/test"] 10:08:33 INFO - --app=APP Application being installed. [default: firefox] 10:08:33 INFO - mkdir: /builds/slave/test/build/application 10:08:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:09:07 INFO - Reading from file tmpfile_stdout 10:09:07 INFO - Output received: 10:09:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:09:07 INFO - Running post-action listener: _resource_record_post_action 10:09:07 INFO - ##### 10:09:07 INFO - ##### Running run-tests step. 10:09:07 INFO - ##### 10:09:07 INFO - Running pre-action listener: _resource_record_pre_action 10:09:07 INFO - Running main action method: run_tests 10:09:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:07 INFO - 2016-02-08 10:09:07.643 screenresolution[2957:29108] starting screenresolution argv=screenresolution get 10:09:07 INFO - 2016-02-08 10:09:07.646 screenresolution[2957:29108] Display 0: 1600x1200x32@60 10:09:07 INFO - 2016-02-08 10:09:07.651 screenresolution[2958:29110] starting screenresolution argv=screenresolution list 10:09:07 INFO - Available Modes on Display 0 10:09:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:07 INFO - Intel Iris: 10:09:07 INFO - Chipset Model: Intel Iris 10:09:07 INFO - Type: GPU 10:09:07 INFO - Bus: Built-In 10:09:07 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:07 INFO - Vendor: Intel (0x8086) 10:09:07 INFO - Device ID: 0x0a2e 10:09:07 INFO - Revision ID: 0x0009 10:09:07 INFO - Displays: 10:09:07 INFO - Display: 10:09:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:07 INFO - Display Serial Number: 1600x1200 60 10:09:07 INFO - Main Display: Yes 10:09:07 INFO - Mirror: Off 10:09:07 INFO - Online: Yes 10:09:07 INFO - Rotation: Supported 10:09:07 INFO - Return code: 0 10:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:07 INFO - Python 2.7.3 10:09:07 INFO - Return code: 0 10:09:07 INFO - grabbing minidump binary from tooltool 10:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:07 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 0x106c1fd30>, '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 0x106a43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c16b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:07 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 10:09:07 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 10:09:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:07 INFO - Return code: 0 10:09:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:09:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:09:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:09:09 INFO - Return code: 0 10:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 10:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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 10:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0BTe3cpRR/Render', 10:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:09 INFO - 'HOME': '/Users/cltbld', 10:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:09 INFO - 'LOGNAME': 'cltbld', 10:09:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:09 INFO - 'MOZ_NO_REMOTE': '1', 10:09:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:09 INFO - 'NO_EM_RESTART': '1', 10:09:09 INFO - 'PAGER': '/bin/cat', 10:09:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:09 INFO - 'PWD': '/builds/slave/test', 10:09:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:09 INFO - 'SHELL': '/bin/bash', 10:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jB91Vei3B/Listeners', 10:09:09 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:09 INFO - 'USER': 'cltbld', 10:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:09 INFO - 'XPC_FLAGS': '0x0', 10:09:09 INFO - 'XPC_SERVICE_NAME': '0', 10:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 10:09:09 INFO - mozversion application_buildid: 20160208081603 10:09:09 INFO - mozversion application_changeset: c57d2020f884e9bfe19a626329faa7da3bd92d79 10:09:09 INFO - mozversion application_display_name: Nightly 10:09:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:09 INFO - mozversion application_name: Firefox 10:09:09 INFO - mozversion application_remotingname: firefox 10:09:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:09:09 INFO - mozversion application_vendor: Mozilla 10:09:09 INFO - mozversion application_version: 47.0a1 10:09:09 INFO - mozversion platform_buildid: 20160208081603 10:09:09 INFO - mozversion platform_changeset: c57d2020f884e9bfe19a626329faa7da3bd92d79 10:09:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:09:09 INFO - mozversion platform_version: 47.0a1 10:09:09 INFO - using testdate: 1454954949 10:09:09 INFO - actual date: 1454954949 10:09:09 INFO - starting webserver on 'localhost:52456' 10:09:09 INFO - SUITE-START | Running 2 tests 10:09:09 INFO - TEST-START | dromaeo_css 10:09:09 INFO - operating with platform_type : mac_ 10:09:09 INFO - Initialising browser for dromaeo_css test... 10:09:09 INFO - TEST-INFO | started process 2976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmphOBNMR/profile http://localhost:52456/getInfo.html) 10:09:11 INFO - PROCESS | 2976 | __metrics Screen width/height:1600/1200 10:09:11 INFO - PROCESS | 2976 | colorDepth:24 10:09:11 INFO - PROCESS | 2976 | Browser inner width/height: 1024/689 10:09:11 INFO - PROCESS | 2976 | __metrics 10:09:11 INFO - PROCESS | 2976 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:09:11 INFO - PROCESS | 2976 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:09:12 INFO - TEST-INFO | 2976: exit 0 10:09:12 INFO - Browser initialized. 10:09:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:12 INFO - TEST-INFO | started process 2979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmphOBNMR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:24 INFO - PROCESS | 2979 | RSS: Main: 245272576 10:09:24 INFO - PROCESS | 2979 | 10:10:19 INFO - PROCESS | 2979 | 1454955019479 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] 10:12:26 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:52456/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52456/tests/dromaeo/cssquery-ext.html) 10:12:27 INFO - PROCESS | 2979 | RSS: Main: 382640128 10:12:27 INFO - PROCESS | 2979 | 10:15:30 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:52456/tests/dromaeo/cssquery-ext.html (next: http://localhost:52456/tests/dromaeo/cssquery-jquery.html) 10:15:30 INFO - PROCESS | 2979 | RSS: Main: 378306560 10:15:30 INFO - PROCESS | 2979 | 10:18:32 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:52456/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52456/tests/dromaeo/cssquery-mootools.html) 10:18:33 INFO - PROCESS | 2979 | RSS: Main: 382795776 10:18:33 INFO - PROCESS | 2979 | 10:21:35 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:52456/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52456/tests/dromaeo/cssquery-prototype.html) 10:21:36 INFO - PROCESS | 2979 | RSS: Main: 375021568 10:21:36 INFO - PROCESS | 2979 | 10:24:39 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:52456/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52456/tests/dromaeo/cssquery-yui.html) 10:24:40 INFO - PROCESS | 2979 | RSS: Main: 342532096 10:24:40 INFO - PROCESS | 2979 | 10:27:42 INFO - PROCESS | 2979 | Cycle 1(1): loaded http://localhost:52456/tests/dromaeo/cssquery-yui.html (next: http://localhost:52456/tests/dromaeo/cssquery-dojo.html) 10:27:43 INFO - PROCESS | 2979 | RSS: Main: 410763264 10:27:43 INFO - PROCESS | 2979 | 10:27:43 INFO - PROCESS | 2979 | __start_tp_report 10:27:43 INFO - PROCESS | 2979 | _x_x_mozilla_page_load 10:27:43 INFO - PROCESS | 2979 | _x_x_mozilla_page_load_details 10:27:43 INFO - PROCESS | 2979 | |i|pagename|runs| 10:27:43 INFO - PROCESS | 2979 | |0;dojo.html;3401.642827503112;3431.3995050866106;3448.4310088835346;3476.235228249784;3490.1449144959474;4736.881577960548;5564.415736347676;5632.155176723493;5656;5705.543556515479;5609.57928155388;5677.57418193635;5682;5688.744006519706;5694.5729070319785;5119.257707632381;5136.2038883972855;5165.7158856262895;5166.302549155872;5236.554892834114;4337.414449049385;5217.947820521784;5221.477852214786;5240.34495688039;5242.737863106849;5202.115640341151;5214.426413094557;5215.765290561915;5218.13900706383;5234.7644356004075;5191.351081114861;5195.246689230041;5205.583553315726;5208.322918020652;5211.739413029333;5067.670601410933;5084.084864724348;5217.58259339252;5242;5254.00173966945;5690.833379157304;5748.741306641211;5773.451522105435;5775.220345253421;5779.479846813807;6192.566520343577;6217.160683307741;6219.906701399483;6225.657588832612;6246.812595622138;4946.33389370229;6126.479249263818;6162.661053642048;6215.782447614311;6247.062940558907;5793.681347525884;5802.970985145047;5824.446677565582;5865.706714664249;5878.470937615635;6205.286392064971;6220.377962203744;6225.066240064027;6233.096201050822;6250.4374606285655;5959.374265702038;6086.6348019119;6129.172561704202;6130.693465326716;6194.876102478015;6188;6198.349173336825;6219.782307619212;6232.252129744369;6264;6190.133381326618;6190.969045154746;6216.316205217422;6219.191505104308;6232.439080482778;6097.8475538111015;6106.358832322631;6130.734471166763;6178.227721534809;6202.844928876814;4877.219644856806;4897.2898929655;4904;4922.72924989129;4925.1381008324115;4377.474703035592;4404.383386325917;4414.050979039522;4420.226460369487;4454.086912182995;5553.972230138824;5633;5644.407337229614;5654;5758.280214973129;6208.565400422018;6215.502759779207;6220.222472190976;6226;6229.377062293825;5628.437156284339;5648.011597970339;5652.406497317805;5653.123765816223;5663.943360566342;5260.579153667697;5271;5322.28149199853;5326.707031113326;5330.626856120112;6242.687865606701;6268.780592679234;6272.905906411316;6277.403646653561;6399.840003999751;6164.537659675452;6232.9715596926;6234.812955611339;6236.875262494634;6248.312685604671;6305.085762564494;6337.366263373626;6346.333634968262;6350.460210882126;6350.4919606432295;6001.939980600138;6142.508599312134;6143.139960405636;6159.476444502267;6193.380661933951;6189.721462534107;6194.845128871814;6209.851177532171;6213.409726076015;6219.937800621936;6037.607555508878;6064.666443345658;6079;6108.511319094373;6117.082437634391;5816.331121921034;5921.763129474945;6056.818295451144;6058.666773327509;6104.76233045773;4990.6506544541535;5808.273965754281;5957.3744756799915;5959.91060134107;5969.492593129633;6003.429674180946;6066.484348830222;6085.604435711664;6089.817305480843;6093.725782339717;5916.319623243382;5967.224260846062;5985.132155837467;6017.608855424383;6073.696315184135 10:27:43 INFO - PROCESS | 2979 | |1;ext.html;450.45944866160613;527.8914280011974;556.2879514221795;561.4469747298909;565.2792689321112;30213.848930755343;37681.62318376819;38430.8078459608;38432.423513647314;38483.23033539327;40910;41382.58617413825;41464.79267603658;41506.75479735605;41521.79239103808;9422.104900034486;9549.140577348036;9555.522223888778;9565.186959108483;9572.80854382912;9494.098060684224;9645.131938125567;9650.758731031745;9667.419954802699;9672.90327096727;9632.277579181555;9674.70975870725;9705.708828735149;9706.514674266295;9711.902880971205;9563.187129094;9656.986016468276;9678.806423871554;9688.515574221332;9696.660616878375;9592.95203523978;9722.2708296878;9727.027297270288;9728.075832795874;9737.172340351079;31725.682743172503;38808.02979925496;39081.41377879334;39131.82604521869;39203.01992450183;3176.9841150794327;3205.743540516753;3236.04536661683;3549.2546565221332;3966.6430021297933;28335.149945501667;28635.14094577166;29231.2692182695;29393.265168370748;29760.66077026539;2722.823016503941;2766.4743698697184;2864.7421732044218;2981.2248815307958;3006.5189569668746;478699;478972;480159.59920200525;480344;480962;56637.71681141568;57422.55464672133;57585.13622295669;57769.42230577725;65432.67283663646;58864;68752;70211.64894175496;70246;70267.64866175636;16110;16291.674166516603;16459.177041147894;16479.505614831574;16481.17594120289;12528;12574.81137782934;12578.993680505537;12598.622041338775;12671.619851404472;17925.64148717018;18264.817351826576;18324.81675183231;18375.08124593765;18388.540286492676;8001.679932802739;8308.958455207685;8314.459560128573;8318.667253309799;8427.41008129425;892.2817132208635;898.667493027584;981.5190556627344;982.3516479123743;989.4904124375952;26342;26393.20820375392;26606.6009009865;28408.00571979971;28794.85602571974;1019.5921631347372;1043.4921538377123;1062.198040479433;1074.7044562745152;1124.8312753087102;12265.632031038904;12483.812742808865;13658.317084145952;13794.241316727475;13968.09207401536;512144;525204;526047;527997;528872;55623.72188139033;55901.161482577794;55933.720331398894;56075.878482430126;56097;1408.5211028250444;1422.4879043544315;1435.648266174773;1439.417036100381;1442.1347191685115;27374.589381159698;28079;28131.43737125287;29279;30152.24619384445;49355;52759;53908;53917.73041134769;54015.72992135014;483548;495980;498831;498920;499024;29277.85361073181;29948.85025574858;30044.3991120172;30134.84932575411;30135;41086;41537.792311038254;41621.75134745963;42321.365179521716;42692.786536068365;36657.135871220045;36660.45009324916;37392;37461.87614371573;37542.812285939486;36621.450678239315;37016.07459813526;37747.43378849374;37846;39334.016649582845;37417;37672.811635941645;37703.86888393352;38136.427953581275;38309.23381532409;36215.094622633595;36932.44601330929;37676;37698;37741;25306.873465632554;29116.7088329114;29412.411751765274;30444;30873.76504939777 10:27:43 INFO - PROCESS | 2979 | |2;jquery.html;360.7871355900019;364.49153430963787;367.7701436602123;368.2781747774362;373.69357127155746;13445.327733613329;16188.75716864248;18697.345592904236;19455.31906383277;20230.190792368325;11913.927746502814;12203.877961220385;12216.816747748791;13464;19364.419067428;3907.1404291055924;5117.897642047157;5336.759845806929;5345.625806193568;5364.785408583672;3377.5778027746533;3903.9804800975953;4076.429299898017;4078.4290199372113;4081.9795901020602;3151.77937544372;4070.430139780433;5652.180433837091;5896.056630939051;6100.145979562864;6140.478059364959;6331.715072821734;6334.556581039352;6335.904961425582;6343.080253363282;5231.241469986869;5448.618596698233;5457.699826509541;5490.4901152183065;5598.748056337434;12833.486660533568;13057.608271751767;22872.65691014636;23635.645465318034;24491.65295908724;2244.9551008979893;2257.977420225793;2326.685897403863;2507.247825652297;2739.493193759161;9657.903420965771;9668.274879384075;9842.114209721089;10177.592896284139;10188.694339169837;1734.6790843693957;1801.6036471976145;1811.420345489444;1828.8811227270185;1832.8625353098437;73085.6345718268;90127.54936225343;96582.9999999993;101499;102584;11121.610743623934;11176.832347514794;11195.216334856483;11209.663710088711;11327.150463715254;13386.732265354638;13545.187288762509;13571;13582.185068895898;13595.048346615642;8357.95821020891;8386.412951093365;8442.324614030862;8530.402871798915;8549.358798090043;8532.018817836028;8533.957330213309;8545.957270213608;8632.956835215784;8638.654453821902;3985.940210896839;4354.629856462237;4439.556044395535;4453.465584129925;4469.821207151743;1741.2860727102081;1793.847522960537;1882.454088314401;1884.7133789719694;1884.9717254241198;853.1894700034992;885.2121611765534;964.2093483343591;994.6469003503797;1053.378506681062;15369.538913832603;19170.424887253404;19500.609987800166;19925.601487970158;20001.699974500396;899.7795540092719;949.7768024514234;1002.7994401119805;1029.7437126705408;1052.310736467615;7520.849583008309;10580.682579522627;10599.788004239872;10606.734831629272;10613.938606139323;347064;670215;671518;700213;736544;69326;72262;101998.49000755096;111664.44167779271;111813;1135.2393896089475;1142.4230763464398;1151.407025381929;1166.5333866453486;1169.92980421175;17315.393961211295;17508;17513;17555.736663950305;17844.91077544604;34943;36906.44640330344;48566;50545.74727126341;52061.47938520566;69109;69989.30010699827;72258.55482890418;72272;72943;7568.886466702894;7733.4973226740085;7759.92240077592;7760.3403710685225;7762.961185194038;7590.620468976639;10070.899291007288;11730.237534560227;11754.23597466162;11887.108466864847;8494.830103397773;10138.949305253427;10263.484344762626;10347.63783267582;10407.271490995558;9133.817323653622;10046.69859904204;10183.796324073624;10270.435126068138;10318.277720559488;10543.78912421732;10554.841677374692;10561.89438105609;10818.404987725751;10934.398608076632;6535.183102112236;7605.163432022584;7745.302922736981;7753.147153812964;7790.5325680459355;10208.285420020527;10480.528376222936;10517.21120915919;10721.678349649523;10754.73113172177 10:27:43 INFO - PROCESS | 2979 | |3;mootools.html;1174.6828356343792;1498.475533563253;1520.4146403634602;1759.12923103064;1948.9610207795836;7894.605269736512;8082.070561885385;8536.231739143475;8745.86881196781;8754.781130471742;7236.384907282887;8670;8738.344624153182;8746.825063498727;8773.254273386754;2162.19998600518;2228.821694264463;2473.356927198932;2500.3874050857476;2500.712418071927;2460.2988148377717;2526.4441822798954;2528.1404322530334;2528.481661259447;2533.721290658026;2427.5630386530415;2507.924762257126;2509.9749002510016;2510.435152090774;2512.648229247907;2465.4452748131616;2482.391814005571;2508.749125087495;2513.258588716333;2515.0317127905705;2471.3327401601646;2501.124606387768;2508.172303139978;2518.7355327690693;2520.4707011527416;8757.605907734167;8801.867971980426;8809.64761409543;8821.911780882174;8835;5383.515483606494;5464.617476776627;5481.150421684645;5488.423715509894;5534.667919924817;3639.1266096137;3639.2175682228185;3719.3119272934596;3769.3403654360377;3773.5471743390694;1036.310853282566;1051.9900895140674;1064.9893501065046;1090.596479302655;1093.371311495893;12228.510859565607;12241.510339586406;12246.81629775554;12257.877421225852;12265.877341226562;4914.459409464956;4917.286993385939;4980.352554167935;4980.551750342414;5001.049800537886;10240.48797560119;10244.334118282288;10261.435621040915;10264.794704106025;10268.178545716324;5535.363433205233;5538.252335934678;5542.3626282977975;5555.250041244381;5560.666360018331;4974.801007959641;4999.625028122832;5035.521625445577;5044.697318160922;5048.419431765394;3634.800085995296;3726.7763934164036;3731.1791405890663;3735.0475628714503;3895.182011777502;1272.7772639788186;1298.1756584568866;1312.3766211049865;1313.0611612696966;1314.2574445438297;1319.577735124751;1331.7269959658247;1358.151155527795;1359.6872719274622;1363.3455941148304;7815.687372505036;7957.244061814118;7963.920360796318;7965.641546130438;8007.919920800834;1157.6874243954085;1173.4602083041725;1176.1355403778387;1186.300082951063;1198.7722332756748;6145.539084568675;6243.063540468966;6245.313015568284;6245.750169993149;6251.343608921089;9978.550965206583;10330.586776528855;10346.275760696679;10459.424731639832;10462.738431539272;9989.051040151175;10281.383117013003;10324.948375258076;10326.01902819231;10368.688939331832;8181.3863960203225;8202.90825839407;8298.751037468886;8306.584670766437;8322.45904016237;7942.205779422012;7943.046834379911;7954.84090318202;8054.798630034062;8192.19771650236;9445.905540944503;9530.571124299284;9637.614495420105;9733.756656083655;9737.951310243403;9526.380785248937;9844.261680374144;10025.298229123891;10038.247131465316;10123;7512.136104347851;7530.058742657168;7534.924650753642;7633.1985141559335;7642.350400216044;7220.025296584894;8090.15053419406;8187.099419063779;8190.344772418073;8202.83594328122;5812.83743251343;7057.0472986146215;7340.192578816219;7547.50941188821;7623.085229772463;7405.925940740523;7601.7719468416035;7641.044869391326;7642.770716878503;7662.080550333995;7589.544627322378;7709.7301594443925;7716.151223365538;7727.343175830118;7729.690812367442;6903.378695917391;6977.511574189758;6996.16046074454;7076.681549330396;7080.610566418691;7107.289271072851;7125.714971401086;7200.315969982843;7201.675924583302;7213.819654508679 10:27:43 INFO - PROCESS | 2979 | |4;prototype.html;322.49368491468397;327.22121351184177;331.5441268256148;334.9681780230879;336.93092915952235;6714.832129196772;6756.425703815169;6773.932260677386;6776.525643204972;6792.218894827096;6622.238442579105;6660.933390666092;6682.6658667066695;6684;6686.130802995616;4101.220768054075;4666.53334666534;4913.91893783368;4928.359313289286;4929.186684197103;4839.209492487785;4853.150698627744;4867.002264535761;4868.318435419044;4877.463479017305;4781.976090119562;4790.281457781343;4808.759562021885;4810.4948980357085;4811.4707382187935;4585.174668559658;4658.068386322749;4737.50256223095;4798.976005119952;4816.542428469307;4033.3546632538655;4073.042834933788;4083.9591604083876;4089.018635527482;4099.077707515815;6134.969325153345;6316.842078948063;6318.74725010999;6355;6356.523260755462;5513.889722205534;5535.086710692731;5633.60564760467;5639.238702775114;5688.11834165705;7032.613206273653;7055.294470552955;7063.646817659096;7066.92933070673;7097.89353159703;4567.817287308504;4576.153411618828;4589.5639914208095;4600.907981840344;4605.976970115128;7093;7438.73964411243;7446.776596702053;7452.329290363839;7458.4033277337685;4639.814407423665;4642.6536304472;4652.860414187579;4655.231886738718;4656.185167595657;4715.104130215248;4734.147853386424;4737.265723812815;4740.004599034172;4741.95258047422;5519.503244707996;5655.802046928337;5669.688167150764;5674.574406919498;5735.483806457439;7146.749863754848;7147.1780745214965;7163.283671632795;7171.533850299714;7180.5691658500655;1628.2184551415387;1648.546649671326;1651.2074204381963;1652.5868532866784;1656.9088700121608;1041.6614600254948;1059.1156384418941;1060.750723579958;1060.9946950265198;1076.6393258258415;6611.206655201407;6616.86766264672;6619.238787539494;6632.568883022588;6663.666816659148;7344.192138864721;7360.595167265745;7363.447741419308;7364.484486085923;7382;6355.777547785898;6626.138601981808;6627.801165965029;6634;6644.368784965421;3876.612338766101;3924;3928.3518219493462;3933.252681990413;3933.2920074386884;7756.379489640815;7760.650770715331;7771.572563509061;7772.922270777333;7781.649825757854;6078.848028799315;7346.118465784033;7505.62471876404;7604.505707129019;7639.465237433437;7780.105287891852;7807.726729564438;7809.609519524115;7833.629114904868;7840.09838868526;6250.781097685907;7076.32774886385;7416.3325300721035;7419.851602968019;7444.813879653052;6239.937600624117;7134.536255143399;7275.308845659654;7366.521176123535;7376.225496323023;5822.679752613478;6995.650217489207;7256.89114663291;7667.00328957232;7858.921410785819;3874.5931677174617;4548.431446069241;4641.791119399568;4695.22528782747;4715.033418149203;7361.227071157666;7365.852682946418;7387.2243414442855;7397.038385009914;7401.33387995083;7152.9284707152265;7163.176234732864;7165.462590305644;7166.032585600877;7172.211056783854;6895.482838787211;7153.856922861618;7155.892661609976;7166.10098323955;7170.462215333767;6950.20072691647;6972.825679357854;6976.965115174392;6979.4765392594745;6986.930130698831;5482.671039737628;7155.749548765768;7158.0336654550965;7165.928340716526;7166.462515311477;6936.930630693629;6978;6986.16166060076;6998.860022799414;7016.894746578703 10:27:43 INFO - PROCESS | 2979 | |5;yui.html;656.7471523463466;671.1878626861501;688.9242183359833;707.4128473367106;733.7285204474346;14727.410903563858;14898.77651835222;14914.925425372872;14916;14917.32872020759;13352.265625390599;13528.729425411486;13736.587902362946;13774.862251377508;13775.242361670129;589.849588354971;683.931606839317;837;853.9701110461135;855.4995327733284;831.9209675080857;837.2213841127749;850.196564246787;850.6554845287637;851.0765819086299;888.0231745080392;892.7143314139478;893.4907102951321;894.4141587260355;894.5259012723267;708.6350529477323;719.3669570777735;855.1021427501099;878.433410450256;881.8544940084911;654.499308029358;656.6454114778014;657.8815813153631;657.947364210862;658.2134349452406;14422.855771442257;14436.49472268476;14469.927650361786;14494.42022319106;14567.927160364236;12228.881635182972;12333.938330308381;12377.443015064253;12862.678433039155;13175.077744557884;9650.855237171449;9788.608455661764;9799.706008819747;9804.215662746963;9805.754856128582;3500.334936362083;3530.0821786335737;3531.682148606638;3535.6287589803214;3538.840752166159;80367;81116.59441702753;81166;82186;82237.58881205616;8918.420302680304;8976.326775491863;8993.955030224806;9058.230050445654;9109.81780364389;19423.708644370345;19630.312939047064;19642.803571964098;19710.605787884448;19763.308284209983;7186.31729985661;7377.6311184440565;7508.62456877154;7524.510906791041;7696.576688282198;4144.41978123057;4164.312888373384;4167.1457351242925;4200.537940826506;4206.8737937861915;3530.894073177809;3586.318599466093;3587.192881601619;3590.0665826885197;3597.8201089945396;636.4780879678619;654.9181352330959;663.5952069237761;665.6072916979006;677.1062197898825;540.6620861961275;575.6920047774504;587.4125874125874;622.7664625765339;652.2401402366285;7839.764807055797;8568.742937711879;8614.526201058876;8772.692955746517;9317.813643727088;522.3575002746643;582.3768567632677;589.1810383566846;600.2436929468901;612;3819.6180381962135;3968.3253846846105;3995.800209989489;4022.0710023747233;4127.979360103181;90910;91818;92442;92636;92793.53603232076;78036;78624;78678;78745.60627196827;80450;59869;60597;61143.388566114656;61201.693991529755;61547.6922615393;7206.89189662145;7924.247196516321;8152.83694326122;8191;8289.751307460545;33782.49326260157;42985.12238042023;43943.780281099665;44183.89540261519;44329.55670443254;56059;57011.71494142503;66350.33649663441;66854;67378.66310668415;10967.396793176453;11041.83437248458;11251.268667536584;11272.041876440266;11586.131040171853;11817.231879927776;11845.46695398692;11853.762924741284;11860.76278474443;12257.754844903231;10807.405592692478;11121.83317250258;11428.657140285804;11490.712732181428;11507.367094809866;11396.316221026766;12052.975497082845;12107.939460302641;12194.26869371394;12347.567835125728;10802.783944320912;10929.344239345346;11244.04425623831;11480.655580332603;12058;9401.952990235006;9423;9547.093026162504;9547.665831695856;9613.279004074862;8195.975503062116;8984.550772461482;9931.354461959949;9998.550065247227;10021.699349019249 10:27:43 INFO - PROCESS | 2979 | __end_tp_report 10:27:43 INFO - PROCESS | 2979 | __start_cc_report 10:27:43 INFO - PROCESS | 2979 | _x_x_mozilla_cycle_collect,1180 10:27:43 INFO - PROCESS | 2979 | __end_cc_report 10:27:43 INFO - PROCESS | 2979 | __startTimestamp1454956063002__endTimestamp 10:27:43 INFO - PROCESS | 2979 | 10:27:43 INFO - PROCESS | 2979 | ------- Summary: start ------- 10:27:43 INFO - PROCESS | 2979 | Number of tests: 6 10:27:43 INFO - PROCESS | 2979 | 10:27:43 INFO - PROCESS | 2979 | [#0] dojo.html Cycles:165 Average:5704.01 Median:5959.37 stddev:640.31 (10.7%) stddev-sans-first:616.28 10:27:43 INFO - PROCESS | 2979 | Values: 3401.6 3431.4 3448.4 3476.2 3490.1 4736.9 5564.4 5632.2 5656.0 5705.5 5609.6 5677.6 5682.0 5688.7 5694.6 5119.3 5136.2 5165.7 5166.3 5236.6 4337.4 5217.9 5221.5 5240.3 5242.7 5202.1 5214.4 5215.8 5218.1 5234.8 5191.4 5195.2 5205.6 5208.3 5211.7 5067.7 5084.1 5217.6 5242.0 5254.0 5690.8 5748.7 5773.5 5775.2 5779.5 6192.6 6217.2 6219.9 6225.7 6246.8 4946.3 6126.5 6162.7 6215.8 6247.1 5793.7 5803.0 5824.4 5865.7 5878.5 6205.3 6220.4 6225.1 6233.1 6250.4 5959.4 6086.6 6129.2 6130.7 6194.9 6188.0 6198.3 6219.8 6232.3 6264.0 6190.1 6191.0 6216.3 6219.2 6232.4 6097.8 6106.4 6130.7 6178.2 6202.8 4877.2 4897.3 4904.0 4922.7 4925.1 4377.5 4404.4 4414.1 4420.2 4454.1 5554.0 5633.0 5644.4 5654.0 5758.3 6208.6 6215.5 6220.2 6226.0 6229.4 5628.4 5648.0 5652.4 5653.1 5663.9 5260.6 5271.0 5322.3 5326.7 5330.6 6242.7 6268.8 6272.9 6277.4 6399.8 6164.5 6233.0 6234.8 6236.9 6248.3 6305.1 6337.4 6346.3 6350.5 6350.5 6001.9 6142.5 6143.1 6159.5 6193.4 6189.7 6194.8 6209.9 6213.4 6219.9 6037.6 6064.7 6079.0 6108.5 6117.1 5816.3 5921.8 6056.8 6058.7 6104.8 4990.7 5808.3 5957.4 5959.9 5969.5 6003.4 6066.5 6085.6 6089.8 6093.7 5916.3 5967.2 5985.1 6017.6 6073.7 10:27:43 INFO - PROCESS | 2979 | 10:27:43 INFO - PROCESS | 2979 | [#1] ext.html Cycles:180 Average:64250.42 Median:39106.62 stddev:132984.78 (340.1%) stddev-sans-first:133271.57 10:27:43 INFO - PROCESS | 2979 | Values: 450.5 527.9 556.3 561.4 565.3 30213.8 37681.6 38430.8 38432.4 38483.2 40910.0 41382.6 41464.8 41506.8 41521.8 9422.1 9549.1 9555.5 9565.2 9572.8 9494.1 9645.1 9650.8 9667.4 9672.9 9632.3 9674.7 9705.7 9706.5 9711.9 9563.2 9657.0 9678.8 9688.5 9696.7 9593.0 9722.3 9727.0 9728.1 9737.2 31725.7 38808.0 39081.4 39131.8 39203.0 3177.0 3205.7 3236.0 3549.3 3966.6 28335.1 28635.1 29231.3 29393.3 29760.7 2722.8 2766.5 2864.7 2981.2 3006.5 478699.0 478972.0 480159.6 480344.0 480962.0 56637.7 57422.6 57585.1 57769.4 65432.7 58864.0 68752.0 70211.6 70246.0 70267.6 16110.0 16291.7 16459.2 16479.5 16481.2 12528.0 12574.8 12579.0 12598.6 12671.6 17925.6 18264.8 18324.8 18375.1 18388.5 8001.7 8309.0 8314.5 8318.7 8427.4 892.3 898.7 981.5 982.4 989.5 26342.0 26393.2 26606.6 28408.0 28794.9 1019.6 1043.5 1062.2 1074.7 1124.8 12265.6 12483.8 13658.3 13794.2 13968.1 512144.0 525204.0 526047.0 527997.0 528872.0 55623.7 55901.2 55933.7 56075.9 56097.0 1408.5 1422.5 1435.6 1439.4 1442.1 27374.6 28079.0 28131.4 29279.0 30152.2 49355.0 52759.0 53908.0 53917.7 54015.7 483548.0 495980.0 498831.0 498920.0 499024.0 29277.9 29948.9 30044.4 30134.8 30135.0 41086.0 41537.8 41621.8 42321.4 42692.8 36657.1 36660.5 37392.0 37461.9 37542.8 36621.5 37016.1 37747.4 37846.0 39334.0 37417.0 37672.8 37703.9 38136.4 38309.2 36215.1 36932.4 37676.0 37698.0 37741.0 25306.9 29116.7 29412.4 30444.0 30873.8 10:27:43 INFO - PROCESS | 2979 | 10:27:43 INFO - PROCESS | 2979 | [#2] jquery.html Cycles:180 Average:32846.50 Median:2623.37 stddev:105680.88 (4028.4%) stddev-sans-first:105949.19 10:27:43 INFO - PROCESS | 2979 | Values: 360.8 364.5 367.8 368.3 373.7 13445.3 16188.8 18697.3 19455.3 20230.2 11913.9 12203.9 12216.8 13464.0 19364.4 3907.1 5117.9 5336.8 5345.6 5364.8 3377.6 3904.0 4076.4 4078.4 4082.0 3151.8 4070.4 5652.2 5896.1 6100.1 6140.5 6331.7 6334.6 6335.9 6343.1 5231.2 5448.6 5457.7 5490.5 5598.7 12833.5 13057.6 22872.7 23635.6 24491.7 2245.0 2258.0 2326.7 2507.2 2739.5 9657.9 9668.3 9842.1 10177.6 10188.7 1734.7 1801.6 1811.4 1828.9 1832.9 73085.6 90127.5 96583.0 101499.0 102584.0 11121.6 11176.8 11195.2 11209.7 11327.2 13386.7 13545.2 13571.0 13582.2 13595.0 8358.0 8386.4 8442.3 8530.4 8549.4 8532.0 8534.0 8546.0 8633.0 8638.7 3985.9 4354.6 4439.6 4453.5 4469.8 1741.3 1793.8 1882.5 1884.7 1885.0 853.2 885.2 964.2 994.6 1053.4 15369.5 19170.4 19500.6 19925.6 20001.7 899.8 949.8 1002.8 1029.7 1052.3 7520.8 10580.7 10599.8 10606.7 10613.9 347064.0 670215.0 671518.0 700213.0 736544.0 69326.0 72262.0 101998.5 111664.4 111813.0 1135.2 1142.4 1151.4 1166.5 1169.9 17315.4 17508.0 17513.0 17555.7 17844.9 34943.0 36906.4 48566.0 50545.7 52061.5 69109.0 69989.3 72258.6 72272.0 72943.0 7568.9 7733.5 7759.9 7760.3 7763.0 7590.6 10070.9 11730.2 11754.2 11887.1 8494.8 10138.9 10263.5 10347.6 10407.3 9133.8 10046.7 10183.8 10270.4 10318.3 10543.8 10554.8 10561.9 10818.4 10934.4 6535.2 7605.2 7745.3 7753.1 7790.5 10208.3 10480.5 10517.2 10721.7 10754.7 10:27:43 INFO - PROCESS | 2979 | 10:27:43 INFO - PROCESS | 2979 | [#3] mootools.html Cycles:180 Average:6058.02 Median:5215.97 stddev:3158.63 (60.6%) stddev-sans-first:3146.16 10:27:43 INFO - PROCESS | 2979 | Values: 1174.7 1498.5 1520.4 1759.1 1949.0 7894.6 8082.1 8536.2 8745.9 8754.8 7236.4 8670.0 8738.3 8746.8 8773.3 2162.2 2228.8 2473.4 2500.4 2500.7 2460.3 2526.4 2528.1 2528.5 2533.7 2427.6 2507.9 2510.0 2510.4 2512.6 2465.4 2482.4 2508.7 2513.3 2515.0 2471.3 2501.1 2508.2 2518.7 2520.5 8757.6 8801.9 8809.6 8821.9 8835.0 5383.5 5464.6 5481.2 5488.4 5534.7 3639.1 3639.2 3719.3 3769.3 3773.5 1036.3 1052.0 1065.0 1090.6 1093.4 12228.5 12241.5 12246.8 12257.9 12265.9 4914.5 4917.3 4980.4 4980.6 5001.0 10240.5 10244.3 10261.4 10264.8 10268.2 5535.4 5538.3 5542.4 5555.3 5560.7 4974.8 4999.6 5035.5 5044.7 5048.4 3634.8 3726.8 3731.2 3735.0 3895.2 1272.8 1298.2 1312.4 1313.1 1314.3 1319.6 1331.7 1358.2 1359.7 1363.3 7815.7 7957.2 7963.9 7965.6 8007.9 1157.7 1173.5 1176.1 1186.3 1198.8 6145.5 6243.1 6245.3 6245.8 6251.3 9978.6 10330.6 10346.3 10459.4 10462.7 9989.1 10281.4 10324.9 10326.0 10368.7 8181.4 8202.9 8298.8 8306.6 8322.5 7942.2 7943.0 7954.8 8054.8 8192.2 9445.9 9530.6 9637.6 9733.8 9738.0 9526.4 9844.3 10025.3 10038.2 10123.0 7512.1 7530.1 7534.9 7633.2 7642.4 7220.0 8090.2 8187.1 8190.3 8202.8 5812.8 7057.0 7340.2 7547.5 7623.1 7405.9 7601.8 7641.0 7642.8 7662.1 7589.5 7709.7 7716.2 7727.3 7729.7 6903.4 6977.5 6996.2 7076.7 7080.6 7107.3 7125.7 7200.3 7201.7 7213.8 10:27:43 INFO - PROCESS | 2979 | 10:27:43 INFO - PROCESS | 2979 | [#4] prototype.html Cycles:180 Average:5786.52 Median:6626.97 stddev:1866.07 (28.2%) stddev-sans-first:1825.68 10:27:43 INFO - PROCESS | 2979 | Values: 322.5 327.2 331.5 335.0 336.9 6714.8 6756.4 6773.9 6776.5 6792.2 6622.2 6660.9 6682.7 6684.0 6686.1 4101.2 4666.5 4913.9 4928.4 4929.2 4839.2 4853.2 4867.0 4868.3 4877.5 4782.0 4790.3 4808.8 4810.5 4811.5 4585.2 4658.1 4737.5 4799.0 4816.5 4033.4 4073.0 4084.0 4089.0 4099.1 6135.0 6316.8 6318.7 6355.0 6356.5 5513.9 5535.1 5633.6 5639.2 5688.1 7032.6 7055.3 7063.6 7066.9 7097.9 4567.8 4576.2 4589.6 4600.9 4606.0 7093.0 7438.7 7446.8 7452.3 7458.4 4639.8 4642.7 4652.9 4655.2 4656.2 4715.1 4734.1 4737.3 4740.0 4742.0 5519.5 5655.8 5669.7 5674.6 5735.5 7146.7 7147.2 7163.3 7171.5 7180.6 1628.2 1648.5 1651.2 1652.6 1656.9 1041.7 1059.1 1060.8 1061.0 1076.6 6611.2 6616.9 6619.2 6632.6 6663.7 7344.2 7360.6 7363.4 7364.5 7382.0 6355.8 6626.1 6627.8 6634.0 6644.4 3876.6 3924.0 3928.4 3933.3 3933.3 7756.4 7760.7 7771.6 7772.9 7781.6 6078.8 7346.1 7505.6 7604.5 7639.5 7780.1 7807.7 7809.6 7833.6 7840.1 6250.8 7076.3 7416.3 7419.9 7444.8 6239.9 7134.5 7275.3 7366.5 7376.2 5822.7 6995.7 7256.9 7667.0 7858.9 3874.6 4548.4 4641.8 4695.2 4715.0 7361.2 7365.9 7387.2 7397.0 7401.3 7152.9 7163.2 7165.5 7166.0 7172.2 6895.5 7153.9 7155.9 7166.1 7170.5 6950.2 6972.8 6977.0 6979.5 6986.9 5482.7 7155.7 7158.0 7165.9 7166.5 6936.9 6978.0 6986.2 6998.9 7016.9 10:27:43 INFO - PROCESS | 2979 | 10:27:43 INFO - PROCESS | 2979 | [#5] yui.html Cycles:180 Average:17621.18 Median:61374.69 stddev:24812.56 (40.4%) stddev-sans-first:24849.47 10:27:43 INFO - PROCESS | 2979 | Values: 656.7 671.2 688.9 707.4 733.7 14727.4 14898.8 14914.9 14916.0 14917.3 13352.3 13528.7 13736.6 13774.9 13775.2 589.8 683.9 837.0 854.0 855.5 831.9 837.2 850.2 850.7 851.1 888.0 892.7 893.5 894.4 894.5 708.6 719.4 855.1 878.4 881.9 654.5 656.6 657.9 657.9 658.2 14422.9 14436.5 14469.9 14494.4 14567.9 12228.9 12333.9 12377.4 12862.7 13175.1 9650.9 9788.6 9799.7 9804.2 9805.8 3500.3 3530.1 3531.7 3535.6 3538.8 80367.0 81116.6 81166.0 82186.0 82237.6 8918.4 8976.3 8994.0 9058.2 9109.8 19423.7 19630.3 19642.8 19710.6 19763.3 7186.3 7377.6 7508.6 7524.5 7696.6 4144.4 4164.3 4167.1 4200.5 4206.9 3530.9 3586.3 3587.2 3590.1 3597.8 636.5 654.9 663.6 665.6 677.1 540.7 575.7 587.4 622.8 652.2 7839.8 8568.7 8614.5 8772.7 9317.8 522.4 582.4 589.2 600.2 612.0 3819.6 3968.3 3995.8 4022.1 4128.0 90910.0 91818.0 92442.0 92636.0 92793.5 78036.0 78624.0 78678.0 78745.6 80450.0 59869.0 60597.0 61143.4 61201.7 61547.7 7206.9 7924.2 8152.8 8191.0 8289.8 33782.5 42985.1 43943.8 44183.9 44329.6 56059.0 57011.7 66350.3 66854.0 67378.7 10967.4 11041.8 11251.3 11272.0 11586.1 11817.2 11845.5 11853.8 11860.8 12257.8 10807.4 11121.8 11428.7 11490.7 11507.4 11396.3 12053.0 12107.9 12194.3 12347.6 10802.8 10929.3 11244.0 11480.7 12058.0 9402.0 9423.0 9547.1 9547.7 9613.3 8196.0 8984.6 9931.4 9998.6 10021.7 10:27:43 INFO - PROCESS | 2979 | -------- Summary: end -------- 10:27:43 INFO - PROCESS | 2979 | 10:27:43 INFO - TEST-INFO | 2979: exit 0 10:27:43 INFO - TEST-OK | dromaeo_css | took 1114098ms 10:27:43 INFO - TEST-START | kraken 10:27:43 INFO - operating with platform_type : mac_ 10:27:43 INFO - Initialising browser for kraken test... 10:27:43 INFO - TEST-INFO | started process 2982 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpPHpEix/profile http://localhost:52456/getInfo.html) 10:27:45 INFO - PROCESS | 2982 | __metrics Screen width/height:1600/1200 10:27:45 INFO - PROCESS | 2982 | colorDepth:24 10:27:45 INFO - PROCESS | 2982 | Browser inner width/height: 1024/689 10:27:45 INFO - PROCESS | 2982 | __metrics 10:27:45 INFO - PROCESS | 2982 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:27:45 INFO - PROCESS | 2982 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:27:46 INFO - TEST-INFO | 2982: exit 0 10:27:46 INFO - Browser initialized. 10:27:46 INFO - Running cycle 1/1 for kraken test... 10:27:46 INFO - TEST-INFO | started process 2984 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpPHpEix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:58 INFO - PROCESS | 2984 | RSS: Main: 243879936 10:27:58 INFO - PROCESS | 2984 | 10:28:01 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52456/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:01 INFO - PROCESS | 2984 | RSS: Main: 292261888 10:28:01 INFO - PROCESS | 2984 | 10:28:04 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52456/tests/kraken/driver.html?testName=audio-dft) 10:28:05 INFO - PROCESS | 2984 | RSS: Main: 303312896 10:28:05 INFO - PROCESS | 2984 | 10:28:08 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52456/tests/kraken/driver.html?testName=audio-fft) 10:28:08 INFO - PROCESS | 2984 | RSS: Main: 288178176 10:28:08 INFO - PROCESS | 2984 | 10:28:10 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52456/tests/kraken/driver.html?testName=audio-oscillator) 10:28:11 INFO - PROCESS | 2984 | RSS: Main: 291643392 10:28:11 INFO - PROCESS | 2984 | 10:28:13 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52456/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:14 INFO - PROCESS | 2984 | RSS: Main: 291405824 10:28:14 INFO - PROCESS | 2984 | 10:28:16 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52456/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:17 INFO - PROCESS | 2984 | RSS: Main: 293081088 10:28:17 INFO - PROCESS | 2984 | 10:28:20 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52456/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:20 INFO - PROCESS | 2984 | RSS: Main: 292634624 10:28:20 INFO - PROCESS | 2984 | 10:28:23 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52456/tests/kraken/driver.html?testName=json-parse-financial) 10:28:24 INFO - PROCESS | 2984 | RSS: Main: 293486592 10:28:24 INFO - PROCESS | 2984 | 10:28:25 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52456/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:26 INFO - PROCESS | 2984 | RSS: Main: 326742016 10:28:26 INFO - PROCESS | 2984 | 10:28:28 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52456/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:28 INFO - PROCESS | 2984 | RSS: Main: 324882432 10:28:28 INFO - PROCESS | 2984 | 10:28:30 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52456/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:31 INFO - PROCESS | 2984 | RSS: Main: 333287424 10:28:31 INFO - PROCESS | 2984 | 10:28:33 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:34 INFO - PROCESS | 2984 | RSS: Main: 334639104 10:28:34 INFO - PROCESS | 2984 | 10:28:37 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:37 INFO - PROCESS | 2984 | RSS: Main: 334618624 10:28:37 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | Cycle 1(1): loaded http://localhost:52456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52456/tests/kraken/driver.html?testName=ai-astar) 10:28:39 INFO - PROCESS | 2984 | RSS: Main: 395051008 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | __start_tp_report 10:28:39 INFO - PROCESS | 2984 | _x_x_mozilla_page_load 10:28:39 INFO - PROCESS | 2984 | _x_x_mozilla_page_load_details 10:28:39 INFO - PROCESS | 2984 | |i|pagename|runs| 10:28:39 INFO - PROCESS | 2984 | |0;ai-astar;110;107;119;162;155;109;115;112;111;108 10:28:39 INFO - PROCESS | 2984 | |1;audio-beat-detection;160;121;144;154;120;140;125;182;170;149 10:28:39 INFO - PROCESS | 2984 | |2;audio-dft;187;187;184;189;187;186;186;183;180;185 10:28:39 INFO - PROCESS | 2984 | |3;audio-fft;74;75;87;78;56;58;58;79;80;55 10:28:39 INFO - PROCESS | 2984 | |4;audio-oscillator;92;93;130;78;82;80;111;76;79;115 10:28:39 INFO - PROCESS | 2984 | |5;imaging-gaussian-blur;85;91;86;92;85;89;84;93;85;91 10:28:39 INFO - PROCESS | 2984 | |6;imaging-darkroom;95;95;95;95;96;94;95;95;94;95 10:28:39 INFO - PROCESS | 2984 | |7;imaging-desaturate;86;85;87;87;88;86;85;86;87;88 10:28:39 INFO - PROCESS | 2984 | |8;json-parse-financial;53;54;54;53;53;53;52;64;60;73 10:28:39 INFO - PROCESS | 2984 | |9;json-stringify-tinderbox;65;67;69;77;72;68;68;68;68;70 10:28:39 INFO - PROCESS | 2984 | |10;stanford-crypto-aes;86;83;84;83;81;83;81;82;85;84 10:28:39 INFO - PROCESS | 2984 | |11;stanford-crypto-ccm;134;128;144;127;121;122;123;128;121;122 10:28:39 INFO - PROCESS | 2984 | |12;stanford-crypto-pbkdf2;162;158;164;174;136;126;162;174;144;136 10:28:39 INFO - PROCESS | 2984 | |13;stanford-crypto-sha256-iterative;67;65;65;68;74;93;81;69;66;67 10:28:39 INFO - PROCESS | 2984 | __end_tp_report 10:28:39 INFO - PROCESS | 2984 | __start_cc_report 10:28:39 INFO - PROCESS | 2984 | _x_x_mozilla_cycle_collect,1182 10:28:39 INFO - PROCESS | 2984 | __end_cc_report 10:28:39 INFO - PROCESS | 2984 | __startTimestamp1454956119751__endTimestamp 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | ------- Summary: start ------- 10:28:39 INFO - PROCESS | 2984 | Number of tests: 14 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#0] ai-astar Cycles:10 Average:120.80 Median:113.50 stddev:20.24 (17.8%) stddev-sans-first:21.09 10:28:39 INFO - PROCESS | 2984 | Values: 110.0 107.0 119.0 162.0 155.0 109.0 115.0 112.0 111.0 108.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:151.50 stddev:20.87 (13.8%) stddev-sans-first:21.56 10:28:39 INFO - PROCESS | 2984 | Values: 160.0 121.0 144.0 154.0 120.0 140.0 125.0 182.0 170.0 149.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#2] audio-dft Cycles:10 Average:185.40 Median:186.50 stddev:2.55 (1.4%) stddev-sans-first:2.64 10:28:39 INFO - PROCESS | 2984 | Values: 187.0 187.0 184.0 189.0 187.0 186.0 186.0 183.0 180.0 185.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#3] audio-fft Cycles:10 Average:70.00 Median:76.50 stddev:11.94 (15.6%) stddev-sans-first:12.58 10:28:39 INFO - PROCESS | 2984 | Values: 74.0 75.0 87.0 78.0 56.0 58.0 58.0 79.0 80.0 55.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:79.50 stddev:18.78 (23.6%) stddev-sans-first:19.91 10:28:39 INFO - PROCESS | 2984 | Values: 92.0 93.0 130.0 78.0 82.0 80.0 111.0 76.0 79.0 115.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:90.00 stddev:3.45 (3.8%) stddev-sans-first:3.47 10:28:39 INFO - PROCESS | 2984 | Values: 85.0 91.0 86.0 92.0 85.0 89.0 84.0 93.0 85.0 91.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 10:28:39 INFO - PROCESS | 2984 | Values: 95.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 94.0 95.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:1.08 (1.2%) stddev-sans-first:1.13 10:28:39 INFO - PROCESS | 2984 | Values: 86.0 85.0 87.0 87.0 88.0 86.0 85.0 86.0 87.0 88.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:54.00 stddev:6.84 (12.7%) stddev-sans-first:7.11 10:28:39 INFO - PROCESS | 2984 | Values: 53.0 54.0 54.0 53.0 53.0 53.0 52.0 64.0 60.0 73.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:68.50 stddev:3.29 (4.8%) stddev-sans-first:3.12 10:28:39 INFO - PROCESS | 2984 | Values: 65.0 67.0 69.0 77.0 72.0 68.0 68.0 68.0 68.0 70.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.62 (1.9%) stddev-sans-first:1.36 10:28:39 INFO - PROCESS | 2984 | Values: 86.0 83.0 84.0 83.0 81.0 83.0 81.0 82.0 85.0 84.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:127.50 stddev:7.29 (5.7%) stddev-sans-first:7.28 10:28:39 INFO - PROCESS | 2984 | Values: 134.0 128.0 144.0 127.0 121.0 122.0 123.0 128.0 121.0 122.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:162.00 stddev:16.91 (10.4%) stddev-sans-first:17.66 10:28:39 INFO - PROCESS | 2984 | Values: 162.0 158.0 164.0 174.0 136.0 126.0 162.0 174.0 144.0 136.0 10:28:39 INFO - PROCESS | 2984 | 10:28:39 INFO - PROCESS | 2984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:68.50 stddev:9.02 (13.2%) stddev-sans-first:9.42 10:28:39 INFO - PROCESS | 2984 | Values: 67.0 65.0 65.0 68.0 74.0 93.0 81.0 69.0 66.0 67.0 10:28:39 INFO - PROCESS | 2984 | -------- Summary: end -------- 10:28:39 INFO - PROCESS | 2984 | 10:28:40 INFO - TEST-INFO | 2984: exit 0 10:28:40 INFO - TEST-OK | kraken | took 56962ms 10:28:40 INFO - SUITE-END | took 1171s 10:28:40 INFO - Completed test suite (00:19:31) 10:28:40 INFO - Working with test: dromaeo_css 10:28:40 INFO - Generating results file: dromaeo_css 10:28:40 INFO - Working with test: kraken 10:28:40 INFO - Generating results file: kraken 10:28:40 INFO - javascript benchmark 10:28:40 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:28:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 10:28:41 INFO - process_Request line: dromaeo_css 7427.70 graph.html#tests=[[72,64,59]] 10:28:41 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:28:41 INFO - process_Request line: kraken 1447.20 graph.html#tests=[[232,64,59]] 10:28:41 INFO - RETURN: dromaeo_css: 7427.70 10:28:41 INFO - RETURN: kraken: 1447.20 10:28:41 INFO - javascript benchmark 10:28:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3401.642827503112, 3431.3995050866106, 3448.4310088835346, 3476.235228249784, 3490.1449144959474, 4736.881577960548, 5564.415736347676, 5632.155176723493, 5656.0, 5705.543556515479, 5609.57928155388, 5677.57418193635, 5682.0, 5688.744006519706, 5694.5729070319785, 5119.257707632381, 5136.2038883972855, 5165.7158856262895, 5166.302549155872, 5236.554892834114, 4337.414449049385, 5217.947820521784, 5221.477852214786, 5240.34495688039, 5242.737863106849, 5202.115640341151, 5214.426413094557, 5215.765290561915, 5218.13900706383, 5234.7644356004075, 5191.351081114861, 5195.246689230041, 5205.583553315726, 5208.322918020652, 5211.739413029333, 5067.670601410933, 5084.084864724348, 5217.58259339252, 5242.0, 5254.00173966945, 5690.833379157304, 5748.741306641211, 5773.451522105435, 5775.220345253421, 5779.479846813807, 6192.566520343577, 6217.160683307741, 6219.906701399483, 6225.657588832612, 6246.812595622138, 4946.33389370229, 6126.479249263818, 6162.661053642048, 6215.782447614311, 6247.062940558907, 5793.681347525884, 5802.970985145047, 5824.446677565582, 5865.706714664249, 5878.470937615635, 6205.286392064971, 6220.377962203744, 6225.066240064027, 6233.096201050822, 6250.4374606285655, 5959.374265702038, 6086.6348019119, 6129.172561704202, 6130.693465326716, 6194.876102478015, 6188.0, 6198.349173336825, 6219.782307619212, 6232.252129744369, 6264.0, 6190.133381326618, 6190.969045154746, 6216.316205217422, 6219.191505104308, 6232.439080482778, 6097.8475538111015, 6106.358832322631, 6130.734471166763, 6178.227721534809, 6202.844928876814, 4877.219644856806, 4897.2898929655, 4904.0, 4922.72924989129, 4925.1381008324115, 4377.474703035592, 4404.383386325917, 4414.050979039522, 4420.226460369487, 4454.086912182995, 5553.972230138824, 5633.0, 5644.407337229614, 5654.0, 5758.280214973129, 6208.565400422018, 6215.502759779207, 6220.222472190976, 6226.0, 6229.377062293825, 5628.437156284339, 5648.011597970339, 5652.406497317805, 5653.123765816223, 5663.943360566342, 5260.579153667697, 5271.0, 5322.28149199853, 5326.707031113326, 5330.626856120112, 6242.687865606701, 6268.780592679234, 6272.905906411316, 6277.403646653561, 6399.840003999751, 6164.537659675452, 6232.9715596926, 6234.812955611339, 6236.875262494634, 6248.312685604671, 6305.085762564494, 6337.366263373626, 6346.333634968262, 6350.460210882126, 6350.4919606432295, 6001.939980600138, 6142.508599312134, 6143.139960405636, 6159.476444502267, 6193.380661933951, 6189.721462534107, 6194.845128871814, 6209.851177532171, 6213.409726076015, 6219.937800621936, 6037.607555508878, 6064.666443345658, 6079.0, 6108.511319094373, 6117.082437634391, 5816.331121921034, 5921.763129474945, 6056.818295451144, 6058.666773327509, 6104.76233045773, 4990.6506544541535, 5808.273965754281, 5957.3744756799915, 5959.91060134107, 5969.492593129633, 6003.429674180946, 6066.484348830222, 6085.604435711664, 6089.817305480843, 6093.725782339717, 5916.319623243382, 5967.224260846062, 5985.132155837467, 6017.608855424383, 6073.696315184135], "unit": "score", "name": "dojo.html", "value": 5664.434459552029}, {"lowerIsBetter": false, "replicates": [450.45944866160613, 527.8914280011974, 556.2879514221795, 561.4469747298909, 565.2792689321112, 30213.848930755343, 37681.62318376819, 38430.8078459608, 38432.423513647314, 38483.23033539327, 40910.0, 41382.58617413825, 41464.79267603658, 41506.75479735605, 41521.79239103808, 9422.104900034486, 9549.140577348036, 9555.522223888778, 9565.186959108483, 9572.80854382912, 9494.098060684224, 9645.131938125567, 9650.758731031745, 9667.419954802699, 9672.90327096727, 9632.277579181555, 9674.70975870725, 9705.708828735149, 9706.514674266295, 9711.902880971205, 9563.187129094, 9656.986016468276, 9678.806423871554, 9688.515574221332, 9696.660616878375, 9592.95203523978, 9722.2708296878, 9727.027297270288, 9728.075832795874, 9737.172340351079, 31725.682743172503, 38808.02979925496, 39081.41377879334, 39131.82604521869, 39203.01992450183, 3176.9841150794327, 3205.743540516753, 3236.04536661683, 3549.2546565221332, 3966.6430021297933, 28335.149945501667, 28635.14094577166, 29231.2692182695, 29393.265168370748, 29760.66077026539, 2722.823016503941, 2766.4743698697184, 2864.7421732044218, 2981.2248815307958, 3006.5189569668746, 478699.0, 478972.0, 480159.59920200525, 480344.0, 480962.0, 56637.71681141568, 57422.55464672133, 57585.13622295669, 57769.42230577725, 65432.67283663646, 58864.0, 68752.0, 70211.64894175496, 70246.0, 70267.64866175636, 16110.0, 16291.674166516603, 16459.177041147894, 16479.505614831574, 16481.17594120289, 12528.0, 12574.81137782934, 12578.993680505537, 12598.622041338775, 12671.619851404472, 17925.64148717018, 18264.817351826576, 18324.81675183231, 18375.08124593765, 18388.540286492676, 8001.679932802739, 8308.958455207685, 8314.459560128573, 8318.667253309799, 8427.41008129425, 892.2817132208635, 898.667493027584, 981.5190556627344, 982.3516479123743, 989.4904124375952, 26342.0, 26393.20820375392, 26606.6009009865, 28408.00571979971, 28794.85602571974, 1019.5921631347372, 1043.4921538377123, 1062.198040479433, 1074.7044562745152, 1124.8312753087102, 12265.632031038904, 12483.812742808865, 13658.317084145952, 13794.241316727475, 13968.09207401536, 512144.0, 525204.0, 526047.0, 527997.0, 528872.0, 55623.72188139033, 55901.161482577794, 55933.720331398894, 56075.878482430126, 56097.0, 1408.5211028250444, 1422.4879043544315, 1435.648266174773, 1439.417036100381, 1442.1347191685115, 27374.589381159698, 28079.0, 28131.43737125287, 29279.0, 30152.24619384445, 49355.0, 52759.0, 53908.0, 53917.73041134769, 54015.72992135014, 483548.0, 495980.0, 498831.0, 498920.0, 499024.0, 29277.85361073181, 29948.85025574858, 30044.3991120172, 30134.84932575411, 30135.0, 41086.0, 41537.792311038254, 41621.75134745963, 42321.365179521716, 42692.786536068365, 36657.135871220045, 36660.45009324916, 37392.0, 37461.87614371573, 37542.812285939486, 36621.450678239315, 37016.07459813526, 37747.43378849374, 37846.0, 39334.016649582845, 37417.0, 37672.811635941645, 37703.86888393352, 38136.427953581275, 38309.23381532409, 36215.094622633595, 36932.44601330929, 37676.0, 37698.0, 37741.0, 25306.873465632554, 29116.7088329114, 29412.411751765274, 30444.0, 30873.76504939777], "unit": "score", "name": "ext.html", "value": 19636.151636399834}, {"lowerIsBetter": false, "replicates": [360.7871355900019, 364.49153430963787, 367.7701436602123, 368.2781747774362, 373.69357127155746, 13445.327733613329, 16188.75716864248, 18697.345592904236, 19455.31906383277, 20230.190792368325, 11913.927746502814, 12203.877961220385, 12216.816747748791, 13464.0, 19364.419067428, 3907.1404291055924, 5117.897642047157, 5336.759845806929, 5345.625806193568, 5364.785408583672, 3377.5778027746533, 3903.9804800975953, 4076.429299898017, 4078.4290199372113, 4081.9795901020602, 3151.77937544372, 4070.430139780433, 5652.180433837091, 5896.056630939051, 6100.145979562864, 6140.478059364959, 6331.715072821734, 6334.556581039352, 6335.904961425582, 6343.080253363282, 5231.241469986869, 5448.618596698233, 5457.699826509541, 5490.4901152183065, 5598.748056337434, 12833.486660533568, 13057.608271751767, 22872.65691014636, 23635.645465318034, 24491.65295908724, 2244.9551008979893, 2257.977420225793, 2326.685897403863, 2507.247825652297, 2739.493193759161, 9657.903420965771, 9668.274879384075, 9842.114209721089, 10177.592896284139, 10188.694339169837, 1734.6790843693957, 1801.6036471976145, 1811.420345489444, 1828.8811227270185, 1832.8625353098437, 73085.6345718268, 90127.54936225343, 96582.9999999993, 101499.0, 102584.0, 11121.610743623934, 11176.832347514794, 11195.216334856483, 11209.663710088711, 11327.150463715254, 13386.732265354638, 13545.187288762509, 13571.0, 13582.185068895898, 13595.048346615642, 8357.95821020891, 8386.412951093365, 8442.324614030862, 8530.402871798915, 8549.358798090043, 8532.018817836028, 8533.957330213309, 8545.957270213608, 8632.956835215784, 8638.654453821902, 3985.940210896839, 4354.629856462237, 4439.556044395535, 4453.465584129925, 4469.821207151743, 1741.2860727102081, 1793.847522960537, 1882.454088314401, 1884.7133789719694, 1884.9717254241198, 853.1894700034992, 885.2121611765534, 964.2093483343591, 994.6469003503797, 1053.378506681062, 15369.538913832603, 19170.424887253404, 19500.609987800166, 19925.601487970158, 20001.699974500396, 899.7795540092719, 949.7768024514234, 1002.7994401119805, 1029.7437126705408, 1052.310736467615, 7520.849583008309, 10580.682579522627, 10599.788004239872, 10606.734831629272, 10613.938606139323, 347064.0, 670215.0, 671518.0, 700213.0, 736544.0, 69326.0, 72262.0, 101998.49000755096, 111664.44167779271, 111813.0, 1135.2393896089475, 1142.4230763464398, 1151.407025381929, 1166.5333866453486, 1169.92980421175, 17315.393961211295, 17508.0, 17513.0, 17555.736663950305, 17844.91077544604, 34943.0, 36906.44640330344, 48566.0, 50545.74727126341, 52061.47938520566, 69109.0, 69989.30010699827, 72258.55482890418, 72272.0, 72943.0, 7568.886466702894, 7733.4973226740085, 7759.92240077592, 7760.3403710685225, 7762.961185194038, 7590.620468976639, 10070.899291007288, 11730.237534560227, 11754.23597466162, 11887.108466864847, 8494.830103397773, 10138.949305253427, 10263.484344762626, 10347.63783267582, 10407.271490995558, 9133.817323653622, 10046.69859904204, 10183.796324073624, 10270.435126068138, 10318.277720559488, 10543.78912421732, 10554.841677374692, 10561.89438105609, 10818.404987725751, 10934.398608076632, 6535.183102112236, 7605.163432022584, 7745.302922736981, 7753.147153812964, 7790.5325680459355, 10208.285420020527, 10480.528376222936, 10517.21120915919, 10721.678349649523, 10754.73113172177], "unit": "score", "name": "jquery.html", "value": 8779.770759056833}, {"lowerIsBetter": false, "replicates": [1174.6828356343792, 1498.475533563253, 1520.4146403634602, 1759.12923103064, 1948.9610207795836, 7894.605269736512, 8082.070561885385, 8536.231739143475, 8745.86881196781, 8754.781130471742, 7236.384907282887, 8670.0, 8738.344624153182, 8746.825063498727, 8773.254273386754, 2162.19998600518, 2228.821694264463, 2473.356927198932, 2500.3874050857476, 2500.712418071927, 2460.2988148377717, 2526.4441822798954, 2528.1404322530334, 2528.481661259447, 2533.721290658026, 2427.5630386530415, 2507.924762257126, 2509.9749002510016, 2510.435152090774, 2512.648229247907, 2465.4452748131616, 2482.391814005571, 2508.749125087495, 2513.258588716333, 2515.0317127905705, 2471.3327401601646, 2501.124606387768, 2508.172303139978, 2518.7355327690693, 2520.4707011527416, 8757.605907734167, 8801.867971980426, 8809.64761409543, 8821.911780882174, 8835.0, 5383.515483606494, 5464.617476776627, 5481.150421684645, 5488.423715509894, 5534.667919924817, 3639.1266096137, 3639.2175682228185, 3719.3119272934596, 3769.3403654360377, 3773.5471743390694, 1036.310853282566, 1051.9900895140674, 1064.9893501065046, 1090.596479302655, 1093.371311495893, 12228.510859565607, 12241.510339586406, 12246.81629775554, 12257.877421225852, 12265.877341226562, 4914.459409464956, 4917.286993385939, 4980.352554167935, 4980.551750342414, 5001.049800537886, 10240.48797560119, 10244.334118282288, 10261.435621040915, 10264.794704106025, 10268.178545716324, 5535.363433205233, 5538.252335934678, 5542.3626282977975, 5555.250041244381, 5560.666360018331, 4974.801007959641, 4999.625028122832, 5035.521625445577, 5044.697318160922, 5048.419431765394, 3634.800085995296, 3726.7763934164036, 3731.1791405890663, 3735.0475628714503, 3895.182011777502, 1272.7772639788186, 1298.1756584568866, 1312.3766211049865, 1313.0611612696966, 1314.2574445438297, 1319.577735124751, 1331.7269959658247, 1358.151155527795, 1359.6872719274622, 1363.3455941148304, 7815.687372505036, 7957.244061814118, 7963.920360796318, 7965.641546130438, 8007.919920800834, 1157.6874243954085, 1173.4602083041725, 1176.1355403778387, 1186.300082951063, 1198.7722332756748, 6145.539084568675, 6243.063540468966, 6245.313015568284, 6245.750169993149, 6251.343608921089, 9978.550965206583, 10330.586776528855, 10346.275760696679, 10459.424731639832, 10462.738431539272, 9989.051040151175, 10281.383117013003, 10324.948375258076, 10326.01902819231, 10368.688939331832, 8181.3863960203225, 8202.90825839407, 8298.751037468886, 8306.584670766437, 8322.45904016237, 7942.205779422012, 7943.046834379911, 7954.84090318202, 8054.798630034062, 8192.19771650236, 9445.905540944503, 9530.571124299284, 9637.614495420105, 9733.756656083655, 9737.951310243403, 9526.380785248937, 9844.261680374144, 10025.298229123891, 10038.247131465316, 10123.0, 7512.136104347851, 7530.058742657168, 7534.924650753642, 7633.1985141559335, 7642.350400216044, 7220.025296584894, 8090.15053419406, 8187.099419063779, 8190.344772418073, 8202.83594328122, 5812.83743251343, 7057.0472986146215, 7340.192578816219, 7547.50941188821, 7623.085229772463, 7405.925940740523, 7601.7719468416035, 7641.044869391326, 7642.770716878503, 7662.080550333995, 7589.544627322378, 7709.7301594443925, 7716.151223365538, 7727.343175830118, 7729.690812367442, 6903.378695917391, 6977.511574189758, 6996.16046074454, 7076.681549330396, 7080.610566418691, 7107.289271072851, 7125.714971401086, 7200.315969982843, 7201.675924583302, 7213.819654508679], "unit": "score", "name": "mootools.html", "value": 4962.234197765286}, {"lowerIsBetter": false, "replicates": [322.49368491468397, 327.22121351184177, 331.5441268256148, 334.9681780230879, 336.93092915952235, 6714.832129196772, 6756.425703815169, 6773.932260677386, 6776.525643204972, 6792.218894827096, 6622.238442579105, 6660.933390666092, 6682.6658667066695, 6684.0, 6686.130802995616, 4101.220768054075, 4666.53334666534, 4913.91893783368, 4928.359313289286, 4929.186684197103, 4839.209492487785, 4853.150698627744, 4867.002264535761, 4868.318435419044, 4877.463479017305, 4781.976090119562, 4790.281457781343, 4808.759562021885, 4810.4948980357085, 4811.4707382187935, 4585.174668559658, 4658.068386322749, 4737.50256223095, 4798.976005119952, 4816.542428469307, 4033.3546632538655, 4073.042834933788, 4083.9591604083876, 4089.018635527482, 4099.077707515815, 6134.969325153345, 6316.842078948063, 6318.74725010999, 6355.0, 6356.523260755462, 5513.889722205534, 5535.086710692731, 5633.60564760467, 5639.238702775114, 5688.11834165705, 7032.613206273653, 7055.294470552955, 7063.646817659096, 7066.92933070673, 7097.89353159703, 4567.817287308504, 4576.153411618828, 4589.5639914208095, 4600.907981840344, 4605.976970115128, 7093.0, 7438.73964411243, 7446.776596702053, 7452.329290363839, 7458.4033277337685, 4639.814407423665, 4642.6536304472, 4652.860414187579, 4655.231886738718, 4656.185167595657, 4715.104130215248, 4734.147853386424, 4737.265723812815, 4740.004599034172, 4741.95258047422, 5519.503244707996, 5655.802046928337, 5669.688167150764, 5674.574406919498, 5735.483806457439, 7146.749863754848, 7147.1780745214965, 7163.283671632795, 7171.533850299714, 7180.5691658500655, 1628.2184551415387, 1648.546649671326, 1651.2074204381963, 1652.5868532866784, 1656.9088700121608, 1041.6614600254948, 1059.1156384418941, 1060.750723579958, 1060.9946950265198, 1076.6393258258415, 6611.206655201407, 6616.86766264672, 6619.238787539494, 6632.568883022588, 6663.666816659148, 7344.192138864721, 7360.595167265745, 7363.447741419308, 7364.484486085923, 7382.0, 6355.777547785898, 6626.138601981808, 6627.801165965029, 6634.0, 6644.368784965421, 3876.612338766101, 3924.0, 3928.3518219493462, 3933.252681990413, 3933.2920074386884, 7756.379489640815, 7760.650770715331, 7771.572563509061, 7772.922270777333, 7781.649825757854, 6078.848028799315, 7346.118465784033, 7505.62471876404, 7604.505707129019, 7639.465237433437, 7780.105287891852, 7807.726729564438, 7809.609519524115, 7833.629114904868, 7840.09838868526, 6250.781097685907, 7076.32774886385, 7416.3325300721035, 7419.851602968019, 7444.813879653052, 6239.937600624117, 7134.536255143399, 7275.308845659654, 7366.521176123535, 7376.225496323023, 5822.679752613478, 6995.650217489207, 7256.89114663291, 7667.00328957232, 7858.921410785819, 3874.5931677174617, 4548.431446069241, 4641.791119399568, 4695.22528782747, 4715.033418149203, 7361.227071157666, 7365.852682946418, 7387.2243414442855, 7397.038385009914, 7401.33387995083, 7152.9284707152265, 7163.176234732864, 7165.462590305644, 7166.032585600877, 7172.211056783854, 6895.482838787211, 7153.856922861618, 7155.892661609976, 7166.10098323955, 7170.462215333767, 6950.20072691647, 6972.825679357854, 6976.965115174392, 6979.4765392594745, 6986.930130698831, 5482.671039737628, 7155.749548765768, 7158.0336654550965, 7165.928340716526, 7166.462515311477, 6936.930630693629, 6978.0, 6986.16166060076, 6998.860022799414, 7016.894746578703], "unit": "score", "name": "prototype.html", "value": 5162.984989157161}, {"lowerIsBetter": false, "replicates": [656.7471523463466, 671.1878626861501, 688.9242183359833, 707.4128473367106, 733.7285204474346, 14727.410903563858, 14898.77651835222, 14914.925425372872, 14916.0, 14917.32872020759, 13352.265625390599, 13528.729425411486, 13736.587902362946, 13774.862251377508, 13775.242361670129, 589.849588354971, 683.931606839317, 837.0, 853.9701110461135, 855.4995327733284, 831.9209675080857, 837.2213841127749, 850.196564246787, 850.6554845287637, 851.0765819086299, 888.0231745080392, 892.7143314139478, 893.4907102951321, 894.4141587260355, 894.5259012723267, 708.6350529477323, 719.3669570777735, 855.1021427501099, 878.433410450256, 881.8544940084911, 654.499308029358, 656.6454114778014, 657.8815813153631, 657.947364210862, 658.2134349452406, 14422.855771442257, 14436.49472268476, 14469.927650361786, 14494.42022319106, 14567.927160364236, 12228.881635182972, 12333.938330308381, 12377.443015064253, 12862.678433039155, 13175.077744557884, 9650.855237171449, 9788.608455661764, 9799.706008819747, 9804.215662746963, 9805.754856128582, 3500.334936362083, 3530.0821786335737, 3531.682148606638, 3535.6287589803214, 3538.840752166159, 80367.0, 81116.59441702753, 81166.0, 82186.0, 82237.58881205616, 8918.420302680304, 8976.326775491863, 8993.955030224806, 9058.230050445654, 9109.81780364389, 19423.708644370345, 19630.312939047064, 19642.803571964098, 19710.605787884448, 19763.308284209983, 7186.31729985661, 7377.6311184440565, 7508.62456877154, 7524.510906791041, 7696.576688282198, 4144.41978123057, 4164.312888373384, 4167.1457351242925, 4200.537940826506, 4206.8737937861915, 3530.894073177809, 3586.318599466093, 3587.192881601619, 3590.0665826885197, 3597.8201089945396, 636.4780879678619, 654.9181352330959, 663.5952069237761, 665.6072916979006, 677.1062197898825, 540.6620861961275, 575.6920047774504, 587.4125874125874, 622.7664625765339, 652.2401402366285, 7839.764807055797, 8568.742937711879, 8614.526201058876, 8772.692955746517, 9317.813643727088, 522.3575002746643, 582.3768567632677, 589.1810383566846, 600.2436929468901, 612.0, 3819.6180381962135, 3968.3253846846105, 3995.800209989489, 4022.0710023747233, 4127.979360103181, 90910.0, 91818.0, 92442.0, 92636.0, 92793.53603232076, 78036.0, 78624.0, 78678.0, 78745.60627196827, 80450.0, 59869.0, 60597.0, 61143.388566114656, 61201.693991529755, 61547.6922615393, 7206.89189662145, 7924.247196516321, 8152.83694326122, 8191.0, 8289.751307460545, 33782.49326260157, 42985.12238042023, 43943.780281099665, 44183.89540261519, 44329.55670443254, 56059.0, 57011.71494142503, 66350.33649663441, 66854.0, 67378.66310668415, 10967.396793176453, 11041.83437248458, 11251.268667536584, 11272.041876440266, 11586.131040171853, 11817.231879927776, 11845.46695398692, 11853.762924741284, 11860.76278474443, 12257.754844903231, 10807.405592692478, 11121.83317250258, 11428.657140285804, 11490.712732181428, 11507.367094809866, 11396.316221026766, 12052.975497082845, 12107.939460302641, 12194.26869371394, 12347.567835125728, 10802.783944320912, 10929.344239345346, 11244.04425623831, 11480.655580332603, 12058.0, 9401.952990235006, 9423.0, 9547.093026162504, 9547.665831695856, 9613.279004074862, 8195.975503062116, 8984.550772461482, 9931.354461959949, 9998.550065247227, 10021.699349019249], "unit": "score", "name": "yui.html", "value": 6711.467267763534}], "name": "dromaeo_css", "value": 7427.698152979993}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 119.0, 162.0, 155.0, 109.0, 115.0, 112.0, 111.0, 108.0], "unit": "score", "name": "ai-astar", "value": 120.8}, {"lowerIsBetter": true, "replicates": [160.0, 121.0, 144.0, 154.0, 120.0, 140.0, 125.0, 182.0, 170.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [187.0, 187.0, 184.0, 189.0, 187.0, 186.0, 186.0, 183.0, 180.0, 185.0], "unit": "score", "name": "audio-dft", "value": 185.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 87.0, 78.0, 56.0, 58.0, 58.0, 79.0, 80.0, 55.0], "unit": "score", "name": "audio-fft", "value": 70.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 130.0, 78.0, 82.0, 80.0, 111.0, 76.0, 79.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 93.6}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 86.0, 92.0, 85.0, 89.0, 84.0, 93.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 94.9}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 87.0, 87.0, 88.0, 86.0, 85.0, 86.0, 87.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 86.5}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 54.0, 53.0, 53.0, 53.0, 52.0, 64.0, 60.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 69.0, 77.0, 72.0, 68.0, 68.0, 68.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 84.0, 83.0, 81.0, 83.0, 81.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [134.0, 128.0, 144.0, 127.0, 121.0, 122.0, 123.0, 128.0, 121.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [162.0, 158.0, 164.0, 174.0, 136.0, 126.0, 162.0, 174.0, 144.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.6}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 65.0, 68.0, 74.0, 93.0, 81.0, 69.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1447.2}]} 10:28:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1447.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7427.70"}}} 10:28:41 INFO - Return code: 0 10:28:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:28:41 INFO - # TBPL SUCCESS # 10:28:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:28:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:28:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:28:41 INFO - 2016-02-08 10:28:41.611 screenresolution[2988:31187] starting screenresolution argv=screenresolution get 10:28:41 INFO - 2016-02-08 10:28:41.613 screenresolution[2988:31187] Display 0: 1600x1200x32@60 10:28:41 INFO - 2016-02-08 10:28:41.619 screenresolution[2989:31190] starting screenresolution argv=screenresolution list 10:28:41 INFO - Available Modes on Display 0 10:28:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:28:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:28:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:28:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:28:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:28:41 INFO - Intel Iris: 10:28:41 INFO - Chipset Model: Intel Iris 10:28:41 INFO - Type: GPU 10:28:41 INFO - Bus: Built-In 10:28:41 INFO - VRAM (Dynamic, Max): 1536 MB 10:28:41 INFO - Vendor: Intel (0x8086) 10:28:41 INFO - Device ID: 0x0a2e 10:28:41 INFO - Revision ID: 0x0009 10:28:41 INFO - Displays: 10:28:41 INFO - Display: 10:28:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:28:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:28:41 INFO - Display Serial Number: 1600x1200 60 10:28:41 INFO - Main Display: Yes 10:28:41 INFO - Mirror: Off 10:28:41 INFO - Online: Yes 10:28:41 INFO - Rotation: Supported 10:28:41 INFO - Return code: 0 10:28:41 INFO - Running post-action listener: _resource_record_post_action 10:28:41 INFO - Running post-run listener: _resource_record_post_run 10:28:42 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 311296; Write bytes: 712271872; Read time: 3; Write time: 1977 10:28:42 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386798080; Write bytes: 381655040; Read time: 29366; Write time: 735 10:28:42 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 311296; Write bytes: 303185920; Read time: 3; Write time: 1191 10:28:42 INFO - Running post-run listener: _upload_blobber_files 10:28:42 INFO - Blob upload gear active. 10:28:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:28:42 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:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:28:43 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:28:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:28:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:46 INFO - (blobuploader) - INFO - Done attempting. 10:28:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:28:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:47 INFO - (blobuploader) - INFO - Done attempting. 10:28:47 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:47 INFO - Return code: 0 10:28:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:28:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9dd31bce22f2dfa9a59ba823f802264c0e478677d7b6af3b83385c72e43af8fbbd67166fc117bf04c631c699142b33a5dc807cab5af619f1cf9174206e29ba7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cfd3ea9fd38fc0802485ff0c9d2790eb6d63b3e91cc20b86ab4185247c4e3fe691109981b44e9f8f445cf1cedc1b42777d74ed85c218a8966566a3c4b53f39d"} 10:28:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:28:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:28:47 INFO - Contents: 10:28:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9dd31bce22f2dfa9a59ba823f802264c0e478677d7b6af3b83385c72e43af8fbbd67166fc117bf04c631c699142b33a5dc807cab5af619f1cf9174206e29ba7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cfd3ea9fd38fc0802485ff0c9d2790eb6d63b3e91cc20b86ab4185247c4e3fe691109981b44e9f8f445cf1cedc1b42777d74ed85c218a8966566a3c4b53f39d"} 10:28:47 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:47 INFO - Copying logs to upload dir... 10:28:47 INFO - mkdir: /builds/slave/test/build/upload/logs 10:28:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.421844 ========= master_lag: 1.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-08 10:28:49.134486) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 10:28:49.138287) ========= 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.w0BTe3cpRR/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.2jB91Vei3B/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9dd31bce22f2dfa9a59ba823f802264c0e478677d7b6af3b83385c72e43af8fbbd67166fc117bf04c631c699142b33a5dc807cab5af619f1cf9174206e29ba7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cfd3ea9fd38fc0802485ff0c9d2790eb6d63b3e91cc20b86ab4185247c4e3fe691109981b44e9f8f445cf1cedc1b42777d74ed85c218a8966566a3c4b53f39d"} build_url:https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/CJnv2eVxQTGfpatNlTGZgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9dd31bce22f2dfa9a59ba823f802264c0e478677d7b6af3b83385c72e43af8fbbd67166fc117bf04c631c699142b33a5dc807cab5af619f1cf9174206e29ba7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cfd3ea9fd38fc0802485ff0c9d2790eb6d63b3e91cc20b86ab4185247c4e3fe691109981b44e9f8f445cf1cedc1b42777d74ed85c218a8966566a3c4b53f39d"}' ========= master_lag: 0.33 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 10:28:49.482528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:28:49.486972) ========= 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.w0BTe3cpRR/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.2jB91Vei3B/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005279 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:28:49.539087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 10:28:49.539470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 10:28:49.539980) ========= ========= Total master_lag: 8.59 =========