builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0027 starttime: 1455186957.29 results: success (0) buildid: 20160211004431 builduid: b39923b66dfd4ef19fc995fe97b5c9e4 revision: ac48acdd0a101adb6c53565c5a14cba7313a6296 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.285495) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.285995) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.286336) ========= 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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.005645 basedir: '/builds/slave/test' ========= master_lag: 0.49 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.783142) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.783432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.822417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.822752) ========= 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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.005591 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.871008) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.871274) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 02:35:57.871610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-11 02:35:57.871879) ========= 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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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-11 02:35:57-- 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% 16.0M=0.001s 2016-02-11 02:35:58 (16.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.560288 ========= master_lag: 1.90 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-11 02:36:00.335310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 02:36:00.338634) ========= 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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.026048 ========= master_lag: 0.89 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 02:36:01.259499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-11 02:36:01.259823) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ac48acdd0a101adb6c53565c5a14cba7313a6296 --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 ac48acdd0a101adb6c53565c5a14cba7313a6296 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RWDkcuMsXt/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.lFuPuMFkmK/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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-11 02:36:01,362 truncating revision to first 12 chars 2016-02-11 02:36:01,362 Setting DEBUG logging. 2016-02-11 02:36:01,362 attempt 1/10 2016-02-11 02:36:01,362 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ac48acdd0a10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 02:36:02,556 unpacking tar archive at: fx-team-ac48acdd0a10/testing/mozharness/ program finished with exit code 0 elapsedTime=1.437582 ========= master_lag: 2.00 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-11 02:36:04.693756) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 02:36:04.694057) ========= echo ac48acdd0a101adb6c53565c5a14cba7313a6296 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ac48acdd0a101adb6c53565c5a14cba7313a6296'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RWDkcuMsXt/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.lFuPuMFkmK/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 ac48acdd0a101adb6c53565c5a14cba7313a6296 program finished with exit code 0 elapsedTime=0.005943 script_repo_revision: 'ac48acdd0a101adb6c53565c5a14cba7313a6296' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 02:36:04.743391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 02:36:04.743678) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 02:36:04.798923) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-02-11 02:36:04.799182) ========= /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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:36:04 INFO - MultiFileLogger online at 20160211 02:36:04 in /builds/slave/test 02:36:04 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 02:36:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:36:04 INFO - {'append_to_log': False, 02:36:04 INFO - 'base_work_dir': '/builds/slave/test', 02:36:04 INFO - 'blob_upload_branch': 'Fx-Team', 02:36:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:36:04 INFO - 'branch': 'Fx-Team', 02:36:04 INFO - 'buildbot_json_path': 'buildprops.json', 02:36:04 INFO - 'config_files': ('talos/mac_config.py',), 02:36:04 INFO - 'default_actions': ('clobber', 02:36:04 INFO - 'read-buildbot-config', 02:36:04 INFO - 'download-and-extract', 02:36:04 INFO - 'populate-webroot', 02:36:04 INFO - 'create-virtualenv', 02:36:04 INFO - 'install', 02:36:04 INFO - 'run-tests'), 02:36:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:36:04 INFO - 'download_minidump_stackwalk': True, 02:36:04 INFO - 'download_symbols': 'ondemand', 02:36:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:36:04 INFO - 'tooltool.py': '/tools/tooltool.py', 02:36:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:36:04 INFO - '/tools/misc-python/virtualenv.py')}, 02:36:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:36:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:36:04 INFO - 'installer_path': 'installer.exe', 02:36:04 INFO - 'log_level': 'info', 02:36:04 INFO - 'log_name': 'talos', 02:36:04 INFO - 'log_to_console': True, 02:36:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:36:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:36:04 INFO - 'opt_config_files': (), 02:36:04 INFO - 'pip_index': False, 02:36:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:36:04 INFO - 'cmd': ('bash', 02:36:04 INFO - '-c', 02:36:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:36:04 INFO - 'enabled': True, 02:36:04 INFO - 'halt_on_failure': False, 02:36:04 INFO - 'name': 'check_screen_resolution'},), 02:36:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:36:04 INFO - 'cmd': ('bash', 02:36:04 INFO - '-c', 02:36:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:36:04 INFO - 'enabled': True, 02:36:04 INFO - 'halt_on_failure': False, 02:36:04 INFO - 'name': 'check_screen_resolution'},), 02:36:04 INFO - 'run_cmd_checks_enabled': True, 02:36:04 INFO - 'sps_profile': False, 02:36:04 INFO - 'sps_profile_interval': 0, 02:36:04 INFO - 'suite': 'dromaeojs', 02:36:04 INFO - 'system_bits': '32', 02:36:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:36:04 INFO - 'title': 't-yosemite-r7-0027', 02:36:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:36:04 INFO - 'use_talos_json': True, 02:36:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:36:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:36:04 INFO - 'work_dir': 'build'} 02:36:04 INFO - ##### 02:36:04 INFO - ##### Running clobber step. 02:36:04 INFO - ##### 02:36:04 INFO - Running pre-action listener: _resource_record_pre_action 02:36:04 INFO - Running main action method: clobber 02:36:04 INFO - rmtree: /builds/slave/test/build 02:36:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:36:06 INFO - Running post-action listener: _resource_record_post_action 02:36:06 INFO - ##### 02:36:06 INFO - ##### Running read-buildbot-config step. 02:36:06 INFO - ##### 02:36:06 INFO - Running pre-action listener: _resource_record_pre_action 02:36:06 INFO - Running main action method: read_buildbot_config 02:36:06 INFO - Using buildbot properties: 02:36:06 INFO - { 02:36:06 INFO - "project": "", 02:36:06 INFO - "product": "firefox", 02:36:06 INFO - "script_repo_revision": "production", 02:36:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:36:06 INFO - "repository": "", 02:36:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:36:06 INFO - "buildid": "20160211004431", 02:36:06 INFO - "pgo_build": "False", 02:36:06 INFO - "basedir": "/builds/slave/test", 02:36:06 INFO - "buildnumber": 332, 02:36:06 INFO - "slavename": "t-yosemite-r7-0027", 02:36:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:36:06 INFO - "platform": "yosemite_r7", 02:36:06 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:36:06 INFO - "branch": "fx-team", 02:36:06 INFO - "repo_path": "integration/fx-team", 02:36:06 INFO - "revision": "ac48acdd0a101adb6c53565c5a14cba7313a6296", 02:36:06 INFO - "stage_platform": "macosx64", 02:36:06 INFO - "builduid": "b39923b66dfd4ef19fc995fe97b5c9e4", 02:36:06 INFO - "slavebuilddir": "test" 02:36:06 INFO - } 02:36:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:36:06 INFO - Running post-action listener: _resource_record_post_action 02:36:06 INFO - ##### 02:36:06 INFO - ##### Running download-and-extract step. 02:36:06 INFO - ##### 02:36:06 INFO - Running pre-action listener: _resource_record_pre_action 02:36:06 INFO - Running main action method: download_and_extract 02:36:06 INFO - mkdir: /builds/slave/test/build/tests 02:36:06 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')]} 02:36:06 INFO - https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:36:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/test_packages.json 02:36:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/test_packages.json 02:36:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:36:09 INFO - Downloaded 1277 bytes. 02:36:09 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:36:09 INFO - Using the following test package requirements: 02:36:09 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:36:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:09 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:36:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:09 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:36:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:09 INFO - u'jsshell-mac.zip'], 02:36:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:09 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:36:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:36:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:09 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:36:09 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:09 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:36:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:09 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:36:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:36:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:09 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:36:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:09 INFO - https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:36:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/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 02:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/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 02:36:20 INFO - Downloaded 17750582 bytes. 02:36:20 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'] 02:36:20 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 02:36:23 INFO - Return code: 0 02:36:23 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 02:36: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')]} 02:36:23 INFO - https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:36:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/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 02:36:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/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 02:36:24 INFO - Downloaded 17750582 bytes. 02:36:24 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'] 02:36:24 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 02:36:28 INFO - Return code: 0 02:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:28 INFO - https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:36:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:36:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:36:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/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 02:36:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/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 02:36:29 INFO - Downloaded 10706547 bytes. 02:36:29 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'] 02:36:29 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 02:36:29 INFO - Return code: 0 02:36:29 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')]} 02:36:29 INFO - https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:36:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:36:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:36:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:36:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HhueajGkRIS0pBSy7NMglA/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 02:36:33 INFO - Downloaded 111185945 bytes. 02:36:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:36:33 INFO - mkdir: /builds/slave/test/properties 02:36:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:36:33 INFO - Writing to file /builds/slave/test/properties/build_url 02:36:33 INFO - Contents: 02:36:33 INFO - build_url:https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:36:35 INFO - Running post-action listener: _resource_record_post_action 02:36:35 INFO - Running post-action listener: set_extra_try_arguments 02:36:35 INFO - ##### 02:36:35 INFO - ##### Running populate-webroot step. 02:36:35 INFO - ##### 02:36:35 INFO - Running pre-action listener: _resource_record_pre_action 02:36:35 INFO - Running main action method: populate_webroot 02:36:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:36:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:36:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:36:35 INFO - '--tppagecycles', 02:36:35 INFO - '7'], 02:36:35 INFO - 'tests': ['tsvgm']}}, 02:36:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:36:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:36:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:36:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:36:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:36:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:36:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:35 INFO - 'talos_options': ['--e10s'], 02:36:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:35 INFO - 'tests': ['damp', 'tps']}, 02:36:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:35 INFO - 'talos_options': ['--e10s'], 02:36:35 INFO - 'tests': ['damp', 'tps']}, 02:36:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:36:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:36:35 INFO - 'other': {'tests': ['a11yr', 02:36:35 INFO - 'ts_paint', 02:36:35 INFO - 'tpaint', 02:36:35 INFO - 'sessionrestore', 02:36:35 INFO - 'sessionrestore_no_auto_restore']}, 02:36:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:36:35 INFO - 'tests': ['a11yr', 02:36:35 INFO - 'ts_paint', 02:36:35 INFO - 'tpaint', 02:36:35 INFO - 'sessionrestore', 02:36:35 INFO - 'sessionrestore_no_auto_restore']}, 02:36:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:36:35 INFO - 'tests': ['a11yr', 02:36:35 INFO - 'ts_paint', 02:36:35 INFO - 'tpaint', 02:36:35 INFO - 'sessionrestore', 02:36:35 INFO - 'sessionrestore_no_auto_restore']}, 02:36:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:36:35 INFO - 'tests': ['a11yr', 02:36:35 INFO - 'ts_paint', 02:36:35 INFO - 'tpaint', 02:36:35 INFO - 'sessionrestore', 02:36:35 INFO - 'sessionrestore_no_auto_restore']}, 02:36:35 INFO - 'other_l64': {'tests': ['a11yr', 02:36:35 INFO - 'ts_paint', 02:36:35 INFO - 'tpaint', 02:36:35 INFO - 'sessionrestore', 02:36:35 INFO - 'sessionrestore_no_auto_restore']}, 02:36:35 INFO - 'other_nol64': {'tests': ['a11yr', 02:36:35 INFO - 'ts_paint', 02:36:35 INFO - 'tpaint', 02:36:35 INFO - 'sessionrestore', 02:36:35 INFO - 'sessionrestore_no_auto_restore']}, 02:36:35 INFO - 'svgr': {'tests': ['tsvgx', 02:36:35 INFO - 'tsvgr_opacity', 02:36:35 INFO - 'tart', 02:36:35 INFO - 'tscrollx', 02:36:35 INFO - 'cart']}, 02:36:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:36:35 INFO - 'tests': ['tsvgx', 02:36:35 INFO - 'tsvgr_opacity', 02:36:35 INFO - 'tart', 02:36:35 INFO - 'tscrollx', 02:36:35 INFO - 'cart']}, 02:36:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:35 INFO - 'tests': ['tp5o']}, 02:36:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:35 INFO - 'talos_options': ['--e10s'], 02:36:35 INFO - 'tests': ['tp5o']}, 02:36:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:35 INFO - 'talos_options': ['--xperf_path', 02:36:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:35 INFO - 'tests': ['tp5n']}, 02:36:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:35 INFO - 'talos_options': ['--e10s', 02:36:35 INFO - '--xperf_path', 02:36:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:35 INFO - 'tests': ['tp5n']}}, 02:36:35 INFO - 'talos.zip': {'path': '', 02:36:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:36:35 INFO - Running post-action listener: _resource_record_post_action 02:36:35 INFO - ##### 02:36:35 INFO - ##### Running create-virtualenv step. 02:36:35 INFO - ##### 02:36:35 INFO - Running pre-action listener: _resource_record_pre_action 02:36:35 INFO - Running main action method: create_virtualenv 02:36:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:36:35 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 02:36:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:36:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:36:35 INFO - Using real prefix '/tools/python27' 02:36:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:36:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:36:38 INFO - Installing pip.................done. 02:36:38 INFO - Return code: 0 02:36:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:36:38 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')]} 02:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:38 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')]} 02:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:38 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 0x101cc2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a25a07f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, '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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:36:38 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 02:36:38 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 02:36:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:36:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:38 INFO - 'HOME': '/Users/cltbld', 02:36:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:38 INFO - 'LOGNAME': 'cltbld', 02:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:38 INFO - 'MOZ_NO_REMOTE': '1', 02:36:38 INFO - 'NO_EM_RESTART': '1', 02:36:38 INFO - 'PAGER': '/bin/cat', 02:36:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:38 INFO - 'PWD': '/builds/slave/test', 02:36:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:38 INFO - 'SHELL': '/bin/bash', 02:36:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:36:38 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:36:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:38 INFO - 'USER': 'cltbld', 02:36:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:38 INFO - 'XPC_FLAGS': '0x0', 02:36:38 INFO - 'XPC_SERVICE_NAME': '0', 02:36:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:39 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 02:36:39 INFO - Cleaning up... 02:36:39 INFO - Return code: 0 02:36:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101cc2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a25a07f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, '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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:36:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:36:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:39 INFO - 'HOME': '/Users/cltbld', 02:36:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:39 INFO - 'LOGNAME': 'cltbld', 02:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:39 INFO - 'MOZ_NO_REMOTE': '1', 02:36:39 INFO - 'NO_EM_RESTART': '1', 02:36:39 INFO - 'PAGER': '/bin/cat', 02:36:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:39 INFO - 'PWD': '/builds/slave/test', 02:36:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:39 INFO - 'SHELL': '/bin/bash', 02:36:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:36:39 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:36:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:39 INFO - 'USER': 'cltbld', 02:36:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:39 INFO - 'XPC_FLAGS': '0x0', 02:36:39 INFO - 'XPC_SERVICE_NAME': '0', 02:36:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:39 INFO - Downloading/unpacking psutil>=0.7.1 02:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:36:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:42 INFO - Installing collected packages: psutil 02:36:42 INFO - Running setup.py install for psutil 02:36:42 INFO - building 'psutil._psutil_osx' extension 02:36:42 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 02:36:43 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 02:36:43 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 02:36:43 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 02:36:43 INFO - building 'psutil._psutil_posix' extension 02:36:43 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 02:36:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:36:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:36:43 INFO - ^ 02:36:43 INFO - 1 warning generated. 02:36:43 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 02:36:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:43 INFO - Successfully installed psutil 02:36:43 INFO - Cleaning up... 02:36:43 INFO - Return code: 0 02:36:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:43 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 0x101cc2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a25a07f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, '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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:36:43 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 02:36:43 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 02:36:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:36:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:43 INFO - 'HOME': '/Users/cltbld', 02:36:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:43 INFO - 'LOGNAME': 'cltbld', 02:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:43 INFO - 'MOZ_NO_REMOTE': '1', 02:36:43 INFO - 'NO_EM_RESTART': '1', 02:36:43 INFO - 'PAGER': '/bin/cat', 02:36:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:43 INFO - 'PWD': '/builds/slave/test', 02:36:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:43 INFO - 'SHELL': '/bin/bash', 02:36:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:36:43 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:36:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:43 INFO - 'USER': 'cltbld', 02:36:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:43 INFO - 'XPC_FLAGS': '0x0', 02:36:43 INFO - 'XPC_SERVICE_NAME': '0', 02:36:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:36:46 INFO - Installing collected packages: mozsystemmonitor 02:36:46 INFO - Running setup.py install for mozsystemmonitor 02:36:46 INFO - Successfully installed mozsystemmonitor 02:36:46 INFO - Cleaning up... 02:36:46 INFO - Return code: 0 02:36:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:36:46 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')]} 02:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:46 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')]} 02:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:46 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 0x101cc2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a25a07f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, '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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:36:46 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 02:36:46 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 02:36:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:36:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:46 INFO - 'HOME': '/Users/cltbld', 02:36:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:46 INFO - 'LOGNAME': 'cltbld', 02:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:46 INFO - 'MOZ_NO_REMOTE': '1', 02:36:46 INFO - 'NO_EM_RESTART': '1', 02:36:46 INFO - 'PAGER': '/bin/cat', 02:36:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:46 INFO - 'PWD': '/builds/slave/test', 02:36:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:46 INFO - 'SHELL': '/bin/bash', 02:36:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:36:46 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:36:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:46 INFO - 'USER': 'cltbld', 02:36:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:46 INFO - 'XPC_FLAGS': '0x0', 02:36:46 INFO - 'XPC_SERVICE_NAME': '0', 02:36:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:46 INFO - Downloading/unpacking blobuploader==1.2.4 02:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:48 INFO - Downloading blobuploader-1.2.4.tar.gz 02:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:36:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:36:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:50 INFO - Downloading docopt-0.6.1.tar.gz 02:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:36:50 INFO - Installing collected packages: blobuploader, requests, docopt 02:36:50 INFO - Running setup.py install for blobuploader 02:36:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:36:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:36:50 INFO - Running setup.py install for requests 02:36:50 INFO - Running setup.py install for docopt 02:36:51 INFO - Successfully installed blobuploader requests docopt 02:36:51 INFO - Cleaning up... 02:36:51 INFO - Return code: 0 02:36:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:51 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')]} 02:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:51 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')]} 02:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:51 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 0x101cc2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a25a07f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, '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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:36:51 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 02:36:51 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 02:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:51 INFO - 'HOME': '/Users/cltbld', 02:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:51 INFO - 'LOGNAME': 'cltbld', 02:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:51 INFO - 'MOZ_NO_REMOTE': '1', 02:36:51 INFO - 'NO_EM_RESTART': '1', 02:36:51 INFO - 'PAGER': '/bin/cat', 02:36:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:51 INFO - 'PWD': '/builds/slave/test', 02:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:51 INFO - 'SHELL': '/bin/bash', 02:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:36:51 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:51 INFO - 'USER': 'cltbld', 02:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:51 INFO - 'XPC_FLAGS': '0x0', 02:36:51 INFO - 'XPC_SERVICE_NAME': '0', 02:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:51 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-tJX6Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:51 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-8AUt49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:51 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-St0JId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:51 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-CVx7eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:51 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-T0rQXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:51 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Q_A9bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:51 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-rSqj1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:52 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-4Y7djh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:52 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-50qqar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:52 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-jwWGw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:52 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-TUSi86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:52 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Zb6FGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:52 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-uGfP5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:52 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Aky_nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:52 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-QsYy7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:52 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-UG0pAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:53 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-0R6CRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:36:53 INFO - Running setup.py install for manifestparser 02:36:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:36:53 INFO - Running setup.py install for mozcrash 02:36:53 INFO - Running setup.py install for mozdebug 02:36:53 INFO - Running setup.py install for mozdevice 02:36:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:36:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:36:53 INFO - Running setup.py install for mozfile 02:36:53 INFO - Running setup.py install for mozhttpd 02:36:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:36:53 INFO - Running setup.py install for mozinfo 02:36:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:36:54 INFO - Running setup.py install for mozInstall 02:36:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:36:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:36:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:36:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:36:54 INFO - Running setup.py install for mozleak 02:36:54 INFO - Running setup.py install for mozlog 02:36:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:36:54 INFO - Running setup.py install for moznetwork 02:36:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:36:54 INFO - Running setup.py install for mozprocess 02:36:54 INFO - Running setup.py install for mozprofile 02:36:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:36:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:36:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:36:55 INFO - Running setup.py install for mozrunner 02:36:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:36:55 INFO - Running setup.py install for mozscreenshot 02:36:55 INFO - Running setup.py install for moztest 02:36:55 INFO - Running setup.py install for mozversion 02:36:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:36:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:36:55 INFO - Cleaning up... 02:36:55 INFO - Return code: 0 02:36:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36: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')]} 02:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:55 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 0x101cc2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a25a07f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, '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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:36:55 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 02:36:55 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 02:36:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:36:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:55 INFO - 'HOME': '/Users/cltbld', 02:36:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:55 INFO - 'LOGNAME': 'cltbld', 02:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:55 INFO - 'MOZ_NO_REMOTE': '1', 02:36:55 INFO - 'NO_EM_RESTART': '1', 02:36:55 INFO - 'PAGER': '/bin/cat', 02:36:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:55 INFO - 'PWD': '/builds/slave/test', 02:36:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:55 INFO - 'SHELL': '/bin/bash', 02:36:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:36:55 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:36:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:55 INFO - 'USER': 'cltbld', 02:36:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:55 INFO - 'XPC_FLAGS': '0x0', 02:36:55 INFO - 'XPC_SERVICE_NAME': '0', 02:36:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:55 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-V6imyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-mWqHT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-O0Mi4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-nhBp8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-abmkpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-51_Qdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-km3o3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-fMiIeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-wwh9Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-iEh1FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:56 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)) 02:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:56 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-tC3lXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:57 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)) 02:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:57 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-y0TNny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:57 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)) 02:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:57 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-mCWEwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:57 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)) 02:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:57 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-LfvYs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:57 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)) 02:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:57 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-yXNJqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:57 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)) 02:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:57 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-7c2Cap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:57 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)) 02:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:57 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-WnBO5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:57 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)) 02:36:57 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)) 02:36:57 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)) 02:36:57 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)) 02:36:57 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)) 02:36:57 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)) 02:36:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:00 INFO - Downloading blessings-1.6.tar.gz 02:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:37:00 INFO - Installing collected packages: blessings 02:37:00 INFO - Running setup.py install for blessings 02:37:00 INFO - Successfully installed blessings 02:37:00 INFO - Cleaning up... 02:37:00 INFO - Return code: 0 02:37:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:37:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:37:00 INFO - Reading from file tmpfile_stdout 02:37:00 INFO - Current package versions: 02:37:00 INFO - blessings == 1.6 02:37:00 INFO - blobuploader == 1.2.4 02:37:00 INFO - docopt == 0.6.1 02:37:00 INFO - manifestparser == 1.1 02:37:00 INFO - mozInstall == 1.12 02:37:00 INFO - mozcrash == 0.16 02:37:00 INFO - mozdebug == 0.1 02:37:00 INFO - mozdevice == 0.48 02:37:00 INFO - mozfile == 1.2 02:37:00 INFO - mozhttpd == 0.7 02:37:00 INFO - mozinfo == 0.9 02:37:00 INFO - mozleak == 0.1 02:37:00 INFO - mozlog == 3.1 02:37:00 INFO - moznetwork == 0.27 02:37:00 INFO - mozprocess == 0.22 02:37:00 INFO - mozprofile == 0.28 02:37:00 INFO - mozrunner == 6.11 02:37:00 INFO - mozscreenshot == 0.1 02:37:00 INFO - mozsystemmonitor == 0.0 02:37:00 INFO - moztest == 0.7 02:37:00 INFO - mozversion == 1.4 02:37:00 INFO - psutil == 3.1.1 02:37:00 INFO - requests == 1.2.3 02:37:00 INFO - wsgiref == 0.1.2 02:37:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:00 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 0x101cc2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a25a07f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, '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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:37:00 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 02:37:00 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 02:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:00 INFO - 'HOME': '/Users/cltbld', 02:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:00 INFO - 'LOGNAME': 'cltbld', 02:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:00 INFO - 'MOZ_NO_REMOTE': '1', 02:37:00 INFO - 'NO_EM_RESTART': '1', 02:37:00 INFO - 'PAGER': '/bin/cat', 02:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:00 INFO - 'PWD': '/builds/slave/test', 02:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:00 INFO - 'SHELL': '/bin/bash', 02:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:37:00 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:00 INFO - 'USER': 'cltbld', 02:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:00 INFO - 'XPC_FLAGS': '0x0', 02:37:00 INFO - 'XPC_SERVICE_NAME': '0', 02:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:00 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)) 02:37:00 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)) 02:37:00 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)) 02:37:00 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)) 02:37:00 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)) 02:37:00 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)) 02:37:00 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)) 02:37:00 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)) 02:37:00 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)) 02:37:00 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)) 02:37:00 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)) 02:37:00 INFO - Cleaning up... 02:37:00 INFO - Return code: 0 02:37:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:00 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 0x101cc2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a25a07f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, '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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:37:00 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 02:37:00 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 02:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:00 INFO - 'HOME': '/Users/cltbld', 02:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:00 INFO - 'LOGNAME': 'cltbld', 02:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:00 INFO - 'MOZ_NO_REMOTE': '1', 02:37:00 INFO - 'NO_EM_RESTART': '1', 02:37:00 INFO - 'PAGER': '/bin/cat', 02:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:00 INFO - 'PWD': '/builds/slave/test', 02:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:00 INFO - 'SHELL': '/bin/bash', 02:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:37:00 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:00 INFO - 'USER': 'cltbld', 02:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:00 INFO - 'XPC_FLAGS': '0x0', 02:37:00 INFO - 'XPC_SERVICE_NAME': '0', 02:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:01 INFO - Downloading/unpacking jsonschema 02:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:37:03 INFO - Downloading/unpacking functools32 (from jsonschema) 02:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:37:04 INFO - warning: no files found matching '*.txt' 02:37:04 INFO - no previously-included directories found matching 'build' 02:37:04 INFO - no previously-included directories found matching 'dist' 02:37:04 INFO - no previously-included directories found matching '.git*' 02:37:04 INFO - Installing collected packages: jsonschema, functools32 02:37:04 INFO - Running setup.py install for functools32 02:37:04 INFO - warning: no files found matching '*.txt' 02:37:04 INFO - no previously-included directories found matching 'build' 02:37:04 INFO - no previously-included directories found matching 'dist' 02:37:04 INFO - no previously-included directories found matching '.git*' 02:37:04 INFO - Successfully installed jsonschema functools32 02:37:04 INFO - Cleaning up... 02:37:04 INFO - Return code: 0 02:37:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:37:04 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')]} 02:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:04 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')]} 02:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:04 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 0x101cc2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cca4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a25a07f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, '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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 02:37:04 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 02:37:04 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 02:37:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:37:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:04 INFO - 'HOME': '/Users/cltbld', 02:37:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:04 INFO - 'LOGNAME': 'cltbld', 02:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:04 INFO - 'MOZ_NO_REMOTE': '1', 02:37:04 INFO - 'NO_EM_RESTART': '1', 02:37:04 INFO - 'PAGER': '/bin/cat', 02:37:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:04 INFO - 'PWD': '/builds/slave/test', 02:37:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:04 INFO - 'SHELL': '/bin/bash', 02:37:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:37:04 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:37:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:04 INFO - 'USER': 'cltbld', 02:37:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:04 INFO - 'XPC_FLAGS': '0x0', 02:37:04 INFO - 'XPC_SERVICE_NAME': '0', 02:37:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:04 INFO - Downloading/unpacking flake8 02:37:04 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 02:37:04 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 02:37:04 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 02:37:04 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 02:37:04 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 02:37:04 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 02:37:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:37:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:37:06 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 02:37:06 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 02:37:06 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 02:37:06 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 02:37:06 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 02:37:06 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 02:37:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:37:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:37:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:37:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:37:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:37:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:37:08 INFO - no previously-included directories found matching 'docs/_build' 02:37:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:37:08 INFO - Running setup.py install for pep8 02:37:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:37:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:37:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:37:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:37:08 INFO - no previously-included directories found matching 'docs/_build' 02:37:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:37:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:37:08 INFO - Cleaning up... 02:37:08 INFO - Return code: 0 02:37:08 INFO - Running post-action listener: _resource_record_post_action 02:37:08 INFO - Running post-action listener: _start_resource_monitoring 02:37:08 INFO - Starting resource monitoring. 02:37:08 INFO - ##### 02:37:08 INFO - ##### Running install step. 02:37:08 INFO - ##### 02:37:08 INFO - Running pre-action listener: _resource_record_pre_action 02:37:08 INFO - Running main action method: install 02:37:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:37:08 INFO - Reading from file tmpfile_stdout 02:37:08 INFO - Detecting whether we're running mozinstall >=1.0... 02:37:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:37:08 INFO - Reading from file tmpfile_stdout 02:37:08 INFO - Output received: 02:37:08 INFO - Usage: mozinstall [options] installer 02:37:08 INFO - Options: 02:37:08 INFO - -h, --help show this help message and exit 02:37:08 INFO - -d DEST, --destination=DEST 02:37:08 INFO - Directory to install application into. [default: 02:37:08 INFO - "/builds/slave/test"] 02:37:08 INFO - --app=APP Application being installed. [default: firefox] 02:37:08 INFO - mkdir: /builds/slave/test/build/application 02:37:08 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'] 02:37:08 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 02:37:43 INFO - Reading from file tmpfile_stdout 02:37:43 INFO - Output received: 02:37:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:37:43 INFO - Running post-action listener: _resource_record_post_action 02:37:43 INFO - ##### 02:37:43 INFO - ##### Running run-tests step. 02:37:43 INFO - ##### 02:37:43 INFO - Running pre-action listener: _resource_record_pre_action 02:37:43 INFO - Running main action method: run_tests 02:37:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:37:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:37:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:37:43 INFO - 2016-02-11 02:37:43.176 screenresolution[1658:7529] starting screenresolution argv=screenresolution get 02:37:43 INFO - 2016-02-11 02:37:43.178 screenresolution[1658:7529] Display 0: 1600x1200x32@60 02:37:43 INFO - 2016-02-11 02:37:43.184 screenresolution[1659:7531] starting screenresolution argv=screenresolution list 02:37:43 INFO - Available Modes on Display 0 02:37:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:37:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:37:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:37:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:37:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:37:43 INFO - Intel Iris: 02:37:43 INFO - Chipset Model: Intel Iris 02:37:43 INFO - Type: GPU 02:37:43 INFO - Bus: Built-In 02:37:43 INFO - VRAM (Dynamic, Max): 1536 MB 02:37:43 INFO - Vendor: Intel (0x8086) 02:37:43 INFO - Device ID: 0x0a2e 02:37:43 INFO - Revision ID: 0x0009 02:37:43 INFO - Displays: 02:37:43 INFO - Display: 02:37:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:37:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:37:43 INFO - Display Serial Number: 1600x1200 60 02:37:43 INFO - Main Display: Yes 02:37:43 INFO - Mirror: Off 02:37:43 INFO - Online: Yes 02:37:43 INFO - Rotation: Supported 02:37:43 INFO - Return code: 0 02:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:37:43 INFO - Python 2.7.3 02:37:43 INFO - Return code: 0 02:37:43 INFO - grabbing minidump binary from tooltool 02:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:43 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 0x101b66d30>, '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 0x10198adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b5db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:37:43 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 02:37:43 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 02:37:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:37:43 INFO - Return code: 0 02:37:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:37:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:37:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:37:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:37:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:37:44 INFO - Return code: 0 02:37:44 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/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--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 02:37:44 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/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0027 --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 02:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RWDkcuMsXt/Render', 02:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:44 INFO - 'HOME': '/Users/cltbld', 02:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:44 INFO - 'LOGNAME': 'cltbld', 02:37:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:37:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:44 INFO - 'MOZ_NO_REMOTE': '1', 02:37:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:37:44 INFO - 'NO_EM_RESTART': '1', 02:37:44 INFO - 'PAGER': '/bin/cat', 02:37:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:44 INFO - 'PWD': '/builds/slave/test', 02:37:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:44 INFO - 'SHELL': '/bin/bash', 02:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lFuPuMFkmK/Listeners', 02:37:44 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 02:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:44 INFO - 'USER': 'cltbld', 02:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:44 INFO - 'XPC_FLAGS': '0x0', 02:37:44 INFO - 'XPC_SERVICE_NAME': '0', 02:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:44 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/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--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 02:37:44 INFO - mozversion application_buildid: 20160211004431 02:37:44 INFO - mozversion application_changeset: ac48acdd0a101adb6c53565c5a14cba7313a6296 02:37:44 INFO - mozversion application_display_name: Nightly 02:37:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:37:44 INFO - mozversion application_name: Firefox 02:37:44 INFO - mozversion application_remotingname: firefox 02:37:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:37:44 INFO - mozversion application_vendor: Mozilla 02:37:44 INFO - mozversion application_version: 47.0a1 02:37:44 INFO - mozversion platform_buildid: 20160211004431 02:37:44 INFO - mozversion platform_changeset: ac48acdd0a101adb6c53565c5a14cba7313a6296 02:37:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:37:44 INFO - mozversion platform_version: 47.0a1 02:37:44 INFO - using testdate: 1455187064 02:37:44 INFO - actual date: 1455187064 02:37:45 INFO - starting webserver on 'localhost:49274' 02:37:45 INFO - SUITE-START | Running 2 tests 02:37:45 INFO - TEST-START | dromaeo_css 02:37:45 INFO - operating with platform_type : mac_ 02:37:45 INFO - Initialising browser for dromaeo_css test... 02:37:45 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpvgnpfc/profile http://localhost:49274/getInfo.html) 02:37:47 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 02:37:47 INFO - PROCESS | 1677 | colorDepth:24 02:37:47 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 02:37:47 INFO - PROCESS | 1677 | __metrics 02:37:47 INFO - PROCESS | 1677 | 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" 02:37:47 INFO - PROCESS | 1677 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:37:48 INFO - TEST-INFO | 1677: exit 0 02:37:48 INFO - Browser initialized. 02:37:48 INFO - Running cycle 1/1 for dromaeo_css test... 02:37:48 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpvgnpfc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:00 INFO - PROCESS | 1680 | RSS: Main: 247201792 02:38:00 INFO - PROCESS | 1680 | 02:38:51 INFO - PROCESS | 1680 | 1455187131040 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] 02:41:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 02:41:03 INFO - PROCESS | 1680 | RSS: Main: 350597120 02:41:03 INFO - PROCESS | 1680 | 02:44:05 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 02:44:06 INFO - PROCESS | 1680 | RSS: Main: 377774080 02:44:06 INFO - PROCESS | 1680 | 02:47:08 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 02:47:09 INFO - PROCESS | 1680 | RSS: Main: 376545280 02:47:09 INFO - PROCESS | 1680 | 02:50:11 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 02:50:11 INFO - PROCESS | 1680 | RSS: Main: 339795968 02:50:11 INFO - PROCESS | 1680 | 02:53:15 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 02:53:15 INFO - PROCESS | 1680 | RSS: Main: 340463616 02:53:15 INFO - PROCESS | 1680 | 02:56:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 02:56:18 INFO - PROCESS | 1680 | RSS: Main: 419434496 02:56:18 INFO - PROCESS | 1680 | 02:56:18 INFO - PROCESS | 1680 | __start_tp_report 02:56:18 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 02:56:18 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 02:56:18 INFO - PROCESS | 1680 | |i|pagename|runs| 02:56:18 INFO - PROCESS | 1680 | |0;dojo.html;3447.8103704296263;3453.568303962005;3463.4458486642143;3504.439289713645;3527.611962684104;5646.971765141178;5697.743601537931;5702.515286200673;5718;5768.826935191945;4785;5732.340780810208;5831.241938547993;5892.616979896304;5936.584439089265;5060.493950604947;5137.332146820918;5141.460146684601;5166.328377310944;5255.86860328491;5264.8157314494;5279.155335146377;5287.524122828944;5310.893782124355;5329.520343169114;5087.491250874901;5128.333316668809;5128.846134615949;5198.896022079575;5205.791768329263;5145.048166089286;5176.197689358156;5193.480651934814;5199.792008319662;5226.738663066832;5152.149895267276;5168.767405466763;5169.147090730025;5180.093483640386;5226.03318386096;5531.3362396512275;5583.637063590853;5648.15277708347;5659.51894089003;5705.486506214461;6247.5939063960695;6262.060690896402;6270.247570291549;6282.497400208018;6289.213848268966;6226.62640241587;6245.469135123474;6293.181886354791;6305.653189074599;6307.400796924285;5688.60179787415;5797.652140871562;5819.243498345188;5821.79623713168;5838.970805145947;6233.345498722569;6244.625322480666;6247.656378899113;6251.843703907348;6269.874602508015;5879.7060146993335;6127.080937859357;6185.257769067651;6185.659788711574;6210.161628180228;6130.061839217998;6226;6256.217972753406;6294.055891616203;6338;6254.499640028786;6271.560990730605;6283.465905398001;6284.214473190851;6285.402886725754;6244.46922011625;6267.435930766253;6298.307186209513;6307.2431308242385;6313.3686631336495;4802.255650374198;4847.394075740533;4877.12211801879;4886.853394398174;4893.192623217129;4214.957850421518;4482.798274077674;4516.232240519054;4517.819287228474;4523.547645235451;5668;5677.659340439587;5694.4590263924865;5697.088465845445;5723.771049157987;5935.169076329317;6261.937380626136;6273;6292.119103325538;6293.087502312139;5565.749541270652;5628.690422026746;5663.688497132614;5709.800156994485;5721.628094173865;5338.252644629755;5386.353637563518;5397.379301380392;5403.459654034565;5436.21174929633;5681.318241811009;6169.691515424211;6256.593321434092;6277.811665650038;6287.811365659038;6161.568690191643;6224.221972253468;6259.436650701458;6264.906026409516;6287.591306565058;6262.123302737711;6307.90538141919;6326.272478665012;6332.461740751904;6380.9361906380345;5263.6578622389425;6213.502919766498;6218;6236.469900058546;6244.65654389013;6139.154842350657;6188.226471691039;6201.10084037803;6223.564350495603;6248;6128.136482154648;6133.273457575459;6163.907541386972;6174.536909731698;6177.567570270217;5990.6705131218205;6092.99465588173;6119.497199206753;6176.876462470816;6180.381961803783;5820.243368362086;5830.358660547421;5951.345352011189;5955.464008239279;5973.133895585029;6019.939800601938;6161.815145545641;6169.753209871735;6186.381361863778;6190.380961903774;6033.396660333931;6039.969800150971;6043.879122417439;6045.818625441244;6102.023676211962 02:56:18 INFO - PROCESS | 1680 | |1;ext.html;484.7503535679124;566.2568967186139;574.9396313387094;589.1545632018053;636.9777057802976;28593.571096433545;37561.81219093904;37786.622133778656;37817.99999999996;37923.43114853273;28891.566626500568;39842.00394990119;40305.39541906866;40469.19061618766;42368.728938131826;9392.201662858648;9621.663241786538;9629.807403851919;9630.18143457807;9637;9472.526373681323;9612.231021518262;9615.230781537495;9617.134457898788;9635.855462168072;8275.255227029566;9602.711918642452;9732.318737688365;9745.902540974606;9780.608775648965;9620.951895240514;9721.611135554569;9721.756956076119;9733.2213422926;9748.95125524375;9485;9629.181519570844;9630.27772917034;9630.518474076269;9659.178969787576;38912.61087389118;39122.804385977885;39280.60719392798;39308.80345598282;39320.606793931984;3419.264858055505;3662.82559414264;3756.380197267475;3802.4866643003115;4014.0767623446477;23964;27860;28209.435811283864;28304.433911321863;28611.713882861113;2770.4043630619312;2782.38787466759;2842.2468045967835;2870.095919785261;2954.719301666338;468087;468793;469140;469517;471497.99999999657;51279.230811537855;52667;54904;59940;59968.70015649981;47653.046939061715;57338.71330643404;57800;58056.41943580595;58244;14223.431062757374;14502.782458263135;15359.924805263525;15554.533363999099;15558;10656.147508199325;12002;12235.69410764738;12320.199187052993;12345.321007344503;18104.366347177787;18440.723389149174;18451.52387808972;18468.722969155475;18485.907570462063;7174.735495349603;8383.790405239917;8656.913430865736;8674.956625216833;8723.258523025614;944.579662050381;983.1986930651497;1043.6034306963306;1048.6434612231878;1130.1806190511813;23151;28250.43499130006;28262.576061359097;28621.427571448454;28904.855475722907;1051.2483574244452;1057.9894201057891;1069.909057730086;1081.2215205052507;1151.8790526994712;12997.480100795863;13206.405711742995;13236.536721214712;13380.598582042554;13609.11540749848;526357.3139208745;531161;533491;533828;535312;51847.74076129595;52293.95412091737;52484.687882803235;52524.73737631287;52534.94930101377;1404.6137312239216;1416.8441471438134;1445.1906932118047;1449.463698431566;1452.1504919621927;25902.22293331203;26289.622123496385;26563.468730624892;26596.335091622863;26617.467650647264;45449;45842.541574583825;45953;45968.770156149;45984;495552;497473;497525;497900;501282;26857.597136043365;29385.412291754474;30799.538006929466;31548.738050477725;31635.89274375386;38143.855684329515;38294.42558361682;38513.614863851006;38681.6131838678;38995;33508.49737253992;33661.83169084139;34222.828885856405;34531.654683453846;34645.307093857475;33908.830455847565;33969.66030339665;34108.658913410545;35203.47194792029;35821.641783582876;28100;29904.25239369033;34548.30903381868;35525.28949421049;35744;27887.442251154458;28297.292567685974;29914.70085299119;29975.850120749255;30150.09549713512;23016.194433194756;23142.652860206774;23559.41101472477;23628.29115126549;23681.763182368646 02:56:18 INFO - PROCESS | 1680 | |2;jquery.html;361.63836163836163;366.1834109934847;367.0310380595228;367.7058353317347;371.38535723377817;14876.256187190651;15269.618259543517;18471.984040877764;19302.613947721038;19953.201871925106;18246;18974.525636859053;19104.522386940334;20076.196952121933;20140.496487587818;5206.947930520693;5432.83701488954;5443;5444.6188766786345;5445.482679145475;3872.554656214529;4088.7546747195265;4667.2532394816835;5975.581709280352;5979.970100149493;5732.541396688255;5893.145493903381;5916.7337469813965;5926.614770039955;5929;4954.950450495485;5860.677662728548;5923.496502797268;5923.555733320019;5929.970350148222;5337.599680024014;5517.944820551783;5585.664860108406;5597.552195824365;5600.439956004408;12525.373731313397;12863.549775757803;13055.151415157985;13065.738685226337;13115.803262951064;2043.989780051105;2140.785921407862;2304.5308491294595;2473.332200305925;2652.1910817200746;9378.67174648884;9979.900200998043;10363.274570780048;10677.679669609925;14967.550973470705;1726.8100508944005;1777.413453560322;1814.528222662104;1837.0906401331292;1863.506170864722;78975.21024789794;85910.94603105278;98085.5095724524;98766;107013.46493267562;11107.278026928385;11294.830577541343;11414.600488982845;11425.37160456183;11496.90779375958;13489.730205395837;13632.182069075887;13640.795388069188;13647.522336718168;13702.246376449391;8453.196946290092;8460.238578527838;8467.449615775078;8534.82930341402;8558.229759321566;8511.233988941025;8515.957420212859;8548.230659240699;8579.056303806576;8628.309735221168;4075.449814275035;4239.872803815891;4424.513303536608;4501.68488205829;4566.566176213254;1733.7286460539367;1782.10003948008;1913.8755980861233;1919.1172060851886;1921.6060707554918;881.1805021330224;932.2733739938446;943.4150826487621;947.5830634520789;957.5690939077443;15646.452374166849;20071.197152113753;20318.695219571717;20414;20471.283505077252;799.8160423102719;843.2242337049929;890.3011136258136;927.5640448988964;1054.435876805905;10618.840717389245;10915.890841091647;11025.61410350634;11169;11179.217454778087;684223;727895;747908;750468;752113;107703.92296077096;110443.44778276217;112590;113041;113690.43154784339;1127.115214556569;1127.6278827986744;1142.405948906564;1143.4797167288864;1146.5356530605118;18007.369742058963;18169.36407225741;18182.727259090858;18247.635047299245;18365.632687346446;47767;50732.492675072775;50908;51432.22851657153;51735.74132129315;42368.576314237696;46288;72101.91847122193;72773;76636.46727065316;7308.744193953186;7912.010998625172;9504.524773761423;9892.653757118755;10820.350778953289;8649;11949.163558550817;12319.858436098737;12618.747625047632;13000.934995324962;10732.624358147428;10873.238873278795;11146.108311334912;11205.775884482428;11285.887141128484;8984.505852178192;10940.726481838017;10984.505697243483;11132.721681958015;11226.382548959886;7699.961500192463;7876;7911.762647120596;10948.233623646587;11540.307581545134;9125.771855703395;10603.522841472306;11098.223124381217;11162.888371116509;11345.432728363383;10958.890411095786;11164.385958772345;11193.608223712132;11265.493052812479;11457.968782809587 02:56:18 INFO - PROCESS | 1680 | |3;mootools.html;1379.2414172205285;1514.1369419430926;1540.1913995152543;1759.9032053237074;1925.8266755991958;7919.326857217136;8607.225349718525;8786.824263514725;8796.208341249294;8803.735887923356;8469.788255293606;8718.171773681506;8722.563871806417;8723.694670686527;8730.214280714734;2166.2418153646254;2224.788645078715;2225.532638145983;2485.266846280347;2513.937151571207;2241.5068684889297;2244.2145249162745;2252.2117258959397;2484.9378765530823;2552.2981180175416;2461.4584791345874;2489.8879550420183;2494.2641920633364;2494.289127598635;2501.0496011515597;2446.425090103824;2495.925122246317;2505.023041014006;2507.962380564293;2510.686164229471;2323.546908352872;2354.5997180479358;2482.8510289382516;2484.6645702830247;2493.675822143128;7378.96310518444;8831.337649676236;8874.955625221897;8903.643854245822;8937;5409.24270602116;5527.972360138174;5537.944620553783;5568.1091025435735;5575.526080283181;3609.675129238355;3654.28741395428;3674.7427680062406;3761.9059523511855;3765.924681506382;1044.4099084017505;1044.4725413666126;1060.199549340251;1095.3537412926412;1113.3876367997568;11913.583024594098;11943.581974630846;11958;11963.282203067756;11974.940125299318;4924.310596516419;4969.975150124226;5009.974950125299;5089.541941225308;5155.278261043457;10179.083882450615;10186.439745813903;10203.489825508696;10215.182785377152;10225.130863876653;5501.862453438696;5525.171224316385;5534.08687566547;5538.224648549206;5547.472990065938;5009.824656137091;5014.473480284518;5027.572656324253;5038.1435156022835;5042.042012017705;3640;3948.7235893487755;3980.283548961215;3992.0818211810865;4053.635172834459;1246.8690787467367;1314.1392387985884;1320.4124164746788;1326.0518729108733;1333.3999700134978;1319.0436933223336;1331.9267440290682;1335.8597347278396;1353.553327401955;1357.8777909988148;8111.432199745961;8137.877931831027;8152.2662960333855;8429.704960326482;8471.576421178916;1089.629525961177;1130.5195292000867;1182.6806762174165;1187.9762404751857;1207.4988879614862;6324.841878953063;6382.266039405527;6383.904241436382;6391.105245265667;6398.776042838572;10264;10552.15582753378;10574.577016919391;10652.254342195973;10700.357978521159;10376.481175941173;10428.843567346496;10429.478526073666;10541.894581054245;10550.261481696361;8141.389395795339;8311.25198732105;8328.167183281745;8330.666773329;8390.664373424994;8056.355491560544;8060;8164.510129392255;8186.304164146114;8232.83534329322;9524.476153811329;9610.423374597547;9683;9746.75633109178;9855.310128291238;9708.805823883624;10031.448270345201;10180.745481363025;10298.691039268833;10307.94846025765;5907.261592300963;7531.171571127062;7553.546787192786;7670.578118203553;7776.105747839071;7318.96340518294;7501.737439189602;8115.310198633182;8189.426740128134;8196.672133114847;7543.510641488186;7544.170141284564;7684.923150768421;7821.92178078212;7844.803879903048;7571.886421703789;7579.317861392281;7602.46782725204;7624.847503049797;7748.263914928073;7506.699732010658;7691.30778229962;7727.343175830118;7790.727324543614;7799.298063174341;6939.861202775815;6997.090378250795;6997.895031574429;7000.649967501503;7002.964985175042;7022.508424410242;7082.716691332495;7104.005439238407;7133.714651413885;7153.60655163971 02:56:18 INFO - PROCESS | 1680 | |4;prototype.html;262.8212815285606;324.69316495911374;328.18609847578006;331.62526345229884;334.7305419137596;6313.494920406368;6417;6555.737770489175;6680.6993685284215;6682.064510968468;6355.8093257202245;6514;6571.145751052357;6594.901076483857;6597.614500954805;4570.680052396334;4668.8599342019625;4802.255650374198;4818.229083346665;4819.807207711688;4651.906961860761;4736.223916031488;4760.214564596855;4776.68951518152;4795.448523419816;4732.1482133216;4732.526747325274;4733.715977041371;4741.502142275063;4746.691465054778;4722.97638511807;4725.787339569728;4733.95266047342;4737.313089601988;4761;3920.647141757227;4045;4046.635802777764;4046.979765101156;4049.311617025113;6182.227221597301;6185.041318595625;6195.690215489252;6196.87606247877;6209.223847019122;5510.366307874566;5524.309461317335;5539;5556.305461817273;5566.359868615121;6582.111414959015;6735.461163106939;6827.317268273133;6875.346842049998;6925.065116209297;4438.778061096965;4475.619572336355;4477.17172323118;4480.8879778005485;4481.462224533077;6792.626405547742;7234.60209688467;7361.9631901840685;7363.374113200384;7365.742199023009;3804.543454785388;4167.8958026049595;4444.711093778894;4570.108828778356;4617.145828021759;4684.414448193976;4692.601128904013;4697.342372067913;4698.154332220233;4719.10337035962;5545.805896793593;5554.77780888768;5563.916541251884;5590.161475778585;5600.299962504687;6060.939390606126;6792.93207067923;7000.544964577286;7004.544704594185;7038.260982596754;1585.5718955881848;1624.6507000994843;1626.487656388234;1627.0481768165519;1630.4293497275858;1026.8870424253325;1031.2368847053276;1041.7135287795916;1047.2983101322131;1049.3441599000626;6497.122888410098;6503.544751867324;6521.576097553644;6526.216853977553;6530.444912182423;6673.766418175341;7257.838745800752;7269.63651817407;7271.345578897819;7280.854382912312;5809.767609295665;6276.780312689034;6470.45001174896;6479.287278399373;6482.805515834532;3147.213196700825;3839.7504162229366;3883.5533913600298;3884.3396622574232;3902.843886244518;6122.969385153046;7437;7692.846143077107;7713.305802477804;7715.537067775951;7282.854342913112;7603.695852165852;7609.961950190213;7611.65747541362;7638.618069096523;7269;7394.667239974106;7413.88879166813;7712.6529306181355;7726.227377262228;6296.874062518632;6726.822806008831;7060.1880783708475;7067.233191702075;7073;7179.246179151114;7239;7272.709091636275;7275.672594733144;7277.963610181915;6212.875742485216;7417.443691723034;7654.464187506821;7747.147813740371;7753.92246077532;4627.652926030494;4652.55800698933;4657.510961349009;4667.813287468599;4685.4143232095985;7289.161746399232;7319.670614822239;7322.890156647761;7335.669894854637;7338.266173382833;6809.557378770364;7083.256258092826;7095.82260443493;7110.715571377087;7132.00455808572;7071.681774320271;7086.39765619928;7095.680694368662;7099.254578269208;7110.217876033529;6633.137692100189;6852.211995620568;6885.242623311532;6897.7240910365035;6903.413209877217;7066.611336376549;7078.292170782881;7079.858402832017;7083.477052433752;7089.858202836018;6904.206016308189;6911.688973996283;6924.238333783381;6933.514653974174;6954.930450695429 02:56:18 INFO - PROCESS | 1680 | |5;yui.html;681.4207923265224;743.3792783026173;744.504904238681;753.796474951763;786.1705900275207;17025.914870425648;17446.3021479141;17446.82553174468;17466;17492.475225743216;15734.449294274702;15765.290561924712;15833.12917789521;15867.682646347066;15881;698.4970821008891;709.0286307758353;856.1823458597056;870.6473878079372;891.2958762577589;866.6100254885296;877.3682948277262;879.2438502887512;880.5465185429509;883.2007033634571;913.5295322908707;913.8766266553996;916.9174774270315;918.2332752151927;919.4299534288717;711.9359257666808;721.9494635375552;896.9372143949926;914.1133100892124;917.6191880369638;666.3636227402818;674.140470899607;675.2234929830685;676.4351766275166;676.509530590323;15041;15073.773893391608;15105.773413398807;15107.32017059235;15164.620884477867;12198.451069701796;12416.627501174979;12445.62663120108;12459.06557008228;12581.938175386043;8826.691065812665;9978.600855965753;10085.142762865165;10270.6405275815;10898.618548350769;3482.251315967054;3516.085817687394;3516.5604299462566;3519.8592056317716;3521.5774107107054;67550.32449675539;84968;86279;86449.56775216147;86564.56717716434;9289.860652090225;9420.717378478657;9507.619695212252;9556.713298601053;9940;20701.58596828085;21100.366988990354;21126.894365528075;21146;21243.937803109784;7388.187299397169;7419.6661150248365;7491.138519070268;7590.734324298623;7703.229677032364;3967.9603203968168;4042.9892526868284;4052.2503336882182;4057.4928133983253;4063.9390409143884;3351.2292172799903;3399;3399.2521645238007;3405.5743032120986;3409.539712138879;510.9361329833771;617.9660118693425;624.8125562331282;636.7675798333574;639.2361128451456;552.160314840424;553.2448208195784;578.6294832600121;634.5462993959342;637.0412529143609;7812.453128280966;8580.947100808708;8586.570671466401;8724.171203735636;8768.517731524827;525.408914970658;535.8392482255308;557.9442055794389;558.5531574740191;593.6883136353449;3872.9031774205305;3896.3571010782903;3944.9211015780097;3966.4248683941246;4003.8798836034966;93491;94810.52594736982;95272.52363738137;95316;95970.52014739881;82082.58958705168;82259.17740822515;83004;83981.32037359219;84488;56889;70569.2943070573;72529.6373518129;72658;73146.90279645809;8217.630206640835;8227.588620568828;8540.658373664985;8942.73171804847;9016.90983090187;42662;49067.26399103945;49657.006859861875;51189.74405127951;51376;69711;71730.28269717236;72469;73207.90188147075;73592.63203683947;10979.505922233358;10997.285176463503;11040.282381645167;11135.443227838414;11443.313401195956;11922;11948.76102477963;12438.626841194779;12447.502099916264;12729.872701272869;11354.318740875575;11598.304101753922;11879.406029698654;12002.939985300018;12317.938410307892;11530.077593792645;11648.825267620823;11832.940835295769;11870.881291186977;12389.690257743629;10453.790924181321;11300.49147788335;11371.886281137082;11667.124965627781;11784.41077946082;9226.215771659485;9484.193843523102;9777.311239409219;9890.653827116017;10443.268971171945;9154.26765858743;9156.304798342166;9412;9681.612735490502;10140.391576505433 02:56:18 INFO - PROCESS | 1680 | __end_tp_report 02:56:18 INFO - PROCESS | 1680 | __start_cc_report 02:56:18 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1022 02:56:18 INFO - PROCESS | 1680 | __end_cc_report 02:56:18 INFO - PROCESS | 1680 | __startTimestamp1455188178631__endTimestamp 02:56:18 INFO - PROCESS | 1680 | 02:56:18 INFO - PROCESS | 1680 | ------- Summary: start ------- 02:56:18 INFO - PROCESS | 1680 | Number of tests: 6 02:56:18 INFO - PROCESS | 1680 | 02:56:18 INFO - PROCESS | 1680 | [#0] dojo.html Cycles:165 Average:5742.37 Median:5955.46 stddev:638.64 (10.7%) stddev-sans-first:614.71 02:56:18 INFO - PROCESS | 1680 | Values: 3447.8 3453.6 3463.4 3504.4 3527.6 5647.0 5697.7 5702.5 5718.0 5768.8 4785.0 5732.3 5831.2 5892.6 5936.6 5060.5 5137.3 5141.5 5166.3 5255.9 5264.8 5279.2 5287.5 5310.9 5329.5 5087.5 5128.3 5128.8 5198.9 5205.8 5145.0 5176.2 5193.5 5199.8 5226.7 5152.1 5168.8 5169.1 5180.1 5226.0 5531.3 5583.6 5648.2 5659.5 5705.5 6247.6 6262.1 6270.2 6282.5 6289.2 6226.6 6245.5 6293.2 6305.7 6307.4 5688.6 5797.7 5819.2 5821.8 5839.0 6233.3 6244.6 6247.7 6251.8 6269.9 5879.7 6127.1 6185.3 6185.7 6210.2 6130.1 6226.0 6256.2 6294.1 6338.0 6254.5 6271.6 6283.5 6284.2 6285.4 6244.5 6267.4 6298.3 6307.2 6313.4 4802.3 4847.4 4877.1 4886.9 4893.2 4215.0 4482.8 4516.2 4517.8 4523.5 5668.0 5677.7 5694.5 5697.1 5723.8 5935.2 6261.9 6273.0 6292.1 6293.1 5565.7 5628.7 5663.7 5709.8 5721.6 5338.3 5386.4 5397.4 5403.5 5436.2 5681.3 6169.7 6256.6 6277.8 6287.8 6161.6 6224.2 6259.4 6264.9 6287.6 6262.1 6307.9 6326.3 6332.5 6380.9 5263.7 6213.5 6218.0 6236.5 6244.7 6139.2 6188.2 6201.1 6223.6 6248.0 6128.1 6133.3 6163.9 6174.5 6177.6 5990.7 6093.0 6119.5 6176.9 6180.4 5820.2 5830.4 5951.3 5955.5 5973.1 6019.9 6161.8 6169.8 6186.4 6190.4 6033.4 6040.0 6043.9 6045.8 6102.0 02:56:18 INFO - PROCESS | 1680 | 02:56:18 INFO - PROCESS | 1680 | [#1] ext.html Cycles:180 Average:62558.73 Median:37870.72 stddev:133369.74 (352.2%) stddev-sans-first:133662.45 02:56:18 INFO - PROCESS | 1680 | Values: 484.8 566.3 574.9 589.2 637.0 28593.6 37561.8 37786.6 37818.0 37923.4 28891.6 39842.0 40305.4 40469.2 42368.7 9392.2 9621.7 9629.8 9630.2 9637.0 9472.5 9612.2 9615.2 9617.1 9635.9 8275.3 9602.7 9732.3 9745.9 9780.6 9621.0 9721.6 9721.8 9733.2 9749.0 9485.0 9629.2 9630.3 9630.5 9659.2 38912.6 39122.8 39280.6 39308.8 39320.6 3419.3 3662.8 3756.4 3802.5 4014.1 23964.0 27860.0 28209.4 28304.4 28611.7 2770.4 2782.4 2842.2 2870.1 2954.7 468087.0 468793.0 469140.0 469517.0 471498.0 51279.2 52667.0 54904.0 59940.0 59968.7 47653.0 57338.7 57800.0 58056.4 58244.0 14223.4 14502.8 15359.9 15554.5 15558.0 10656.1 12002.0 12235.7 12320.2 12345.3 18104.4 18440.7 18451.5 18468.7 18485.9 7174.7 8383.8 8656.9 8675.0 8723.3 944.6 983.2 1043.6 1048.6 1130.2 23151.0 28250.4 28262.6 28621.4 28904.9 1051.2 1058.0 1069.9 1081.2 1151.9 12997.5 13206.4 13236.5 13380.6 13609.1 526357.3 531161.0 533491.0 533828.0 535312.0 51847.7 52294.0 52484.7 52524.7 52534.9 1404.6 1416.8 1445.2 1449.5 1452.2 25902.2 26289.6 26563.5 26596.3 26617.5 45449.0 45842.5 45953.0 45968.8 45984.0 495552.0 497473.0 497525.0 497900.0 501282.0 26857.6 29385.4 30799.5 31548.7 31635.9 38143.9 38294.4 38513.6 38681.6 38995.0 33508.5 33661.8 34222.8 34531.7 34645.3 33908.8 33969.7 34108.7 35203.5 35821.6 28100.0 29904.3 34548.3 35525.3 35744.0 27887.4 28297.3 29914.7 29975.9 30150.1 23016.2 23142.7 23559.4 23628.3 23681.8 02:56:18 INFO - PROCESS | 1680 | 02:56:18 INFO - PROCESS | 1680 | [#2] jquery.html Cycles:180 Average:36568.49 Median:11306.03 stddev:120553.93 (1066.3%) stddev-sans-first:120861.46 02:56:18 INFO - PROCESS | 1680 | Values: 361.6 366.2 367.0 367.7 371.4 14876.3 15269.6 18472.0 19302.6 19953.2 18246.0 18974.5 19104.5 20076.2 20140.5 5206.9 5432.8 5443.0 5444.6 5445.5 3872.6 4088.8 4667.3 5975.6 5980.0 5732.5 5893.1 5916.7 5926.6 5929.0 4955.0 5860.7 5923.5 5923.6 5930.0 5337.6 5517.9 5585.7 5597.6 5600.4 12525.4 12863.5 13055.2 13065.7 13115.8 2044.0 2140.8 2304.5 2473.3 2652.2 9378.7 9979.9 10363.3 10677.7 14967.6 1726.8 1777.4 1814.5 1837.1 1863.5 78975.2 85910.9 98085.5 98766.0 107013.5 11107.3 11294.8 11414.6 11425.4 11496.9 13489.7 13632.2 13640.8 13647.5 13702.2 8453.2 8460.2 8467.4 8534.8 8558.2 8511.2 8516.0 8548.2 8579.1 8628.3 4075.4 4239.9 4424.5 4501.7 4566.6 1733.7 1782.1 1913.9 1919.1 1921.6 881.2 932.3 943.4 947.6 957.6 15646.5 20071.2 20318.7 20414.0 20471.3 799.8 843.2 890.3 927.6 1054.4 10618.8 10915.9 11025.6 11169.0 11179.2 684223.0 727895.0 747908.0 750468.0 752113.0 107703.9 110443.4 112590.0 113041.0 113690.4 1127.1 1127.6 1142.4 1143.5 1146.5 18007.4 18169.4 18182.7 18247.6 18365.6 47767.0 50732.5 50908.0 51432.2 51735.7 42368.6 46288.0 72101.9 72773.0 76636.5 7308.7 7912.0 9504.5 9892.7 10820.4 8649.0 11949.2 12319.9 12618.7 13000.9 10732.6 10873.2 11146.1 11205.8 11285.9 8984.5 10940.7 10984.5 11132.7 11226.4 7700.0 7876.0 7911.8 10948.2 11540.3 9125.8 10603.5 11098.2 11162.9 11345.4 10958.9 11164.4 11193.6 11265.5 11458.0 02:56:18 INFO - PROCESS | 1680 | 02:56:18 INFO - PROCESS | 1680 | [#3] mootools.html Cycles:180 Average:6095.71 Median:5040.09 stddev:3185.58 (63.2%) stddev-sans-first:3174.78 02:56:18 INFO - PROCESS | 1680 | Values: 1379.2 1514.1 1540.2 1759.9 1925.8 7919.3 8607.2 8786.8 8796.2 8803.7 8469.8 8718.2 8722.6 8723.7 8730.2 2166.2 2224.8 2225.5 2485.3 2513.9 2241.5 2244.2 2252.2 2484.9 2552.3 2461.5 2489.9 2494.3 2494.3 2501.0 2446.4 2495.9 2505.0 2508.0 2510.7 2323.5 2354.6 2482.9 2484.7 2493.7 7379.0 8831.3 8875.0 8903.6 8937.0 5409.2 5528.0 5537.9 5568.1 5575.5 3609.7 3654.3 3674.7 3761.9 3765.9 1044.4 1044.5 1060.2 1095.4 1113.4 11913.6 11943.6 11958.0 11963.3 11974.9 4924.3 4970.0 5010.0 5089.5 5155.3 10179.1 10186.4 10203.5 10215.2 10225.1 5501.9 5525.2 5534.1 5538.2 5547.5 5009.8 5014.5 5027.6 5038.1 5042.0 3640.0 3948.7 3980.3 3992.1 4053.6 1246.9 1314.1 1320.4 1326.1 1333.4 1319.0 1331.9 1335.9 1353.6 1357.9 8111.4 8137.9 8152.3 8429.7 8471.6 1089.6 1130.5 1182.7 1188.0 1207.5 6324.8 6382.3 6383.9 6391.1 6398.8 10264.0 10552.2 10574.6 10652.3 10700.4 10376.5 10428.8 10429.5 10541.9 10550.3 8141.4 8311.3 8328.2 8330.7 8390.7 8056.4 8060.0 8164.5 8186.3 8232.8 9524.5 9610.4 9683.0 9746.8 9855.3 9708.8 10031.4 10180.7 10298.7 10307.9 5907.3 7531.2 7553.5 7670.6 7776.1 7319.0 7501.7 8115.3 8189.4 8196.7 7543.5 7544.2 7684.9 7821.9 7844.8 7571.9 7579.3 7602.5 7624.8 7748.3 7506.7 7691.3 7727.3 7790.7 7799.3 6939.9 6997.1 6997.9 7000.6 7003.0 7022.5 7082.7 7104.0 7133.7 7153.6 02:56:18 INFO - PROCESS | 1680 | 02:56:18 INFO - PROCESS | 1680 | [#4] prototype.html Cycles:180 Average:5697.01 Median:6481.05 stddev:1838.73 (28.4%) stddev-sans-first:1798.08 02:56:18 INFO - PROCESS | 1680 | Values: 262.8 324.7 328.2 331.6 334.7 6313.5 6417.0 6555.7 6680.7 6682.1 6355.8 6514.0 6571.1 6594.9 6597.6 4570.7 4668.9 4802.3 4818.2 4819.8 4651.9 4736.2 4760.2 4776.7 4795.4 4732.1 4732.5 4733.7 4741.5 4746.7 4723.0 4725.8 4734.0 4737.3 4761.0 3920.6 4045.0 4046.6 4047.0 4049.3 6182.2 6185.0 6195.7 6196.9 6209.2 5510.4 5524.3 5539.0 5556.3 5566.4 6582.1 6735.5 6827.3 6875.3 6925.1 4438.8 4475.6 4477.2 4480.9 4481.5 6792.6 7234.6 7362.0 7363.4 7365.7 3804.5 4167.9 4444.7 4570.1 4617.1 4684.4 4692.6 4697.3 4698.2 4719.1 5545.8 5554.8 5563.9 5590.2 5600.3 6060.9 6792.9 7000.5 7004.5 7038.3 1585.6 1624.7 1626.5 1627.0 1630.4 1026.9 1031.2 1041.7 1047.3 1049.3 6497.1 6503.5 6521.6 6526.2 6530.4 6673.8 7257.8 7269.6 7271.3 7280.9 5809.8 6276.8 6470.5 6479.3 6482.8 3147.2 3839.8 3883.6 3884.3 3902.8 6123.0 7437.0 7692.8 7713.3 7715.5 7282.9 7603.7 7610.0 7611.7 7638.6 7269.0 7394.7 7413.9 7712.7 7726.2 6296.9 6726.8 7060.2 7067.2 7073.0 7179.2 7239.0 7272.7 7275.7 7278.0 6212.9 7417.4 7654.5 7747.1 7753.9 4627.7 4652.6 4657.5 4667.8 4685.4 7289.2 7319.7 7322.9 7335.7 7338.3 6809.6 7083.3 7095.8 7110.7 7132.0 7071.7 7086.4 7095.7 7099.3 7110.2 6633.1 6852.2 6885.2 6897.7 6903.4 7066.6 7078.3 7079.9 7083.5 7089.9 6904.2 6911.7 6924.2 6933.5 6954.9 02:56:18 INFO - PROCESS | 1680 | 02:56:18 INFO - PROCESS | 1680 | [#5] yui.html Cycles:180 Average:18769.08 Median:621.39 stddev:26539.55 (4271.0%) stddev-sans-first:26579.25 02:56:18 INFO - PROCESS | 1680 | Values: 681.4 743.4 744.5 753.8 786.2 17025.9 17446.3 17446.8 17466.0 17492.5 15734.4 15765.3 15833.1 15867.7 15881.0 698.5 709.0 856.2 870.6 891.3 866.6 877.4 879.2 880.5 883.2 913.5 913.9 916.9 918.2 919.4 711.9 721.9 896.9 914.1 917.6 666.4 674.1 675.2 676.4 676.5 15041.0 15073.8 15105.8 15107.3 15164.6 12198.5 12416.6 12445.6 12459.1 12581.9 8826.7 9978.6 10085.1 10270.6 10898.6 3482.3 3516.1 3516.6 3519.9 3521.6 67550.3 84968.0 86279.0 86449.6 86564.6 9289.9 9420.7 9507.6 9556.7 9940.0 20701.6 21100.4 21126.9 21146.0 21243.9 7388.2 7419.7 7491.1 7590.7 7703.2 3968.0 4043.0 4052.3 4057.5 4063.9 3351.2 3399.0 3399.3 3405.6 3409.5 510.9 618.0 624.8 636.8 639.2 552.2 553.2 578.6 634.5 637.0 7812.5 8580.9 8586.6 8724.2 8768.5 525.4 535.8 557.9 558.6 593.7 3872.9 3896.4 3944.9 3966.4 4003.9 93491.0 94810.5 95272.5 95316.0 95970.5 82082.6 82259.2 83004.0 83981.3 84488.0 56889.0 70569.3 72529.6 72658.0 73146.9 8217.6 8227.6 8540.7 8942.7 9016.9 42662.0 49067.3 49657.0 51189.7 51376.0 69711.0 71730.3 72469.0 73207.9 73592.6 10979.5 10997.3 11040.3 11135.4 11443.3 11922.0 11948.8 12438.6 12447.5 12729.9 11354.3 11598.3 11879.4 12002.9 12317.9 11530.1 11648.8 11832.9 11870.9 12389.7 10453.8 11300.5 11371.9 11667.1 11784.4 9226.2 9484.2 9777.3 9890.7 10443.3 9154.3 9156.3 9412.0 9681.6 10140.4 02:56:18 INFO - PROCESS | 1680 | -------- Summary: end -------- 02:56:18 INFO - PROCESS | 1680 | 02:56:19 INFO - TEST-INFO | 1680: exit 0 02:56:19 INFO - TEST-OK | dromaeo_css | took 1114113ms 02:56:19 INFO - TEST-START | kraken 02:56:19 INFO - operating with platform_type : mac_ 02:56:19 INFO - Initialising browser for kraken test... 02:56:19 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpxkiHKd/profile http://localhost:49274/getInfo.html) 02:56:21 INFO - PROCESS | 1686 | __metrics Screen width/height:1600/1200 02:56:21 INFO - PROCESS | 1686 | colorDepth:24 02:56:21 INFO - PROCESS | 1686 | Browser inner width/height: 1024/689 02:56:21 INFO - PROCESS | 1686 | __metrics 02:56:21 INFO - PROCESS | 1686 | 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" 02:56:21 INFO - PROCESS | 1686 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:56:22 INFO - TEST-INFO | 1686: exit 0 02:56:22 INFO - Browser initialized. 02:56:22 INFO - Running cycle 1/1 for kraken test... 02:56:22 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpxkiHKd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:34 INFO - PROCESS | 1688 | RSS: Main: 245796864 02:56:34 INFO - PROCESS | 1688 | 02:56:36 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 02:56:37 INFO - PROCESS | 1688 | RSS: Main: 292306944 02:56:37 INFO - PROCESS | 1688 | 02:56:39 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 02:56:40 INFO - PROCESS | 1688 | RSS: Main: 302604288 02:56:40 INFO - PROCESS | 1688 | 02:56:43 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 02:56:44 INFO - PROCESS | 1688 | RSS: Main: 286765056 02:56:44 INFO - PROCESS | 1688 | 02:56:46 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 02:56:46 INFO - PROCESS | 1688 | RSS: Main: 289837056 02:56:46 INFO - PROCESS | 1688 | 02:56:48 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:56:49 INFO - PROCESS | 1688 | RSS: Main: 290099200 02:56:49 INFO - PROCESS | 1688 | 02:56:52 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 02:56:52 INFO - PROCESS | 1688 | RSS: Main: 290050048 02:56:52 INFO - PROCESS | 1688 | 02:56:55 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 02:56:56 INFO - PROCESS | 1688 | RSS: Main: 291401728 02:56:56 INFO - PROCESS | 1688 | 02:56:58 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 02:56:59 INFO - PROCESS | 1688 | RSS: Main: 292270080 02:56:59 INFO - PROCESS | 1688 | 02:57:01 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:57:01 INFO - PROCESS | 1688 | RSS: Main: 326479872 02:57:01 INFO - PROCESS | 1688 | 02:57:03 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:57:04 INFO - PROCESS | 1688 | RSS: Main: 326516736 02:57:04 INFO - PROCESS | 1688 | 02:57:06 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:57:06 INFO - PROCESS | 1688 | RSS: Main: 334372864 02:57:06 INFO - PROCESS | 1688 | 02:57:09 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:57:09 INFO - PROCESS | 1688 | RSS: Main: 336457728 02:57:09 INFO - PROCESS | 1688 | 02:57:12 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:57:12 INFO - PROCESS | 1688 | RSS: Main: 335355904 02:57:12 INFO - PROCESS | 1688 | 02:57:14 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 02:57:15 INFO - PROCESS | 1688 | RSS: Main: 395014144 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | __start_tp_report 02:57:15 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 02:57:15 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 02:57:15 INFO - PROCESS | 1688 | |i|pagename|runs| 02:57:15 INFO - PROCESS | 1688 | |0;ai-astar;109;109;109;109;109;110;117;110;110;110 02:57:15 INFO - PROCESS | 1688 | |1;audio-beat-detection;156;146;172;184;119;144;141;112;173;148 02:57:15 INFO - PROCESS | 1688 | |2;audio-dft;183;184;184;185;189;184;185;186;182;181 02:57:15 INFO - PROCESS | 1688 | |3;audio-fft;77;79;90;77;59;57;58;79;81;56 02:57:15 INFO - PROCESS | 1688 | |4;audio-oscillator;95;91;125;79;80;80;107;75;78;111 02:57:15 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;86;90;87;93;85;96;128;119;87;93 02:57:15 INFO - PROCESS | 1688 | |6;imaging-darkroom;95;95;96;95;95;96;94;94;96;95 02:57:15 INFO - PROCESS | 1688 | |7;imaging-desaturate;81;85;84;85;86;84;83;85;85;86 02:57:15 INFO - PROCESS | 1688 | |8;json-parse-financial;55;54;53;54;53;54;55;65;52;53 02:57:15 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;62;73;68;71;67;65;66;66;68;66 02:57:15 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;84;81;84;82;83;83;84;82;85;84 02:57:15 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;128;136;131;125;120;121;125;123;126;123 02:57:15 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;136;128;139;138;137;126;138;132;131;143 02:57:15 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;68;71;87;93;97;94;67;66;67;66 02:57:15 INFO - PROCESS | 1688 | __end_tp_report 02:57:15 INFO - PROCESS | 1688 | __start_cc_report 02:57:15 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,1168 02:57:15 INFO - PROCESS | 1688 | __end_cc_report 02:57:15 INFO - PROCESS | 1688 | __startTimestamp1455188235030__endTimestamp 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | ------- Summary: start ------- 02:57:15 INFO - PROCESS | 1688 | Number of tests: 14 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:2.44 (2.2%) stddev-sans-first:2.55 02:57:15 INFO - PROCESS | 1688 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 117.0 110.0 110.0 110.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:152.00 stddev:22.96 (15.1%) stddev-sans-first:24.23 02:57:15 INFO - PROCESS | 1688 | Values: 156.0 146.0 172.0 184.0 119.0 144.0 141.0 112.0 173.0 148.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:2.21 (1.2%) stddev-sans-first:2.30 02:57:15 INFO - PROCESS | 1688 | Values: 183.0 184.0 184.0 185.0 189.0 184.0 185.0 186.0 182.0 181.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:71.30 Median:78.00 stddev:12.45 (16.0%) stddev-sans-first:13.03 02:57:15 INFO - PROCESS | 1688 | Values: 77.0 79.0 90.0 77.0 59.0 57.0 58.0 79.0 81.0 56.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:79.50 stddev:17.08 (21.5%) stddev-sans-first:18.09 02:57:15 INFO - PROCESS | 1688 | Values: 95.0 91.0 125.0 79.0 80.0 80.0 107.0 75.0 78.0 111.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:88.50 stddev:14.86 (16.8%) stddev-sans-first:15.28 02:57:15 INFO - PROCESS | 1688 | Values: 86.0 90.0 87.0 93.0 85.0 96.0 128.0 119.0 87.0 93.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 02:57:15 INFO - PROCESS | 1688 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 94.0 94.0 96.0 95.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:1.51 (1.8%) stddev-sans-first:0.97 02:57:15 INFO - PROCESS | 1688 | Values: 81.0 85.0 84.0 85.0 86.0 84.0 83.0 85.0 85.0 86.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.71 (6.9%) stddev-sans-first:3.93 02:57:15 INFO - PROCESS | 1688 | Values: 55.0 54.0 53.0 54.0 53.0 54.0 55.0 65.0 52.0 53.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:3.08 (4.6%) stddev-sans-first:2.64 02:57:15 INFO - PROCESS | 1688 | Values: 62.0 73.0 68.0 71.0 67.0 65.0 66.0 66.0 68.0 66.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.27 02:57:15 INFO - PROCESS | 1688 | Values: 84.0 81.0 84.0 82.0 83.0 83.0 84.0 82.0 85.0 84.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:125.50 stddev:4.83 (3.8%) stddev-sans-first:5.05 02:57:15 INFO - PROCESS | 1688 | Values: 128.0 136.0 131.0 125.0 120.0 121.0 125.0 123.0 126.0 123.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.80 Median:137.50 stddev:5.35 (3.9%) stddev-sans-first:5.66 02:57:15 INFO - PROCESS | 1688 | Values: 136.0 128.0 139.0 138.0 137.0 126.0 138.0 132.0 131.0 143.0 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.60 Median:79.00 stddev:13.33 (16.9%) stddev-sans-first:13.68 02:57:15 INFO - PROCESS | 1688 | Values: 68.0 71.0 87.0 93.0 97.0 94.0 67.0 66.0 67.0 66.0 02:57:15 INFO - PROCESS | 1688 | -------- Summary: end -------- 02:57:15 INFO - PROCESS | 1688 | 02:57:15 INFO - TEST-INFO | 1688: exit 0 02:57:15 INFO - TEST-OK | kraken | took 56583ms 02:57:15 INFO - SUITE-END | took 1170s 02:57:16 INFO - Completed test suite (00:19:31) 02:57:16 INFO - Working with test: dromaeo_css 02:57:16 INFO - Generating results file: dromaeo_css 02:57:16 INFO - Working with test: kraken 02:57:16 INFO - Generating results file: kraken 02:57:16 INFO - javascript benchmark 02:57:16 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:57:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 02:57:16 INFO - process_Request line: dromaeo_css 7462.78 graph.html#tests=[[72,64,59]] 02:57:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:57:16 INFO - process_Request line: kraken 1426.70 graph.html#tests=[[232,64,59]] 02:57:16 INFO - RETURN: dromaeo_css: 7462.78 02:57:16 INFO - RETURN: kraken: 1426.70 02:57:16 INFO - javascript benchmark 02:57:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3447.8103704296263, 3453.568303962005, 3463.4458486642143, 3504.439289713645, 3527.611962684104, 5646.971765141178, 5697.743601537931, 5702.515286200673, 5718.0, 5768.826935191945, 4785.0, 5732.340780810208, 5831.241938547993, 5892.616979896304, 5936.584439089265, 5060.493950604947, 5137.332146820918, 5141.460146684601, 5166.328377310944, 5255.86860328491, 5264.8157314494, 5279.155335146377, 5287.524122828944, 5310.893782124355, 5329.520343169114, 5087.491250874901, 5128.333316668809, 5128.846134615949, 5198.896022079575, 5205.791768329263, 5145.048166089286, 5176.197689358156, 5193.480651934814, 5199.792008319662, 5226.738663066832, 5152.149895267276, 5168.767405466763, 5169.147090730025, 5180.093483640386, 5226.03318386096, 5531.3362396512275, 5583.637063590853, 5648.15277708347, 5659.51894089003, 5705.486506214461, 6247.5939063960695, 6262.060690896402, 6270.247570291549, 6282.497400208018, 6289.213848268966, 6226.62640241587, 6245.469135123474, 6293.181886354791, 6305.653189074599, 6307.400796924285, 5688.60179787415, 5797.652140871562, 5819.243498345188, 5821.79623713168, 5838.970805145947, 6233.345498722569, 6244.625322480666, 6247.656378899113, 6251.843703907348, 6269.874602508015, 5879.7060146993335, 6127.080937859357, 6185.257769067651, 6185.659788711574, 6210.161628180228, 6130.061839217998, 6226.0, 6256.217972753406, 6294.055891616203, 6338.0, 6254.499640028786, 6271.560990730605, 6283.465905398001, 6284.214473190851, 6285.402886725754, 6244.46922011625, 6267.435930766253, 6298.307186209513, 6307.2431308242385, 6313.3686631336495, 4802.255650374198, 4847.394075740533, 4877.12211801879, 4886.853394398174, 4893.192623217129, 4214.957850421518, 4482.798274077674, 4516.232240519054, 4517.819287228474, 4523.547645235451, 5668.0, 5677.659340439587, 5694.4590263924865, 5697.088465845445, 5723.771049157987, 5935.169076329317, 6261.937380626136, 6273.0, 6292.119103325538, 6293.087502312139, 5565.749541270652, 5628.690422026746, 5663.688497132614, 5709.800156994485, 5721.628094173865, 5338.252644629755, 5386.353637563518, 5397.379301380392, 5403.459654034565, 5436.21174929633, 5681.318241811009, 6169.691515424211, 6256.593321434092, 6277.811665650038, 6287.811365659038, 6161.568690191643, 6224.221972253468, 6259.436650701458, 6264.906026409516, 6287.591306565058, 6262.123302737711, 6307.90538141919, 6326.272478665012, 6332.461740751904, 6380.9361906380345, 5263.6578622389425, 6213.502919766498, 6218.0, 6236.469900058546, 6244.65654389013, 6139.154842350657, 6188.226471691039, 6201.10084037803, 6223.564350495603, 6248.0, 6128.136482154648, 6133.273457575459, 6163.907541386972, 6174.536909731698, 6177.567570270217, 5990.6705131218205, 6092.99465588173, 6119.497199206753, 6176.876462470816, 6180.381961803783, 5820.243368362086, 5830.358660547421, 5951.345352011189, 5955.464008239279, 5973.133895585029, 6019.939800601938, 6161.815145545641, 6169.753209871735, 6186.381361863778, 6190.380961903774, 6033.396660333931, 6039.969800150971, 6043.879122417439, 6045.818625441244, 6102.023676211962], "unit": "score", "name": "dojo.html", "value": 5702.5779352048185}, {"lowerIsBetter": false, "replicates": [484.7503535679124, 566.2568967186139, 574.9396313387094, 589.1545632018053, 636.9777057802976, 28593.571096433545, 37561.81219093904, 37786.622133778656, 37817.99999999996, 37923.43114853273, 28891.566626500568, 39842.00394990119, 40305.39541906866, 40469.19061618766, 42368.728938131826, 9392.201662858648, 9621.663241786538, 9629.807403851919, 9630.18143457807, 9637.0, 9472.526373681323, 9612.231021518262, 9615.230781537495, 9617.134457898788, 9635.855462168072, 8275.255227029566, 9602.711918642452, 9732.318737688365, 9745.902540974606, 9780.608775648965, 9620.951895240514, 9721.611135554569, 9721.756956076119, 9733.2213422926, 9748.95125524375, 9485.0, 9629.181519570844, 9630.27772917034, 9630.518474076269, 9659.178969787576, 38912.61087389118, 39122.804385977885, 39280.60719392798, 39308.80345598282, 39320.606793931984, 3419.264858055505, 3662.82559414264, 3756.380197267475, 3802.4866643003115, 4014.0767623446477, 23964.0, 27860.0, 28209.435811283864, 28304.433911321863, 28611.713882861113, 2770.4043630619312, 2782.38787466759, 2842.2468045967835, 2870.095919785261, 2954.719301666338, 468087.0, 468793.0, 469140.0, 469517.0, 471497.99999999657, 51279.230811537855, 52667.0, 54904.0, 59940.0, 59968.70015649981, 47653.046939061715, 57338.71330643404, 57800.0, 58056.41943580595, 58244.0, 14223.431062757374, 14502.782458263135, 15359.924805263525, 15554.533363999099, 15558.0, 10656.147508199325, 12002.0, 12235.69410764738, 12320.199187052993, 12345.321007344503, 18104.366347177787, 18440.723389149174, 18451.52387808972, 18468.722969155475, 18485.907570462063, 7174.735495349603, 8383.790405239917, 8656.913430865736, 8674.956625216833, 8723.258523025614, 944.579662050381, 983.1986930651497, 1043.6034306963306, 1048.6434612231878, 1130.1806190511813, 23151.0, 28250.43499130006, 28262.576061359097, 28621.427571448454, 28904.855475722907, 1051.2483574244452, 1057.9894201057891, 1069.909057730086, 1081.2215205052507, 1151.8790526994712, 12997.480100795863, 13206.405711742995, 13236.536721214712, 13380.598582042554, 13609.11540749848, 526357.3139208745, 531161.0, 533491.0, 533828.0, 535312.0, 51847.74076129595, 52293.95412091737, 52484.687882803235, 52524.73737631287, 52534.94930101377, 1404.6137312239216, 1416.8441471438134, 1445.1906932118047, 1449.463698431566, 1452.1504919621927, 25902.22293331203, 26289.622123496385, 26563.468730624892, 26596.335091622863, 26617.467650647264, 45449.0, 45842.541574583825, 45953.0, 45968.770156149, 45984.0, 495552.0, 497473.0, 497525.0, 497900.0, 501282.0, 26857.597136043365, 29385.412291754474, 30799.538006929466, 31548.738050477725, 31635.89274375386, 38143.855684329515, 38294.42558361682, 38513.614863851006, 38681.6131838678, 38995.0, 33508.49737253992, 33661.83169084139, 34222.828885856405, 34531.654683453846, 34645.307093857475, 33908.830455847565, 33969.66030339665, 34108.658913410545, 35203.47194792029, 35821.641783582876, 28100.0, 29904.25239369033, 34548.30903381868, 35525.28949421049, 35744.0, 27887.442251154458, 28297.292567685974, 29914.70085299119, 29975.850120749255, 30150.09549713512, 23016.194433194756, 23142.652860206774, 23559.41101472477, 23628.29115126549, 23681.763182368646], "unit": "score", "name": "ext.html", "value": 18885.74758203937}, {"lowerIsBetter": false, "replicates": [361.63836163836163, 366.1834109934847, 367.0310380595228, 367.7058353317347, 371.38535723377817, 14876.256187190651, 15269.618259543517, 18471.984040877764, 19302.613947721038, 19953.201871925106, 18246.0, 18974.525636859053, 19104.522386940334, 20076.196952121933, 20140.496487587818, 5206.947930520693, 5432.83701488954, 5443.0, 5444.6188766786345, 5445.482679145475, 3872.554656214529, 4088.7546747195265, 4667.2532394816835, 5975.581709280352, 5979.970100149493, 5732.541396688255, 5893.145493903381, 5916.7337469813965, 5926.614770039955, 5929.0, 4954.950450495485, 5860.677662728548, 5923.496502797268, 5923.555733320019, 5929.970350148222, 5337.599680024014, 5517.944820551783, 5585.664860108406, 5597.552195824365, 5600.439956004408, 12525.373731313397, 12863.549775757803, 13055.151415157985, 13065.738685226337, 13115.803262951064, 2043.989780051105, 2140.785921407862, 2304.5308491294595, 2473.332200305925, 2652.1910817200746, 9378.67174648884, 9979.900200998043, 10363.274570780048, 10677.679669609925, 14967.550973470705, 1726.8100508944005, 1777.413453560322, 1814.528222662104, 1837.0906401331292, 1863.506170864722, 78975.21024789794, 85910.94603105278, 98085.5095724524, 98766.0, 107013.46493267562, 11107.278026928385, 11294.830577541343, 11414.600488982845, 11425.37160456183, 11496.90779375958, 13489.730205395837, 13632.182069075887, 13640.795388069188, 13647.522336718168, 13702.246376449391, 8453.196946290092, 8460.238578527838, 8467.449615775078, 8534.82930341402, 8558.229759321566, 8511.233988941025, 8515.957420212859, 8548.230659240699, 8579.056303806576, 8628.309735221168, 4075.449814275035, 4239.872803815891, 4424.513303536608, 4501.68488205829, 4566.566176213254, 1733.7286460539367, 1782.10003948008, 1913.8755980861233, 1919.1172060851886, 1921.6060707554918, 881.1805021330224, 932.2733739938446, 943.4150826487621, 947.5830634520789, 957.5690939077443, 15646.452374166849, 20071.197152113753, 20318.695219571717, 20414.0, 20471.283505077252, 799.8160423102719, 843.2242337049929, 890.3011136258136, 927.5640448988964, 1054.435876805905, 10618.840717389245, 10915.890841091647, 11025.61410350634, 11169.0, 11179.217454778087, 684223.0, 727895.0, 747908.0, 750468.0, 752113.0, 107703.92296077096, 110443.44778276217, 112590.0, 113041.0, 113690.43154784339, 1127.115214556569, 1127.6278827986744, 1142.405948906564, 1143.4797167288864, 1146.5356530605118, 18007.369742058963, 18169.36407225741, 18182.727259090858, 18247.635047299245, 18365.632687346446, 47767.0, 50732.492675072775, 50908.0, 51432.22851657153, 51735.74132129315, 42368.576314237696, 46288.0, 72101.91847122193, 72773.0, 76636.46727065316, 7308.744193953186, 7912.010998625172, 9504.524773761423, 9892.653757118755, 10820.350778953289, 8649.0, 11949.163558550817, 12319.858436098737, 12618.747625047632, 13000.934995324962, 10732.624358147428, 10873.238873278795, 11146.108311334912, 11205.775884482428, 11285.887141128484, 8984.505852178192, 10940.726481838017, 10984.505697243483, 11132.721681958015, 11226.382548959886, 7699.961500192463, 7876.0, 7911.762647120596, 10948.233623646587, 11540.307581545134, 9125.771855703395, 10603.522841472306, 11098.223124381217, 11162.888371116509, 11345.432728363383, 10958.890411095786, 11164.385958772345, 11193.608223712132, 11265.493052812479, 11457.968782809587], "unit": "score", "name": "jquery.html", "value": 9152.351641934041}, {"lowerIsBetter": false, "replicates": [1379.2414172205285, 1514.1369419430926, 1540.1913995152543, 1759.9032053237074, 1925.8266755991958, 7919.326857217136, 8607.225349718525, 8786.824263514725, 8796.208341249294, 8803.735887923356, 8469.788255293606, 8718.171773681506, 8722.563871806417, 8723.694670686527, 8730.214280714734, 2166.2418153646254, 2224.788645078715, 2225.532638145983, 2485.266846280347, 2513.937151571207, 2241.5068684889297, 2244.2145249162745, 2252.2117258959397, 2484.9378765530823, 2552.2981180175416, 2461.4584791345874, 2489.8879550420183, 2494.2641920633364, 2494.289127598635, 2501.0496011515597, 2446.425090103824, 2495.925122246317, 2505.023041014006, 2507.962380564293, 2510.686164229471, 2323.546908352872, 2354.5997180479358, 2482.8510289382516, 2484.6645702830247, 2493.675822143128, 7378.96310518444, 8831.337649676236, 8874.955625221897, 8903.643854245822, 8937.0, 5409.24270602116, 5527.972360138174, 5537.944620553783, 5568.1091025435735, 5575.526080283181, 3609.675129238355, 3654.28741395428, 3674.7427680062406, 3761.9059523511855, 3765.924681506382, 1044.4099084017505, 1044.4725413666126, 1060.199549340251, 1095.3537412926412, 1113.3876367997568, 11913.583024594098, 11943.581974630846, 11958.0, 11963.282203067756, 11974.940125299318, 4924.310596516419, 4969.975150124226, 5009.974950125299, 5089.541941225308, 5155.278261043457, 10179.083882450615, 10186.439745813903, 10203.489825508696, 10215.182785377152, 10225.130863876653, 5501.862453438696, 5525.171224316385, 5534.08687566547, 5538.224648549206, 5547.472990065938, 5009.824656137091, 5014.473480284518, 5027.572656324253, 5038.1435156022835, 5042.042012017705, 3640.0, 3948.7235893487755, 3980.283548961215, 3992.0818211810865, 4053.635172834459, 1246.8690787467367, 1314.1392387985884, 1320.4124164746788, 1326.0518729108733, 1333.3999700134978, 1319.0436933223336, 1331.9267440290682, 1335.8597347278396, 1353.553327401955, 1357.8777909988148, 8111.432199745961, 8137.877931831027, 8152.2662960333855, 8429.704960326482, 8471.576421178916, 1089.629525961177, 1130.5195292000867, 1182.6806762174165, 1187.9762404751857, 1207.4988879614862, 6324.841878953063, 6382.266039405527, 6383.904241436382, 6391.105245265667, 6398.776042838572, 10264.0, 10552.15582753378, 10574.577016919391, 10652.254342195973, 10700.357978521159, 10376.481175941173, 10428.843567346496, 10429.478526073666, 10541.894581054245, 10550.261481696361, 8141.389395795339, 8311.25198732105, 8328.167183281745, 8330.666773329, 8390.664373424994, 8056.355491560544, 8060.0, 8164.510129392255, 8186.304164146114, 8232.83534329322, 9524.476153811329, 9610.423374597547, 9683.0, 9746.75633109178, 9855.310128291238, 9708.805823883624, 10031.448270345201, 10180.745481363025, 10298.691039268833, 10307.94846025765, 5907.261592300963, 7531.171571127062, 7553.546787192786, 7670.578118203553, 7776.105747839071, 7318.96340518294, 7501.737439189602, 8115.310198633182, 8189.426740128134, 8196.672133114847, 7543.510641488186, 7544.170141284564, 7684.923150768421, 7821.92178078212, 7844.803879903048, 7571.886421703789, 7579.317861392281, 7602.46782725204, 7624.847503049797, 7748.263914928073, 7506.699732010658, 7691.30778229962, 7727.343175830118, 7790.727324543614, 7799.298063174341, 6939.861202775815, 6997.090378250795, 6997.895031574429, 7000.649967501503, 7002.964985175042, 7022.508424410242, 7082.716691332495, 7104.005439238407, 7133.714651413885, 7153.60655163971], "unit": "score", "name": "mootools.html", "value": 4979.698199449066}, {"lowerIsBetter": false, "replicates": [262.8212815285606, 324.69316495911374, 328.18609847578006, 331.62526345229884, 334.7305419137596, 6313.494920406368, 6417.0, 6555.737770489175, 6680.6993685284215, 6682.064510968468, 6355.8093257202245, 6514.0, 6571.145751052357, 6594.901076483857, 6597.614500954805, 4570.680052396334, 4668.8599342019625, 4802.255650374198, 4818.229083346665, 4819.807207711688, 4651.906961860761, 4736.223916031488, 4760.214564596855, 4776.68951518152, 4795.448523419816, 4732.1482133216, 4732.526747325274, 4733.715977041371, 4741.502142275063, 4746.691465054778, 4722.97638511807, 4725.787339569728, 4733.95266047342, 4737.313089601988, 4761.0, 3920.647141757227, 4045.0, 4046.635802777764, 4046.979765101156, 4049.311617025113, 6182.227221597301, 6185.041318595625, 6195.690215489252, 6196.87606247877, 6209.223847019122, 5510.366307874566, 5524.309461317335, 5539.0, 5556.305461817273, 5566.359868615121, 6582.111414959015, 6735.461163106939, 6827.317268273133, 6875.346842049998, 6925.065116209297, 4438.778061096965, 4475.619572336355, 4477.17172323118, 4480.8879778005485, 4481.462224533077, 6792.626405547742, 7234.60209688467, 7361.9631901840685, 7363.374113200384, 7365.742199023009, 3804.543454785388, 4167.8958026049595, 4444.711093778894, 4570.108828778356, 4617.145828021759, 4684.414448193976, 4692.601128904013, 4697.342372067913, 4698.154332220233, 4719.10337035962, 5545.805896793593, 5554.77780888768, 5563.916541251884, 5590.161475778585, 5600.299962504687, 6060.939390606126, 6792.93207067923, 7000.544964577286, 7004.544704594185, 7038.260982596754, 1585.5718955881848, 1624.6507000994843, 1626.487656388234, 1627.0481768165519, 1630.4293497275858, 1026.8870424253325, 1031.2368847053276, 1041.7135287795916, 1047.2983101322131, 1049.3441599000626, 6497.122888410098, 6503.544751867324, 6521.576097553644, 6526.216853977553, 6530.444912182423, 6673.766418175341, 7257.838745800752, 7269.63651817407, 7271.345578897819, 7280.854382912312, 5809.767609295665, 6276.780312689034, 6470.45001174896, 6479.287278399373, 6482.805515834532, 3147.213196700825, 3839.7504162229366, 3883.5533913600298, 3884.3396622574232, 3902.843886244518, 6122.969385153046, 7437.0, 7692.846143077107, 7713.305802477804, 7715.537067775951, 7282.854342913112, 7603.695852165852, 7609.961950190213, 7611.65747541362, 7638.618069096523, 7269.0, 7394.667239974106, 7413.88879166813, 7712.6529306181355, 7726.227377262228, 6296.874062518632, 6726.822806008831, 7060.1880783708475, 7067.233191702075, 7073.0, 7179.246179151114, 7239.0, 7272.709091636275, 7275.672594733144, 7277.963610181915, 6212.875742485216, 7417.443691723034, 7654.464187506821, 7747.147813740371, 7753.92246077532, 4627.652926030494, 4652.55800698933, 4657.510961349009, 4667.813287468599, 4685.4143232095985, 7289.161746399232, 7319.670614822239, 7322.890156647761, 7335.669894854637, 7338.266173382833, 6809.557378770364, 7083.256258092826, 7095.82260443493, 7110.715571377087, 7132.00455808572, 7071.681774320271, 7086.39765619928, 7095.680694368662, 7099.254578269208, 7110.217876033529, 6633.137692100189, 6852.211995620568, 6885.242623311532, 6897.7240910365035, 6903.413209877217, 7066.611336376549, 7078.292170782881, 7079.858402832017, 7083.477052433752, 7089.858202836018, 6904.206016308189, 6911.688973996283, 6924.238333783381, 6933.514653974174, 6954.930450695429], "unit": "score", "name": "prototype.html", "value": 5077.265872852729}, {"lowerIsBetter": false, "replicates": [681.4207923265224, 743.3792783026173, 744.504904238681, 753.796474951763, 786.1705900275207, 17025.914870425648, 17446.3021479141, 17446.82553174468, 17466.0, 17492.475225743216, 15734.449294274702, 15765.290561924712, 15833.12917789521, 15867.682646347066, 15881.0, 698.4970821008891, 709.0286307758353, 856.1823458597056, 870.6473878079372, 891.2958762577589, 866.6100254885296, 877.3682948277262, 879.2438502887512, 880.5465185429509, 883.2007033634571, 913.5295322908707, 913.8766266553996, 916.9174774270315, 918.2332752151927, 919.4299534288717, 711.9359257666808, 721.9494635375552, 896.9372143949926, 914.1133100892124, 917.6191880369638, 666.3636227402818, 674.140470899607, 675.2234929830685, 676.4351766275166, 676.509530590323, 15041.0, 15073.773893391608, 15105.773413398807, 15107.32017059235, 15164.620884477867, 12198.451069701796, 12416.627501174979, 12445.62663120108, 12459.06557008228, 12581.938175386043, 8826.691065812665, 9978.600855965753, 10085.142762865165, 10270.6405275815, 10898.618548350769, 3482.251315967054, 3516.085817687394, 3516.5604299462566, 3519.8592056317716, 3521.5774107107054, 67550.32449675539, 84968.0, 86279.0, 86449.56775216147, 86564.56717716434, 9289.860652090225, 9420.717378478657, 9507.619695212252, 9556.713298601053, 9940.0, 20701.58596828085, 21100.366988990354, 21126.894365528075, 21146.0, 21243.937803109784, 7388.187299397169, 7419.6661150248365, 7491.138519070268, 7590.734324298623, 7703.229677032364, 3967.9603203968168, 4042.9892526868284, 4052.2503336882182, 4057.4928133983253, 4063.9390409143884, 3351.2292172799903, 3399.0, 3399.2521645238007, 3405.5743032120986, 3409.539712138879, 510.9361329833771, 617.9660118693425, 624.8125562331282, 636.7675798333574, 639.2361128451456, 552.160314840424, 553.2448208195784, 578.6294832600121, 634.5462993959342, 637.0412529143609, 7812.453128280966, 8580.947100808708, 8586.570671466401, 8724.171203735636, 8768.517731524827, 525.408914970658, 535.8392482255308, 557.9442055794389, 558.5531574740191, 593.6883136353449, 3872.9031774205305, 3896.3571010782903, 3944.9211015780097, 3966.4248683941246, 4003.8798836034966, 93491.0, 94810.52594736982, 95272.52363738137, 95316.0, 95970.52014739881, 82082.58958705168, 82259.17740822515, 83004.0, 83981.32037359219, 84488.0, 56889.0, 70569.2943070573, 72529.6373518129, 72658.0, 73146.90279645809, 8217.630206640835, 8227.588620568828, 8540.658373664985, 8942.73171804847, 9016.90983090187, 42662.0, 49067.26399103945, 49657.006859861875, 51189.74405127951, 51376.0, 69711.0, 71730.28269717236, 72469.0, 73207.90188147075, 73592.63203683947, 10979.505922233358, 10997.285176463503, 11040.282381645167, 11135.443227838414, 11443.313401195956, 11922.0, 11948.76102477963, 12438.626841194779, 12447.502099916264, 12729.872701272869, 11354.318740875575, 11598.304101753922, 11879.406029698654, 12002.939985300018, 12317.938410307892, 11530.077593792645, 11648.825267620823, 11832.940835295769, 11870.881291186977, 12389.690257743629, 10453.790924181321, 11300.49147788335, 11371.886281137082, 11667.124965627781, 11784.41077946082, 9226.215771659485, 9484.193843523102, 9777.311239409219, 9890.653827116017, 10443.268971171945, 9154.26765858743, 9156.304798342166, 9412.0, 9681.612735490502, 10140.391576505433], "unit": "score", "name": "yui.html", "value": 6931.043197903247}], "name": "dromaeo_css", "value": 7462.776122595651}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 117.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [156.0, 146.0, 172.0, 184.0, 119.0, 144.0, 141.0, 112.0, 173.0, 148.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 184.0, 185.0, 189.0, 184.0, 185.0, 186.0, 182.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 90.0, 77.0, 59.0, 57.0, 58.0, 79.0, 81.0, 56.0], "unit": "score", "name": "audio-fft", "value": 71.3}, {"lowerIsBetter": true, "replicates": [95.0, 91.0, 125.0, 79.0, 80.0, 80.0, 107.0, 75.0, 78.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [86.0, 90.0, 87.0, 93.0, 85.0, 96.0, 128.0, 119.0, 87.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 94.0, 94.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.1}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 84.0, 85.0, 86.0, 84.0, 83.0, 85.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 84.4}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 53.0, 54.0, 53.0, 54.0, 55.0, 65.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [62.0, 73.0, 68.0, 71.0, 67.0, 65.0, 66.0, 66.0, 68.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 84.0, 82.0, 83.0, 83.0, 84.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [128.0, 136.0, 131.0, 125.0, 120.0, 121.0, 125.0, 123.0, 126.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [136.0, 128.0, 139.0, 138.0, 137.0, 126.0, 138.0, 132.0, 131.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.8}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 87.0, 93.0, 97.0, 94.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.6}], "name": "kraken", "value": 1426.6999999999998}]} 02:57:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1426.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7462.78"}}} 02:57:16 INFO - Return code: 0 02:57:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:57:16 INFO - # TBPL SUCCESS # 02:57:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:57:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:57:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:57:16 INFO - 2016-02-11 02:57:16.766 screenresolution[1692:9639] starting screenresolution argv=screenresolution get 02:57:16 INFO - 2016-02-11 02:57:16.769 screenresolution[1692:9639] Display 0: 1600x1200x32@60 02:57:16 INFO - 2016-02-11 02:57:16.775 screenresolution[1693:9642] starting screenresolution argv=screenresolution list 02:57:16 INFO - Available Modes on Display 0 02:57:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:57:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:57:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:57:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:57:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:57:17 INFO - Intel Iris: 02:57:17 INFO - Chipset Model: Intel Iris 02:57:17 INFO - Type: GPU 02:57:17 INFO - Bus: Built-In 02:57:17 INFO - VRAM (Dynamic, Max): 1536 MB 02:57:17 INFO - Vendor: Intel (0x8086) 02:57:17 INFO - Device ID: 0x0a2e 02:57:17 INFO - Revision ID: 0x0009 02:57:17 INFO - Displays: 02:57:17 INFO - Display: 02:57:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:57:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:57:17 INFO - Display Serial Number: 1600x1200 60 02:57:17 INFO - Main Display: Yes 02:57:17 INFO - Mirror: Off 02:57:17 INFO - Online: Yes 02:57:17 INFO - Rotation: Supported 02:57:17 INFO - Return code: 0 02:57:17 INFO - Running post-action listener: _resource_record_post_action 02:57:17 INFO - Running post-run listener: _resource_record_post_run 02:57:18 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39298560; Write bytes: 707868672; Read time: 426; Write time: 2069 02:57:18 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 396237312; Write bytes: 387779584; Read time: 30248; Write time: 875 02:57:18 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 33037824; Write bytes: 299990016; Read time: 342; Write time: 1147 02:57:18 INFO - Running post-run listener: _upload_blobber_files 02:57:18 INFO - Blob upload gear active. 02:57:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:57:18 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 02:57:18 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'] 02:57:18 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 02:57:18 INFO - (blobuploader) - INFO - Open directory for files ... 02:57:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:57:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:57:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:57:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:57:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:57:19 INFO - (blobuploader) - INFO - Done attempting. 02:57:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:57:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:57:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:57:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:57:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:57:21 INFO - (blobuploader) - INFO - Done attempting. 02:57:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:57:21 INFO - Return code: 0 02:57:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:57:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:57:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d2f9927548b1a5dc125bc9c1026ff88b294b1035926f96d19c4ee4ba0c34fb0e5e79d49298189e3553ce855552864737f10e6b0b4bc919b0e5f8349a075b128", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3691b2cabc5f0bfd2821c82fd7baa2ae629ef13201022c242ccf5ef3c7c2a4a54d363e5530b2afd4d5707ae18456d7fc91ee0b96937a3b6553906781dbf424b"} 02:57:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:57:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:57:21 INFO - Contents: 02:57:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d2f9927548b1a5dc125bc9c1026ff88b294b1035926f96d19c4ee4ba0c34fb0e5e79d49298189e3553ce855552864737f10e6b0b4bc919b0e5f8349a075b128", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3691b2cabc5f0bfd2821c82fd7baa2ae629ef13201022c242ccf5ef3c7c2a4a54d363e5530b2afd4d5707ae18456d7fc91ee0b96937a3b6553906781dbf424b"} 02:57:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:57:21 INFO - Copying logs to upload dir... 02:57:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:57:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.414621 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-02-11 02:57:21.342024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 02:57:21.345811) ========= 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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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/7d2f9927548b1a5dc125bc9c1026ff88b294b1035926f96d19c4ee4ba0c34fb0e5e79d49298189e3553ce855552864737f10e6b0b4bc919b0e5f8349a075b128", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3691b2cabc5f0bfd2821c82fd7baa2ae629ef13201022c242ccf5ef3c7c2a4a54d363e5530b2afd4d5707ae18456d7fc91ee0b96937a3b6553906781dbf424b"} build_url:https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/HhueajGkRIS0pBSy7NMglA/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/7d2f9927548b1a5dc125bc9c1026ff88b294b1035926f96d19c4ee4ba0c34fb0e5e79d49298189e3553ce855552864737f10e6b0b4bc919b0e5f8349a075b128", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3691b2cabc5f0bfd2821c82fd7baa2ae629ef13201022c242ccf5ef3c7c2a4a54d363e5530b2afd4d5707ae18456d7fc91ee0b96937a3b6553906781dbf424b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 02:57:21.376749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 02:57:21.377241) ========= 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.RWDkcuMsXt/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.lFuPuMFkmK/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.005107 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 02:57:21.427259) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 02:57:21.427578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 02:57:21.427968) ========= ========= Total master_lag: 5.56 =========