builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0020 starttime: 1455535476.87 results: success (0) buildid: 20160210023622 builduid: 79b6366fca934c29aa0ddaefb4171218 revision: cb04e167e1df430f985451628b796b8d26819772 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:36.865912) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:36.866338) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-02-15 03:24:36.866658) ========= 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.IbaFXqomPa/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.TNI1r8CynE/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005627 basedir: '/builds/slave/test' ========= master_lag: 1.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-02-15 03:24:37.946804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2016-02-15 03:24:37.947169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2016-02-15 03:24:43.289662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:43.289948) ========= 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.IbaFXqomPa/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.TNI1r8CynE/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005703 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:43.374904) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:43.375240) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:43.375641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 03:24:43.375949) ========= 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.IbaFXqomPa/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.TNI1r8CynE/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-15 03:24:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.9M=0.001s 2016-02-15 03:24:43 (19.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196108 ========= master_lag: 1.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 03:24:44.970226) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:44.970549) ========= 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.IbaFXqomPa/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.TNI1r8CynE/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.027276 ========= master_lag: 0.85 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:45.845557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 03:24:45.845898) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cb04e167e1df430f985451628b796b8d26819772 --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 cb04e167e1df430f985451628b796b8d26819772 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IbaFXqomPa/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.TNI1r8CynE/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-15 03:24:45,956 truncating revision to first 12 chars 2016-02-15 03:24:45,956 Setting DEBUG logging. 2016-02-15 03:24:45,956 attempt 1/10 2016-02-15 03:24:45,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cb04e167e1df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 03:24:46,940 unpacking tar archive at: fx-team-cb04e167e1df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.219354 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 03:24:47.485979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:47.492365) ========= echo cb04e167e1df430f985451628b796b8d26819772 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cb04e167e1df430f985451628b796b8d26819772'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IbaFXqomPa/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.TNI1r8CynE/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 cb04e167e1df430f985451628b796b8d26819772 program finished with exit code 0 elapsedTime=0.005870 script_repo_revision: 'cb04e167e1df430f985451628b796b8d26819772' ========= master_lag: 0.44 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:47.936834) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:47.937159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 03:24:48.149914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2016-02-15 03:24:48.150332) ========= /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.IbaFXqomPa/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.TNI1r8CynE/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:24:48 INFO - MultiFileLogger online at 20160215 03:24:48 in /builds/slave/test 03:24:48 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 03:24:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:48 INFO - {'append_to_log': False, 03:24:48 INFO - 'base_work_dir': '/builds/slave/test', 03:24:48 INFO - 'blob_upload_branch': 'Fx-Team', 03:24:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:48 INFO - 'branch': 'Fx-Team', 03:24:48 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:48 INFO - 'config_files': ('talos/mac_config.py',), 03:24:48 INFO - 'default_actions': ('clobber', 03:24:48 INFO - 'read-buildbot-config', 03:24:48 INFO - 'download-and-extract', 03:24:48 INFO - 'populate-webroot', 03:24:48 INFO - 'create-virtualenv', 03:24:48 INFO - 'install', 03:24:48 INFO - 'run-tests'), 03:24:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:48 INFO - 'download_minidump_stackwalk': True, 03:24:48 INFO - 'download_symbols': 'ondemand', 03:24:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:48 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:48 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:48 INFO - 'installer_path': 'installer.exe', 03:24:48 INFO - 'log_level': 'info', 03:24:48 INFO - 'log_name': 'talos', 03:24:48 INFO - 'log_to_console': True, 03:24:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:24:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:24:48 INFO - 'opt_config_files': (), 03:24:48 INFO - 'pip_index': False, 03:24:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:24:48 INFO - 'cmd': ('bash', 03:24:48 INFO - '-c', 03:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:24:48 INFO - 'enabled': True, 03:24:48 INFO - 'halt_on_failure': False, 03:24:48 INFO - 'name': 'check_screen_resolution'},), 03:24:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:24:48 INFO - 'cmd': ('bash', 03:24:48 INFO - '-c', 03:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:24:48 INFO - 'enabled': True, 03:24:48 INFO - 'halt_on_failure': False, 03:24:48 INFO - 'name': 'check_screen_resolution'},), 03:24:48 INFO - 'run_cmd_checks_enabled': True, 03:24:48 INFO - 'sps_profile': False, 03:24:48 INFO - 'sps_profile_interval': 0, 03:24:48 INFO - 'suite': 'dromaeojs', 03:24:48 INFO - 'system_bits': '32', 03:24:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:48 INFO - 'title': 't-yosemite-r7-0020', 03:24:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:48 INFO - 'use_talos_json': True, 03:24:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:48 INFO - 'work_dir': 'build'} 03:24:48 INFO - ##### 03:24:48 INFO - ##### Running clobber step. 03:24:48 INFO - ##### 03:24:48 INFO - Running pre-action listener: _resource_record_pre_action 03:24:48 INFO - Running main action method: clobber 03:24:48 INFO - rmtree: /builds/slave/test/build 03:24:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:49 INFO - Running post-action listener: _resource_record_post_action 03:24:49 INFO - ##### 03:24:49 INFO - ##### Running read-buildbot-config step. 03:24:49 INFO - ##### 03:24:49 INFO - Running pre-action listener: _resource_record_pre_action 03:24:49 INFO - Running main action method: read_buildbot_config 03:24:49 INFO - Using buildbot properties: 03:24:49 INFO - { 03:24:49 INFO - "project": "", 03:24:49 INFO - "product": "firefox", 03:24:49 INFO - "script_repo_revision": "production", 03:24:49 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 03:24:49 INFO - "repository": "", 03:24:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 03:24:49 INFO - "buildid": "20160210023622", 03:24:49 INFO - "pgo_build": "False", 03:24:49 INFO - "basedir": "/builds/slave/test", 03:24:49 INFO - "buildnumber": 438, 03:24:49 INFO - "slavename": "t-yosemite-r7-0020", 03:24:49 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:24:49 INFO - "platform": "yosemite_r7", 03:24:49 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:24:49 INFO - "branch": "fx-team", 03:24:49 INFO - "repo_path": "integration/fx-team", 03:24:49 INFO - "revision": "cb04e167e1df430f985451628b796b8d26819772", 03:24:49 INFO - "stage_platform": "macosx64", 03:24:49 INFO - "builduid": "79b6366fca934c29aa0ddaefb4171218", 03:24:49 INFO - "slavebuilddir": "test" 03:24:49 INFO - } 03:24:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 03:24:49 INFO - Running post-action listener: _resource_record_post_action 03:24:49 INFO - ##### 03:24:49 INFO - ##### Running download-and-extract step. 03:24:49 INFO - ##### 03:24:49 INFO - Running pre-action listener: _resource_record_pre_action 03:24:49 INFO - Running main action method: download_and_extract 03:24:49 INFO - mkdir: /builds/slave/test/build/tests 03:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:49 INFO - https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/test_packages.json 03:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/test_packages.json 03:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:24:55 INFO - Downloaded 1277 bytes. 03:24:55 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:24:55 INFO - Using the following test package requirements: 03:24:55 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:24:55 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:24:55 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 03:24:55 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:24:55 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 03:24:55 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:24:55 INFO - u'jsshell-mac.zip'], 03:24:55 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:24:55 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 03:24:55 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:24:55 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:24:55 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 03:24:55 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:24:55 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 03:24:55 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:24:55 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 03:24:55 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:24:55 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:24:55 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 03:24:55 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:55 INFO - https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:24:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:24:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:24:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/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 03:24:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/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 03:25:16 INFO - Downloaded 17747103 bytes. 03:25:16 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'] 03:25:16 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 03:25:19 INFO - Return code: 0 03:25:19 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 03:25: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')]} 03:25:19 INFO - https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:25:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:25:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:25:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/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 03:25:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/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 03:25:44 INFO - Downloaded 17747103 bytes. 03:25: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'] 03:25: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 03:25:47 INFO - Return code: 0 03:25: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')]} 03:25:47 INFO - https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:25:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:25:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:25:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/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 03:25:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/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 03:25:49 INFO - Downloaded 10706547 bytes. 03:25:49 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'] 03:25:49 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 03:25:49 INFO - Return code: 0 03:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:49 INFO - https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:25:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:25:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:25:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 03:25:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GubVD9ozRK-0UGaFsB3lEw/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 03:25:52 INFO - Downloaded 111184231 bytes. 03:25:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:25:52 INFO - mkdir: /builds/slave/test/properties 03:25:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:52 INFO - Contents: 03:25:52 INFO - build_url:https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:25:53 INFO - Running post-action listener: _resource_record_post_action 03:25:53 INFO - Running post-action listener: set_extra_try_arguments 03:25:53 INFO - ##### 03:25:53 INFO - ##### Running populate-webroot step. 03:25:53 INFO - ##### 03:25:53 INFO - Running pre-action listener: _resource_record_pre_action 03:25:53 INFO - Running main action method: populate_webroot 03:25:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:53 INFO - '--tppagecycles', 03:25:53 INFO - '7'], 03:25:53 INFO - 'tests': ['tsvgm']}}, 03:25:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:25:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:25:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:25:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:25:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--e10s'], 03:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'tests': ['damp', 'tps']}, 03:25:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--e10s'], 03:25:53 INFO - 'tests': ['damp', 'tps']}, 03:25:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:25:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:53 INFO - 'other': {'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore']}, 03:25:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:25:53 INFO - 'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore']}, 03:25:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:25:53 INFO - 'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore']}, 03:25:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:25:53 INFO - 'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore']}, 03:25:53 INFO - 'other_l64': {'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore']}, 03:25:53 INFO - 'other_nol64': {'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore']}, 03:25:53 INFO - 'svgr': {'tests': ['tsvgx', 03:25:53 INFO - 'tsvgr_opacity', 03:25:53 INFO - 'tart', 03:25:53 INFO - 'tscrollx', 03:25:53 INFO - 'cart']}, 03:25:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:25:53 INFO - 'tests': ['tsvgx', 03:25:53 INFO - 'tsvgr_opacity', 03:25:53 INFO - 'tart', 03:25:53 INFO - 'tscrollx', 03:25:53 INFO - 'cart']}, 03:25:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'tests': ['tp5o']}, 03:25:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--e10s'], 03:25:53 INFO - 'tests': ['tp5o']}, 03:25:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--xperf_path', 03:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:53 INFO - 'tests': ['tp5n']}, 03:25:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--e10s', 03:25:53 INFO - '--xperf_path', 03:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:53 INFO - 'tests': ['tp5n']}}, 03:25:53 INFO - 'talos.zip': {'path': '', 03:25:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:53 INFO - Running post-action listener: _resource_record_post_action 03:25:53 INFO - ##### 03:25:53 INFO - ##### Running create-virtualenv step. 03:25:53 INFO - ##### 03:25:53 INFO - Running pre-action listener: _resource_record_pre_action 03:25:53 INFO - Running main action method: create_virtualenv 03:25:53 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:53 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 03:25:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:54 INFO - Using real prefix '/tools/python27' 03:25:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:57 INFO - Installing pip.................done. 03:25:57 INFO - Return code: 0 03:25:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:57 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 0x10da99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd283dd8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, '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.IbaFXqomPa/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.TNI1r8CynE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:25:57 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 03:25:57 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 03:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:57 INFO - 'HOME': '/Users/cltbld', 03:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:57 INFO - 'LOGNAME': 'cltbld', 03:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:57 INFO - 'MOZ_NO_REMOTE': '1', 03:25:57 INFO - 'NO_EM_RESTART': '1', 03:25:57 INFO - 'PAGER': '/bin/cat', 03:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:57 INFO - 'PWD': '/builds/slave/test', 03:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:57 INFO - 'SHELL': '/bin/bash', 03:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:25:57 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:57 INFO - 'USER': 'cltbld', 03:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:57 INFO - 'XPC_FLAGS': '0x0', 03:25:57 INFO - 'XPC_SERVICE_NAME': '0', 03:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:57 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 03:25:57 INFO - Cleaning up... 03:25:57 INFO - Return code: 0 03:25:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:57 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 0x10da99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd283dd8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, '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.IbaFXqomPa/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.TNI1r8CynE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:25:57 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 03:25:57 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 03:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:57 INFO - 'HOME': '/Users/cltbld', 03:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:57 INFO - 'LOGNAME': 'cltbld', 03:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:57 INFO - 'MOZ_NO_REMOTE': '1', 03:25:57 INFO - 'NO_EM_RESTART': '1', 03:25:57 INFO - 'PAGER': '/bin/cat', 03:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:57 INFO - 'PWD': '/builds/slave/test', 03:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:57 INFO - 'SHELL': '/bin/bash', 03:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:25:57 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:57 INFO - 'USER': 'cltbld', 03:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:57 INFO - 'XPC_FLAGS': '0x0', 03:25:57 INFO - 'XPC_SERVICE_NAME': '0', 03:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:58 INFO - Downloading/unpacking psutil>=0.7.1 03:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:01 INFO - Installing collected packages: psutil 03:26:01 INFO - Running setup.py install for psutil 03:26:01 INFO - building 'psutil._psutil_osx' extension 03:26:01 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 03:26:02 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 03:26:02 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 03:26:02 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 03:26:02 INFO - building 'psutil._psutil_posix' extension 03:26:02 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 03:26:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:26:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:26:02 INFO - ^ 03:26:02 INFO - 1 warning generated. 03:26:02 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 03:26:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:02 INFO - Successfully installed psutil 03:26:02 INFO - Cleaning up... 03:26:02 INFO - Return code: 0 03:26:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:02 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 0x10da99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd283dd8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, '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.IbaFXqomPa/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.TNI1r8CynE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:26:02 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 03:26:02 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 03:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:02 INFO - 'HOME': '/Users/cltbld', 03:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:02 INFO - 'LOGNAME': 'cltbld', 03:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:02 INFO - 'MOZ_NO_REMOTE': '1', 03:26:02 INFO - 'NO_EM_RESTART': '1', 03:26:02 INFO - 'PAGER': '/bin/cat', 03:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:02 INFO - 'PWD': '/builds/slave/test', 03:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:02 INFO - 'SHELL': '/bin/bash', 03:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:26:02 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:02 INFO - 'USER': 'cltbld', 03:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:02 INFO - 'XPC_FLAGS': '0x0', 03:26:02 INFO - 'XPC_SERVICE_NAME': '0', 03:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:26:02 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 03:26:02 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 03:26:02 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 03:26:02 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 03:26:02 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 03:26:02 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 03:26:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:26:05 INFO - Installing collected packages: mozsystemmonitor 03:26:05 INFO - Running setup.py install for mozsystemmonitor 03:26:05 INFO - Successfully installed mozsystemmonitor 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:05 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')]} 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 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')]} 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 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 0x10da99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd283dd8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, '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.IbaFXqomPa/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.TNI1r8CynE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:26:05 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 03:26:05 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 03:26:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:26:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:05 INFO - 'HOME': '/Users/cltbld', 03:26:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:05 INFO - 'LOGNAME': 'cltbld', 03:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:05 INFO - 'MOZ_NO_REMOTE': '1', 03:26:05 INFO - 'NO_EM_RESTART': '1', 03:26:05 INFO - 'PAGER': '/bin/cat', 03:26:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:05 INFO - 'PWD': '/builds/slave/test', 03:26:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:05 INFO - 'SHELL': '/bin/bash', 03:26:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:26:05 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:26:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:05 INFO - 'USER': 'cltbld', 03:26:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:05 INFO - 'XPC_FLAGS': '0x0', 03:26:05 INFO - 'XPC_SERVICE_NAME': '0', 03:26:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:05 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 03:26:05 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 03:26:05 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 03:26:05 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 03:26:05 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 03:26:05 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 03:26:08 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:08 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 03:26:08 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 03:26:08 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 03:26:08 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 03:26:08 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 03:26:08 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 03:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:08 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 03:26:08 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 03:26:08 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 03:26:08 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 03:26:08 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 03:26:08 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 03:26:09 INFO - Downloading docopt-0.6.1.tar.gz 03:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:09 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:09 INFO - Running setup.py install for blobuploader 03:26:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:09 INFO - Running setup.py install for requests 03:26:09 INFO - Running setup.py install for docopt 03:26:10 INFO - Successfully installed blobuploader requests docopt 03:26:10 INFO - Cleaning up... 03:26:10 INFO - Return code: 0 03:26:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:10 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 0x10da99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd283dd8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, '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.IbaFXqomPa/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.TNI1r8CynE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:26:10 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 03:26:10 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 03:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:10 INFO - 'HOME': '/Users/cltbld', 03:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:10 INFO - 'LOGNAME': 'cltbld', 03:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:10 INFO - 'MOZ_NO_REMOTE': '1', 03:26:10 INFO - 'NO_EM_RESTART': '1', 03:26:10 INFO - 'PAGER': '/bin/cat', 03:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:10 INFO - 'PWD': '/builds/slave/test', 03:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:10 INFO - 'SHELL': '/bin/bash', 03:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:26:10 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:10 INFO - 'USER': 'cltbld', 03:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:10 INFO - 'XPC_FLAGS': '0x0', 03:26:10 INFO - 'XPC_SERVICE_NAME': '0', 03:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:10 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-I1SbdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:10 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-EZgprJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:10 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-qsNXAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:10 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-FMExC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:10 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-lQMWsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:10 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-4DKesc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-MREjG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-xUam2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-EKyiyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-lhH4d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-eQqYeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-cnwWfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-sP2m48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-oIF7mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:11 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-cAhnjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-LA077b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:12 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-UFMEOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:12 INFO - Running setup.py install for manifestparser 03:26:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:12 INFO - Running setup.py install for mozcrash 03:26:12 INFO - Running setup.py install for mozdebug 03:26:12 INFO - Running setup.py install for mozdevice 03:26:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:12 INFO - Running setup.py install for mozfile 03:26:12 INFO - Running setup.py install for mozhttpd 03:26:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for mozinfo 03:26:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for mozInstall 03:26:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for mozleak 03:26:13 INFO - Running setup.py install for mozlog 03:26:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for moznetwork 03:26:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Running setup.py install for mozprocess 03:26:13 INFO - Running setup.py install for mozprofile 03:26:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Running setup.py install for mozrunner 03:26:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Running setup.py install for mozscreenshot 03:26:14 INFO - Running setup.py install for moztest 03:26:14 INFO - Running setup.py install for mozversion 03:26:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:14 INFO - Cleaning up... 03:26:14 INFO - Return code: 0 03:26:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:14 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 0x10da99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd283dd8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, '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.IbaFXqomPa/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.TNI1r8CynE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:26:14 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 03:26:14 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 03:26:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:26:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:14 INFO - 'HOME': '/Users/cltbld', 03:26:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:14 INFO - 'LOGNAME': 'cltbld', 03:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:14 INFO - 'MOZ_NO_REMOTE': '1', 03:26:14 INFO - 'NO_EM_RESTART': '1', 03:26:14 INFO - 'PAGER': '/bin/cat', 03:26:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:14 INFO - 'PWD': '/builds/slave/test', 03:26:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:14 INFO - 'SHELL': '/bin/bash', 03:26:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:26:14 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:26:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:14 INFO - 'USER': 'cltbld', 03:26:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:14 INFO - 'XPC_FLAGS': '0x0', 03:26:14 INFO - 'XPC_SERVICE_NAME': '0', 03:26:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-JsnYEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-myJ5wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-A7wXEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-nZsIHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-IdjzOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-iwqmsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ACa_ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-rgtuys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-wGnep5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:15 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)) 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-uRupuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:16 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)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-o8oFSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:16 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)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-EWreRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:16 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)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-U9yjKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:16 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)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Aa9Ntp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:16 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)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-oF0WO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:16 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)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-qSr4j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:16 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)) 03:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-m2Q2RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:16 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)) 03:26:16 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)) 03:26:16 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)) 03:26:16 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)) 03:26:16 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)) 03:26:16 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)) 03:26:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:16 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 03:26:16 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 03:26:16 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 03:26:16 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 03:26:16 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 03:26:16 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 03:26:19 INFO - Downloading blessings-1.6.tar.gz 03:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:19 INFO - Installing collected packages: blessings 03:26:19 INFO - Running setup.py install for blessings 03:26:19 INFO - Successfully installed blessings 03:26:19 INFO - Cleaning up... 03:26:19 INFO - Return code: 0 03:26:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:19 INFO - Reading from file tmpfile_stdout 03:26:19 INFO - Current package versions: 03:26:19 INFO - blessings == 1.6 03:26:19 INFO - blobuploader == 1.2.4 03:26:19 INFO - docopt == 0.6.1 03:26:19 INFO - manifestparser == 1.1 03:26:19 INFO - mozInstall == 1.12 03:26:19 INFO - mozcrash == 0.16 03:26:19 INFO - mozdebug == 0.1 03:26:19 INFO - mozdevice == 0.48 03:26:19 INFO - mozfile == 1.2 03:26:19 INFO - mozhttpd == 0.7 03:26:19 INFO - mozinfo == 0.9 03:26:19 INFO - mozleak == 0.1 03:26:19 INFO - mozlog == 3.1 03:26:19 INFO - moznetwork == 0.27 03:26:19 INFO - mozprocess == 0.22 03:26:19 INFO - mozprofile == 0.28 03:26:19 INFO - mozrunner == 6.11 03:26:19 INFO - mozscreenshot == 0.1 03:26:19 INFO - mozsystemmonitor == 0.0 03:26:19 INFO - moztest == 0.7 03:26:19 INFO - mozversion == 1.4 03:26:19 INFO - psutil == 3.1.1 03:26:19 INFO - requests == 1.2.3 03:26:19 INFO - wsgiref == 0.1.2 03:26:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:19 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 0x10da99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd283dd8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, '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.IbaFXqomPa/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.TNI1r8CynE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:26:19 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 03:26:19 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 03:26:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:26:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:19 INFO - 'HOME': '/Users/cltbld', 03:26:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:19 INFO - 'LOGNAME': 'cltbld', 03:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:19 INFO - 'MOZ_NO_REMOTE': '1', 03:26:19 INFO - 'NO_EM_RESTART': '1', 03:26:19 INFO - 'PAGER': '/bin/cat', 03:26:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:19 INFO - 'PWD': '/builds/slave/test', 03:26:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:19 INFO - 'SHELL': '/bin/bash', 03:26:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:26:19 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:26:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:19 INFO - 'USER': 'cltbld', 03:26:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:19 INFO - 'XPC_FLAGS': '0x0', 03:26:19 INFO - 'XPC_SERVICE_NAME': '0', 03:26:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:20 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)) 03:26:20 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)) 03:26:20 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)) 03:26:20 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)) 03:26:20 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)) 03:26:20 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)) 03:26:20 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)) 03:26:20 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)) 03:26:20 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)) 03:26:20 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)) 03:26:20 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)) 03:26:20 INFO - Cleaning up... 03:26:20 INFO - Return code: 0 03:26:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd283dd8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, '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.IbaFXqomPa/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.TNI1r8CynE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:20 INFO - 'HOME': '/Users/cltbld', 03:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:20 INFO - 'LOGNAME': 'cltbld', 03:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:20 INFO - 'MOZ_NO_REMOTE': '1', 03:26:20 INFO - 'NO_EM_RESTART': '1', 03:26:20 INFO - 'PAGER': '/bin/cat', 03:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:20 INFO - 'PWD': '/builds/slave/test', 03:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:20 INFO - 'SHELL': '/bin/bash', 03:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:26:20 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:20 INFO - 'USER': 'cltbld', 03:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:20 INFO - 'XPC_FLAGS': '0x0', 03:26:20 INFO - 'XPC_SERVICE_NAME': '0', 03:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:20 INFO - Downloading/unpacking jsonschema 03:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:22 INFO - Downloading/unpacking functools32 (from jsonschema) 03:26: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 03:26: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 03:26:22 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 03:26: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 03:26: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 03:26: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 03:26:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:23 INFO - warning: no files found matching '*.txt' 03:26:23 INFO - no previously-included directories found matching 'build' 03:26:23 INFO - no previously-included directories found matching 'dist' 03:26:23 INFO - no previously-included directories found matching '.git*' 03:26:23 INFO - Installing collected packages: jsonschema, functools32 03:26:23 INFO - Running setup.py install for functools32 03:26:23 INFO - warning: no files found matching '*.txt' 03:26:23 INFO - no previously-included directories found matching 'build' 03:26:23 INFO - no previously-included directories found matching 'dist' 03:26:23 INFO - no previously-included directories found matching '.git*' 03:26:23 INFO - Successfully installed jsonschema functools32 03:26:23 INFO - Cleaning up... 03:26:23 INFO - Return code: 0 03:26:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:23 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 0x10da99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daa14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd283dd8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, '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.IbaFXqomPa/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.TNI1r8CynE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 03:26:23 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 03:26:23 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 03:26:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:26:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:23 INFO - 'HOME': '/Users/cltbld', 03:26:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:23 INFO - 'LOGNAME': 'cltbld', 03:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:23 INFO - 'MOZ_NO_REMOTE': '1', 03:26:23 INFO - 'NO_EM_RESTART': '1', 03:26:23 INFO - 'PAGER': '/bin/cat', 03:26:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:23 INFO - 'PWD': '/builds/slave/test', 03:26:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:23 INFO - 'SHELL': '/bin/bash', 03:26:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:26:23 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:26:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:23 INFO - 'USER': 'cltbld', 03:26:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:23 INFO - 'XPC_FLAGS': '0x0', 03:26:23 INFO - 'XPC_SERVICE_NAME': '0', 03:26:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:23 INFO - Downloading/unpacking flake8 03:26:23 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 03:26:23 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 03:26:23 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 03:26:23 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 03:26:23 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 03:26:23 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 03:26:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:26 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 03:26:26 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 03:26:26 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 03:26:26 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 03:26:26 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 03:26:26 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 03:26:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:26 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 03:26:26 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 03:26:26 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 03:26:26 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 03:26:26 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 03:26:26 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 03:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:27 INFO - no previously-included directories found matching 'docs/_build' 03:26:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:27 INFO - Running setup.py install for pep8 03:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:27 INFO - no previously-included directories found matching 'docs/_build' 03:26:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:27 INFO - Cleaning up... 03:26:27 INFO - Return code: 0 03:26:27 INFO - Running post-action listener: _resource_record_post_action 03:26:27 INFO - Running post-action listener: _start_resource_monitoring 03:26:27 INFO - Starting resource monitoring. 03:26:27 INFO - ##### 03:26:27 INFO - ##### Running install step. 03:26:27 INFO - ##### 03:26:27 INFO - Running pre-action listener: _resource_record_pre_action 03:26:27 INFO - Running main action method: install 03:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:27 INFO - Reading from file tmpfile_stdout 03:26:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:27 INFO - Reading from file tmpfile_stdout 03:26:27 INFO - Output received: 03:26:27 INFO - Usage: mozinstall [options] installer 03:26:27 INFO - Options: 03:26:27 INFO - -h, --help show this help message and exit 03:26:27 INFO - -d DEST, --destination=DEST 03:26:27 INFO - Directory to install application into. [default: 03:26:27 INFO - "/builds/slave/test"] 03:26:27 INFO - --app=APP Application being installed. [default: firefox] 03:26:27 INFO - mkdir: /builds/slave/test/build/application 03:26:27 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'] 03:26:27 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 03:27:01 INFO - Reading from file tmpfile_stdout 03:27:01 INFO - Output received: 03:27:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:27:01 INFO - Running post-action listener: _resource_record_post_action 03:27:01 INFO - ##### 03:27:01 INFO - ##### Running run-tests step. 03:27:01 INFO - ##### 03:27:01 INFO - Running pre-action listener: _resource_record_pre_action 03:27:01 INFO - Running main action method: run_tests 03:27:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:27:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:27:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:27:01 INFO - 2016-02-15 03:27:01.585 screenresolution[1656:8071] starting screenresolution argv=screenresolution get 03:27:01 INFO - 2016-02-15 03:27:01.588 screenresolution[1656:8071] Display 0: 1600x1200x32@60 03:27:01 INFO - 2016-02-15 03:27:01.594 screenresolution[1657:8073] starting screenresolution argv=screenresolution list 03:27:01 INFO - Available Modes on Display 0 03:27:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:27:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:27:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:27:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:27:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:27:01 INFO - Intel Iris: 03:27:01 INFO - Chipset Model: Intel Iris 03:27:01 INFO - Type: GPU 03:27:01 INFO - Bus: Built-In 03:27:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:27:01 INFO - Vendor: Intel (0x8086) 03:27:01 INFO - Device ID: 0x0a2e 03:27:01 INFO - Revision ID: 0x0009 03:27:01 INFO - Displays: 03:27:01 INFO - Display: 03:27:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:27:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:27:01 INFO - Display Serial Number: 1600x1200 60 03:27:01 INFO - Main Display: Yes 03:27:01 INFO - Mirror: Off 03:27:01 INFO - Online: Yes 03:27:01 INFO - Rotation: Supported 03:27:01 INFO - Return code: 0 03:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:01 INFO - Python 2.7.3 03:27:01 INFO - Return code: 0 03:27:01 INFO - grabbing minidump binary from tooltool 03:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:01 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 0x10d93dd30>, '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 0x10d761db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d934b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:01 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 03:27:01 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 03:27:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:01 INFO - Return code: 0 03:27:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:27:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:27:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:27:03 INFO - Return code: 0 03:27:03 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/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 03:27:03 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/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --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 03:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbaFXqomPa/Render', 03:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:03 INFO - 'HOME': '/Users/cltbld', 03:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:03 INFO - 'LOGNAME': 'cltbld', 03:27:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:03 INFO - 'MOZ_NO_REMOTE': '1', 03:27:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:03 INFO - 'NO_EM_RESTART': '1', 03:27:03 INFO - 'PAGER': '/bin/cat', 03:27:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:03 INFO - 'PWD': '/builds/slave/test', 03:27:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:03 INFO - 'SHELL': '/bin/bash', 03:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNI1r8CynE/Listeners', 03:27:03 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 03:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:03 INFO - 'USER': 'cltbld', 03:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:03 INFO - 'XPC_FLAGS': '0x0', 03:27:03 INFO - 'XPC_SERVICE_NAME': '0', 03:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:03 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/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 03:27:03 INFO - mozversion application_buildid: 20160210023622 03:27:03 INFO - mozversion application_changeset: cb04e167e1df430f985451628b796b8d26819772 03:27:03 INFO - mozversion application_display_name: Nightly 03:27:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:03 INFO - mozversion application_name: Firefox 03:27:03 INFO - mozversion application_remotingname: firefox 03:27:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:27:03 INFO - mozversion application_vendor: Mozilla 03:27:03 INFO - mozversion application_version: 47.0a1 03:27:03 INFO - mozversion platform_buildid: 20160210023622 03:27:03 INFO - mozversion platform_changeset: cb04e167e1df430f985451628b796b8d26819772 03:27:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:27:03 INFO - mozversion platform_version: 47.0a1 03:27:03 INFO - using testdate: 1455535623 03:27:03 INFO - actual date: 1455535623 03:27:03 INFO - starting webserver on 'localhost:49275' 03:27:03 INFO - SUITE-START | Running 2 tests 03:27:03 INFO - TEST-START | dromaeo_css 03:27:03 INFO - operating with platform_type : mac_ 03:27:03 INFO - Initialising browser for dromaeo_css test... 03:27:03 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmp39Ouxj/profile http://localhost:49275/getInfo.html) 03:27:05 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 03:27:05 INFO - PROCESS | 1675 | colorDepth:24 03:27:05 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 03:27:05 INFO - PROCESS | 1675 | __metrics 03:27:05 INFO - PROCESS | 1675 | 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" 03:27:05 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:27:06 INFO - TEST-INFO | 1675: exit 0 03:27:06 INFO - Browser initialized. 03:27:06 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:06 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmp39Ouxj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:18 INFO - PROCESS | 1679 | RSS: Main: 246411264 03:27:18 INFO - PROCESS | 1679 | 03:28:10 INFO - PROCESS | 1679 | 1455535690031 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] 03:30:19 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:30:21 INFO - PROCESS | 1679 | RSS: Main: 415137792 03:30:21 INFO - PROCESS | 1679 | 03:33:23 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:33:24 INFO - PROCESS | 1679 | RSS: Main: 374054912 03:33:24 INFO - PROCESS | 1679 | 03:36:26 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:36:27 INFO - PROCESS | 1679 | RSS: Main: 376967168 03:36:27 INFO - PROCESS | 1679 | 03:39:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:39:29 INFO - PROCESS | 1679 | RSS: Main: 340496384 03:39:29 INFO - PROCESS | 1679 | 03:42:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:42:33 INFO - PROCESS | 1679 | RSS: Main: 343515136 03:42:33 INFO - PROCESS | 1679 | 03:45:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:45:36 INFO - PROCESS | 1679 | RSS: Main: 389472256 03:45:36 INFO - PROCESS | 1679 | 03:45:36 INFO - PROCESS | 1679 | __start_tp_report 03:45:36 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 03:45:36 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 03:45:36 INFO - PROCESS | 1679 | |i|pagename|runs| 03:45:36 INFO - PROCESS | 1679 | |0;dojo.html;2982.314067764414;3467.4798780182973;3541.8229088545568;3547.024568243731;3605.4411566207245;4471.4187155669715;5716.970945229857;5724;5814.215080964069;5847.970760146193;4715.5048719884435;5744.6840423776675;5835.0663893777;5895.852603684899;5916.3787802280785;5179.093658609747;5220.243064755608;5246.108161612516;5250.186221135711;5316.149416093426;5308.309919710451;5330.626856120073;5342.652727572715;5356.598255130862;5392.487713667196;4947.208446648537;5037.319961805183;5048.671836330626;5054.267131265946;5271.789128434877;5218.791248350061;5233.319668443078;5240.659357141812;5244.056069907415;5246.029484545371;5005;5147.588192944556;5203;5205.193195054772;5212.921806172911;5652.547796176296;5676.1769543416385;5726.942730572682;5741.88516229673;5767.538596912237;6230.5638605297645;6232.439080482733;6266.216722909637;6270.965290727025;6280.811575652738;6127.830981140894;6197.349278325801;6264.937350626481;6274.87450250997;6277.937220627781;5763.337216220147;5763.538916886639;5849.064149736022;5856.619319744203;5863.912041319426;6224.751009959551;6233.563650544418;6252.937470625327;6260.593061450991;6265.96867015662;5961.672108034013;5965.880682386328;5998.760049597967;6059.394060593905;6117.979653188387;6142.877142457126;6166.1983942087245;6260.812175634738;6264.780732674334;6266.216722909637;4785.688930219594;5748.770049197985;6189.597676151036;6215.96892015537;6240.251169859555;5964.135200395918;6067.423594758491;6158.476529494954;6262.906056409158;6279.183706118175;4891.755412229374;4896.534829191221;4907.852764417074;4918.729469879119;4932.482089380635;4430.955690443118;4441.89067652638;4442.777861106996;4443.622292105208;4470.083632855257;5646.096624540136;5682.090865461506;5761.8559536011935;5762.366139724627;5778.104393818965;6190;6204.286507051746;6208.875822483525;6213.875722485525;6214.689265536705;5587.664740115606;5613.214150019001;5617.9719101404235;5637.46444087811;5639.605227634026;5314.468553144655;5404.621676482687;5406;5440.755166017539;5489;6307.148534947723;6320.209973753281;6324.335944725737;6328.841778955379;6337.65142917144;6142.498775697988;6271.592346497463;6320.62076275425;6349.936500634934;6353.68231588428;6267.2479302484;6299.370062993664;6326.367363263636;6345.4923606112325;6350.460210882126;6139.26328840542;6198.597091189058;6204.410580994799;6211.130441738251;6245.219347581552;6101.277634935997;6273.372662733873;6320.810375688737;6326.145970293951;6331.461825744679;5547.528460080777;5716.114002329646;6097.329293777592;6129.816105516842;6133.325334213144;6071.7571297147615;6103.176071230327;6105.267367915879;6105.664188469676;6115.602485838406;5825.825225243249;5933.169356290036;5937.376575459514;5940.138679891478;5947.881042379215;5948.196993405835;6053.697315134314;6062.636241825505;6089.934261504308;6109;5883.705814709162;5904.734286957011;5910.822675319747;5913.024350982212;5914.792982245601 03:45:36 INFO - PROCESS | 1679 | |1;ext.html;452.64919687242383;467.0332411907351;497.08784380661484;501.8193450357873;515.8839261166237;29358.85320573397;36722.63277367229;38098.809505952464;38592.84221473353;38620;40836.79581602095;41162.38256426156;41411;41468.17063658725;41481.792591037076;9408.905910940888;9593;9602.663906763264;9611.375260608038;9633.759156021086;9490.240780737558;9625.807483850318;9645.999999999965;9651.276154288422;9756.707298781048;9039.954800225989;9165.679201227958;9785.951070244639;9787.217022638171;9789.853152202722;9659.840819101682;9759.804803903882;9762.511874406322;9770.218382529416;9777.266704997153;9604.327697061208;9722.805543889082;9732.464714440703;9733.756656083584;9738;33006.669933300596;40450.595494044974;40480.392794107815;40481;40485;3186.474231751758;3250.674932506754;3258.706716395512;3404.5744281964753;3635.509206257148;25935.481290374275;28941.42117157666;29766.10701678953;30168;30449.08652740421;2705.6212130301774;2721.9727802722114;2773.4453109378205;2842.047913948809;2843.1044221070297;323441;379652;381468.9999999972;382244;382404;62589.37410625927;62880.685596571726;62953;63060.36939630637;66883.99674004894;70301.64849175824;70423.29576704168;70428.2957170432;70484.64757676178;70566.294337057;16514.75227871583;16740.49778506647;16744.497665070066;16750.581235468966;16785.748213776802;12739.490420383267;12792.168509046882;12809.103362764517;12824.102312838198;12824.871751282555;17330.220140093727;20189.49526261855;20973.895130524554;21068.578628427345;21073.473163170736;7556.433267504959;8786.121387861163;9075.727728168165;9082.863757043517;9109.76810681374;923.5290002098978;941;1024.3853687787416;1114.3703807348822;1171.3030746705697;31697.8415107923;32017.03948881537;32474.350512989608;32649.817040251106;32763.180920477178;1068.4070340960686;1079.1330997374587;1094.2395035450445;1123.8258069999163;1209.7882870497629;15969.920150399406;16018.79859010579;16050;16124.589574954425;16378.426755063516;592903;630356.848215756;688881;696270;700549;55718;57528.71235643795;59147.704261478415;59200;59271.703641481516;1297.7015286483972;1429.2639290765264;1441.4162264282982;1441.8990670653163;1558.4545409106722;25895.870520647277;28929.42141157123;29049.564256536592;29671.851640741657;29760.40479190361;51348;51839.481605183464;51939.48060519498;51951.22073168981;51985.22022169595;392876;393121;393833;393836;393849;30909;31338.686613133577;31611.84194079015;31733.04800855978;33030.33939321152;35421;43191;43618;44344.33483497686;44477;34592.135196620286;36598.63401366059;36694;36737;37889.43165852459;34620.82689586536;35311.47032794459;35509.82245088758;35526.111847204025;35670.82164589161;35280.11799704925;35619.82190089033;37561.87314380573;37844.62155378521;38755.80622096871;29731.851340743156;32787.67212327846;32831.8358408216;32898.67101328956;33009.50485742764;21170.470738231666;24083.277501674977;24340.26979190627;24990.62514062327;25046.74953250444 03:45:36 INFO - PROCESS | 1679 | |2;jquery.html;366.8385910199512;370.42399069447015;371.66364440181644;376.38836890053665;378.4569143279393;14360.56918292453;14877;16690.83309166908;18080.186391612377;19939.202431902726;17862.106894655248;18140.818591814077;18548.350807721734;19373.612527749436;19412.417627471164;5706.1440783882435;5731.856703582423;5766.711664416784;5777.768889244425;5802;3640.76335038223;4355.390245365651;6213.130161777355;6448.677566121699;6488.026795980593;5317.308749862513;6342.682865856712;6363.204599425072;6414.839629009265;6417.967910160442;5744.3394009689;6359.618422894618;6363.077353783676;6364.904526432108;6376.362363763633;5697.629654072513;5705.800296989627;5709.65742055478;5711.400302968212;5720.970225359433;12996.480140794356;14329.856701432956;15245.085294882343;23187.188448404224;23245.18641847544;2110.2614085070254;2171.2003993012227;2212.38053345062;2242.865428074321;2304.0092760113143;10114.747131321703;11909.94045029778;11960.40197990097;13643.895514193387;13958.58124256274;1700.1074435921116;1794.4796009157328;1795.2998330651058;1804.1430320597742;1825.233401971162;91092.54453727689;95864.52067739687;96347.51826240894;97155.51422242915;97261.51369243179;9401.623935042659;11015.118790496741;11015.339079655247;11087.778244435067;11167.72080697989;13198.73602527944;13278.66803329905;13317.600471985856;13344.199348039148;13352.399142038437;7657.1959944205055;7698.615069246515;8313.584320783937;8341.582920853933;8459.154084591615;8454.746357609281;8467.449615774955;8514.659413623385;8551.828963420821;8562.871556926651;3251.528528363374;4158.981049642857;4200.768957707355;4289.399484072233;4440.600345968878;1688.7129188038064;1740.530056884634;1857.8606604504716;1860.8604354673453;1862.2923289150037;893.5487578772808;914.4970266353479;974.907383798538;1007.9668339951462;1055.8152323343384;15906.617272609246;18395.356162534514;19309.882881036254;20130.69803952942;20144;950.9904900951041;954.8758661373977;979.848677803578;981.3866333541537;1036.7511797168777;8830.779230519289;10198.745031374126;10277.537510812032;10430.947845260725;10489.580416783396;569347;574421.5829417452;722128;747920;756875;96779.51610241903;102006.48996754969;102067;102745;105484.47257763815;1119.160629527854;1136.3352438823215;1178.8467499225046;1198.1433275208094;1203.5967950736601;17605;17761.644767104845;17791.73312400341;17908.373206937693;18150.909245453688;47405;48067.798305042656;48090.519094810006;48197;48815.5118448811;60297;62160;62671;62881.68559157358;65077.349226507125;7019.438444924496;7251.492395532473;7280.017197678246;7323.450741194325;7350.448716346188;8222.958885205535;8932.419392739452;11215.88784112181;11526.135539834713;11694;10106.747331316481;10128;10284.485775711335;10322.019408156213;10466.110380617733;6298.937010629835;7494.613496503164;7499.962500187464;7613.6573854175585;7619.123800762984;6642.402183803288;7451.180370159386;7518.204881550052;7717.8809072683025;7814.90082196697;7609.445105073217;8807.075257097913;9353.812923741623;9839.65561205383;10909.290896091728;7531.623418829146;7753.340966017951;10621.356815081235;10862.402567858844;11213 03:45:36 INFO - PROCESS | 1679 | |3;mootools.html;1508.3514088941752;1538.776877352784;1674.4558018643943;1806.7560879281293;1834.587217875979;6965.407940325073;7692.807679807994;7890.92109078909;8673.479591224523;8678.218960293572;7870.2916737493615;7877.80305492363;7993.560354180518;7996.96001519993;8004.4797088189225;2289.748127705955;2311.7572654871246;2313.9190128345513;2314.456102815837;2319.907203711858;2135.6476181430044;2183.3122566391617;2189.124350259901;2327.44141406063;2367.396313939943;2126.1814201532366;2368.9526209475885;2419.8548087114827;2422.527607116613;2429.4290841652196;2352.4001379648253;2400.8919598618018;2401.495685905953;2409.975900240993;2415.1909110448023;2346.4720437901506;2385.785279324869;2393.246127469859;2396.496735685508;2399.3042017814814;8417;8522.957385213034;8527.062023177445;8537.786555336166;8645.827083458358;5226.686398816083;5344.812931547377;5381.273528073699;5383.515483606455;5388.949154914793;3424.8972530824117;3478.234788346585;3557.94663080054;3563.8396272167556;3570.0539357070397;1042.2860340666668;1044.2585764107494;1065.8028264770965;1074.1514203779004;1087.0108201536564;11567.710807229803;11602.767944641144;11618.593349232737;11630.592929247521;11644.47599858;4722.338872557844;4725.432948046257;4773.284007398918;4796.112719146969;4806.519348065235;9708.174805141502;9711.514424278757;9714.125728684452;9723.65967191145;9757.756056098513;5306.867328316745;5334.253204551366;5337.01265265927;5339.359276886721;5345.01117293302;4065.6747460203114;4797.4482934462985;4835.854924352275;4839.854804355875;4846.951530484721;3270.5094235864335;3906.687465002793;3937.468441760383;3937.684985201177;3952.7825969571372;1064.8455973883742;1213.660175150959;1281.474595415875;1290.1742884553894;1304.1001708820884;1084.4631907205983;1084.6258040975852;1125.5047778977223;1223.4922507159606;1319.973600527984;6831.385175334244;7844.333231675258;7923.247291507298;8030.759077227693;8031.317338026216;1157.8263260510823;1173.8767429419959;1175.6061719324123;1182.810750279951;1198.2570806100273;6168.845778855564;6248.9062664060075;6254.311335939362;6263.154474146023;6267.9373206268265;10000.499975001221;10018.448985305879;10023.899761002442;10082;10166.085052345325;9903.554340054714;9965.152961998312;9972.850407243897;10058.798824023625;10065.993400660022;8200.42597018203;8283;8283.17168283167;8285.25432711059;8293.295069919004;7697;7905.525668459911;7939.245771651684;8037.718679846177;8043.477173983672;9313.789207402995;9394.107559781809;9452.338336316392;9464.905350946678;9509.096635819586;8170.8152317914755;9256.814863702553;9724.222062235145;9917.504124793875;9944.950275248866;7336.926630733625;7384.4830861839155;7478.551286922802;7489.737859174903;7519.473636845369;7681.539107653335;7781;7867.763967080997;7869.606519674108;7887.132415434183;6442.613443193423;7570.318671319607;7689.231076892266;7768.378529717722;7836.981192445173;7373.262673732584;7378.852422951618;7413.962930185315;7501.399888009056;7506.3244308012545;7511.3615342696485;7562;7562.773116806505;7574.659140338587;7581.848363032819;6817.386435220854;6838.623875686686;6893.345132212432;6907.6891539881835;6918.757843475454;6613.834654133685;6742.898856517058;6755.695993680394;6765.695543700447;6770.966145169243 03:45:36 INFO - PROCESS | 1679 | |4;prototype.html;311.28404669260703;327.3469428490163;332.53943288545355;332.6989074887226;337.9003194057754;6540.117084193633;6573.901391479126;6579.342065793418;6611.305812889649;6653.4344580710695;6568;6590.308017658149;6591.538592298541;6599.439047680953;6609.372109649587;4756.809727610891;4883.511648835123;4900.534449227318;4901.5588597026435;4920.3111564381015;4874.829380971667;4892.5596696297325;4895.388076490439;4928.753562321887;4931.975340123312;4301.634361079312;4539.182947069527;4823.445303790057;4843.612510999112;4850.951490485103;4573.153966516205;4646.558576935186;4680.485146633868;4854.2233242681;4857.8299759508245;4088.325426304656;4133.751974881517;4137.027798467358;4146.212219678251;4148.357004664282;5727.427257274281;5822.243108395882;6298.212723409574;6298.842528936768;6299.244090709099;4893.388326459192;5332.093544097474;5498.367687715924;5519.889602207973;5705.800296989627;7043.683034263419;7053.647317634149;7062.788116356466;7064.823379415504;7064.823379415504;4658.906821863544;4672.883177920545;4674.2053850845095;4675.345451636774;4677.158111539921;7254.623747348831;7362.3373896349585;7444.776656700307;7480.8877866832045;7480.9251907480775;4757.524247575215;4762.618990480753;4762.666613337103;4764.261539461319;4765.285207218945;4821.228603423436;4835.637327200474;4847.151748444008;4847.224444088929;4847.745798203852;5523.420040895729;5714.828555143269;5722.77108915647;5727.625369911191;5739.598228124075;7088.822779430556;7112.359887610037;7114.32413920687;7114.608696521741;7118.181409138016;1654.5780825889321;1681.7393304037894;1682.5541231573643;1688.0125126800958;1693.889897156681;1078.789636020984;1088.6951653537021;1102.3551222534907;1104.972375690598;1118.8937050980144;6621.940489521653;6622.9006564901565;6624.8012559623285;6633.402993730588;6660.267370589231;6908.5509441887125;7322;7328.523645962995;7341.119065712149;7343.596102214429;6384.170057892445;6611.834704132339;6620.205575330991;6623.801285961429;6630.7679231226675;3844.59631738669;3895.006773272854;3897.2010737798682;3900.6099390060767;3906.1797022625565;7633.313001829862;7666;7668.309852113337;7671.07947046358;7692.653830577638;6901.654917254217;7257.854842903218;7398.926010739931;7443.771777656626;7552.055993000875;6276;7599.848003039909;7715.884261736079;7724.266194711493;7734.690612375667;5678.659280443187;7352;7384.704611815468;7388;7401.555906645618;7070.151581810215;7306.744263950949;7321;7331.266873312626;7339;7753.961230193813;7763.456558040883;7766;7769.184235655401;7777.222277772177;4611.21609326422;4649.1863923812525;4659.883502912318;4662.906741865211;4663.487016428258;7138.64306784669;7329.083864516935;7370.005049318273;7371.741989030358;7388.667509961957;7114.075170227838;7117.893231601426;7132.429405647639;7139.607321597362;7141.035960145314;6235.220597425322;6765.594064356154;6832.59004459734;7095.538789978635;7101.538400003983;6939.167299924042;6941.895871561829;6942.444604431533;6953.374196322356;6964.965175174092;7103.715851365888;7105.9289407107335;7107.893381599177;7118.145822501333;7126.608036558039;6735.292794256533;6928.376446119873;6950.965245173742;6969.0940177776565;6981.0924579804305 03:45:36 INFO - PROCESS | 1679 | |5;yui.html;648.1056142523317;682.3960794696693;698.7240040184131;725.8620862036214;780.2860382749784;14074.648133796647;15220;15241.92379038106;15260.008099473527;15272.694546109085;13569.982251331141;13653.044286899922;13661.863381366184;13669;13674.384652690627;702.3819039245457;711.5517224148805;848.8854004709347;858.103282070235;866.4065115395974;870.5603670146567;880.2122100719852;881.4667126388539;882.188386684252;882.6248844241172;911.3210658059754;914.2777206007246;914.7850255190025;914.8810654614891;915.3455279475207;726.7202127181047;735.36758387787;736.5249414127884;737.542723511421;892.312919052326;668.9264180940093;669.130130829924;669.8358902068976;671.8085345676459;675.1897722732691;13719;13765.724685506333;13853.584392468241;13855.584332470042;13856.792148117785;12236.388180591024;12314;12395.442205100702;12831.87168128316;13010;9793.155772072025;9928.45393503357;9956.402615843073;9961.252906032076;9963.402195868199;3440.3807314683345;3501.1772233525103;3502.176988407722;3502.562179727534;3509.385857474957;78077.60961195157;79400.20599793986;79865.20134798693;79939;80675.59662201651;9483.336166468282;9517.524123793783;9539.52302384878;9556.904430955601;9657.758556036015;16544.917275413787;20430.284940027028;20445.182192712422;20458;20483.590328193353;7271.200167981518;7354.227806080285;7379.594122323324;7585.127710313384;7647.655855486517;3854.5759966403675;3947.0527073502153;3974.9205015900097;4087.8542229612785;4104.630583247522;3455.170759017868;3495.563054618173;3505.631908649606;3509.6665816747877;3511.4030614795547;641.682367228225;651.0917270407849;652.3281020548842;676.8443258050676;678.6572780745691;540.8674874655735;544.6976927805027;574.7959474386616;591.677535743021;597.3280059932575;8183.877241841377;8443.535605541754;8582.313414926792;8819.823603527893;8952.925648922172;423.69282270354364;495.72734995752916;524.301056049574;534.4735435595935;564.4271064869162;3801.6388443097862;3818.2745278397015;3833.769973801581;3949.328614135604;4030.5969403059457;83236.2498315392;83560.91097722606;84364.57817710994;89498;89695;78885.60557197177;79248.60375698084;79735;80083;80622.38755224862;30549;35427.11432214215;71223;71943.92084118743;72009.19977000616;7744.535327880345;7810;7898.210178982055;8038.39712021589;8051.436399451982;50785.492145078075;50926;51064.74467627638;51194;51890;66347.66826165839;68353;68499.3150068493;68864.65567672129;68881;10962.287451315638;11065.944670276918;11129.666110016713;11227.27022743519;11320.716982075513;11970.22193557416;12265.080118990933;12343.814842777187;12537;12552.184108033314;9398.765030874283;11342;11549.307041577196;11644.35956022427;11912.880871191177;10998.558556773558;11225.71935701614;11294.717632059264;11597.536098555964;11603.419829008348;10814.56741730322;10904.836427453753;11129.666110016713;11514.481848317013;12178.330191839534;9124.44282498352;9229.169374756304;9484.620615175316;9544.665936692183;9703.272254580794;8985.415947963362;9129.863052054092;9317.487538185465;9419.481928493999;9457.763555910882 03:45:36 INFO - PROCESS | 1679 | __end_tp_report 03:45:36 INFO - PROCESS | 1679 | __start_cc_report 03:45:36 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1550 03:45:36 INFO - PROCESS | 1679 | __end_cc_report 03:45:36 INFO - PROCESS | 1679 | __startTimestamp1455536736782__endTimestamp 03:45:36 INFO - PROCESS | 1679 | 03:45:36 INFO - PROCESS | 1679 | ------- Summary: start ------- 03:45:36 INFO - PROCESS | 1679 | Number of tests: 6 03:45:36 INFO - PROCESS | 1679 | 03:45:36 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5718.86 Median:5913.02 stddev:643.09 (10.9%) stddev-sans-first:608.18 03:45:36 INFO - PROCESS | 1679 | Values: 2982.3 3467.5 3541.8 3547.0 3605.4 4471.4 5717.0 5724.0 5814.2 5848.0 4715.5 5744.7 5835.1 5895.9 5916.4 5179.1 5220.2 5246.1 5250.2 5316.1 5308.3 5330.6 5342.7 5356.6 5392.5 4947.2 5037.3 5048.7 5054.3 5271.8 5218.8 5233.3 5240.7 5244.1 5246.0 5005.0 5147.6 5203.0 5205.2 5212.9 5652.5 5676.2 5726.9 5741.9 5767.5 6230.6 6232.4 6266.2 6271.0 6280.8 6127.8 6197.3 6264.9 6274.9 6277.9 5763.3 5763.5 5849.1 5856.6 5863.9 6224.8 6233.6 6252.9 6260.6 6266.0 5961.7 5965.9 5998.8 6059.4 6118.0 6142.9 6166.2 6260.8 6264.8 6266.2 4785.7 5748.8 6189.6 6216.0 6240.3 5964.1 6067.4 6158.5 6262.9 6279.2 4891.8 4896.5 4907.9 4918.7 4932.5 4431.0 4441.9 4442.8 4443.6 4470.1 5646.1 5682.1 5761.9 5762.4 5778.1 6190.0 6204.3 6208.9 6213.9 6214.7 5587.7 5613.2 5618.0 5637.5 5639.6 5314.5 5404.6 5406.0 5440.8 5489.0 6307.1 6320.2 6324.3 6328.8 6337.7 6142.5 6271.6 6320.6 6349.9 6353.7 6267.2 6299.4 6326.4 6345.5 6350.5 6139.3 6198.6 6204.4 6211.1 6245.2 6101.3 6273.4 6320.8 6326.1 6331.5 5547.5 5716.1 6097.3 6129.8 6133.3 6071.8 6103.2 6105.3 6105.7 6115.6 5825.8 5933.2 5937.4 5940.1 5947.9 5948.2 6053.7 6062.6 6089.9 6109.0 5883.7 5904.7 5910.8 5913.0 5914.8 03:45:36 INFO - PROCESS | 1679 | 03:45:36 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:62432.94 Median:37867.03 stddev:132028.96 (348.7%) stddev-sans-first:132317.33 03:45:36 INFO - PROCESS | 1679 | Values: 452.6 467.0 497.1 501.8 515.9 29358.9 36722.6 38098.8 38592.8 38620.0 40836.8 41162.4 41411.0 41468.2 41481.8 9408.9 9593.0 9602.7 9611.4 9633.8 9490.2 9625.8 9646.0 9651.3 9756.7 9040.0 9165.7 9786.0 9787.2 9789.9 9659.8 9759.8 9762.5 9770.2 9777.3 9604.3 9722.8 9732.5 9733.8 9738.0 33006.7 40450.6 40480.4 40481.0 40485.0 3186.5 3250.7 3258.7 3404.6 3635.5 25935.5 28941.4 29766.1 30168.0 30449.1 2705.6 2722.0 2773.4 2842.0 2843.1 323441.0 379652.0 381469.0 382244.0 382404.0 62589.4 62880.7 62953.0 63060.4 66884.0 70301.6 70423.3 70428.3 70484.6 70566.3 16514.8 16740.5 16744.5 16750.6 16785.7 12739.5 12792.2 12809.1 12824.1 12824.9 17330.2 20189.5 20973.9 21068.6 21073.5 7556.4 8786.1 9075.7 9082.9 9109.8 923.5 941.0 1024.4 1114.4 1171.3 31697.8 32017.0 32474.4 32649.8 32763.2 1068.4 1079.1 1094.2 1123.8 1209.8 15969.9 16018.8 16050.0 16124.6 16378.4 592903.0 630356.8 688881.0 696270.0 700549.0 55718.0 57528.7 59147.7 59200.0 59271.7 1297.7 1429.3 1441.4 1441.9 1558.5 25895.9 28929.4 29049.6 29671.9 29760.4 51348.0 51839.5 51939.5 51951.2 51985.2 392876.0 393121.0 393833.0 393836.0 393849.0 30909.0 31338.7 31611.8 31733.0 33030.3 35421.0 43191.0 43618.0 44344.3 44477.0 34592.1 36598.6 36694.0 36737.0 37889.4 34620.8 35311.5 35509.8 35526.1 35670.8 35280.1 35619.8 37561.9 37844.6 38755.8 29731.9 32787.7 32831.8 32898.7 33009.5 21170.5 24083.3 24340.3 24990.6 25046.7 03:45:36 INFO - PROCESS | 1679 | 03:45:36 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:34423.14 Median:4245.08 stddev:111834.47 (2634.4%) stddev-sans-first:112118.95 03:45:36 INFO - PROCESS | 1679 | Values: 366.8 370.4 371.7 376.4 378.5 14360.6 14877.0 16690.8 18080.2 19939.2 17862.1 18140.8 18548.4 19373.6 19412.4 5706.1 5731.9 5766.7 5777.8 5802.0 3640.8 4355.4 6213.1 6448.7 6488.0 5317.3 6342.7 6363.2 6414.8 6418.0 5744.3 6359.6 6363.1 6364.9 6376.4 5697.6 5705.8 5709.7 5711.4 5721.0 12996.5 14329.9 15245.1 23187.2 23245.2 2110.3 2171.2 2212.4 2242.9 2304.0 10114.7 11909.9 11960.4 13643.9 13958.6 1700.1 1794.5 1795.3 1804.1 1825.2 91092.5 95864.5 96347.5 97155.5 97261.5 9401.6 11015.1 11015.3 11087.8 11167.7 13198.7 13278.7 13317.6 13344.2 13352.4 7657.2 7698.6 8313.6 8341.6 8459.2 8454.7 8467.4 8514.7 8551.8 8562.9 3251.5 4159.0 4200.8 4289.4 4440.6 1688.7 1740.5 1857.9 1860.9 1862.3 893.5 914.5 974.9 1008.0 1055.8 15906.6 18395.4 19309.9 20130.7 20144.0 951.0 954.9 979.8 981.4 1036.8 8830.8 10198.7 10277.5 10430.9 10489.6 569347.0 574421.6 722128.0 747920.0 756875.0 96779.5 102006.5 102067.0 102745.0 105484.5 1119.2 1136.3 1178.8 1198.1 1203.6 17605.0 17761.6 17791.7 17908.4 18150.9 47405.0 48067.8 48090.5 48197.0 48815.5 60297.0 62160.0 62671.0 62881.7 65077.3 7019.4 7251.5 7280.0 7323.5 7350.4 8223.0 8932.4 11215.9 11526.1 11694.0 10106.7 10128.0 10284.5 10322.0 10466.1 6298.9 7494.6 7500.0 7613.7 7619.1 6642.4 7451.2 7518.2 7717.9 7814.9 7609.4 8807.1 9353.8 9839.7 10909.3 7531.6 7753.3 10621.4 10862.4 11213.0 03:45:36 INFO - PROCESS | 1679 | 03:45:36 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:5877.68 Median:5386.23 stddev:3064.61 (56.9%) stddev-sans-first:3055.61 03:45:36 INFO - PROCESS | 1679 | Values: 1508.4 1538.8 1674.5 1806.8 1834.6 6965.4 7692.8 7890.9 8673.5 8678.2 7870.3 7877.8 7993.6 7997.0 8004.5 2289.7 2311.8 2313.9 2314.5 2319.9 2135.6 2183.3 2189.1 2327.4 2367.4 2126.2 2369.0 2419.9 2422.5 2429.4 2352.4 2400.9 2401.5 2410.0 2415.2 2346.5 2385.8 2393.2 2396.5 2399.3 8417.0 8523.0 8527.1 8537.8 8645.8 5226.7 5344.8 5381.3 5383.5 5388.9 3424.9 3478.2 3557.9 3563.8 3570.1 1042.3 1044.3 1065.8 1074.2 1087.0 11567.7 11602.8 11618.6 11630.6 11644.5 4722.3 4725.4 4773.3 4796.1 4806.5 9708.2 9711.5 9714.1 9723.7 9757.8 5306.9 5334.3 5337.0 5339.4 5345.0 4065.7 4797.4 4835.9 4839.9 4847.0 3270.5 3906.7 3937.5 3937.7 3952.8 1064.8 1213.7 1281.5 1290.2 1304.1 1084.5 1084.6 1125.5 1223.5 1320.0 6831.4 7844.3 7923.2 8030.8 8031.3 1157.8 1173.9 1175.6 1182.8 1198.3 6168.8 6248.9 6254.3 6263.2 6267.9 10000.5 10018.4 10023.9 10082.0 10166.1 9903.6 9965.2 9972.9 10058.8 10066.0 8200.4 8283.0 8283.2 8285.3 8293.3 7697.0 7905.5 7939.2 8037.7 8043.5 9313.8 9394.1 9452.3 9464.9 9509.1 8170.8 9256.8 9724.2 9917.5 9945.0 7336.9 7384.5 7478.6 7489.7 7519.5 7681.5 7781.0 7867.8 7869.6 7887.1 6442.6 7570.3 7689.2 7768.4 7837.0 7373.3 7378.9 7414.0 7501.4 7506.3 7511.4 7562.0 7562.8 7574.7 7581.8 6817.4 6838.6 6893.3 6907.7 6918.8 6613.8 6742.9 6755.7 6765.7 6771.0 03:45:36 INFO - PROCESS | 1679 | 03:45:36 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:5785.94 Median:6604.41 stddev:1841.89 (27.9%) stddev-sans-first:1800.63 03:45:36 INFO - PROCESS | 1679 | Values: 311.3 327.3 332.5 332.7 337.9 6540.1 6573.9 6579.3 6611.3 6653.4 6568.0 6590.3 6591.5 6599.4 6609.4 4756.8 4883.5 4900.5 4901.6 4920.3 4874.8 4892.6 4895.4 4928.8 4932.0 4301.6 4539.2 4823.4 4843.6 4851.0 4573.2 4646.6 4680.5 4854.2 4857.8 4088.3 4133.8 4137.0 4146.2 4148.4 5727.4 5822.2 6298.2 6298.8 6299.2 4893.4 5332.1 5498.4 5519.9 5705.8 7043.7 7053.6 7062.8 7064.8 7064.8 4658.9 4672.9 4674.2 4675.3 4677.2 7254.6 7362.3 7444.8 7480.9 7480.9 4757.5 4762.6 4762.7 4764.3 4765.3 4821.2 4835.6 4847.2 4847.2 4847.7 5523.4 5714.8 5722.8 5727.6 5739.6 7088.8 7112.4 7114.3 7114.6 7118.2 1654.6 1681.7 1682.6 1688.0 1693.9 1078.8 1088.7 1102.4 1105.0 1118.9 6621.9 6622.9 6624.8 6633.4 6660.3 6908.6 7322.0 7328.5 7341.1 7343.6 6384.2 6611.8 6620.2 6623.8 6630.8 3844.6 3895.0 3897.2 3900.6 3906.2 7633.3 7666.0 7668.3 7671.1 7692.7 6901.7 7257.9 7398.9 7443.8 7552.1 6276.0 7599.8 7715.9 7724.3 7734.7 5678.7 7352.0 7384.7 7388.0 7401.6 7070.2 7306.7 7321.0 7331.3 7339.0 7754.0 7763.5 7766.0 7769.2 7777.2 4611.2 4649.2 4659.9 4662.9 4663.5 7138.6 7329.1 7370.0 7371.7 7388.7 7114.1 7117.9 7132.4 7139.6 7141.0 6235.2 6765.6 6832.6 7095.5 7101.5 6939.2 6941.9 6942.4 6953.4 6965.0 7103.7 7105.9 7107.9 7118.1 7126.6 6735.3 6928.4 6951.0 6969.1 6981.1 03:45:36 INFO - PROCESS | 1679 | 03:45:36 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:17678.03 Median:33508.30 stddev:24832.09 (74.1%) stddev-sans-first:24868.83 03:45:36 INFO - PROCESS | 1679 | Values: 648.1 682.4 698.7 725.9 780.3 14074.6 15220.0 15241.9 15260.0 15272.7 13570.0 13653.0 13661.9 13669.0 13674.4 702.4 711.6 848.9 858.1 866.4 870.6 880.2 881.5 882.2 882.6 911.3 914.3 914.8 914.9 915.3 726.7 735.4 736.5 737.5 892.3 668.9 669.1 669.8 671.8 675.2 13719.0 13765.7 13853.6 13855.6 13856.8 12236.4 12314.0 12395.4 12831.9 13010.0 9793.2 9928.5 9956.4 9961.3 9963.4 3440.4 3501.2 3502.2 3502.6 3509.4 78077.6 79400.2 79865.2 79939.0 80675.6 9483.3 9517.5 9539.5 9556.9 9657.8 16544.9 20430.3 20445.2 20458.0 20483.6 7271.2 7354.2 7379.6 7585.1 7647.7 3854.6 3947.1 3974.9 4087.9 4104.6 3455.2 3495.6 3505.6 3509.7 3511.4 641.7 651.1 652.3 676.8 678.7 540.9 544.7 574.8 591.7 597.3 8183.9 8443.5 8582.3 8819.8 8952.9 423.7 495.7 524.3 534.5 564.4 3801.6 3818.3 3833.8 3949.3 4030.6 83236.2 83560.9 84364.6 89498.0 89695.0 78885.6 79248.6 79735.0 80083.0 80622.4 30549.0 35427.1 71223.0 71943.9 72009.2 7744.5 7810.0 7898.2 8038.4 8051.4 50785.5 50926.0 51064.7 51194.0 51890.0 66347.7 68353.0 68499.3 68864.7 68881.0 10962.3 11065.9 11129.7 11227.3 11320.7 11970.2 12265.1 12343.8 12537.0 12552.2 9398.8 11342.0 11549.3 11644.4 11912.9 10998.6 11225.7 11294.7 11597.5 11603.4 10814.6 10904.8 11129.7 11514.5 12178.3 9124.4 9229.2 9484.6 9544.7 9703.3 8985.4 9129.9 9317.5 9419.5 9457.8 03:45:36 INFO - PROCESS | 1679 | -------- Summary: end -------- 03:45:36 INFO - PROCESS | 1679 | 03:45:37 INFO - TEST-INFO | 1679: exit 0 03:45:37 INFO - TEST-OK | dromaeo_css | took 1113853ms 03:45:37 INFO - TEST-START | kraken 03:45:37 INFO - operating with platform_type : mac_ 03:45:37 INFO - Initialising browser for kraken test... 03:45:37 INFO - TEST-INFO | started process 1708 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmp8Ltt_H/profile http://localhost:49275/getInfo.html) 03:45:39 INFO - PROCESS | 1708 | __metrics Screen width/height:1600/1200 03:45:39 INFO - PROCESS | 1708 | colorDepth:24 03:45:39 INFO - PROCESS | 1708 | Browser inner width/height: 1024/689 03:45:39 INFO - PROCESS | 1708 | __metrics 03:45:39 INFO - PROCESS | 1708 | 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" 03:45:39 INFO - PROCESS | 1708 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:45:40 INFO - TEST-INFO | 1708: exit 0 03:45:40 INFO - Browser initialized. 03:45:40 INFO - Running cycle 1/1 for kraken test... 03:45:40 INFO - TEST-INFO | started process 1710 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmp8Ltt_H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:52 INFO - PROCESS | 1710 | RSS: Main: 246714368 03:45:52 INFO - PROCESS | 1710 | 03:45:54 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:55 INFO - PROCESS | 1710 | RSS: Main: 292442112 03:45:55 INFO - PROCESS | 1710 | 03:45:57 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 03:45:58 INFO - PROCESS | 1710 | RSS: Main: 301985792 03:45:58 INFO - PROCESS | 1710 | 03:46:01 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 03:46:02 INFO - PROCESS | 1710 | RSS: Main: 287756288 03:46:02 INFO - PROCESS | 1710 | 03:46:04 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 03:46:04 INFO - PROCESS | 1710 | RSS: Main: 289775616 03:46:04 INFO - PROCESS | 1710 | 03:46:06 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:07 INFO - PROCESS | 1710 | RSS: Main: 291307520 03:46:07 INFO - PROCESS | 1710 | 03:46:10 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:10 INFO - PROCESS | 1710 | RSS: Main: 291090432 03:46:10 INFO - PROCESS | 1710 | 03:46:13 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:14 INFO - PROCESS | 1710 | RSS: Main: 291254272 03:46:14 INFO - PROCESS | 1710 | 03:46:16 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 03:46:17 INFO - PROCESS | 1710 | RSS: Main: 293212160 03:46:17 INFO - PROCESS | 1710 | 03:46:19 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:19 INFO - PROCESS | 1710 | RSS: Main: 325525504 03:46:19 INFO - PROCESS | 1710 | 03:46:21 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:22 INFO - PROCESS | 1710 | RSS: Main: 324792320 03:46:22 INFO - PROCESS | 1710 | 03:46:24 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:24 INFO - PROCESS | 1710 | RSS: Main: 333062144 03:46:24 INFO - PROCESS | 1710 | 03:46:27 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:27 INFO - PROCESS | 1710 | RSS: Main: 335196160 03:46:27 INFO - PROCESS | 1710 | 03:46:30 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:30 INFO - PROCESS | 1710 | RSS: Main: 334684160 03:46:30 INFO - PROCESS | 1710 | 03:46:32 INFO - PROCESS | 1710 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 03:46:33 INFO - PROCESS | 1710 | RSS: Main: 395304960 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | __start_tp_report 03:46:33 INFO - PROCESS | 1710 | _x_x_mozilla_page_load 03:46:33 INFO - PROCESS | 1710 | _x_x_mozilla_page_load_details 03:46:33 INFO - PROCESS | 1710 | |i|pagename|runs| 03:46:33 INFO - PROCESS | 1710 | |0;ai-astar;111;108;111;110;110;112;116;111;110;110 03:46:33 INFO - PROCESS | 1710 | |1;audio-beat-detection;156;121;143;157;124;166;171;142;157;119 03:46:33 INFO - PROCESS | 1710 | |2;audio-dft;184;185;186;184;185;185;185;179;182;183 03:46:33 INFO - PROCESS | 1710 | |3;audio-fft;74;78;87;78;58;57;57;80;77;56 03:46:33 INFO - PROCESS | 1710 | |4;audio-oscillator;92;93;129;78;81;83;108;82;112;151 03:46:33 INFO - PROCESS | 1710 | |5;imaging-gaussian-blur;85;90;84;91;84;89;84;90;85;90 03:46:33 INFO - PROCESS | 1710 | |6;imaging-darkroom;93;93;92;95;94;93;94;92;96;93 03:46:33 INFO - PROCESS | 1710 | |7;imaging-desaturate;87;86;87;88;87;88;88;87;88;87 03:46:33 INFO - PROCESS | 1710 | |8;json-parse-financial;55;55;54;54;53;53;55;65;52;53 03:46:33 INFO - PROCESS | 1710 | |9;json-stringify-tinderbox;62;61;75;73;68;67;65;66;69;66 03:46:33 INFO - PROCESS | 1710 | |10;stanford-crypto-aes;83;83;83;82;84;82;82;81;82;83 03:46:33 INFO - PROCESS | 1710 | |11;stanford-crypto-ccm;121;125;126;123;123;119;131;119;127;131 03:46:33 INFO - PROCESS | 1710 | |12;stanford-crypto-pbkdf2;139;127;140;137;138;135;120;158;171;167 03:46:33 INFO - PROCESS | 1710 | |13;stanford-crypto-sha256-iterative;63;67;70;89;90;93;90;67;66;67 03:46:33 INFO - PROCESS | 1710 | __end_tp_report 03:46:33 INFO - PROCESS | 1710 | __start_cc_report 03:46:33 INFO - PROCESS | 1710 | _x_x_mozilla_cycle_collect,1145 03:46:33 INFO - PROCESS | 1710 | __end_cc_report 03:46:33 INFO - PROCESS | 1710 | __startTimestamp1455536793050__endTimestamp 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | ------- Summary: start ------- 03:46:33 INFO - PROCESS | 1710 | Number of tests: 14 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.08 (1.9%) stddev-sans-first:2.20 03:46:33 INFO - PROCESS | 1710 | Values: 111.0 108.0 111.0 110.0 110.0 112.0 116.0 111.0 110.0 110.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:156.50 stddev:18.94 (12.1%) stddev-sans-first:19.71 03:46:33 INFO - PROCESS | 1710 | Values: 156.0 121.0 143.0 157.0 124.0 166.0 171.0 142.0 157.0 119.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#2] audio-dft Cycles:10 Average:183.80 Median:185.00 stddev:2.04 (1.1%) stddev-sans-first:2.17 03:46:33 INFO - PROCESS | 1710 | Values: 184.0 185.0 186.0 184.0 185.0 185.0 185.0 179.0 182.0 183.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#3] audio-fft Cycles:10 Average:70.20 Median:77.50 stddev:11.83 (15.3%) stddev-sans-first:12.47 03:46:33 INFO - PROCESS | 1710 | Values: 74.0 78.0 87.0 78.0 58.0 57.0 57.0 80.0 77.0 56.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:81.50 stddev:24.07 (29.5%) stddev-sans-first:25.31 03:46:33 INFO - PROCESS | 1710 | Values: 92.0 93.0 129.0 78.0 81.0 83.0 108.0 82.0 112.0 151.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:89.50 stddev:3.01 (3.4%) stddev-sans-first:3.09 03:46:33 INFO - PROCESS | 1710 | Values: 85.0 90.0 84.0 91.0 84.0 89.0 84.0 90.0 85.0 90.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.50 stddev:1.27 (1.4%) stddev-sans-first:1.33 03:46:33 INFO - PROCESS | 1710 | Values: 93.0 93.0 92.0 95.0 94.0 93.0 94.0 92.0 96.0 93.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#7] imaging-desaturate Cycles:10 Average:87.30 Median:87.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 03:46:33 INFO - PROCESS | 1710 | Values: 87.0 86.0 87.0 88.0 87.0 88.0 88.0 87.0 88.0 87.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.70 (6.8%) stddev-sans-first:3.92 03:46:33 INFO - PROCESS | 1710 | Values: 55.0 55.0 54.0 54.0 53.0 53.0 55.0 65.0 52.0 53.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:4.37 (6.5%) stddev-sans-first:4.21 03:46:33 INFO - PROCESS | 1710 | Values: 62.0 61.0 75.0 73.0 68.0 67.0 65.0 66.0 69.0 66.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 03:46:33 INFO - PROCESS | 1710 | Values: 83.0 83.0 83.0 82.0 84.0 82.0 82.0 81.0 82.0 83.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:125.50 stddev:4.35 (3.5%) stddev-sans-first:4.43 03:46:33 INFO - PROCESS | 1710 | Values: 121.0 125.0 126.0 123.0 123.0 119.0 131.0 119.0 127.0 131.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:139.50 stddev:16.73 (12.0%) stddev-sans-first:17.68 03:46:33 INFO - PROCESS | 1710 | Values: 139.0 127.0 140.0 137.0 138.0 135.0 120.0 158.0 171.0 167.0 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - PROCESS | 1710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:79.50 stddev:12.46 (15.7%) stddev-sans-first:12.27 03:46:33 INFO - PROCESS | 1710 | Values: 63.0 67.0 70.0 89.0 90.0 93.0 90.0 67.0 66.0 67.0 03:46:33 INFO - PROCESS | 1710 | -------- Summary: end -------- 03:46:33 INFO - PROCESS | 1710 | 03:46:33 INFO - TEST-INFO | 1710: exit 0 03:46:33 INFO - TEST-OK | kraken | took 56469ms 03:46:33 INFO - SUITE-END | took 1170s 03:46:34 INFO - Completed test suite (00:19:30) 03:46:34 INFO - Working with test: dromaeo_css 03:46:34 INFO - Generating results file: dromaeo_css 03:46:34 INFO - Working with test: kraken 03:46:34 INFO - Generating results file: kraken 03:46:34 INFO - javascript benchmark 03:46:34 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:46:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 03:46:34 INFO - process_Request line: dromaeo_css 7405.99 graph.html#tests=[[72,64,59]] 03:46:34 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:46:34 INFO - process_Request line: kraken 1427.90 graph.html#tests=[[232,64,59]] 03:46:34 INFO - RETURN: dromaeo_css: 7405.99 03:46:34 INFO - RETURN: kraken: 1427.90 03:46:34 INFO - javascript benchmark 03:46:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2982.314067764414, 3467.4798780182973, 3541.8229088545568, 3547.024568243731, 3605.4411566207245, 4471.4187155669715, 5716.970945229857, 5724.0, 5814.215080964069, 5847.970760146193, 4715.5048719884435, 5744.6840423776675, 5835.0663893777, 5895.852603684899, 5916.3787802280785, 5179.093658609747, 5220.243064755608, 5246.108161612516, 5250.186221135711, 5316.149416093426, 5308.309919710451, 5330.626856120073, 5342.652727572715, 5356.598255130862, 5392.487713667196, 4947.208446648537, 5037.319961805183, 5048.671836330626, 5054.267131265946, 5271.789128434877, 5218.791248350061, 5233.319668443078, 5240.659357141812, 5244.056069907415, 5246.029484545371, 5005.0, 5147.588192944556, 5203.0, 5205.193195054772, 5212.921806172911, 5652.547796176296, 5676.1769543416385, 5726.942730572682, 5741.88516229673, 5767.538596912237, 6230.5638605297645, 6232.439080482733, 6266.216722909637, 6270.965290727025, 6280.811575652738, 6127.830981140894, 6197.349278325801, 6264.937350626481, 6274.87450250997, 6277.937220627781, 5763.337216220147, 5763.538916886639, 5849.064149736022, 5856.619319744203, 5863.912041319426, 6224.751009959551, 6233.563650544418, 6252.937470625327, 6260.593061450991, 6265.96867015662, 5961.672108034013, 5965.880682386328, 5998.760049597967, 6059.394060593905, 6117.979653188387, 6142.877142457126, 6166.1983942087245, 6260.812175634738, 6264.780732674334, 6266.216722909637, 4785.688930219594, 5748.770049197985, 6189.597676151036, 6215.96892015537, 6240.251169859555, 5964.135200395918, 6067.423594758491, 6158.476529494954, 6262.906056409158, 6279.183706118175, 4891.755412229374, 4896.534829191221, 4907.852764417074, 4918.729469879119, 4932.482089380635, 4430.955690443118, 4441.89067652638, 4442.777861106996, 4443.622292105208, 4470.083632855257, 5646.096624540136, 5682.090865461506, 5761.8559536011935, 5762.366139724627, 5778.104393818965, 6190.0, 6204.286507051746, 6208.875822483525, 6213.875722485525, 6214.689265536705, 5587.664740115606, 5613.214150019001, 5617.9719101404235, 5637.46444087811, 5639.605227634026, 5314.468553144655, 5404.621676482687, 5406.0, 5440.755166017539, 5489.0, 6307.148534947723, 6320.209973753281, 6324.335944725737, 6328.841778955379, 6337.65142917144, 6142.498775697988, 6271.592346497463, 6320.62076275425, 6349.936500634934, 6353.68231588428, 6267.2479302484, 6299.370062993664, 6326.367363263636, 6345.4923606112325, 6350.460210882126, 6139.26328840542, 6198.597091189058, 6204.410580994799, 6211.130441738251, 6245.219347581552, 6101.277634935997, 6273.372662733873, 6320.810375688737, 6326.145970293951, 6331.461825744679, 5547.528460080777, 5716.114002329646, 6097.329293777592, 6129.816105516842, 6133.325334213144, 6071.7571297147615, 6103.176071230327, 6105.267367915879, 6105.664188469676, 6115.602485838406, 5825.825225243249, 5933.169356290036, 5937.376575459514, 5940.138679891478, 5947.881042379215, 5948.196993405835, 6053.697315134314, 6062.636241825505, 6089.934261504308, 6109.0, 5883.705814709162, 5904.734286957011, 5910.822675319747, 5913.024350982212, 5914.792982245601], "unit": "score", "name": "dojo.html", "value": 5679.621531910355}, {"lowerIsBetter": false, "replicates": [452.64919687242383, 467.0332411907351, 497.08784380661484, 501.8193450357873, 515.8839261166237, 29358.85320573397, 36722.63277367229, 38098.809505952464, 38592.84221473353, 38620.0, 40836.79581602095, 41162.38256426156, 41411.0, 41468.17063658725, 41481.792591037076, 9408.905910940888, 9593.0, 9602.663906763264, 9611.375260608038, 9633.759156021086, 9490.240780737558, 9625.807483850318, 9645.999999999965, 9651.276154288422, 9756.707298781048, 9039.954800225989, 9165.679201227958, 9785.951070244639, 9787.217022638171, 9789.853152202722, 9659.840819101682, 9759.804803903882, 9762.511874406322, 9770.218382529416, 9777.266704997153, 9604.327697061208, 9722.805543889082, 9732.464714440703, 9733.756656083584, 9738.0, 33006.669933300596, 40450.595494044974, 40480.392794107815, 40481.0, 40485.0, 3186.474231751758, 3250.674932506754, 3258.706716395512, 3404.5744281964753, 3635.509206257148, 25935.481290374275, 28941.42117157666, 29766.10701678953, 30168.0, 30449.08652740421, 2705.6212130301774, 2721.9727802722114, 2773.4453109378205, 2842.047913948809, 2843.1044221070297, 323441.0, 379652.0, 381468.9999999972, 382244.0, 382404.0, 62589.37410625927, 62880.685596571726, 62953.0, 63060.36939630637, 66883.99674004894, 70301.64849175824, 70423.29576704168, 70428.2957170432, 70484.64757676178, 70566.294337057, 16514.75227871583, 16740.49778506647, 16744.497665070066, 16750.581235468966, 16785.748213776802, 12739.490420383267, 12792.168509046882, 12809.103362764517, 12824.102312838198, 12824.871751282555, 17330.220140093727, 20189.49526261855, 20973.895130524554, 21068.578628427345, 21073.473163170736, 7556.433267504959, 8786.121387861163, 9075.727728168165, 9082.863757043517, 9109.76810681374, 923.5290002098978, 941.0, 1024.3853687787416, 1114.3703807348822, 1171.3030746705697, 31697.8415107923, 32017.03948881537, 32474.350512989608, 32649.817040251106, 32763.180920477178, 1068.4070340960686, 1079.1330997374587, 1094.2395035450445, 1123.8258069999163, 1209.7882870497629, 15969.920150399406, 16018.79859010579, 16050.0, 16124.589574954425, 16378.426755063516, 592903.0, 630356.848215756, 688881.0, 696270.0, 700549.0, 55718.0, 57528.71235643795, 59147.704261478415, 59200.0, 59271.703641481516, 1297.7015286483972, 1429.2639290765264, 1441.4162264282982, 1441.8990670653163, 1558.4545409106722, 25895.870520647277, 28929.42141157123, 29049.564256536592, 29671.851640741657, 29760.40479190361, 51348.0, 51839.481605183464, 51939.48060519498, 51951.22073168981, 51985.22022169595, 392876.0, 393121.0, 393833.0, 393836.0, 393849.0, 30909.0, 31338.686613133577, 31611.84194079015, 31733.04800855978, 33030.33939321152, 35421.0, 43191.0, 43618.0, 44344.33483497686, 44477.0, 34592.135196620286, 36598.63401366059, 36694.0, 36737.0, 37889.43165852459, 34620.82689586536, 35311.47032794459, 35509.82245088758, 35526.111847204025, 35670.82164589161, 35280.11799704925, 35619.82190089033, 37561.87314380573, 37844.62155378521, 38755.80622096871, 29731.851340743156, 32787.67212327846, 32831.8358408216, 32898.67101328956, 33009.50485742764, 21170.470738231666, 24083.277501674977, 24340.26979190627, 24990.62514062327, 25046.74953250444], "unit": "score", "name": "ext.html", "value": 19674.709973677604}, {"lowerIsBetter": false, "replicates": [366.8385910199512, 370.42399069447015, 371.66364440181644, 376.38836890053665, 378.4569143279393, 14360.56918292453, 14877.0, 16690.83309166908, 18080.186391612377, 19939.202431902726, 17862.106894655248, 18140.818591814077, 18548.350807721734, 19373.612527749436, 19412.417627471164, 5706.1440783882435, 5731.856703582423, 5766.711664416784, 5777.768889244425, 5802.0, 3640.76335038223, 4355.390245365651, 6213.130161777355, 6448.677566121699, 6488.026795980593, 5317.308749862513, 6342.682865856712, 6363.204599425072, 6414.839629009265, 6417.967910160442, 5744.3394009689, 6359.618422894618, 6363.077353783676, 6364.904526432108, 6376.362363763633, 5697.629654072513, 5705.800296989627, 5709.65742055478, 5711.400302968212, 5720.970225359433, 12996.480140794356, 14329.856701432956, 15245.085294882343, 23187.188448404224, 23245.18641847544, 2110.2614085070254, 2171.2003993012227, 2212.38053345062, 2242.865428074321, 2304.0092760113143, 10114.747131321703, 11909.94045029778, 11960.40197990097, 13643.895514193387, 13958.58124256274, 1700.1074435921116, 1794.4796009157328, 1795.2998330651058, 1804.1430320597742, 1825.233401971162, 91092.54453727689, 95864.52067739687, 96347.51826240894, 97155.51422242915, 97261.51369243179, 9401.623935042659, 11015.118790496741, 11015.339079655247, 11087.778244435067, 11167.72080697989, 13198.73602527944, 13278.66803329905, 13317.600471985856, 13344.199348039148, 13352.399142038437, 7657.1959944205055, 7698.615069246515, 8313.584320783937, 8341.582920853933, 8459.154084591615, 8454.746357609281, 8467.449615774955, 8514.659413623385, 8551.828963420821, 8562.871556926651, 3251.528528363374, 4158.981049642857, 4200.768957707355, 4289.399484072233, 4440.600345968878, 1688.7129188038064, 1740.530056884634, 1857.8606604504716, 1860.8604354673453, 1862.2923289150037, 893.5487578772808, 914.4970266353479, 974.907383798538, 1007.9668339951462, 1055.8152323343384, 15906.617272609246, 18395.356162534514, 19309.882881036254, 20130.69803952942, 20144.0, 950.9904900951041, 954.8758661373977, 979.848677803578, 981.3866333541537, 1036.7511797168777, 8830.779230519289, 10198.745031374126, 10277.537510812032, 10430.947845260725, 10489.580416783396, 569347.0, 574421.5829417452, 722128.0, 747920.0, 756875.0, 96779.51610241903, 102006.48996754969, 102067.0, 102745.0, 105484.47257763815, 1119.160629527854, 1136.3352438823215, 1178.8467499225046, 1198.1433275208094, 1203.5967950736601, 17605.0, 17761.644767104845, 17791.73312400341, 17908.373206937693, 18150.909245453688, 47405.0, 48067.798305042656, 48090.519094810006, 48197.0, 48815.5118448811, 60297.0, 62160.0, 62671.0, 62881.68559157358, 65077.349226507125, 7019.438444924496, 7251.492395532473, 7280.017197678246, 7323.450741194325, 7350.448716346188, 8222.958885205535, 8932.419392739452, 11215.88784112181, 11526.135539834713, 11694.0, 10106.747331316481, 10128.0, 10284.485775711335, 10322.019408156213, 10466.110380617733, 6298.937010629835, 7494.613496503164, 7499.962500187464, 7613.6573854175585, 7619.123800762984, 6642.402183803288, 7451.180370159386, 7518.204881550052, 7717.8809072683025, 7814.90082196697, 7609.445105073217, 8807.075257097913, 9353.812923741623, 9839.65561205383, 10909.290896091728, 7531.623418829146, 7753.340966017951, 10621.356815081235, 10862.402567858844, 11213.0], "unit": "score", "name": "jquery.html", "value": 8878.281068131346}, {"lowerIsBetter": false, "replicates": [1508.3514088941752, 1538.776877352784, 1674.4558018643943, 1806.7560879281293, 1834.587217875979, 6965.407940325073, 7692.807679807994, 7890.92109078909, 8673.479591224523, 8678.218960293572, 7870.2916737493615, 7877.80305492363, 7993.560354180518, 7996.96001519993, 8004.4797088189225, 2289.748127705955, 2311.7572654871246, 2313.9190128345513, 2314.456102815837, 2319.907203711858, 2135.6476181430044, 2183.3122566391617, 2189.124350259901, 2327.44141406063, 2367.396313939943, 2126.1814201532366, 2368.9526209475885, 2419.8548087114827, 2422.527607116613, 2429.4290841652196, 2352.4001379648253, 2400.8919598618018, 2401.495685905953, 2409.975900240993, 2415.1909110448023, 2346.4720437901506, 2385.785279324869, 2393.246127469859, 2396.496735685508, 2399.3042017814814, 8417.0, 8522.957385213034, 8527.062023177445, 8537.786555336166, 8645.827083458358, 5226.686398816083, 5344.812931547377, 5381.273528073699, 5383.515483606455, 5388.949154914793, 3424.8972530824117, 3478.234788346585, 3557.94663080054, 3563.8396272167556, 3570.0539357070397, 1042.2860340666668, 1044.2585764107494, 1065.8028264770965, 1074.1514203779004, 1087.0108201536564, 11567.710807229803, 11602.767944641144, 11618.593349232737, 11630.592929247521, 11644.47599858, 4722.338872557844, 4725.432948046257, 4773.284007398918, 4796.112719146969, 4806.519348065235, 9708.174805141502, 9711.514424278757, 9714.125728684452, 9723.65967191145, 9757.756056098513, 5306.867328316745, 5334.253204551366, 5337.01265265927, 5339.359276886721, 5345.01117293302, 4065.6747460203114, 4797.4482934462985, 4835.854924352275, 4839.854804355875, 4846.951530484721, 3270.5094235864335, 3906.687465002793, 3937.468441760383, 3937.684985201177, 3952.7825969571372, 1064.8455973883742, 1213.660175150959, 1281.474595415875, 1290.1742884553894, 1304.1001708820884, 1084.4631907205983, 1084.6258040975852, 1125.5047778977223, 1223.4922507159606, 1319.973600527984, 6831.385175334244, 7844.333231675258, 7923.247291507298, 8030.759077227693, 8031.317338026216, 1157.8263260510823, 1173.8767429419959, 1175.6061719324123, 1182.810750279951, 1198.2570806100273, 6168.845778855564, 6248.9062664060075, 6254.311335939362, 6263.154474146023, 6267.9373206268265, 10000.499975001221, 10018.448985305879, 10023.899761002442, 10082.0, 10166.085052345325, 9903.554340054714, 9965.152961998312, 9972.850407243897, 10058.798824023625, 10065.993400660022, 8200.42597018203, 8283.0, 8283.17168283167, 8285.25432711059, 8293.295069919004, 7697.0, 7905.525668459911, 7939.245771651684, 8037.718679846177, 8043.477173983672, 9313.789207402995, 9394.107559781809, 9452.338336316392, 9464.905350946678, 9509.096635819586, 8170.8152317914755, 9256.814863702553, 9724.222062235145, 9917.504124793875, 9944.950275248866, 7336.926630733625, 7384.4830861839155, 7478.551286922802, 7489.737859174903, 7519.473636845369, 7681.539107653335, 7781.0, 7867.763967080997, 7869.606519674108, 7887.132415434183, 6442.613443193423, 7570.318671319607, 7689.231076892266, 7768.378529717722, 7836.981192445173, 7373.262673732584, 7378.852422951618, 7413.962930185315, 7501.399888009056, 7506.3244308012545, 7511.3615342696485, 7562.0, 7562.773116806505, 7574.659140338587, 7581.848363032819, 6817.386435220854, 6838.623875686686, 6893.345132212432, 6907.6891539881835, 6918.757843475454, 6613.834654133685, 6742.898856517058, 6755.695993680394, 6765.695543700447, 6770.966145169243], "unit": "score", "name": "mootools.html", "value": 4804.5561113223475}, {"lowerIsBetter": false, "replicates": [311.28404669260703, 327.3469428490163, 332.53943288545355, 332.6989074887226, 337.9003194057754, 6540.117084193633, 6573.901391479126, 6579.342065793418, 6611.305812889649, 6653.4344580710695, 6568.0, 6590.308017658149, 6591.538592298541, 6599.439047680953, 6609.372109649587, 4756.809727610891, 4883.511648835123, 4900.534449227318, 4901.5588597026435, 4920.3111564381015, 4874.829380971667, 4892.5596696297325, 4895.388076490439, 4928.753562321887, 4931.975340123312, 4301.634361079312, 4539.182947069527, 4823.445303790057, 4843.612510999112, 4850.951490485103, 4573.153966516205, 4646.558576935186, 4680.485146633868, 4854.2233242681, 4857.8299759508245, 4088.325426304656, 4133.751974881517, 4137.027798467358, 4146.212219678251, 4148.357004664282, 5727.427257274281, 5822.243108395882, 6298.212723409574, 6298.842528936768, 6299.244090709099, 4893.388326459192, 5332.093544097474, 5498.367687715924, 5519.889602207973, 5705.800296989627, 7043.683034263419, 7053.647317634149, 7062.788116356466, 7064.823379415504, 7064.823379415504, 4658.906821863544, 4672.883177920545, 4674.2053850845095, 4675.345451636774, 4677.158111539921, 7254.623747348831, 7362.3373896349585, 7444.776656700307, 7480.8877866832045, 7480.9251907480775, 4757.524247575215, 4762.618990480753, 4762.666613337103, 4764.261539461319, 4765.285207218945, 4821.228603423436, 4835.637327200474, 4847.151748444008, 4847.224444088929, 4847.745798203852, 5523.420040895729, 5714.828555143269, 5722.77108915647, 5727.625369911191, 5739.598228124075, 7088.822779430556, 7112.359887610037, 7114.32413920687, 7114.608696521741, 7118.181409138016, 1654.5780825889321, 1681.7393304037894, 1682.5541231573643, 1688.0125126800958, 1693.889897156681, 1078.789636020984, 1088.6951653537021, 1102.3551222534907, 1104.972375690598, 1118.8937050980144, 6621.940489521653, 6622.9006564901565, 6624.8012559623285, 6633.402993730588, 6660.267370589231, 6908.5509441887125, 7322.0, 7328.523645962995, 7341.119065712149, 7343.596102214429, 6384.170057892445, 6611.834704132339, 6620.205575330991, 6623.801285961429, 6630.7679231226675, 3844.59631738669, 3895.006773272854, 3897.2010737798682, 3900.6099390060767, 3906.1797022625565, 7633.313001829862, 7666.0, 7668.309852113337, 7671.07947046358, 7692.653830577638, 6901.654917254217, 7257.854842903218, 7398.926010739931, 7443.771777656626, 7552.055993000875, 6276.0, 7599.848003039909, 7715.884261736079, 7724.266194711493, 7734.690612375667, 5678.659280443187, 7352.0, 7384.704611815468, 7388.0, 7401.555906645618, 7070.151581810215, 7306.744263950949, 7321.0, 7331.266873312626, 7339.0, 7753.961230193813, 7763.456558040883, 7766.0, 7769.184235655401, 7777.222277772177, 4611.21609326422, 4649.1863923812525, 4659.883502912318, 4662.906741865211, 4663.487016428258, 7138.64306784669, 7329.083864516935, 7370.005049318273, 7371.741989030358, 7388.667509961957, 7114.075170227838, 7117.893231601426, 7132.429405647639, 7139.607321597362, 7141.035960145314, 6235.220597425322, 6765.594064356154, 6832.59004459734, 7095.538789978635, 7101.538400003983, 6939.167299924042, 6941.895871561829, 6942.444604431533, 6953.374196322356, 6964.965175174092, 7103.715851365888, 7105.9289407107335, 7107.893381599177, 7118.145822501333, 7126.608036558039, 6735.292794256533, 6928.376446119873, 6950.965245173742, 6969.0940177776565, 6981.0924579804305], "unit": "score", "name": "prototype.html", "value": 5172.096430876507}, {"lowerIsBetter": false, "replicates": [648.1056142523317, 682.3960794696693, 698.7240040184131, 725.8620862036214, 780.2860382749784, 14074.648133796647, 15220.0, 15241.92379038106, 15260.008099473527, 15272.694546109085, 13569.982251331141, 13653.044286899922, 13661.863381366184, 13669.0, 13674.384652690627, 702.3819039245457, 711.5517224148805, 848.8854004709347, 858.103282070235, 866.4065115395974, 870.5603670146567, 880.2122100719852, 881.4667126388539, 882.188386684252, 882.6248844241172, 911.3210658059754, 914.2777206007246, 914.7850255190025, 914.8810654614891, 915.3455279475207, 726.7202127181047, 735.36758387787, 736.5249414127884, 737.542723511421, 892.312919052326, 668.9264180940093, 669.130130829924, 669.8358902068976, 671.8085345676459, 675.1897722732691, 13719.0, 13765.724685506333, 13853.584392468241, 13855.584332470042, 13856.792148117785, 12236.388180591024, 12314.0, 12395.442205100702, 12831.87168128316, 13010.0, 9793.155772072025, 9928.45393503357, 9956.402615843073, 9961.252906032076, 9963.402195868199, 3440.3807314683345, 3501.1772233525103, 3502.176988407722, 3502.562179727534, 3509.385857474957, 78077.60961195157, 79400.20599793986, 79865.20134798693, 79939.0, 80675.59662201651, 9483.336166468282, 9517.524123793783, 9539.52302384878, 9556.904430955601, 9657.758556036015, 16544.917275413787, 20430.284940027028, 20445.182192712422, 20458.0, 20483.590328193353, 7271.200167981518, 7354.227806080285, 7379.594122323324, 7585.127710313384, 7647.655855486517, 3854.5759966403675, 3947.0527073502153, 3974.9205015900097, 4087.8542229612785, 4104.630583247522, 3455.170759017868, 3495.563054618173, 3505.631908649606, 3509.6665816747877, 3511.4030614795547, 641.682367228225, 651.0917270407849, 652.3281020548842, 676.8443258050676, 678.6572780745691, 540.8674874655735, 544.6976927805027, 574.7959474386616, 591.677535743021, 597.3280059932575, 8183.877241841377, 8443.535605541754, 8582.313414926792, 8819.823603527893, 8952.925648922172, 423.69282270354364, 495.72734995752916, 524.301056049574, 534.4735435595935, 564.4271064869162, 3801.6388443097862, 3818.2745278397015, 3833.769973801581, 3949.328614135604, 4030.5969403059457, 83236.2498315392, 83560.91097722606, 84364.57817710994, 89498.0, 89695.0, 78885.60557197177, 79248.60375698084, 79735.0, 80083.0, 80622.38755224862, 30549.0, 35427.11432214215, 71223.0, 71943.92084118743, 72009.19977000616, 7744.535327880345, 7810.0, 7898.210178982055, 8038.39712021589, 8051.436399451982, 50785.492145078075, 50926.0, 51064.74467627638, 51194.0, 51890.0, 66347.66826165839, 68353.0, 68499.3150068493, 68864.65567672129, 68881.0, 10962.287451315638, 11065.944670276918, 11129.666110016713, 11227.27022743519, 11320.716982075513, 11970.22193557416, 12265.080118990933, 12343.814842777187, 12537.0, 12552.184108033314, 9398.765030874283, 11342.0, 11549.307041577196, 11644.35956022427, 11912.880871191177, 10998.558556773558, 11225.71935701614, 11294.717632059264, 11597.536098555964, 11603.419829008348, 10814.56741730322, 10904.836427453753, 11129.666110016713, 11514.481848317013, 12178.330191839534, 9124.44282498352, 9229.169374756304, 9484.620615175316, 9544.665936692183, 9703.272254580794, 8985.415947963362, 9129.863052054092, 9317.487538185465, 9419.481928493999, 9457.763555910882], "unit": "score", "name": "yui.html", "value": 6692.446557470387}], "name": "dromaeo_css", "value": 7405.983031249542}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 110.0, 110.0, 112.0, 116.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [156.0, 121.0, 143.0, 157.0, 124.0, 166.0, 171.0, 142.0, 157.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 186.0, 184.0, 185.0, 185.0, 185.0, 179.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [74.0, 78.0, 87.0, 78.0, 58.0, 57.0, 57.0, 80.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.2}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 129.0, 78.0, 81.0, 83.0, 108.0, 82.0, 112.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 100.9}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 84.0, 91.0, 84.0, 89.0, 84.0, 90.0, 85.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 92.0, 95.0, 94.0, 93.0, 94.0, 92.0, 96.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.5}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 87.0, 88.0, 87.0, 88.0, 88.0, 87.0, 88.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 87.3}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 54.0, 53.0, 53.0, 55.0, 65.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 75.0, 73.0, 68.0, 67.0, 65.0, 66.0, 69.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 82.0, 84.0, 82.0, 82.0, 81.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [121.0, 125.0, 126.0, 123.0, 123.0, 119.0, 131.0, 119.0, 127.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [139.0, 127.0, 140.0, 137.0, 138.0, 135.0, 120.0, 158.0, 171.0, 167.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [63.0, 67.0, 70.0, 89.0, 90.0, 93.0, 90.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.2}], "name": "kraken", "value": 1427.9}]} 03:46:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1427.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7405.99"}}} 03:46:34 INFO - Return code: 0 03:46:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:46:34 INFO - # TBPL SUCCESS # 03:46:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:46:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:46:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:46:34 INFO - 2016-02-15 03:46:34.946 screenresolution[1714:10187] starting screenresolution argv=screenresolution get 03:46:34 INFO - 2016-02-15 03:46:34.949 screenresolution[1714:10187] Display 0: 1600x1200x32@60 03:46:34 INFO - 2016-02-15 03:46:34.955 screenresolution[1715:10190] starting screenresolution argv=screenresolution list 03:46:34 INFO - Available Modes on Display 0 03:46:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:46:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:46:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:46:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:46:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:46:35 INFO - Intel Iris: 03:46:35 INFO - Chipset Model: Intel Iris 03:46:35 INFO - Type: GPU 03:46:35 INFO - Bus: Built-In 03:46:35 INFO - VRAM (Dynamic, Max): 1536 MB 03:46:35 INFO - Vendor: Intel (0x8086) 03:46:35 INFO - Device ID: 0x0a2e 03:46:35 INFO - Revision ID: 0x0009 03:46:35 INFO - Displays: 03:46:35 INFO - Display: 03:46:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:46:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:46:35 INFO - Display Serial Number: 1600x1200 60 03:46:35 INFO - Main Display: Yes 03:46:35 INFO - Mirror: Off 03:46:35 INFO - Online: Yes 03:46:35 INFO - Rotation: Supported 03:46:35 INFO - Return code: 0 03:46:35 INFO - Running post-action listener: _resource_record_post_action 03:46:35 INFO - Running post-run listener: _resource_record_post_run 03:46:36 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33955328; Write bytes: 708580352; Read time: 354; Write time: 1916 03:46:36 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 274432; Write bytes: 406857216; Read time: 7; Write time: 806 03:46:36 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32144896; Write bytes: 300875264; Read time: 335; Write time: 1108 03:46:36 INFO - Running post-run listener: _upload_blobber_files 03:46:36 INFO - Blob upload gear active. 03:46:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:36 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 03:46:36 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'] 03:46:36 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 03:46:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:46:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:46:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:37 INFO - (blobuploader) - INFO - Done attempting. 03:46:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:46:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:46:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:38 INFO - (blobuploader) - INFO - Done attempting. 03:46:38 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:38 INFO - Return code: 0 03:46:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3edf6e98785c7de4f95f28950f9b6f7a08023e45cf9befad9400546a9c1662c508d43dc1d1355132d868ee03cbfee3b4d971d06595091e92a22e6e714eacf79e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e4513d9a596c36545afb0965e698df31ae247f4b99cf7df5d032bec1c84838eb2b338147e972e32d3e4bf219791368ca58d518867d8ff321864529661e0607d"} 03:46:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:38 INFO - Contents: 03:46:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3edf6e98785c7de4f95f28950f9b6f7a08023e45cf9befad9400546a9c1662c508d43dc1d1355132d868ee03cbfee3b4d971d06595091e92a22e6e714eacf79e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e4513d9a596c36545afb0965e698df31ae247f4b99cf7df5d032bec1c84838eb2b338147e972e32d3e4bf219791368ca58d518867d8ff321864529661e0607d"} 03:46:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:38 INFO - Copying logs to upload dir... 03:46:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1310.400697 ========= master_lag: 8.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2016-02-15 03:46:46.939495) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-15 03:46:46.942837) ========= 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.IbaFXqomPa/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.TNI1r8CynE/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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/3edf6e98785c7de4f95f28950f9b6f7a08023e45cf9befad9400546a9c1662c508d43dc1d1355132d868ee03cbfee3b4d971d06595091e92a22e6e714eacf79e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e4513d9a596c36545afb0965e698df31ae247f4b99cf7df5d032bec1c84838eb2b338147e972e32d3e4bf219791368ca58d518867d8ff321864529661e0607d"} build_url:https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/GubVD9ozRK-0UGaFsB3lEw/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/3edf6e98785c7de4f95f28950f9b6f7a08023e45cf9befad9400546a9c1662c508d43dc1d1355132d868ee03cbfee3b4d971d06595091e92a22e6e714eacf79e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e4513d9a596c36545afb0965e698df31ae247f4b99cf7df5d032bec1c84838eb2b338147e972e32d3e4bf219791368ca58d518867d8ff321864529661e0607d"}' ========= master_lag: 1.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-15 03:46:47.960555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 03:46:47.960907) ========= 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.IbaFXqomPa/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.TNI1r8CynE/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005203 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 03:46:48.260465) ========= ========= Started reboot skipped (results: 3, elapsed: 13 secs) (at 2016-02-15 03:46:48.260810) ========= ========= Finished reboot skipped (results: 3, elapsed: 13 secs) (at 2016-02-15 03:47:01.310136) ========= ========= Total master_lag: 13.95 =========