builder: date_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0049 starttime: 1456801579.39 results: success (0) buildid: 20160229095626 builduid: 940f575a62a340dc82bf617395ac26fe revision: 987fdde4def3c14ddefc1c531bf42825615f8b2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.386856) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.387353) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.387689) ========= 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.6TuFITZAb3/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.jXiyLfWIcn/Listeners TMPDIR=/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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.005955 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.411631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.412000) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.427990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.428580) ========= 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.6TuFITZAb3/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.jXiyLfWIcn/Listeners TMPDIR=/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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.005502 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.477769) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.478130) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.478525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.478854) ========= 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.6TuFITZAb3/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.jXiyLfWIcn/Listeners TMPDIR=/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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-29 19:06:19-- 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% 42.6M=0s 2016-02-29 19:06:19 (42.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157276 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.652168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.652530) ========= 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.6TuFITZAb3/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.jXiyLfWIcn/Listeners TMPDIR=/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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.020677 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:19.702134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-29 19:06:19.702535) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 987fdde4def3c14ddefc1c531bf42825615f8b2b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev 987fdde4def3c14ddefc1c531bf42825615f8b2b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6TuFITZAb3/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.jXiyLfWIcn/Listeners TMPDIR=/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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-29 19:06:19,779 truncating revision to first 12 chars 2016-02-29 19:06:19,779 Setting DEBUG logging. 2016-02-29 19:06:19,779 attempt 1/10 2016-02-29 19:06:19,779 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/987fdde4def3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 19:06:21,570 unpacking tar archive at: date-987fdde4def3/testing/mozharness/ program finished with exit code 0 elapsedTime=2.043367 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-29 19:06:21.763100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:21.763506) ========= echo 987fdde4def3c14ddefc1c531bf42825615f8b2b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'987fdde4def3c14ddefc1c531bf42825615f8b2b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6TuFITZAb3/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.jXiyLfWIcn/Listeners TMPDIR=/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 987fdde4def3c14ddefc1c531bf42825615f8b2b program finished with exit code 0 elapsedTime=0.005224 script_repo_revision: '987fdde4def3c14ddefc1c531bf42825615f8b2b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:21.813966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:21.814322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 19:06:21.827306) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-02-29 19:06:21.827626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date 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', 'Date', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Date'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6TuFITZAb3/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.jXiyLfWIcn/Listeners TMPDIR=/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:06:22 INFO - MultiFileLogger online at 20160229 19:06:22 in /builds/slave/test 19:06:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date 19:06:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:06:22 INFO - {'append_to_log': False, 19:06:22 INFO - 'base_work_dir': '/builds/slave/test', 19:06:22 INFO - 'blob_upload_branch': 'Date', 19:06:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:06:22 INFO - 'branch': 'Date', 19:06:22 INFO - 'buildbot_json_path': 'buildprops.json', 19:06:22 INFO - 'config_files': ('talos/mac_config.py',), 19:06:22 INFO - 'default_actions': ('clobber', 19:06:22 INFO - 'read-buildbot-config', 19:06:22 INFO - 'download-and-extract', 19:06:22 INFO - 'populate-webroot', 19:06:22 INFO - 'create-virtualenv', 19:06:22 INFO - 'install', 19:06:22 INFO - 'run-tests'), 19:06:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:06:22 INFO - 'download_minidump_stackwalk': True, 19:06:22 INFO - 'download_symbols': 'ondemand', 19:06:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:06:22 INFO - 'tooltool.py': '/tools/tooltool.py', 19:06:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:06:22 INFO - '/tools/misc-python/virtualenv.py')}, 19:06:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:06:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:06:22 INFO - 'installer_path': 'installer.exe', 19:06:22 INFO - 'log_level': 'info', 19:06:22 INFO - 'log_name': 'talos', 19:06:22 INFO - 'log_to_console': True, 19:06:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:06:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:06:22 INFO - 'opt_config_files': (), 19:06:22 INFO - 'pip_index': False, 19:06:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:06:22 INFO - 'cmd': ('bash', 19:06:22 INFO - '-c', 19:06:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:06:22 INFO - 'enabled': True, 19:06:22 INFO - 'halt_on_failure': False, 19:06:22 INFO - 'name': 'check_screen_resolution'},), 19:06:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:06:22 INFO - 'cmd': ('bash', 19:06:22 INFO - '-c', 19:06:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:06:22 INFO - 'enabled': True, 19:06:22 INFO - 'halt_on_failure': False, 19:06:22 INFO - 'name': 'check_screen_resolution'},), 19:06:22 INFO - 'run_cmd_checks_enabled': True, 19:06:22 INFO - 'sps_profile': False, 19:06:22 INFO - 'sps_profile_interval': 0, 19:06:22 INFO - 'suite': 'dromaeojs', 19:06:22 INFO - 'system_bits': '32', 19:06:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:06:22 INFO - 'title': 't-yosemite-r7-0049', 19:06:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:06:22 INFO - 'use_talos_json': True, 19:06:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:06:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:06:22 INFO - 'work_dir': 'build'} 19:06:22 INFO - ##### 19:06:22 INFO - ##### Running clobber step. 19:06:22 INFO - ##### 19:06:22 INFO - Running pre-action listener: _resource_record_pre_action 19:06:22 INFO - Running main action method: clobber 19:06:22 INFO - rmtree: /builds/slave/test/build 19:06:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:06:22 INFO - Running post-action listener: _resource_record_post_action 19:06:22 INFO - ##### 19:06:22 INFO - ##### Running read-buildbot-config step. 19:06:22 INFO - ##### 19:06:22 INFO - Running pre-action listener: _resource_record_pre_action 19:06:22 INFO - Running main action method: read_buildbot_config 19:06:22 INFO - Using buildbot properties: 19:06:22 INFO - { 19:06:22 INFO - "project": "", 19:06:22 INFO - "product": "firefox", 19:06:22 INFO - "script_repo_revision": "production", 19:06:22 INFO - "builddir": "date_yosemite_r7_test-dromaeojs", 19:06:22 INFO - "repository": "", 19:06:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 date talos dromaeojs", 19:06:22 INFO - "buildid": "20160229095626", 19:06:22 INFO - "pgo_build": "False", 19:06:22 INFO - "basedir": "/builds/slave/test", 19:06:22 INFO - "buildnumber": 0, 19:06:22 INFO - "slavename": "t-yosemite-r7-0049", 19:06:22 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:06:22 INFO - "platform": "yosemite_r7", 19:06:22 INFO - "scheduler": "tests-date-macosx64-talos", 19:06:22 INFO - "branch": "date", 19:06:22 INFO - "repo_path": "projects/date", 19:06:22 INFO - "revision": "987fdde4def3c14ddefc1c531bf42825615f8b2b", 19:06:22 INFO - "stage_platform": "macosx64", 19:06:22 INFO - "builduid": "940f575a62a340dc82bf617395ac26fe", 19:06:22 INFO - "slavebuilddir": "test" 19:06:22 INFO - } 19:06:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 19:06:22 INFO - Running post-action listener: _resource_record_post_action 19:06:22 INFO - ##### 19:06:22 INFO - ##### Running download-and-extract step. 19:06:22 INFO - ##### 19:06:22 INFO - Running pre-action listener: _resource_record_pre_action 19:06:22 INFO - Running main action method: download_and_extract 19:06:22 INFO - mkdir: /builds/slave/test/build/tests 19:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:22 INFO - https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:06:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/test_packages.json 19:06:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/test_packages.json 19:06:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:06:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:06:25 INFO - Downloaded 1241 bytes. 19:06:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:06:25 INFO - Using the following test package requirements: 19:06:25 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 19:06:25 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:06:25 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 19:06:25 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:06:25 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 19:06:25 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:06:25 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:06:25 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 19:06:25 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 19:06:25 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:06:25 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 19:06:25 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:06:25 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 19:06:25 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:06:25 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 19:06:25 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 19:06:25 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:06:25 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 19:06:25 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 19:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:25 INFO - https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 19:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 19:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 19:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 19:06:29 INFO - Downloaded 17650349 bytes. 19:06:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:06:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:06:32 INFO - Return code: 0 19:06:32 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 19:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:32 INFO - https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 19:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 19:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 19:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 19:06:33 INFO - Downloaded 17650349 bytes. 19:06:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:06:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:06:37 INFO - Return code: 0 19:06:37 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')]} 19:06:37 INFO - https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 19:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 19:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 19:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 19:06:39 INFO - Downloaded 10707015 bytes. 19:06:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:06:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:06:39 INFO - Return code: 0 19:06: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')]} 19:06:39 INFO - https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 19:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 19:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 19:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 19:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 19:06:41 INFO - Downloaded 87208661 bytes. 19:06:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 19:06:41 INFO - mkdir: /builds/slave/test/properties 19:06:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:06:41 INFO - Writing to file /builds/slave/test/properties/build_url 19:06:41 INFO - Contents: 19:06:41 INFO - build_url:https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 19:06:42 INFO - Running post-action listener: _resource_record_post_action 19:06:42 INFO - Running post-action listener: set_extra_try_arguments 19:06:42 INFO - ##### 19:06:42 INFO - ##### Running populate-webroot step. 19:06:42 INFO - ##### 19:06:42 INFO - Running pre-action listener: _resource_record_pre_action 19:06:42 INFO - Running main action method: populate_webroot 19:06:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:06:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:06:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:06:42 INFO - '--tppagecycles', 19:06:42 INFO - '7'], 19:06:42 INFO - 'tests': ['tsvgm']}}, 19:06:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:06:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:06:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:06:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:06:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:06:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:06:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:42 INFO - 'talos_options': ['--e10s'], 19:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:42 INFO - 'tests': ['damp', 'tps']}, 19:06:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:42 INFO - 'talos_options': ['--e10s'], 19:06:42 INFO - 'tests': ['damp', 'tps']}, 19:06:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:06:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:06:42 INFO - 'other': {'tests': ['a11yr', 19:06:42 INFO - 'ts_paint', 19:06:42 INFO - 'tpaint', 19:06:42 INFO - 'sessionrestore', 19:06:42 INFO - 'sessionrestore_no_auto_restore']}, 19:06:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:06:42 INFO - 'tests': ['a11yr', 19:06:42 INFO - 'ts_paint', 19:06:42 INFO - 'tpaint', 19:06:42 INFO - 'sessionrestore', 19:06:42 INFO - 'sessionrestore_no_auto_restore']}, 19:06:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:06:42 INFO - 'tests': ['a11yr', 19:06:42 INFO - 'ts_paint', 19:06:42 INFO - 'tpaint', 19:06:42 INFO - 'sessionrestore', 19:06:42 INFO - 'sessionrestore_no_auto_restore']}, 19:06:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:06:42 INFO - 'tests': ['a11yr', 19:06:42 INFO - 'ts_paint', 19:06:42 INFO - 'tpaint', 19:06:42 INFO - 'sessionrestore', 19:06:42 INFO - 'sessionrestore_no_auto_restore']}, 19:06:42 INFO - 'other_l64': {'tests': ['a11yr', 19:06:42 INFO - 'ts_paint', 19:06:42 INFO - 'tpaint', 19:06:42 INFO - 'sessionrestore', 19:06:42 INFO - 'sessionrestore_no_auto_restore']}, 19:06:42 INFO - 'other_nol64': {'tests': ['a11yr', 19:06:42 INFO - 'ts_paint', 19:06:42 INFO - 'tpaint', 19:06:42 INFO - 'sessionrestore', 19:06:42 INFO - 'sessionrestore_no_auto_restore']}, 19:06:42 INFO - 'svgr': {'tests': ['tsvgx', 19:06:42 INFO - 'tsvgr_opacity', 19:06:42 INFO - 'tart', 19:06:42 INFO - 'tscrollx', 19:06:42 INFO - 'cart']}, 19:06:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:06:42 INFO - 'tests': ['tsvgx', 19:06:42 INFO - 'tsvgr_opacity', 19:06:42 INFO - 'tart', 19:06:42 INFO - 'tscrollx', 19:06:42 INFO - 'cart']}, 19:06:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:42 INFO - 'tests': ['tp5o']}, 19:06:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:42 INFO - 'talos_options': ['--e10s'], 19:06:42 INFO - 'tests': ['tp5o']}, 19:06:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:42 INFO - 'talos_options': ['--xperf_path', 19:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:42 INFO - 'tests': ['tp5n']}, 19:06:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:42 INFO - 'talos_options': ['--e10s', 19:06:42 INFO - '--xperf_path', 19:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:42 INFO - 'tests': ['tp5n']}}, 19:06:42 INFO - 'talos.zip': {'path': '', 19:06:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:06:42 INFO - Running post-action listener: _resource_record_post_action 19:06:42 INFO - ##### 19:06:42 INFO - ##### Running create-virtualenv step. 19:06:42 INFO - ##### 19:06:42 INFO - Running pre-action listener: _resource_record_pre_action 19:06:42 INFO - Running main action method: create_virtualenv 19:06:42 INFO - Creating virtualenv /builds/slave/test/build/venv 19:06:42 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 19:06:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:06:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:06:42 INFO - Using real prefix '/tools/python27' 19:06:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:06:43 INFO - Installing distribute.............................................................................................................................................................................................done. 19:06:46 INFO - Installing pip.................done. 19:06:46 INFO - Return code: 0 19:06:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:06: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')]} 19:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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')]} 19:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c049d960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, '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.6TuFITZAb3/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.jXiyLfWIcn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:06: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', 'pip>=1.5'] in /builds/slave/test/build 19:06: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 pip>=1.5 19:06:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:06:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:46 INFO - 'HOME': '/Users/cltbld', 19:06:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:46 INFO - 'LOGNAME': 'cltbld', 19:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:46 INFO - 'MOZ_NO_REMOTE': '1', 19:06:46 INFO - 'NO_EM_RESTART': '1', 19:06:46 INFO - 'PAGER': '/bin/cat', 19:06:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:46 INFO - 'PWD': '/builds/slave/test', 19:06:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:46 INFO - 'SHELL': '/bin/bash', 19:06:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:06:46 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:06:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:46 INFO - 'USER': 'cltbld', 19:06:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:46 INFO - 'XPC_FLAGS': '0x0', 19:06:46 INFO - 'XPC_SERVICE_NAME': '0', 19:06:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:46 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 19:06:46 INFO - Cleaning up... 19:06:46 INFO - Return code: 0 19:06:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:06: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')]} 19:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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')]} 19:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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', '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 0x102c6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c049d960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, '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.6TuFITZAb3/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.jXiyLfWIcn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:06: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', 'psutil>=0.7.1'] in /builds/slave/test/build 19:06: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 psutil>=0.7.1 19:06:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:06:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:46 INFO - 'HOME': '/Users/cltbld', 19:06:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:46 INFO - 'LOGNAME': 'cltbld', 19:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:46 INFO - 'MOZ_NO_REMOTE': '1', 19:06:46 INFO - 'NO_EM_RESTART': '1', 19:06:46 INFO - 'PAGER': '/bin/cat', 19:06:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:46 INFO - 'PWD': '/builds/slave/test', 19:06:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:46 INFO - 'SHELL': '/bin/bash', 19:06:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:06:46 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:06:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:46 INFO - 'USER': 'cltbld', 19:06:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:46 INFO - 'XPC_FLAGS': '0x0', 19:06:46 INFO - 'XPC_SERVICE_NAME': '0', 19:06:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:46 INFO - Downloading/unpacking psutil>=0.7.1 19:06: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 19:06: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 19:06: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 19:06: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 19:06: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 19:06: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 19:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:06:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:49 INFO - Installing collected packages: psutil 19:06:49 INFO - Running setup.py install for psutil 19:06:49 INFO - building 'psutil._psutil_osx' extension 19:06:49 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 19:06:49 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 19:06:49 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 19:06:49 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 19:06:49 INFO - building 'psutil._psutil_posix' extension 19:06:49 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 19:06:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:06:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:06:49 INFO - ^ 19:06:49 INFO - 1 warning generated. 19:06:49 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 19:06:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:49 INFO - Successfully installed psutil 19:06:49 INFO - Cleaning up... 19:06:50 INFO - Return code: 0 19:06:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:50 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 0x102c6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c049d960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, '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.6TuFITZAb3/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.jXiyLfWIcn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:06:50 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 19:06:50 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 19:06:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:06:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:50 INFO - 'HOME': '/Users/cltbld', 19:06:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:50 INFO - 'LOGNAME': 'cltbld', 19:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:50 INFO - 'MOZ_NO_REMOTE': '1', 19:06:50 INFO - 'NO_EM_RESTART': '1', 19:06:50 INFO - 'PAGER': '/bin/cat', 19:06:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:50 INFO - 'PWD': '/builds/slave/test', 19:06:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:50 INFO - 'SHELL': '/bin/bash', 19:06:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:06:50 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:06:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:50 INFO - 'USER': 'cltbld', 19:06:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:50 INFO - 'XPC_FLAGS': '0x0', 19:06:50 INFO - 'XPC_SERVICE_NAME': '0', 19:06:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:06:50 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 19:06:50 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 19:06:50 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 19:06:50 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 19:06:50 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 19:06:50 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 19:06:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:06:52 INFO - Installing collected packages: mozsystemmonitor 19:06:52 INFO - Running setup.py install for mozsystemmonitor 19:06:52 INFO - Successfully installed mozsystemmonitor 19:06:52 INFO - Cleaning up... 19:06:52 INFO - Return code: 0 19:06:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:52 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 0x102c6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c049d960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, '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.6TuFITZAb3/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.jXiyLfWIcn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:06:52 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 19:06:52 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 19:06:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:06:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:52 INFO - 'HOME': '/Users/cltbld', 19:06:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:52 INFO - 'LOGNAME': 'cltbld', 19:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:52 INFO - 'MOZ_NO_REMOTE': '1', 19:06:52 INFO - 'NO_EM_RESTART': '1', 19:06:52 INFO - 'PAGER': '/bin/cat', 19:06:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:52 INFO - 'PWD': '/builds/slave/test', 19:06:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:52 INFO - 'SHELL': '/bin/bash', 19:06:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:06:52 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:06:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:52 INFO - 'USER': 'cltbld', 19:06:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:52 INFO - 'XPC_FLAGS': '0x0', 19:06:52 INFO - 'XPC_SERVICE_NAME': '0', 19:06:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:06:53 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 19:06:53 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 19:06:53 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 19:06:53 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 19:06:53 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 19:06:53 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 19:06:55 INFO - Downloading blobuploader-1.2.4.tar.gz 19:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:06:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:06:55 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 19:06:55 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 19:06:55 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 19:06:55 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 19:06:55 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 19:06:55 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 19:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:06:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:06:56 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 19:06:56 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 19:06:56 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 19:06:56 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 19:06:56 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 19:06:56 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 19:06:56 INFO - Downloading docopt-0.6.1.tar.gz 19:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:06:56 INFO - Installing collected packages: blobuploader, requests, docopt 19:06:56 INFO - Running setup.py install for blobuploader 19:06:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:06:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:06:56 INFO - Running setup.py install for requests 19:06:57 INFO - Running setup.py install for docopt 19:06:57 INFO - Successfully installed blobuploader requests docopt 19:06:57 INFO - Cleaning up... 19:06:57 INFO - Return code: 0 19:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:57 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 0x102c6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c049d960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, '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.6TuFITZAb3/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.jXiyLfWIcn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:06:57 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 19:06:57 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 19:06:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:06:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:57 INFO - 'HOME': '/Users/cltbld', 19:06:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:57 INFO - 'LOGNAME': 'cltbld', 19:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:57 INFO - 'MOZ_NO_REMOTE': '1', 19:06:57 INFO - 'NO_EM_RESTART': '1', 19:06:57 INFO - 'PAGER': '/bin/cat', 19:06:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:57 INFO - 'PWD': '/builds/slave/test', 19:06:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:57 INFO - 'SHELL': '/bin/bash', 19:06:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:06:57 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:06:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:57 INFO - 'USER': 'cltbld', 19:06:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:57 INFO - 'XPC_FLAGS': '0x0', 19:06:57 INFO - 'XPC_SERVICE_NAME': '0', 19:06:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:57 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-RdnTnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-_ha8FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-uw_Tc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-iygqa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-w_INPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-714g4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-_b5wdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-DF_eH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-_zIeeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-Kr2q9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:58 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-d1IY_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:59 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-ZbQY6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:59 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-Z_Pr55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:59 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-jlfRCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:59 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-5Zrm46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:59 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-blO1VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:59 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-nyDnJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:06:59 INFO - Running setup.py install for manifestparser 19:06:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:06:59 INFO - Running setup.py install for mozcrash 19:06:59 INFO - Running setup.py install for mozdebug 19:07:00 INFO - Running setup.py install for mozdevice 19:07:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:07:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:07:00 INFO - Running setup.py install for mozfile 19:07:00 INFO - Running setup.py install for mozhttpd 19:07:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:07:00 INFO - Running setup.py install for mozinfo 19:07:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:07:00 INFO - Running setup.py install for mozInstall 19:07:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:07:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:07:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:07:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:07:00 INFO - Running setup.py install for mozleak 19:07:00 INFO - Running setup.py install for mozlog 19:07:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:07:01 INFO - Running setup.py install for moznetwork 19:07:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:07:01 INFO - Running setup.py install for mozprocess 19:07:01 INFO - Running setup.py install for mozprofile 19:07:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:07:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:07:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:07:01 INFO - Running setup.py install for mozrunner 19:07:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:07:01 INFO - Running setup.py install for mozscreenshot 19:07:01 INFO - Running setup.py install for moztest 19:07:02 INFO - Running setup.py install for mozversion 19:07:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:07:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:07:02 INFO - Cleaning up... 19:07:02 INFO - Return code: 0 19:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:02 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 0x102c6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c049d960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, '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.6TuFITZAb3/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.jXiyLfWIcn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:07:02 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 19:07:02 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 19:07:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:07:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:02 INFO - 'HOME': '/Users/cltbld', 19:07:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:02 INFO - 'LOGNAME': 'cltbld', 19:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:02 INFO - 'MOZ_NO_REMOTE': '1', 19:07:02 INFO - 'NO_EM_RESTART': '1', 19:07:02 INFO - 'PAGER': '/bin/cat', 19:07:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:02 INFO - 'PWD': '/builds/slave/test', 19:07:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:02 INFO - 'SHELL': '/bin/bash', 19:07:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:07:02 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:07:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:02 INFO - 'USER': 'cltbld', 19:07:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:02 INFO - 'XPC_FLAGS': '0x0', 19:07:02 INFO - 'XPC_SERVICE_NAME': '0', 19:07:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:02 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-luGBg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:02 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)) 19:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:02 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-jXtaAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:02 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)) 19:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:02 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-YuCF1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:02 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)) 19:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:02 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-3S0u1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-KmxvbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-FSLmUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-JaJghR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-Ql3hZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-c1Ih3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-iPplk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-SMykyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-VpILGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-j5t059-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:03 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)) 19:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:03 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-GtDAbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:04 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)) 19:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:04 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-O6KzTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:04 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)) 19:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:04 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-I2N7Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:04 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)) 19:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:04 INFO - Running setup.py (path:/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/pip-_1cd3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:04 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)) 19:07:04 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)) 19:07:04 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)) 19:07:04 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)) 19:07:04 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)) 19:07:04 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)) 19:07:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:06 INFO - Downloading blessings-1.6.tar.gz 19:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:07:06 INFO - Installing collected packages: blessings 19:07:06 INFO - Running setup.py install for blessings 19:07:06 INFO - Successfully installed blessings 19:07:06 INFO - Cleaning up... 19:07:07 INFO - Return code: 0 19:07:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:07 INFO - Reading from file tmpfile_stdout 19:07:07 INFO - Current package versions: 19:07:07 INFO - blessings == 1.6 19:07:07 INFO - blobuploader == 1.2.4 19:07:07 INFO - docopt == 0.6.1 19:07:07 INFO - manifestparser == 1.1 19:07:07 INFO - mozInstall == 1.12 19:07:07 INFO - mozcrash == 0.16 19:07:07 INFO - mozdebug == 0.1 19:07:07 INFO - mozdevice == 0.48 19:07:07 INFO - mozfile == 1.2 19:07:07 INFO - mozhttpd == 0.7 19:07:07 INFO - mozinfo == 0.9 19:07:07 INFO - mozleak == 0.1 19:07:07 INFO - mozlog == 3.1 19:07:07 INFO - moznetwork == 0.27 19:07:07 INFO - mozprocess == 0.22 19:07:07 INFO - mozprofile == 0.28 19:07:07 INFO - mozrunner == 6.11 19:07:07 INFO - mozscreenshot == 0.1 19:07:07 INFO - mozsystemmonitor == 0.0 19:07:07 INFO - moztest == 0.7 19:07:07 INFO - mozversion == 1.4 19:07:07 INFO - psutil == 3.1.1 19:07:07 INFO - requests == 1.2.3 19:07:07 INFO - wsgiref == 0.1.2 19:07:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:07 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 0x102c6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c049d960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, '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.6TuFITZAb3/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.jXiyLfWIcn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:07:07 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 19:07:07 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 19:07:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:07 INFO - 'HOME': '/Users/cltbld', 19:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:07 INFO - 'LOGNAME': 'cltbld', 19:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:07 INFO - 'MOZ_NO_REMOTE': '1', 19:07:07 INFO - 'NO_EM_RESTART': '1', 19:07:07 INFO - 'PAGER': '/bin/cat', 19:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:07 INFO - 'PWD': '/builds/slave/test', 19:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:07 INFO - 'SHELL': '/bin/bash', 19:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:07:07 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:07 INFO - 'USER': 'cltbld', 19:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:07 INFO - 'XPC_FLAGS': '0x0', 19:07:07 INFO - 'XPC_SERVICE_NAME': '0', 19:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:07 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)) 19:07:07 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)) 19:07:07 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)) 19:07:07 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)) 19:07:07 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)) 19:07:07 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)) 19:07:07 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)) 19:07:07 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)) 19:07:07 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)) 19:07:07 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)) 19:07:07 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)) 19:07:07 INFO - Cleaning up... 19:07:07 INFO - Return code: 0 19:07:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c049d960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, '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.6TuFITZAb3/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.jXiyLfWIcn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:07:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:07 INFO - 'HOME': '/Users/cltbld', 19:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:07 INFO - 'LOGNAME': 'cltbld', 19:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:07 INFO - 'MOZ_NO_REMOTE': '1', 19:07:07 INFO - 'NO_EM_RESTART': '1', 19:07:07 INFO - 'PAGER': '/bin/cat', 19:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:07 INFO - 'PWD': '/builds/slave/test', 19:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:07 INFO - 'SHELL': '/bin/bash', 19:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:07:07 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:07 INFO - 'USER': 'cltbld', 19:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:07 INFO - 'XPC_FLAGS': '0x0', 19:07:07 INFO - 'XPC_SERVICE_NAME': '0', 19:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:07 INFO - Downloading/unpacking jsonschema 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:07:10 INFO - Downloading/unpacking functools32 (from jsonschema) 19:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:10 INFO - Downloading functools32-3.2.3-2.tar.gz 19:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:07:10 INFO - warning: no files found matching '*.txt' 19:07:10 INFO - no previously-included directories found matching 'build' 19:07:10 INFO - no previously-included directories found matching 'dist' 19:07:10 INFO - no previously-included directories found matching '.git*' 19:07:10 INFO - Installing collected packages: jsonschema, functools32 19:07:10 INFO - Running setup.py install for functools32 19:07:10 INFO - warning: no files found matching '*.txt' 19:07:10 INFO - no previously-included directories found matching 'build' 19:07:10 INFO - no previously-included directories found matching 'dist' 19:07:10 INFO - no previously-included directories found matching '.git*' 19:07:10 INFO - Successfully installed jsonschema functools32 19:07:10 INFO - Cleaning up... 19:07:11 INFO - Return code: 0 19:07:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:07:11 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')]} 19:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:11 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')]} 19:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:11 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 0x102c6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82c049d960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, '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.6TuFITZAb3/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.jXiyLfWIcn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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 19:07:11 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 19:07:11 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 19:07:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:07:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:11 INFO - 'HOME': '/Users/cltbld', 19:07:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:11 INFO - 'LOGNAME': 'cltbld', 19:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:11 INFO - 'MOZ_NO_REMOTE': '1', 19:07:11 INFO - 'NO_EM_RESTART': '1', 19:07:11 INFO - 'PAGER': '/bin/cat', 19:07:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:11 INFO - 'PWD': '/builds/slave/test', 19:07:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:11 INFO - 'SHELL': '/bin/bash', 19:07:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:07:11 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:07:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:11 INFO - 'USER': 'cltbld', 19:07:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:11 INFO - 'XPC_FLAGS': '0x0', 19:07:11 INFO - 'XPC_SERVICE_NAME': '0', 19:07:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:11 INFO - Downloading/unpacking flake8 19:07:11 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 19:07:11 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 19:07:11 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 19:07:11 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 19:07:11 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 19:07:11 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 19:07:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:07:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:07:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:07:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:14 INFO - no previously-included directories found matching 'docs/_build' 19:07:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:07:15 INFO - Running setup.py install for pep8 19:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:07:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:07:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:07:15 INFO - no previously-included directories found matching 'docs/_build' 19:07:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:07:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:07:15 INFO - Cleaning up... 19:07:15 INFO - Return code: 0 19:07:15 INFO - Running post-action listener: _resource_record_post_action 19:07:15 INFO - Running post-action listener: _start_resource_monitoring 19:07:15 INFO - Starting resource monitoring. 19:07:15 INFO - ##### 19:07:15 INFO - ##### Running install step. 19:07:15 INFO - ##### 19:07:15 INFO - Running pre-action listener: _resource_record_pre_action 19:07:15 INFO - Running main action method: install 19:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:15 INFO - Reading from file tmpfile_stdout 19:07:15 INFO - Detecting whether we're running mozinstall >=1.0... 19:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:07:15 INFO - Reading from file tmpfile_stdout 19:07:15 INFO - Output received: 19:07:15 INFO - Usage: mozinstall [options] installer 19:07:15 INFO - Options: 19:07:15 INFO - -h, --help show this help message and exit 19:07:15 INFO - -d DEST, --destination=DEST 19:07:15 INFO - Directory to install application into. [default: 19:07:15 INFO - "/builds/slave/test"] 19:07:15 INFO - --app=APP Application being installed. [default: firefox] 19:07:15 INFO - mkdir: /builds/slave/test/build/application 19:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 19:07:37 INFO - Reading from file tmpfile_stdout 19:07:37 INFO - Output received: 19:07:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:07:37 INFO - Running post-action listener: _resource_record_post_action 19:07:37 INFO - ##### 19:07:37 INFO - ##### Running run-tests step. 19:07:37 INFO - ##### 19:07:37 INFO - Running pre-action listener: _resource_record_pre_action 19:07:37 INFO - Running main action method: run_tests 19:07:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:07:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:07:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:07:37 INFO - 2016-02-29 19:07:37.694 screenresolution[6822:124116] starting screenresolution argv=screenresolution get 19:07:37 INFO - 2016-02-29 19:07:37.697 screenresolution[6822:124116] Display 0: 1600x1200x32@60 19:07:37 INFO - 2016-02-29 19:07:37.703 screenresolution[6823:124118] starting screenresolution argv=screenresolution list 19:07:37 INFO - Available Modes on Display 0 19:07:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:07:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:07:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:07:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:07:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:07:37 INFO - Intel Iris: 19:07:37 INFO - Chipset Model: Intel Iris 19:07:37 INFO - Type: GPU 19:07:37 INFO - Bus: Built-In 19:07:37 INFO - VRAM (Dynamic, Max): 1536 MB 19:07:37 INFO - Vendor: Intel (0x8086) 19:07:37 INFO - Device ID: 0x0a2e 19:07:37 INFO - Revision ID: 0x0009 19:07:37 INFO - Displays: 19:07:37 INFO - Display: 19:07:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:07:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:07:37 INFO - Display Serial Number: 1600x1200 60 19:07:37 INFO - Main Display: Yes 19:07:37 INFO - Mirror: Off 19:07:37 INFO - Online: Yes 19:07:37 INFO - Rotation: Supported 19:07:37 INFO - Return code: 0 19:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:07:37 INFO - Python 2.7.3 19:07:37 INFO - Return code: 0 19:07:37 INFO - grabbing minidump binary from tooltool 19:07:37 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')]} 19:07:37 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 0x102b11d30>, '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 0x102935db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b08b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:07:37 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 19:07:37 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 19:07:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:07:38 INFO - Return code: 0 19:07:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:07:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:07:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:07:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:07:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:07:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:07:39 INFO - Return code: 0 19:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0049', '--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 19:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0049 --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 19:07:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6TuFITZAb3/Render', 19:07:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:39 INFO - 'HOME': '/Users/cltbld', 19:07:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:39 INFO - 'LOGNAME': 'cltbld', 19:07:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:07:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:39 INFO - 'MOZ_NO_REMOTE': '1', 19:07:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:07:39 INFO - 'NO_EM_RESTART': '1', 19:07:39 INFO - 'PAGER': '/bin/cat', 19:07:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:39 INFO - 'PWD': '/builds/slave/test', 19:07:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:07:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:39 INFO - 'SHELL': '/bin/bash', 19:07:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jXiyLfWIcn/Listeners', 19:07:39 INFO - 'TMPDIR': '/var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/', 19:07:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:39 INFO - 'USER': 'cltbld', 19:07:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:39 INFO - 'XPC_FLAGS': '0x0', 19:07:39 INFO - 'XPC_SERVICE_NAME': '0', 19:07:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0049', '--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 19:07:39 INFO - mozversion application_buildid: 20160229095626 19:07:39 INFO - mozversion application_changeset: 987fdde4def3c14ddefc1c531bf42825615f8b2b 19:07:39 INFO - mozversion application_display_name: Firefox 19:07:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:07:39 INFO - mozversion application_name: Firefox 19:07:39 INFO - mozversion application_remotingname: firefox 19:07:39 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 19:07:39 INFO - mozversion application_vendor: Mozilla 19:07:39 INFO - mozversion application_version: 47.0 19:07:39 INFO - mozversion platform_buildid: 20160229095626 19:07:39 INFO - mozversion platform_changeset: 987fdde4def3c14ddefc1c531bf42825615f8b2b 19:07:39 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 19:07:39 INFO - mozversion platform_version: 47.0 19:07:39 INFO - using testdate: 1456801659 19:07:39 INFO - actual date: 1456801659 19:07:39 INFO - starting webserver on 'localhost:59653' 19:07:39 INFO - SUITE-START | Running 2 tests 19:07:39 INFO - TEST-START | dromaeo_css 19:07:39 INFO - operating with platform_type : mac_ 19:07:39 INFO - Initialising browser for dromaeo_css test... 19:07:39 INFO - TEST-INFO | started process 6841 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/tmpIfLJon/profile http://localhost:59653/getInfo.html) 19:07:41 INFO - PROCESS | 6841 | __metrics Screen width/height:1600/1200 19:07:41 INFO - PROCESS | 6841 | colorDepth:24 19:07:41 INFO - PROCESS | 6841 | Browser inner width/height: 1024/689 19:07:41 INFO - PROCESS | 6841 | __metrics 19:07:42 INFO - PROCESS | 6841 | 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" 19:07:42 INFO - PROCESS | 6841 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:07:42 INFO - TEST-INFO | 6841: exit 0 19:07:42 INFO - Browser initialized. 19:07:42 INFO - Running cycle 1/1 for dromaeo_css test... 19:07:42 INFO - TEST-INFO | started process 6843 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/tmpIfLJon/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:54 INFO - PROCESS | 6843 | RSS: Main: 159727616 19:07:54 INFO - PROCESS | 6843 | 19:08:45 INFO - PROCESS | 6843 | 1456801725030 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] 19:10:54 INFO - PROCESS | 6843 | Cycle 1(1): loaded http://localhost:59653/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59653/tests/dromaeo/cssquery-ext.html) 19:10:55 INFO - PROCESS | 6843 | RSS: Main: 282509312 19:10:55 INFO - PROCESS | 6843 | 19:13:58 INFO - PROCESS | 6843 | Cycle 1(1): loaded http://localhost:59653/tests/dromaeo/cssquery-ext.html (next: http://localhost:59653/tests/dromaeo/cssquery-jquery.html) 19:13:58 INFO - PROCESS | 6843 | RSS: Main: 295141376 19:13:58 INFO - PROCESS | 6843 | 19:17:00 INFO - PROCESS | 6843 | Cycle 1(1): loaded http://localhost:59653/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59653/tests/dromaeo/cssquery-mootools.html) 19:17:01 INFO - PROCESS | 6843 | RSS: Main: 291975168 19:17:01 INFO - PROCESS | 6843 | 19:20:03 INFO - PROCESS | 6843 | Cycle 1(1): loaded http://localhost:59653/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59653/tests/dromaeo/cssquery-prototype.html) 19:20:03 INFO - PROCESS | 6843 | RSS: Main: 262615040 19:20:03 INFO - PROCESS | 6843 | 19:23:06 INFO - PROCESS | 6843 | Cycle 1(1): loaded http://localhost:59653/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59653/tests/dromaeo/cssquery-yui.html) 19:23:07 INFO - PROCESS | 6843 | RSS: Main: 262422528 19:23:07 INFO - PROCESS | 6843 | 19:26:09 INFO - PROCESS | 6843 | Cycle 1(1): loaded http://localhost:59653/tests/dromaeo/cssquery-yui.html (next: http://localhost:59653/tests/dromaeo/cssquery-dojo.html) 19:26:09 INFO - PROCESS | 6843 | RSS: Main: 308965376 19:26:09 INFO - PROCESS | 6843 | 19:26:09 INFO - PROCESS | 6843 | __start_tp_report 19:26:09 INFO - PROCESS | 6843 | _x_x_mozilla_page_load 19:26:09 INFO - PROCESS | 6843 | _x_x_mozilla_page_load_details 19:26:09 INFO - PROCESS | 6843 | |i|pagename|runs| 19:26:09 INFO - PROCESS | 6843 | |0;dojo.html;3508.193115583416;3564.055525285801;3566.500689903414;3614.34941710492;3641.4719865619486;5675.51758100562;5681.801136960207;5694.430556944309;5712.71436428178;5731.828045158647;5681.119426488891;5719.799807006755;5733.197352370661;5733.913991290124;5736.397678243787;5089.567386772129;5120.641555091145;5137.434882162968;5145.948540514603;5226.712530810804;5216.58267338612;5219.243209734586;5221.399539053001;5228.5555727763185;5247.344081989751;5140.871478213037;5179.766910489018;5189.351331083614;5189.766460509286;5197.532222100011;5179.093658609747;5217.713025783581;5220.634555581111;5223.268742376071;5262.158054711228;4961.429435614915;5084.79660813567;5112.642115051948;5145.3568303962;5176.50823171798;4628.583427491542;5541.0580201365865;5554.611177217596;5575.916361254584;5621.241132447109;6200.255969283715;6216.595921265149;6224.688765561704;6229.314775374751;6231.688415579203;6164.167837341946;6190.257169139687;6292;6294.905576416358;6327.96836015817;5802.65184088956;5812.82561523155;5813.76744930198;5822.9417705822825;5835.212246346731;6339.366063393623;6358.713857876407;6365.649889256043;6371.936280637227;6376.585521941059;6026.939730602726;6093.360197179321;6113.354685976905;6162.506999440034;6166.537509686702;5625.648588126003;6234.781782637677;6261.217347831521;6263.592866463665;6265.624062556261;5959;6072.967595508774;6128.1114238435175;6169.753209871555;6190.7523699052435;6132.695218635848;6179.84550386235;6188.907166392508;6193.1329613854095;6202;5014.147594908874;5021.020900924358;5023.723695196726;5024.547790698854;5043.394792624835;4323.870283891489;4324.805383757738;4498.5501449854755;4544.2047641662575;4552.817887284537;4961.727105009187;5893.292804863444;5925.170476133345;5926.081457374114;5973.223480947449;6305.873882522324;6317.431431171217;6320.968395157995;6322.462590679752;6340.175777149033;5740.913886291709;5859.970700146558;5865.413458654186;5976.402359764076;6005.279366475964;4590.862274131781;5404.83785486436;5412.594055445778;5415.323084614423;5423.29497165366;6373.936260637427;6378;6398.1362516059735;6415.422611964946;6424.196975378078;6099.9390006099375;6282;6338.239411270677;6348.968255158879;6366.554341196072;6352.745890164341;6369.235691717024;6411.711472983634;6424.582402143846;6442.35576442352;6044.7279872406725;6126.823043872828;6250.406211409909;6259.561830671809;6271;6299.590526615939;6305.621662700252;6320.178376810985;6327.620342779448;6354.491640668828;6107.175531303395;6110.358412366815;6115.235595550556;6125.356837531995;6139.386061393825;5873.236479257669;5976.940230597638;6056.36408177135;6091.695415229309;6120.663363515049;5945.167676525203;5966.791162309299;5968.731407086605;5980.1328807321825;5986.2517185351835;5736.5984381094595;5979.162917191509;6104.481119104926;6142.201513803177;6142.447179753844;5856.150858125633;5884.293884733859;5899.616524925866;5926.555508336805;5932 19:26:09 INFO - PROCESS | 6843 | |1;ext.html;500.3895247797686;577.5495113811226;586.34329550903;602.9698515074246;605.8428401752652;31151.221219469524;35909.46135807965;39052.80473597628;39098;39220.411693824615;41969.37045944305;42251.57748422515;42393.152136957244;42405.15189696212;42463.78768106155;9658.27562932781;9930.404175749441;9932.304738668296;9933.950330248339;9941.155001824853;9726.270529710264;9808;9863.802723945517;9877.45673987934;9895.307328486973;9837.508124593742;9903.306768526207;9905.603775848957;9912.454814985173;9919.3056486046;9828.606855725762;9860.408375497493;9878.654247101389;9880.35777674449;9881.110700037032;9696.224302055889;9832.262580306506;9837.508124593813;9839;9848.655297064568;42212;42774.57225427737;42894.78552607248;42960.35559466611;43094;3149.9055028348957;3629.3467175908327;3811.4854494643146;3921.568627450978;4083.9994201420545;28720.425591488052;29830.55254171189;30027.69972300271;30049.549256761165;31010.379792404252;2866;2919.722626350493;2944.749696275819;2963.4962056450454;3024.3346463777934;523341;526396;527351;532799;532964;46887;47246.291305630446;47497;65908.67045664837;66184.33815661877;46060;46074;46193.53806461892;46197;46250.07499849984;15575.987560808511;15729;15746.68506629861;15749.291281892343;15765.763513547307;12452.003839692803;12466.875331246752;12542.623721288375;12543;12556.623301300975;14288.428462861577;14308.928455357656;14345.856541434452;14358.066725662798;14416.351264193136;6403.903941440882;6447.25856526496;6491.188601424822;6537.8692426152165;6541.640209788412;962.7978124593914;1074.463517170438;1117.5523509971665;1189.2507720136432;1251.1867286264;28415.857920710678;29487.852560737058;31283.84358078195;31586.210344741106;31976;1024.5440778853338;1160.9013233875214;1174.2602160638914;1247.3451437995125;1274.8661390554043;11266.66200014001;12158.756824863452;12162.939185304194;15324.770128448083;16443.58891027734;575013;582202;582667;583606;583886;57201.71399143061;57928.71035644795;63773;64874.67562662157;65444;1461.203644014015;1463.334182946778;1479.3860547872512;1480.2746654139394;1587.9757556376073;29141;31001.05815880397;32027.67972320247;32208.83895580507;32241.06817034349;55036;55515.88968220532;55517;55577.166342505705;55723.442765571825;400785;404299;404314;406909;409295;33598;33669;34347;34530.482042768876;34956.47565286574;48279.793005175154;50518.74740626274;51969.480305197976;52747;53748.193777092594;37771.05572360713;38905.80547097247;39261.018474537224;39460.40809387919;39930.80034599808;38184.61815381922;39248.80375598218;39384.60615393924;39414.80292598519;40352.79823600863;38439.231215376094;39364.01589960274;39383;39458.60541394549;39580.208395832495;28696.569551457163;31841.04476865698;34880.779172728835;34916;35034.64965350314;26411.73588264093;26595.33511662224;26681.19956401311;26814.927402903664;26844.328891777863 19:26:09 INFO - PROCESS | 6843 | |2;jquery.html;378.421015845756;379.68106790296144;385.5912732503546;387.6743535430238;388.7337174035784;16898.98606083636;16912.915435422805;19445.319413820518;21453.892730536347;21515.784842151574;17375.73936390955;17980.55048623785;20754;21271.680924786142;21477;5689.800856970017;5944.524438044968;5994.6403215807195;6007.309159446676;6007.7596896124105;4371.431713877191;4563.06457176278;5640.661560306395;5846.970765146169;6265.937340626604;6459.289478157399;6469.320721324264;6472.446612812938;6475.255345635242;6480.125183100268;6153.507719382439;6402.6158430494315;6407.295197528291;6420.775272865428;6437.613743175401;5538.556915446755;5558.138488534284;5567.220589117527;5577.44225577439;5577.8047768328315;25772.613410798855;26545.336366590796;26706.19881403561;26920.865395672896;26959.595606065926;2059.7116403703494;2266.263464374085;2361.740208577055;2437.146998550511;2817.7604903583015;10050.597976080948;10073.99260073994;10108.342957707799;10242.28304018719;10410.531526081344;1739.6694628020637;1751.658426606812;1758.3669878843607;1790.7313902914536;1833.14758637233;86380;103227.45158822699;103695;107332.92667073307;109842;9691.466969316614;11018.95319944604;11024.346348047857;11318.660440186808;11332.093432525378;13653.04428690002;13715.794263086062;13728.931355343359;13738.450461981609;13742.969277304242;8239.629216685264;8310.667573297122;8394.45436046655;8401;8518.190771876662;8436.198561136682;8466.576671166416;8473.279771219391;8523.232909038215;8529.14708529142;4496.6177874881005;4589.954100459019;4607.470140933836;4650.162970665313;4651.813927442932;1570.5209910977032;1741.9216135273944;1752.816848627197;1807.493901707524;1947.51312171957;878.5958459108881;982.3418309732497;995.3928103856641;1056.9260151789301;1065.728239298974;19580.412587622395;20056.69914951277;20095.899520502597;20239;20395.592088158155;836.998719183444;974.3325821812082;992.8907820139779;1037.7976294622476;1080.2330345454816;8928.241099506486;10313.381197128196;10726.785464290671;10747.516361763739;10843.3254989444;682640;686430;702942;711484;721485;76059.61970190113;82249.58875205586;126247.3687631556;126622;127098;1017.7659138398062;1021.7394564386034;1036.1555332404066;1039.464675692004;1039.6413237433073;17187.484375468757;17921;17951.551211219303;18461.723074154168;18690.81309186945;53011.20483192832;53040.73479632577;53615.46384536261;57330;58502.70748646229;61691.766164677356;72450;78657.60671196607;78762.81855772053;80584.19415806001;8167.305779008851;8302.750917472486;8386.580670966548;8483.06686264498;8575.914240857512;9720.368176068532;11402.543898244308;14011.859881401055;14152.646183845487;14306.926980476297;9289.124878648065;9465.432074075577;10294;10822.621208257673;11876.168668193144;9920.900790991998;10816.513256903301;11610.88389116098;11889.881101189223;11936.343501107174;11355.37545435009;11966.64100076999;12011.057704280985;12026.819597705866;12277.386130693609;8393.622286996977;8399.790005249917;8429.873551896604;8454.239118479367;8629.568521574021;10068.69793906184;10334.069933706003;11122.944385278022;11719.824202637137;12040.578579750018 19:26:09 INFO - PROCESS | 6843 | |3;mootools.html;1329.6542898846299;1585.476792658423;1813.8186181381864;1967.3901090661905;2030.8781473111605;9061.864072038916;9089.90910090899;9260.953695231532;9268.721938341852;9299.349045566812;9101.681441149562;9142.954285228581;9148.085191480848;9162.816743665122;9163.496007719572;2520.3447103752974;2545.5799793034175;2568.114000669766;2571.241483762285;2575.381908341994;2565.422779874523;2590.1452520668136;2609.621604867293;2610.6606141201714;2613.8170328077044;2259.7062381890332;2327.813774898004;2499.6250562415603;2561.3340531461863;2580.6903171619433;2486.825922185448;2523;2529.962050569243;2531.556977528925;2533.9493210135693;2542.567763480194;2553.9106131285503;2557.2711777143427;2557.8465292082533;2566.396896729267;8137.593120344019;8834;9008.234300084501;9015.729528114167;9016.05331440196;5668.858278543028;5820.097884827858;5839.416058394169;5846.473817356458;5850.6782126983;3715.2755212733528;3816.217675376569;3846.903827404309;3848.730588858781;3859.8842034739005;1072.769354588767;1078.6440474643348;1081.086481922774;1093.923425360225;1137.4881303413415;10483.318584292072;12599.992000639926;12654.936725316407;12659.493620255178;12706.682332941751;5134.640575159703;5136.075506408883;5189.636725429184;5214.713190774544;5231.55531779803;10762.784744305227;10793.568257269779;10795.46022698862;10796.244262901679;10812.243142980073;5838.095095260242;5858.121281807763;5863.355030946593;5877.588568800228;5892;5132.384113906355;5233.162693968947;5256;5256.6320357574605;5258.2112683097075;4015.5984401560195;4016.979915100406;4026.8993275168355;4053.0880551875593;4070.531888832763;1314.8290722206243;1323.2060763541797;1325.847527534346;1334.552924770213;1335.3056410666593;1083.7832433513329;1101.1081024370285;1140.0822338017974;1241.4599649152647;1457.4388860288652;8499.277561407225;8509.61706723199;8555.957220213984;8567.4002819802;8644.524551149621;1250.4060571228595;1250.7435975625158;1254.1158483269273;1257.1639859493516;1264.4752427742385;6410.166678331787;6440.291567927524;6529.314421985623;6536.738530458823;6546.803595892131;11088;11334.093272538177;11426.314421134759;11459.369734664508;11511.366874821964;11022.614208502664;11244.831327530093;11246.268992515461;11327.886721132849;11332.150088743378;8735.213830755136;8798.912010879938;8846.867296990551;8857.3799834011;8867.980182278992;8295.087540370676;8363.958180209303;8395.790105247417;8413.116622754767;8415.074341822517;9970.252231082843;9988.550515226978;10236.948815255875;10287.125594324267;10358.430286334022;10265.230107742098;10452.843207352047;10466.581336746749;10698.14414846826;10700.464976751287;7623.504472209289;7819.84360312802;7825.530468171928;7832.0601527817025;7852.13626501073;8563.785905352415;8599.22606965351;8695.95652021761;8703.91296087031;8706.782330441789;6480.70836812354;7327.670254838438;7789.298963093349;7799.45403821727;7930.682772689028;6516.73933042673;7493.775186744407;7507.587082710504;7612;7614.200508946481;8010.359171266401;8014.19858014194;8067.991501062367;8069.717559885611;8075.353971682134;6208.658523781235;6225.501959843111;7294.635268236673;7298.781036568911;7346.926530734838;7462.328390444886;7509.3617042552;7596.772096837104;7605.163432022362;7619 19:26:09 INFO - PROCESS | 6843 | |4;prototype.html;302.2006792035066;325.9185203699075;336.76258237942255;338.3672532364478;341.344618332801;6012.819615411534;6239.032949892762;6307.747690092397;6374.8406289842715;6406.135171751806;5500.50495455409;5619.072852979264;6123.908141377883;6163.167972323746;6184.845378865531;4648.349231107648;4661.953380466186;4666.76666166692;4667.4632417272105;4677.532246775329;4673.626109911199;4680.321353403771;4681.969966607341;4682.6019788318035;4689.648276379268;4398.362237475564;4491.326301054835;4561.954380456203;4629.240888462379;4698.389209402773;4626.190416677102;4642.953570464286;4649.953500465002;4670.929936050945;4673.182193116225;4038.676905847525;4043.1307268937026;4052.3111071117983;4052.53395859477;4053.6757059435176;5965.940340596625;5976.73104710289;5983.461488466015;5987.131865879466;6023.397660233985;5424.566034717213;5472.781088756445;5489.670619762787;5491.423400542925;5493.890122197534;6440;6667.066610674509;6682.866342673168;6713.664316784141;6751.392374686302;3775.3959366501226;4580.839670611546;4587.7017993830295;4594.104149690812;4600.35595016698;7155.856882862314;7171.856562868714;7172.856542869165;7189.532680375759;7194.316539928698;4359.542248063971;4500.054988452396;4507.030988337523;4508.864734057984;4514.074614703978;4631.235846085426;4638.652101092364;4643.814247430132;4649.790759415834;4656.604188643935;5404.864878377994;5411.78352865881;5422.8373148805595;5426.34883813937;5428.945710542844;6806.863862722717;6826.044353790473;6829.795106146824;6838.93161068383;6840.144981877265;1493.9626509337136;1532.8850336224828;1573.2762929052765;1593.2033983008496;1603.9599010024842;1016.867807185076;1039.6413237433073;1041.0110395124661;1042.8800687920987;1046.3303485769113;5292.497212764782;6395.104685343963;6423.42189202974;6467.741290348427;6498.3826536478955;6962.2341542430295;7094.396976256973;7117.110361204849;7118.715251389886;7122.2521635228595;6441.355864413521;6456.903146452807;6457.2574153971955;6481.870362592722;6495.642739649365;3610.4403817408343;3647.9817600912356;3661.9267614647556;3670.504481894963;3680.9263814723554;7385.3722433592675;7422.591757453392;7668.38652907766;7681.7695469136015;7702.152763196156;6238.970569856014;7140.6072666003865;7332.743353982585;7373.33639972405;7383.556986580822;7628.771136865903;7644.426668000034;7665.776924691777;7665.808354791175;7681.692732290758;7109.964450177716;7110.537815042006;7115.715371385087;7121.323474269936;7132.144142702701;6677.198736151693;6958.443324533924;6966.825829354307;6979.267176946348;7012.5792452453015;5709.829484955657;7542.509736867086;7572.545647261182;7573.242675732383;7586.355159811478;4287.3140297552245;4561.77191140435;4563.680542362003;4575.267957126977;4576.244919588231;5680.318361796611;5773.672055427359;7069.505134640526;7076.363127318566;7080.858382832417;6257.405546473078;6585.967070164618;6600.933990660032;6731.932680673131;6738.528303018742;6775.186977562724;6801.795946121624;6805.761798337035;6824.283450237852;6828.419584335188;6666.899996499959;6675.132232809704;6692.163479565054;6694.096296999843;6701.932980670131;6547.869042619216;6829.419499342612;6834.282400347892;6837.589744615339;6873.140857392826;6630.171228596426;6682.966585167043;6690.83272918181;6708.396244338033;6711.765088221889 19:26:09 INFO - PROCESS | 6843 | |5;yui.html;687.7420967137324;701.8105111619861;766.0309708219104;785.9410544209184;786.6381464526318;15591.1424871632;15737.84262157378;15802.683946321067;15840.445584404548;15848.683026339466;14486.420543178287;14507.27463626817;14567.854321456782;14570.854291457108;14594.05138665986;768.2279309294152;790.0203747353298;915.1717695485596;943.9716808495722;945.0219023310875;942.726609283307;949.4398305000049;954.5465903695724;956.0582825916501;959.1319855530755;825.9463134896242;1008.5159123620666;1015.7206768138747;1017.8829434615003;1018.4856647393057;981.8478135888948;1005.0301459092011;1008.4554340656036;1009.5356136177404;1009.7273736091214;752.6124046116255;753.0549160803157;753.6796861333911;755.1014292991323;756.130449982519;15165.393384264617;15200.011999220125;15270.923645381701;15294.847051529565;15306.234688265542;13437.462501500026;13520.59438216855;13587.184768913898;13603.843673287782;13616.795748063787;10371.740706482324;11342.14933879954;11497.310161390344;12031.278123312542;12068.275903445734;3500.2474467989505;3615.710743140569;3624;3627.075095850568;3630.8366123524506;77525;77554.83667744989;78345;78388.99999999943;78458.21541784565;9888.110070093726;10004.649837255662;10019.499025048719;10129.848052279222;10213.693589192188;21274.680879786814;21367.35897923065;21378.465538361666;21439.78560214409;21537.892310538347;6256.562040657202;7752.922470775333;7919.762407127795;7958.721444749406;8168.183181681903;4243.405923170759;4245.363195520635;4282.935755963663;4283.336082907154;4302.161078589645;3751.3247615429486;3798.6771124454176;3804.7336686432236;3805.0487378155462;3817.4273858921383;746.2798100922108;756.3533179131873;760.1714131596586;768.1742127213269;771.0939645916026;634.2579182356653;635.2123367024948;637.9346491359441;654.7642848574509;676.2831398717375;8686.91313086861;9010.14403631654;9037.231835293942;9103.196056606726;9208.309376796633;642.862134022777;647.779754883342;653.2128784814382;660.5112216959416;662.4965026579738;4218.620324170839;4221.472315960505;4253.893652658709;4368;4630.791614377361;88580;96816.51591741997;96856;96983;97090.5145474268;83939.16060839436;85893;86317;87277;87372.56313718391;75534.11164720816;75610;76011.8598221027;76798.23201768023;79063.60468197623;9280.489573073546;9365;9402.717918462457;9504.47725375111;9529.52352382392;49625;52555.21167182572;53044;54874.902501950535;56062.439375605725;74808.62595686987;75501;75823.24176758382;76924;77968.05079873049;11494.482748276181;11650.417479125841;11685.707857303636;11924.821127683264;12225.327606981702;12210.511579536718;12325.50697972071;12333.62999110028;12688.111832171659;12722.98216142725;9712.465814380277;12118.636440906786;12174.695632609255;12211.511539538318;12563.246205227715;11998.04015678761;12010.339431331011;12021.338826364634;12031.398430078636;12037.518499259932;11850.585229516926;11860.525578977089;11864;11864.288142711464;11885.46515406826;10249.897501024894;10334.948325258325;10472.476376181314;10496;10646.946765266124;9195.678151264674;9468.810623787347;9509.762255943657;9589.986837857414;9623.326367154232 19:26:09 INFO - PROCESS | 6843 | __end_tp_report 19:26:09 INFO - PROCESS | 6843 | __start_cc_report 19:26:09 INFO - PROCESS | 6843 | _x_x_mozilla_cycle_collect,1079 19:26:09 INFO - PROCESS | 6843 | __end_cc_report 19:26:09 INFO - PROCESS | 6843 | __startTimestamp1456802769911__endTimestamp 19:26:09 INFO - PROCESS | 6843 | 19:26:09 INFO - PROCESS | 6843 | ------- Summary: start ------- 19:26:09 INFO - PROCESS | 6843 | Number of tests: 6 19:26:09 INFO - PROCESS | 6843 | 19:26:09 INFO - PROCESS | 6843 | [#0] dojo.html Cycles:165 Average:5749.45 Median:5966.79 stddev:638.04 (10.7%) stddev-sans-first:615.29 19:26:09 INFO - PROCESS | 6843 | Values: 3508.2 3564.1 3566.5 3614.3 3641.5 5675.5 5681.8 5694.4 5712.7 5731.8 5681.1 5719.8 5733.2 5733.9 5736.4 5089.6 5120.6 5137.4 5145.9 5226.7 5216.6 5219.2 5221.4 5228.6 5247.3 5140.9 5179.8 5189.4 5189.8 5197.5 5179.1 5217.7 5220.6 5223.3 5262.2 4961.4 5084.8 5112.6 5145.4 5176.5 4628.6 5541.1 5554.6 5575.9 5621.2 6200.3 6216.6 6224.7 6229.3 6231.7 6164.2 6190.3 6292.0 6294.9 6328.0 5802.7 5812.8 5813.8 5822.9 5835.2 6339.4 6358.7 6365.6 6371.9 6376.6 6026.9 6093.4 6113.4 6162.5 6166.5 5625.6 6234.8 6261.2 6263.6 6265.6 5959.0 6073.0 6128.1 6169.8 6190.8 6132.7 6179.8 6188.9 6193.1 6202.0 5014.1 5021.0 5023.7 5024.5 5043.4 4323.9 4324.8 4498.6 4544.2 4552.8 4961.7 5893.3 5925.2 5926.1 5973.2 6305.9 6317.4 6321.0 6322.5 6340.2 5740.9 5860.0 5865.4 5976.4 6005.3 4590.9 5404.8 5412.6 5415.3 5423.3 6373.9 6378.0 6398.1 6415.4 6424.2 6099.9 6282.0 6338.2 6349.0 6366.6 6352.7 6369.2 6411.7 6424.6 6442.4 6044.7 6126.8 6250.4 6259.6 6271.0 6299.6 6305.6 6320.2 6327.6 6354.5 6107.2 6110.4 6115.2 6125.4 6139.4 5873.2 5976.9 6056.4 6091.7 6120.7 5945.2 5966.8 5968.7 5980.1 5986.3 5736.6 5979.2 6104.5 6142.2 6142.4 5856.2 5884.3 5899.6 5926.6 5932.0 19:26:09 INFO - PROCESS | 6843 | 19:26:09 INFO - PROCESS | 6843 | [#1] ext.html Cycles:180 Average:64806.58 Median:39755.50 stddev:135982.64 (342.0%) stddev-sans-first:136278.39 19:26:09 INFO - PROCESS | 6843 | Values: 500.4 577.5 586.3 603.0 605.8 31151.2 35909.5 39052.8 39098.0 39220.4 41969.4 42251.6 42393.2 42405.2 42463.8 9658.3 9930.4 9932.3 9934.0 9941.2 9726.3 9808.0 9863.8 9877.5 9895.3 9837.5 9903.3 9905.6 9912.5 9919.3 9828.6 9860.4 9878.7 9880.4 9881.1 9696.2 9832.3 9837.5 9839.0 9848.7 42212.0 42774.6 42894.8 42960.4 43094.0 3149.9 3629.3 3811.5 3921.6 4084.0 28720.4 29830.6 30027.7 30049.5 31010.4 2866.0 2919.7 2944.7 2963.5 3024.3 523341.0 526396.0 527351.0 532799.0 532964.0 46887.0 47246.3 47497.0 65908.7 66184.3 46060.0 46074.0 46193.5 46197.0 46250.1 15576.0 15729.0 15746.7 15749.3 15765.8 12452.0 12466.9 12542.6 12543.0 12556.6 14288.4 14308.9 14345.9 14358.1 14416.4 6403.9 6447.3 6491.2 6537.9 6541.6 962.8 1074.5 1117.6 1189.3 1251.2 28415.9 29487.9 31283.8 31586.2 31976.0 1024.5 1160.9 1174.3 1247.3 1274.9 11266.7 12158.8 12162.9 15324.8 16443.6 575013.0 582202.0 582667.0 583606.0 583886.0 57201.7 57928.7 63773.0 64874.7 65444.0 1461.2 1463.3 1479.4 1480.3 1588.0 29141.0 31001.1 32027.7 32208.8 32241.1 55036.0 55515.9 55517.0 55577.2 55723.4 400785.0 404299.0 404314.0 406909.0 409295.0 33598.0 33669.0 34347.0 34530.5 34956.5 48279.8 50518.7 51969.5 52747.0 53748.2 37771.1 38905.8 39261.0 39460.4 39930.8 38184.6 39248.8 39384.6 39414.8 40352.8 38439.2 39364.0 39383.0 39458.6 39580.2 28696.6 31841.0 34880.8 34916.0 35034.6 26411.7 26595.3 26681.2 26814.9 26844.3 19:26:09 INFO - PROCESS | 6843 | 19:26:09 INFO - PROCESS | 6843 | [#2] jquery.html Cycles:180 Average:36768.08 Median:26625.77 stddev:115560.83 (434.0%) stddev-sans-first:115852.71 19:26:09 INFO - PROCESS | 6843 | Values: 378.4 379.7 385.6 387.7 388.7 16899.0 16912.9 19445.3 21453.9 21515.8 17375.7 17980.6 20754.0 21271.7 21477.0 5689.8 5944.5 5994.6 6007.3 6007.8 4371.4 4563.1 5640.7 5847.0 6265.9 6459.3 6469.3 6472.4 6475.3 6480.1 6153.5 6402.6 6407.3 6420.8 6437.6 5538.6 5558.1 5567.2 5577.4 5577.8 25772.6 26545.3 26706.2 26920.9 26959.6 2059.7 2266.3 2361.7 2437.1 2817.8 10050.6 10074.0 10108.3 10242.3 10410.5 1739.7 1751.7 1758.4 1790.7 1833.1 86380.0 103227.5 103695.0 107332.9 109842.0 9691.5 11019.0 11024.3 11318.7 11332.1 13653.0 13715.8 13728.9 13738.5 13743.0 8239.6 8310.7 8394.5 8401.0 8518.2 8436.2 8466.6 8473.3 8523.2 8529.1 4496.6 4590.0 4607.5 4650.2 4651.8 1570.5 1741.9 1752.8 1807.5 1947.5 878.6 982.3 995.4 1056.9 1065.7 19580.4 20056.7 20095.9 20239.0 20395.6 837.0 974.3 992.9 1037.8 1080.2 8928.2 10313.4 10726.8 10747.5 10843.3 682640.0 686430.0 702942.0 711484.0 721485.0 76059.6 82249.6 126247.4 126622.0 127098.0 1017.8 1021.7 1036.2 1039.5 1039.6 17187.5 17921.0 17951.6 18461.7 18690.8 53011.2 53040.7 53615.5 57330.0 58502.7 61691.8 72450.0 78657.6 78762.8 80584.2 8167.3 8302.8 8386.6 8483.1 8575.9 9720.4 11402.5 14011.9 14152.6 14306.9 9289.1 9465.4 10294.0 10822.6 11876.2 9920.9 10816.5 11610.9 11889.9 11936.3 11355.4 11966.6 12011.1 12026.8 12277.4 8393.6 8399.8 8429.9 8454.2 8629.6 10068.7 10334.1 11122.9 11719.8 12040.6 19:26:09 INFO - PROCESS | 6843 | 19:26:09 INFO - PROCESS | 6843 | [#3] mootools.html Cycles:180 Average:6351.66 Median:5162.86 stddev:3352.88 (64.9%) stddev-sans-first:3341.03 19:26:09 INFO - PROCESS | 6843 | Values: 1329.7 1585.5 1813.8 1967.4 2030.9 9061.9 9089.9 9261.0 9268.7 9299.3 9101.7 9143.0 9148.1 9162.8 9163.5 2520.3 2545.6 2568.1 2571.2 2575.4 2565.4 2590.1 2609.6 2610.7 2613.8 2259.7 2327.8 2499.6 2561.3 2580.7 2486.8 2523.0 2530.0 2531.6 2533.9 2542.6 2553.9 2557.3 2557.8 2566.4 8137.6 8834.0 9008.2 9015.7 9016.1 5668.9 5820.1 5839.4 5846.5 5850.7 3715.3 3816.2 3846.9 3848.7 3859.9 1072.8 1078.6 1081.1 1093.9 1137.5 10483.3 12600.0 12654.9 12659.5 12706.7 5134.6 5136.1 5189.6 5214.7 5231.6 10762.8 10793.6 10795.5 10796.2 10812.2 5838.1 5858.1 5863.4 5877.6 5892.0 5132.4 5233.2 5256.0 5256.6 5258.2 4015.6 4017.0 4026.9 4053.1 4070.5 1314.8 1323.2 1325.8 1334.6 1335.3 1083.8 1101.1 1140.1 1241.5 1457.4 8499.3 8509.6 8556.0 8567.4 8644.5 1250.4 1250.7 1254.1 1257.2 1264.5 6410.2 6440.3 6529.3 6536.7 6546.8 11088.0 11334.1 11426.3 11459.4 11511.4 11022.6 11244.8 11246.3 11327.9 11332.2 8735.2 8798.9 8846.9 8857.4 8868.0 8295.1 8364.0 8395.8 8413.1 8415.1 9970.3 9988.6 10236.9 10287.1 10358.4 10265.2 10452.8 10466.6 10698.1 10700.5 7623.5 7819.8 7825.5 7832.1 7852.1 8563.8 8599.2 8696.0 8703.9 8706.8 6480.7 7327.7 7789.3 7799.5 7930.7 6516.7 7493.8 7507.6 7612.0 7614.2 8010.4 8014.2 8068.0 8069.7 8075.4 6208.7 6225.5 7294.6 7298.8 7346.9 7462.3 7509.4 7596.8 7605.2 7619.0 19:26:09 INFO - PROCESS | 6843 | 19:26:09 INFO - PROCESS | 6843 | [#4] prototype.html Cycles:180 Average:5565.89 Median:6239.00 stddev:1787.87 (28.7%) stddev-sans-first:1748.69 19:26:09 INFO - PROCESS | 6843 | Values: 302.2 325.9 336.8 338.4 341.3 6012.8 6239.0 6307.7 6374.8 6406.1 5500.5 5619.1 6123.9 6163.2 6184.8 4648.3 4662.0 4666.8 4667.5 4677.5 4673.6 4680.3 4682.0 4682.6 4689.6 4398.4 4491.3 4562.0 4629.2 4698.4 4626.2 4643.0 4650.0 4670.9 4673.2 4038.7 4043.1 4052.3 4052.5 4053.7 5965.9 5976.7 5983.5 5987.1 6023.4 5424.6 5472.8 5489.7 5491.4 5493.9 6440.0 6667.1 6682.9 6713.7 6751.4 3775.4 4580.8 4587.7 4594.1 4600.4 7155.9 7171.9 7172.9 7189.5 7194.3 4359.5 4500.1 4507.0 4508.9 4514.1 4631.2 4638.7 4643.8 4649.8 4656.6 5404.9 5411.8 5422.8 5426.3 5428.9 6806.9 6826.0 6829.8 6838.9 6840.1 1494.0 1532.9 1573.3 1593.2 1604.0 1016.9 1039.6 1041.0 1042.9 1046.3 5292.5 6395.1 6423.4 6467.7 6498.4 6962.2 7094.4 7117.1 7118.7 7122.3 6441.4 6456.9 6457.3 6481.9 6495.6 3610.4 3648.0 3661.9 3670.5 3680.9 7385.4 7422.6 7668.4 7681.8 7702.2 6239.0 7140.6 7332.7 7373.3 7383.6 7628.8 7644.4 7665.8 7665.8 7681.7 7110.0 7110.5 7115.7 7121.3 7132.1 6677.2 6958.4 6966.8 6979.3 7012.6 5709.8 7542.5 7572.5 7573.2 7586.4 4287.3 4561.8 4563.7 4575.3 4576.2 5680.3 5773.7 7069.5 7076.4 7080.9 6257.4 6586.0 6600.9 6731.9 6738.5 6775.2 6801.8 6805.8 6824.3 6828.4 6666.9 6675.1 6692.2 6694.1 6701.9 6547.9 6829.4 6834.3 6837.6 6873.1 6630.2 6683.0 6690.8 6708.4 6711.8 19:26:09 INFO - PROCESS | 6843 | 19:26:09 INFO - PROCESS | 6843 | [#5] yui.html Cycles:180 Average:19354.50 Median:27127.90 stddev:27165.65 (100.1%) stddev-sans-first:27205.69 19:26:09 INFO - PROCESS | 6843 | Values: 687.7 701.8 766.0 785.9 786.6 15591.1 15737.8 15802.7 15840.4 15848.7 14486.4 14507.3 14567.9 14570.9 14594.1 768.2 790.0 915.2 944.0 945.0 942.7 949.4 954.5 956.1 959.1 825.9 1008.5 1015.7 1017.9 1018.5 981.8 1005.0 1008.5 1009.5 1009.7 752.6 753.1 753.7 755.1 756.1 15165.4 15200.0 15270.9 15294.8 15306.2 13437.5 13520.6 13587.2 13603.8 13616.8 10371.7 11342.1 11497.3 12031.3 12068.3 3500.2 3615.7 3624.0 3627.1 3630.8 77525.0 77554.8 78345.0 78389.0 78458.2 9888.1 10004.6 10019.5 10129.8 10213.7 21274.7 21367.4 21378.5 21439.8 21537.9 6256.6 7752.9 7919.8 7958.7 8168.2 4243.4 4245.4 4282.9 4283.3 4302.2 3751.3 3798.7 3804.7 3805.0 3817.4 746.3 756.4 760.2 768.2 771.1 634.3 635.2 637.9 654.8 676.3 8686.9 9010.1 9037.2 9103.2 9208.3 642.9 647.8 653.2 660.5 662.5 4218.6 4221.5 4253.9 4368.0 4630.8 88580.0 96816.5 96856.0 96983.0 97090.5 83939.2 85893.0 86317.0 87277.0 87372.6 75534.1 75610.0 76011.9 76798.2 79063.6 9280.5 9365.0 9402.7 9504.5 9529.5 49625.0 52555.2 53044.0 54874.9 56062.4 74808.6 75501.0 75823.2 76924.0 77968.1 11494.5 11650.4 11685.7 11924.8 12225.3 12210.5 12325.5 12333.6 12688.1 12723.0 9712.5 12118.6 12174.7 12211.5 12563.2 11998.0 12010.3 12021.3 12031.4 12037.5 11850.6 11860.5 11864.0 11864.3 11885.5 10249.9 10334.9 10472.5 10496.0 10646.9 9195.7 9468.8 9509.8 9590.0 9623.3 19:26:09 INFO - PROCESS | 6843 | -------- Summary: end -------- 19:26:09 INFO - PROCESS | 6843 | 19:26:10 INFO - TEST-INFO | 6843: exit 0 19:26:10 INFO - TEST-OK | dromaeo_css | took 1110478ms 19:26:10 INFO - TEST-START | kraken 19:26:10 INFO - operating with platform_type : mac_ 19:26:10 INFO - Initialising browser for kraken test... 19:26:10 INFO - TEST-INFO | started process 6845 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/tmp2y8vV8/profile http://localhost:59653/getInfo.html) 19:26:12 INFO - PROCESS | 6845 | __metrics Screen width/height:1600/1200 19:26:12 INFO - PROCESS | 6845 | colorDepth:24 19:26:12 INFO - PROCESS | 6845 | Browser inner width/height: 1024/689 19:26:12 INFO - PROCESS | 6845 | __metrics 19:26:12 INFO - PROCESS | 6845 | 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" 19:26:12 INFO - PROCESS | 6845 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:26:12 INFO - TEST-INFO | 6845: exit 0 19:26:12 INFO - Browser initialized. 19:26:12 INFO - Running cycle 1/1 for kraken test... 19:26:12 INFO - TEST-INFO | started process 6847 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/237d458d70v0srksgx6f_qt800000w/T/tmp2y8vV8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:24 INFO - PROCESS | 6847 | RSS: Main: 159621120 19:26:24 INFO - PROCESS | 6847 | 19:26:27 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59653/tests/kraken/driver.html?testName=audio-beat-detection) 19:26:27 INFO - PROCESS | 6847 | RSS: Main: 215531520 19:26:27 INFO - PROCESS | 6847 | 19:26:30 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59653/tests/kraken/driver.html?testName=audio-dft) 19:26:31 INFO - PROCESS | 6847 | RSS: Main: 224665600 19:26:31 INFO - PROCESS | 6847 | 19:26:34 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59653/tests/kraken/driver.html?testName=audio-fft) 19:26:34 INFO - PROCESS | 6847 | RSS: Main: 214310912 19:26:34 INFO - PROCESS | 6847 | 19:26:36 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59653/tests/kraken/driver.html?testName=audio-oscillator) 19:26:37 INFO - PROCESS | 6847 | RSS: Main: 215674880 19:26:37 INFO - PROCESS | 6847 | 19:26:39 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59653/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:26:40 INFO - PROCESS | 6847 | RSS: Main: 217260032 19:26:40 INFO - PROCESS | 6847 | 19:26:42 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59653/tests/kraken/driver.html?testName=imaging-darkroom) 19:26:43 INFO - PROCESS | 6847 | RSS: Main: 215699456 19:26:43 INFO - PROCESS | 6847 | 19:26:46 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59653/tests/kraken/driver.html?testName=imaging-desaturate) 19:26:46 INFO - PROCESS | 6847 | RSS: Main: 217485312 19:26:46 INFO - PROCESS | 6847 | 19:26:49 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59653/tests/kraken/driver.html?testName=json-parse-financial) 19:26:49 INFO - PROCESS | 6847 | RSS: Main: 217956352 19:26:49 INFO - PROCESS | 6847 | 19:26:51 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59653/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:26:51 INFO - PROCESS | 6847 | RSS: Main: 251457536 19:26:51 INFO - PROCESS | 6847 | 19:26:53 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59653/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:26:54 INFO - PROCESS | 6847 | RSS: Main: 253308928 19:26:54 INFO - PROCESS | 6847 | 19:26:56 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59653/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:26:57 INFO - PROCESS | 6847 | RSS: Main: 258265088 19:26:57 INFO - PROCESS | 6847 | 19:26:59 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:27:00 INFO - PROCESS | 6847 | RSS: Main: 258859008 19:27:00 INFO - PROCESS | 6847 | 19:27:02 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:27:03 INFO - PROCESS | 6847 | RSS: Main: 259207168 19:27:03 INFO - PROCESS | 6847 | 19:27:04 INFO - PROCESS | 6847 | Cycle 1(1): loaded http://localhost:59653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59653/tests/kraken/driver.html?testName=ai-astar) 19:27:05 INFO - PROCESS | 6847 | RSS: Main: 320458752 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | __start_tp_report 19:27:05 INFO - PROCESS | 6847 | _x_x_mozilla_page_load 19:27:05 INFO - PROCESS | 6847 | _x_x_mozilla_page_load_details 19:27:05 INFO - PROCESS | 6847 | |i|pagename|runs| 19:27:05 INFO - PROCESS | 6847 | |0;ai-astar;112;110;110;110;113;112;122;110;109;109 19:27:05 INFO - PROCESS | 6847 | |1;audio-beat-detection;155;120;153;151;144;168;146;160;144;117 19:27:05 INFO - PROCESS | 6847 | |2;audio-dft;182;180;184;183;200;256;184;184;184;185 19:27:05 INFO - PROCESS | 6847 | |3;audio-fft;73;79;76;112;54;56;58;58;117;59 19:27:05 INFO - PROCESS | 6847 | |4;audio-oscillator;89;98;129;83;111;119;137;78;77;116 19:27:05 INFO - PROCESS | 6847 | |5;imaging-gaussian-blur;84;91;84;91;84;89;83;93;85;112 19:27:05 INFO - PROCESS | 6847 | |6;imaging-darkroom;93;93;94;93;94;94;93;93;94;93 19:27:05 INFO - PROCESS | 6847 | |7;imaging-desaturate;85;84;87;85;86;84;85;87;85;86 19:27:05 INFO - PROCESS | 6847 | |8;json-parse-financial;56;57;58;57;61;58;58;55;50;50 19:27:05 INFO - PROCESS | 6847 | |9;json-stringify-tinderbox;62;62;66;74;73;69;66;67;67;69 19:27:05 INFO - PROCESS | 6847 | |10;stanford-crypto-aes;80;82;81;81;81;81;79;79;85;85 19:27:05 INFO - PROCESS | 6847 | |11;stanford-crypto-ccm;126;122;120;123;117;125;126;122;129;111 19:27:05 INFO - PROCESS | 6847 | |12;stanford-crypto-pbkdf2;133;121;131;132;130;125;131;159;130;131 19:27:05 INFO - PROCESS | 6847 | |13;stanford-crypto-sha256-iterative;65;66;65;65;63;67;80;97;95;94 19:27:05 INFO - PROCESS | 6847 | __end_tp_report 19:27:05 INFO - PROCESS | 6847 | __start_cc_report 19:27:05 INFO - PROCESS | 6847 | _x_x_mozilla_cycle_collect,1089 19:27:05 INFO - PROCESS | 6847 | __end_cc_report 19:27:05 INFO - PROCESS | 6847 | __startTimestamp1456802825145__endTimestamp 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | ------- Summary: start ------- 19:27:05 INFO - PROCESS | 6847 | Number of tests: 14 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.00 stddev:3.86 (3.5%) stddev-sans-first:4.09 19:27:05 INFO - PROCESS | 6847 | Values: 112.0 110.0 110.0 110.0 113.0 112.0 122.0 110.0 109.0 109.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:152.00 stddev:16.19 (10.7%) stddev-sans-first:16.83 19:27:05 INFO - PROCESS | 6847 | Values: 155.0 120.0 153.0 151.0 144.0 168.0 146.0 160.0 144.0 117.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#2] audio-dft Cycles:10 Average:192.20 Median:184.00 stddev:23.07 (12.5%) stddev-sans-first:24.17 19:27:05 INFO - PROCESS | 6847 | Values: 182.0 180.0 184.0 183.0 200.0 256.0 184.0 184.0 184.0 185.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#3] audio-fft Cycles:10 Average:74.20 Median:58.50 stddev:23.05 (39.4%) stddev-sans-first:24.45 19:27:05 INFO - PROCESS | 6847 | Values: 73.0 79.0 76.0 112.0 54.0 56.0 58.0 58.0 117.0 59.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:77.50 stddev:21.70 (28.0%) stddev-sans-first:22.36 19:27:05 INFO - PROCESS | 6847 | Values: 89.0 98.0 129.0 83.0 111.0 119.0 137.0 78.0 77.0 116.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:87.00 stddev:8.67 (10.0%) stddev-sans-first:8.96 19:27:05 INFO - PROCESS | 6847 | Values: 84.0 91.0 84.0 91.0 84.0 89.0 83.0 93.0 85.0 112.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 19:27:05 INFO - PROCESS | 6847 | Values: 93.0 93.0 94.0 93.0 94.0 94.0 93.0 93.0 94.0 93.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:1.07 (1.3%) stddev-sans-first:1.13 19:27:05 INFO - PROCESS | 6847 | Values: 85.0 84.0 87.0 85.0 86.0 84.0 85.0 87.0 85.0 86.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.50 stddev:3.53 (6.1%) stddev-sans-first:3.74 19:27:05 INFO - PROCESS | 6847 | Values: 56.0 57.0 58.0 57.0 61.0 58.0 58.0 55.0 50.0 50.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:3.98 (5.9%) stddev-sans-first:3.69 19:27:05 INFO - PROCESS | 6847 | Values: 62.0 62.0 66.0 74.0 73.0 69.0 66.0 67.0 67.0 69.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:2.12 (2.6%) stddev-sans-first:2.19 19:27:05 INFO - PROCESS | 6847 | Values: 80.0 82.0 81.0 81.0 81.0 81.0 79.0 79.0 85.0 85.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:124.00 stddev:5.17 (4.2%) stddev-sans-first:5.29 19:27:05 INFO - PROCESS | 6847 | Values: 126.0 122.0 120.0 123.0 117.0 125.0 126.0 122.0 129.0 111.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.30 Median:131.00 stddev:10.06 (7.7%) stddev-sans-first:10.66 19:27:05 INFO - PROCESS | 6847 | Values: 133.0 121.0 131.0 132.0 130.0 125.0 131.0 159.0 130.0 131.0 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - PROCESS | 6847 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:73.50 stddev:14.35 (19.5%) stddev-sans-first:14.69 19:27:05 INFO - PROCESS | 6847 | Values: 65.0 66.0 65.0 65.0 63.0 67.0 80.0 97.0 95.0 94.0 19:27:05 INFO - PROCESS | 6847 | -------- Summary: end -------- 19:27:05 INFO - PROCESS | 6847 | 19:27:05 INFO - TEST-INFO | 6847: exit 0 19:27:05 INFO - TEST-OK | kraken | took 55427ms 19:27:05 INFO - SUITE-END | took 1165s 19:27:05 INFO - Completed test suite (00:19:25) 19:27:05 INFO - Working with test: dromaeo_css 19:27:05 INFO - Generating results file: dromaeo_css 19:27:05 INFO - Working with test: kraken 19:27:05 INFO - Generating results file: kraken 19:27:05 INFO - javascript benchmark 19:27:05 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:27:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,173,59]] 19:27:06 INFO - process_Request line: dromaeo_css 7670.75 graph.html#tests=[[72,173,59]] 19:27:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:27:06 INFO - process_Request line: kraken 1431.00 graph.html#tests=[[232,173,59]] 19:27:06 INFO - RETURN: dromaeo_css: 7670.75 19:27:06 INFO - RETURN: kraken: 1431.00 19:27:06 INFO - javascript benchmark 19:27:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3508.193115583416, 3564.055525285801, 3566.500689903414, 3614.34941710492, 3641.4719865619486, 5675.51758100562, 5681.801136960207, 5694.430556944309, 5712.71436428178, 5731.828045158647, 5681.119426488891, 5719.799807006755, 5733.197352370661, 5733.913991290124, 5736.397678243787, 5089.567386772129, 5120.641555091145, 5137.434882162968, 5145.948540514603, 5226.712530810804, 5216.58267338612, 5219.243209734586, 5221.399539053001, 5228.5555727763185, 5247.344081989751, 5140.871478213037, 5179.766910489018, 5189.351331083614, 5189.766460509286, 5197.532222100011, 5179.093658609747, 5217.713025783581, 5220.634555581111, 5223.268742376071, 5262.158054711228, 4961.429435614915, 5084.79660813567, 5112.642115051948, 5145.3568303962, 5176.50823171798, 4628.583427491542, 5541.0580201365865, 5554.611177217596, 5575.916361254584, 5621.241132447109, 6200.255969283715, 6216.595921265149, 6224.688765561704, 6229.314775374751, 6231.688415579203, 6164.167837341946, 6190.257169139687, 6292.0, 6294.905576416358, 6327.96836015817, 5802.65184088956, 5812.82561523155, 5813.76744930198, 5822.9417705822825, 5835.212246346731, 6339.366063393623, 6358.713857876407, 6365.649889256043, 6371.936280637227, 6376.585521941059, 6026.939730602726, 6093.360197179321, 6113.354685976905, 6162.506999440034, 6166.537509686702, 5625.648588126003, 6234.781782637677, 6261.217347831521, 6263.592866463665, 6265.624062556261, 5959.0, 6072.967595508774, 6128.1114238435175, 6169.753209871555, 6190.7523699052435, 6132.695218635848, 6179.84550386235, 6188.907166392508, 6193.1329613854095, 6202.0, 5014.147594908874, 5021.020900924358, 5023.723695196726, 5024.547790698854, 5043.394792624835, 4323.870283891489, 4324.805383757738, 4498.5501449854755, 4544.2047641662575, 4552.817887284537, 4961.727105009187, 5893.292804863444, 5925.170476133345, 5926.081457374114, 5973.223480947449, 6305.873882522324, 6317.431431171217, 6320.968395157995, 6322.462590679752, 6340.175777149033, 5740.913886291709, 5859.970700146558, 5865.413458654186, 5976.402359764076, 6005.279366475964, 4590.862274131781, 5404.83785486436, 5412.594055445778, 5415.323084614423, 5423.29497165366, 6373.936260637427, 6378.0, 6398.1362516059735, 6415.422611964946, 6424.196975378078, 6099.9390006099375, 6282.0, 6338.239411270677, 6348.968255158879, 6366.554341196072, 6352.745890164341, 6369.235691717024, 6411.711472983634, 6424.582402143846, 6442.35576442352, 6044.7279872406725, 6126.823043872828, 6250.406211409909, 6259.561830671809, 6271.0, 6299.590526615939, 6305.621662700252, 6320.178376810985, 6327.620342779448, 6354.491640668828, 6107.175531303395, 6110.358412366815, 6115.235595550556, 6125.356837531995, 6139.386061393825, 5873.236479257669, 5976.940230597638, 6056.36408177135, 6091.695415229309, 6120.663363515049, 5945.167676525203, 5966.791162309299, 5968.731407086605, 5980.1328807321825, 5986.2517185351835, 5736.5984381094595, 5979.162917191509, 6104.481119104926, 6142.201513803177, 6142.447179753844, 5856.150858125633, 5884.293884733859, 5899.616524925866, 5926.555508336805, 5932.0], "unit": "score", "name": "dojo.html", "value": 5710.724508932764}, {"lowerIsBetter": false, "replicates": [500.3895247797686, 577.5495113811226, 586.34329550903, 602.9698515074246, 605.8428401752652, 31151.221219469524, 35909.46135807965, 39052.80473597628, 39098.0, 39220.411693824615, 41969.37045944305, 42251.57748422515, 42393.152136957244, 42405.15189696212, 42463.78768106155, 9658.27562932781, 9930.404175749441, 9932.304738668296, 9933.950330248339, 9941.155001824853, 9726.270529710264, 9808.0, 9863.802723945517, 9877.45673987934, 9895.307328486973, 9837.508124593742, 9903.306768526207, 9905.603775848957, 9912.454814985173, 9919.3056486046, 9828.606855725762, 9860.408375497493, 9878.654247101389, 9880.35777674449, 9881.110700037032, 9696.224302055889, 9832.262580306506, 9837.508124593813, 9839.0, 9848.655297064568, 42212.0, 42774.57225427737, 42894.78552607248, 42960.35559466611, 43094.0, 3149.9055028348957, 3629.3467175908327, 3811.4854494643146, 3921.568627450978, 4083.9994201420545, 28720.425591488052, 29830.55254171189, 30027.69972300271, 30049.549256761165, 31010.379792404252, 2866.0, 2919.722626350493, 2944.749696275819, 2963.4962056450454, 3024.3346463777934, 523341.0, 526396.0, 527351.0, 532799.0, 532964.0, 46887.0, 47246.291305630446, 47497.0, 65908.67045664837, 66184.33815661877, 46060.0, 46074.0, 46193.53806461892, 46197.0, 46250.07499849984, 15575.987560808511, 15729.0, 15746.68506629861, 15749.291281892343, 15765.763513547307, 12452.003839692803, 12466.875331246752, 12542.623721288375, 12543.0, 12556.623301300975, 14288.428462861577, 14308.928455357656, 14345.856541434452, 14358.066725662798, 14416.351264193136, 6403.903941440882, 6447.25856526496, 6491.188601424822, 6537.8692426152165, 6541.640209788412, 962.7978124593914, 1074.463517170438, 1117.5523509971665, 1189.2507720136432, 1251.1867286264, 28415.857920710678, 29487.852560737058, 31283.84358078195, 31586.210344741106, 31976.0, 1024.5440778853338, 1160.9013233875214, 1174.2602160638914, 1247.3451437995125, 1274.8661390554043, 11266.66200014001, 12158.756824863452, 12162.939185304194, 15324.770128448083, 16443.58891027734, 575013.0, 582202.0, 582667.0, 583606.0, 583886.0, 57201.71399143061, 57928.71035644795, 63773.0, 64874.67562662157, 65444.0, 1461.203644014015, 1463.334182946778, 1479.3860547872512, 1480.2746654139394, 1587.9757556376073, 29141.0, 31001.05815880397, 32027.67972320247, 32208.83895580507, 32241.06817034349, 55036.0, 55515.88968220532, 55517.0, 55577.166342505705, 55723.442765571825, 400785.0, 404299.0, 404314.0, 406909.0, 409295.0, 33598.0, 33669.0, 34347.0, 34530.482042768876, 34956.47565286574, 48279.793005175154, 50518.74740626274, 51969.480305197976, 52747.0, 53748.193777092594, 37771.05572360713, 38905.80547097247, 39261.018474537224, 39460.40809387919, 39930.80034599808, 38184.61815381922, 39248.80375598218, 39384.60615393924, 39414.80292598519, 40352.79823600863, 38439.231215376094, 39364.01589960274, 39383.0, 39458.60541394549, 39580.208395832495, 28696.569551457163, 31841.04476865698, 34880.779172728835, 34916.0, 35034.64965350314, 26411.73588264093, 26595.33511662224, 26681.19956401311, 26814.927402903664, 26844.328891777863], "unit": "score", "name": "ext.html", "value": 19877.12286053416}, {"lowerIsBetter": false, "replicates": [378.421015845756, 379.68106790296144, 385.5912732503546, 387.6743535430238, 388.7337174035784, 16898.98606083636, 16912.915435422805, 19445.319413820518, 21453.892730536347, 21515.784842151574, 17375.73936390955, 17980.55048623785, 20754.0, 21271.680924786142, 21477.0, 5689.800856970017, 5944.524438044968, 5994.6403215807195, 6007.309159446676, 6007.7596896124105, 4371.431713877191, 4563.06457176278, 5640.661560306395, 5846.970765146169, 6265.937340626604, 6459.289478157399, 6469.320721324264, 6472.446612812938, 6475.255345635242, 6480.125183100268, 6153.507719382439, 6402.6158430494315, 6407.295197528291, 6420.775272865428, 6437.613743175401, 5538.556915446755, 5558.138488534284, 5567.220589117527, 5577.44225577439, 5577.8047768328315, 25772.613410798855, 26545.336366590796, 26706.19881403561, 26920.865395672896, 26959.595606065926, 2059.7116403703494, 2266.263464374085, 2361.740208577055, 2437.146998550511, 2817.7604903583015, 10050.597976080948, 10073.99260073994, 10108.342957707799, 10242.28304018719, 10410.531526081344, 1739.6694628020637, 1751.658426606812, 1758.3669878843607, 1790.7313902914536, 1833.14758637233, 86380.0, 103227.45158822699, 103695.0, 107332.92667073307, 109842.0, 9691.466969316614, 11018.95319944604, 11024.346348047857, 11318.660440186808, 11332.093432525378, 13653.04428690002, 13715.794263086062, 13728.931355343359, 13738.450461981609, 13742.969277304242, 8239.629216685264, 8310.667573297122, 8394.45436046655, 8401.0, 8518.190771876662, 8436.198561136682, 8466.576671166416, 8473.279771219391, 8523.232909038215, 8529.14708529142, 4496.6177874881005, 4589.954100459019, 4607.470140933836, 4650.162970665313, 4651.813927442932, 1570.5209910977032, 1741.9216135273944, 1752.816848627197, 1807.493901707524, 1947.51312171957, 878.5958459108881, 982.3418309732497, 995.3928103856641, 1056.9260151789301, 1065.728239298974, 19580.412587622395, 20056.69914951277, 20095.899520502597, 20239.0, 20395.592088158155, 836.998719183444, 974.3325821812082, 992.8907820139779, 1037.7976294622476, 1080.2330345454816, 8928.241099506486, 10313.381197128196, 10726.785464290671, 10747.516361763739, 10843.3254989444, 682640.0, 686430.0, 702942.0, 711484.0, 721485.0, 76059.61970190113, 82249.58875205586, 126247.3687631556, 126622.0, 127098.0, 1017.7659138398062, 1021.7394564386034, 1036.1555332404066, 1039.464675692004, 1039.6413237433073, 17187.484375468757, 17921.0, 17951.551211219303, 18461.723074154168, 18690.81309186945, 53011.20483192832, 53040.73479632577, 53615.46384536261, 57330.0, 58502.70748646229, 61691.766164677356, 72450.0, 78657.60671196607, 78762.81855772053, 80584.19415806001, 8167.305779008851, 8302.750917472486, 8386.580670966548, 8483.06686264498, 8575.914240857512, 9720.368176068532, 11402.543898244308, 14011.859881401055, 14152.646183845487, 14306.926980476297, 9289.124878648065, 9465.432074075577, 10294.0, 10822.621208257673, 11876.168668193144, 9920.900790991998, 10816.513256903301, 11610.88389116098, 11889.881101189223, 11936.343501107174, 11355.37545435009, 11966.64100076999, 12011.057704280985, 12026.819597705866, 12277.386130693609, 8393.622286996977, 8399.790005249917, 8429.873551896604, 8454.239118479367, 8629.568521574021, 10068.69793906184, 10334.069933706003, 11122.944385278022, 11719.824202637137, 12040.578579750018], "unit": "score", "name": "jquery.html", "value": 9525.035981475681}, {"lowerIsBetter": false, "replicates": [1329.6542898846299, 1585.476792658423, 1813.8186181381864, 1967.3901090661905, 2030.8781473111605, 9061.864072038916, 9089.90910090899, 9260.953695231532, 9268.721938341852, 9299.349045566812, 9101.681441149562, 9142.954285228581, 9148.085191480848, 9162.816743665122, 9163.496007719572, 2520.3447103752974, 2545.5799793034175, 2568.114000669766, 2571.241483762285, 2575.381908341994, 2565.422779874523, 2590.1452520668136, 2609.621604867293, 2610.6606141201714, 2613.8170328077044, 2259.7062381890332, 2327.813774898004, 2499.6250562415603, 2561.3340531461863, 2580.6903171619433, 2486.825922185448, 2523.0, 2529.962050569243, 2531.556977528925, 2533.9493210135693, 2542.567763480194, 2553.9106131285503, 2557.2711777143427, 2557.8465292082533, 2566.396896729267, 8137.593120344019, 8834.0, 9008.234300084501, 9015.729528114167, 9016.05331440196, 5668.858278543028, 5820.097884827858, 5839.416058394169, 5846.473817356458, 5850.6782126983, 3715.2755212733528, 3816.217675376569, 3846.903827404309, 3848.730588858781, 3859.8842034739005, 1072.769354588767, 1078.6440474643348, 1081.086481922774, 1093.923425360225, 1137.4881303413415, 10483.318584292072, 12599.992000639926, 12654.936725316407, 12659.493620255178, 12706.682332941751, 5134.640575159703, 5136.075506408883, 5189.636725429184, 5214.713190774544, 5231.55531779803, 10762.784744305227, 10793.568257269779, 10795.46022698862, 10796.244262901679, 10812.243142980073, 5838.095095260242, 5858.121281807763, 5863.355030946593, 5877.588568800228, 5892.0, 5132.384113906355, 5233.162693968947, 5256.0, 5256.6320357574605, 5258.2112683097075, 4015.5984401560195, 4016.979915100406, 4026.8993275168355, 4053.0880551875593, 4070.531888832763, 1314.8290722206243, 1323.2060763541797, 1325.847527534346, 1334.552924770213, 1335.3056410666593, 1083.7832433513329, 1101.1081024370285, 1140.0822338017974, 1241.4599649152647, 1457.4388860288652, 8499.277561407225, 8509.61706723199, 8555.957220213984, 8567.4002819802, 8644.524551149621, 1250.4060571228595, 1250.7435975625158, 1254.1158483269273, 1257.1639859493516, 1264.4752427742385, 6410.166678331787, 6440.291567927524, 6529.314421985623, 6536.738530458823, 6546.803595892131, 11088.0, 11334.093272538177, 11426.314421134759, 11459.369734664508, 11511.366874821964, 11022.614208502664, 11244.831327530093, 11246.268992515461, 11327.886721132849, 11332.150088743378, 8735.213830755136, 8798.912010879938, 8846.867296990551, 8857.3799834011, 8867.980182278992, 8295.087540370676, 8363.958180209303, 8395.790105247417, 8413.116622754767, 8415.074341822517, 9970.252231082843, 9988.550515226978, 10236.948815255875, 10287.125594324267, 10358.430286334022, 10265.230107742098, 10452.843207352047, 10466.581336746749, 10698.14414846826, 10700.464976751287, 7623.504472209289, 7819.84360312802, 7825.530468171928, 7832.0601527817025, 7852.13626501073, 8563.785905352415, 8599.22606965351, 8695.95652021761, 8703.91296087031, 8706.782330441789, 6480.70836812354, 7327.670254838438, 7789.298963093349, 7799.45403821727, 7930.682772689028, 6516.73933042673, 7493.775186744407, 7507.587082710504, 7612.0, 7614.200508946481, 8010.359171266401, 8014.19858014194, 8067.991501062367, 8069.717559885611, 8075.353971682134, 6208.658523781235, 6225.501959843111, 7294.635268236673, 7298.781036568911, 7346.926530734838, 7462.328390444886, 7509.3617042552, 7596.772096837104, 7605.163432022362, 7619.0], "unit": "score", "name": "mootools.html", "value": 5169.370237063814}, {"lowerIsBetter": false, "replicates": [302.2006792035066, 325.9185203699075, 336.76258237942255, 338.3672532364478, 341.344618332801, 6012.819615411534, 6239.032949892762, 6307.747690092397, 6374.8406289842715, 6406.135171751806, 5500.50495455409, 5619.072852979264, 6123.908141377883, 6163.167972323746, 6184.845378865531, 4648.349231107648, 4661.953380466186, 4666.76666166692, 4667.4632417272105, 4677.532246775329, 4673.626109911199, 4680.321353403771, 4681.969966607341, 4682.6019788318035, 4689.648276379268, 4398.362237475564, 4491.326301054835, 4561.954380456203, 4629.240888462379, 4698.389209402773, 4626.190416677102, 4642.953570464286, 4649.953500465002, 4670.929936050945, 4673.182193116225, 4038.676905847525, 4043.1307268937026, 4052.3111071117983, 4052.53395859477, 4053.6757059435176, 5965.940340596625, 5976.73104710289, 5983.461488466015, 5987.131865879466, 6023.397660233985, 5424.566034717213, 5472.781088756445, 5489.670619762787, 5491.423400542925, 5493.890122197534, 6440.0, 6667.066610674509, 6682.866342673168, 6713.664316784141, 6751.392374686302, 3775.3959366501226, 4580.839670611546, 4587.7017993830295, 4594.104149690812, 4600.35595016698, 7155.856882862314, 7171.856562868714, 7172.856542869165, 7189.532680375759, 7194.316539928698, 4359.542248063971, 4500.054988452396, 4507.030988337523, 4508.864734057984, 4514.074614703978, 4631.235846085426, 4638.652101092364, 4643.814247430132, 4649.790759415834, 4656.604188643935, 5404.864878377994, 5411.78352865881, 5422.8373148805595, 5426.34883813937, 5428.945710542844, 6806.863862722717, 6826.044353790473, 6829.795106146824, 6838.93161068383, 6840.144981877265, 1493.9626509337136, 1532.8850336224828, 1573.2762929052765, 1593.2033983008496, 1603.9599010024842, 1016.867807185076, 1039.6413237433073, 1041.0110395124661, 1042.8800687920987, 1046.3303485769113, 5292.497212764782, 6395.104685343963, 6423.42189202974, 6467.741290348427, 6498.3826536478955, 6962.2341542430295, 7094.396976256973, 7117.110361204849, 7118.715251389886, 7122.2521635228595, 6441.355864413521, 6456.903146452807, 6457.2574153971955, 6481.870362592722, 6495.642739649365, 3610.4403817408343, 3647.9817600912356, 3661.9267614647556, 3670.504481894963, 3680.9263814723554, 7385.3722433592675, 7422.591757453392, 7668.38652907766, 7681.7695469136015, 7702.152763196156, 6238.970569856014, 7140.6072666003865, 7332.743353982585, 7373.33639972405, 7383.556986580822, 7628.771136865903, 7644.426668000034, 7665.776924691777, 7665.808354791175, 7681.692732290758, 7109.964450177716, 7110.537815042006, 7115.715371385087, 7121.323474269936, 7132.144142702701, 6677.198736151693, 6958.443324533924, 6966.825829354307, 6979.267176946348, 7012.5792452453015, 5709.829484955657, 7542.509736867086, 7572.545647261182, 7573.242675732383, 7586.355159811478, 4287.3140297552245, 4561.77191140435, 4563.680542362003, 4575.267957126977, 4576.244919588231, 5680.318361796611, 5773.672055427359, 7069.505134640526, 7076.363127318566, 7080.858382832417, 6257.405546473078, 6585.967070164618, 6600.933990660032, 6731.932680673131, 6738.528303018742, 6775.186977562724, 6801.795946121624, 6805.761798337035, 6824.283450237852, 6828.419584335188, 6666.899996499959, 6675.132232809704, 6692.163479565054, 6694.096296999843, 6701.932980670131, 6547.869042619216, 6829.419499342612, 6834.282400347892, 6837.589744615339, 6873.140857392826, 6630.171228596426, 6682.966585167043, 6690.83272918181, 6708.396244338033, 6711.765088221889], "unit": "score", "name": "prototype.html", "value": 4973.546618692906}, {"lowerIsBetter": false, "replicates": [687.7420967137324, 701.8105111619861, 766.0309708219104, 785.9410544209184, 786.6381464526318, 15591.1424871632, 15737.84262157378, 15802.683946321067, 15840.445584404548, 15848.683026339466, 14486.420543178287, 14507.27463626817, 14567.854321456782, 14570.854291457108, 14594.05138665986, 768.2279309294152, 790.0203747353298, 915.1717695485596, 943.9716808495722, 945.0219023310875, 942.726609283307, 949.4398305000049, 954.5465903695724, 956.0582825916501, 959.1319855530755, 825.9463134896242, 1008.5159123620666, 1015.7206768138747, 1017.8829434615003, 1018.4856647393057, 981.8478135888948, 1005.0301459092011, 1008.4554340656036, 1009.5356136177404, 1009.7273736091214, 752.6124046116255, 753.0549160803157, 753.6796861333911, 755.1014292991323, 756.130449982519, 15165.393384264617, 15200.011999220125, 15270.923645381701, 15294.847051529565, 15306.234688265542, 13437.462501500026, 13520.59438216855, 13587.184768913898, 13603.843673287782, 13616.795748063787, 10371.740706482324, 11342.14933879954, 11497.310161390344, 12031.278123312542, 12068.275903445734, 3500.2474467989505, 3615.710743140569, 3624.0, 3627.075095850568, 3630.8366123524506, 77525.0, 77554.83667744989, 78345.0, 78388.99999999943, 78458.21541784565, 9888.110070093726, 10004.649837255662, 10019.499025048719, 10129.848052279222, 10213.693589192188, 21274.680879786814, 21367.35897923065, 21378.465538361666, 21439.78560214409, 21537.892310538347, 6256.562040657202, 7752.922470775333, 7919.762407127795, 7958.721444749406, 8168.183181681903, 4243.405923170759, 4245.363195520635, 4282.935755963663, 4283.336082907154, 4302.161078589645, 3751.3247615429486, 3798.6771124454176, 3804.7336686432236, 3805.0487378155462, 3817.4273858921383, 746.2798100922108, 756.3533179131873, 760.1714131596586, 768.1742127213269, 771.0939645916026, 634.2579182356653, 635.2123367024948, 637.9346491359441, 654.7642848574509, 676.2831398717375, 8686.91313086861, 9010.14403631654, 9037.231835293942, 9103.196056606726, 9208.309376796633, 642.862134022777, 647.779754883342, 653.2128784814382, 660.5112216959416, 662.4965026579738, 4218.620324170839, 4221.472315960505, 4253.893652658709, 4368.0, 4630.791614377361, 88580.0, 96816.51591741997, 96856.0, 96983.0, 97090.5145474268, 83939.16060839436, 85893.0, 86317.0, 87277.0, 87372.56313718391, 75534.11164720816, 75610.0, 76011.8598221027, 76798.23201768023, 79063.60468197623, 9280.489573073546, 9365.0, 9402.717918462457, 9504.47725375111, 9529.52352382392, 49625.0, 52555.21167182572, 53044.0, 54874.902501950535, 56062.439375605725, 74808.62595686987, 75501.0, 75823.24176758382, 76924.0, 77968.05079873049, 11494.482748276181, 11650.417479125841, 11685.707857303636, 11924.821127683264, 12225.327606981702, 12210.511579536718, 12325.50697972071, 12333.62999110028, 12688.111832171659, 12722.98216142725, 9712.465814380277, 12118.636440906786, 12174.695632609255, 12211.511539538318, 12563.246205227715, 11998.04015678761, 12010.339431331011, 12021.338826364634, 12031.398430078636, 12037.518499259932, 11850.585229516926, 11860.525578977089, 11864.0, 11864.288142711464, 11885.46515406826, 10249.897501024894, 10334.948325258325, 10472.476376181314, 10496.0, 10646.946765266124, 9195.678151264674, 9468.810623787347, 9509.762255943657, 9589.986837857414, 9623.326367154232], "unit": "score", "name": "yui.html", "value": 7327.8928604672565}], "name": "dromaeo_css", "value": 7670.755032235722}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 110.0, 110.0, 113.0, 112.0, 122.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [155.0, 120.0, 153.0, 151.0, 144.0, 168.0, 146.0, 160.0, 144.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [182.0, 180.0, 184.0, 183.0, 200.0, 256.0, 184.0, 184.0, 184.0, 185.0], "unit": "score", "name": "audio-dft", "value": 192.2}, {"lowerIsBetter": true, "replicates": [73.0, 79.0, 76.0, 112.0, 54.0, 56.0, 58.0, 58.0, 117.0, 59.0], "unit": "score", "name": "audio-fft", "value": 74.2}, {"lowerIsBetter": true, "replicates": [89.0, 98.0, 129.0, 83.0, 111.0, 119.0, 137.0, 78.0, 77.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [84.0, 91.0, 84.0, 91.0, 84.0, 89.0, 83.0, 93.0, 85.0, 112.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.4}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 87.0, 85.0, 86.0, 84.0, 85.0, 87.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 57.0, 61.0, 58.0, 58.0, 55.0, 50.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 66.0, 74.0, 73.0, 69.0, 66.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 81.0, 81.0, 81.0, 81.0, 79.0, 79.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.4}, {"lowerIsBetter": true, "replicates": [126.0, 122.0, 120.0, 123.0, 117.0, 125.0, 126.0, 122.0, 129.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [133.0, 121.0, 131.0, 132.0, 130.0, 125.0, 131.0, 159.0, 130.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.3}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 65.0, 63.0, 67.0, 80.0, 97.0, 95.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.7}], "name": "kraken", "value": 1431.0}]} 19:27:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,173,59]]", "result": "1431.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,173,59]]", "result": "7670.75"}}} 19:27:06 INFO - Return code: 0 19:27:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:27:06 INFO - # TBPL SUCCESS # 19:27:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:27:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:27:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:27:06 INFO - 2016-02-29 19:27:06.482 screenresolution[6851:125997] starting screenresolution argv=screenresolution get 19:27:06 INFO - 2016-02-29 19:27:06.484 screenresolution[6851:125997] Display 0: 1600x1200x32@60 19:27:06 INFO - 2016-02-29 19:27:06.490 screenresolution[6852:126000] starting screenresolution argv=screenresolution list 19:27:06 INFO - Available Modes on Display 0 19:27:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:27:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:27:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:27:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:27:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:27:06 INFO - Intel Iris: 19:27:06 INFO - Chipset Model: Intel Iris 19:27:06 INFO - Type: GPU 19:27:06 INFO - Bus: Built-In 19:27:06 INFO - VRAM (Dynamic, Max): 1536 MB 19:27:06 INFO - Vendor: Intel (0x8086) 19:27:06 INFO - Device ID: 0x0a2e 19:27:06 INFO - Revision ID: 0x0009 19:27:06 INFO - Displays: 19:27:06 INFO - Display: 19:27:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:27:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:27:06 INFO - Display Serial Number: 1600x1200 60 19:27:06 INFO - Main Display: Yes 19:27:06 INFO - Mirror: Off 19:27:06 INFO - Online: Yes 19:27:06 INFO - Rotation: Supported 19:27:06 INFO - Return code: 0 19:27:06 INFO - Running post-action listener: _resource_record_post_action 19:27:06 INFO - Running post-run listener: _resource_record_post_run 19:27:07 INFO - Total resource usage - Wall time: 1190s; CPU: 53.0%; Read bytes: 442368; Write bytes: 507791872; Read time: 5; Write time: 1612 19:27:07 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 201116160; Write bytes: 197744128; Read time: 18034; Write time: 376 19:27:07 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 442368; Write bytes: 299308032; Read time: 5; Write time: 1201 19:27:07 INFO - Running post-run listener: _upload_blobber_files 19:27:07 INFO - Blob upload gear active. 19:27:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:27:07 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 19:27:07 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', 'Date', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:27:07 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 Date -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:27:08 INFO - (blobuploader) - INFO - Open directory for files ... 19:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:27:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:08 INFO - (blobuploader) - INFO - Done attempting. 19:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:27:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:09 INFO - (blobuploader) - INFO - Done attempting. 19:27:09 INFO - (blobuploader) - INFO - Iteration through files over. 19:27:09 INFO - Return code: 0 19:27:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:27:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:27:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/4b4ed32fc7e08e172bcfca4599e1d805f2e31af9777c0c63bb017ff44e0cd77f1b6039c5e2de8d648b24f968123c5090851bc2b3d52b1ba828fcdedbe05f3a16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/40a3a43eb18953643c85d25499f27545f937666d0b54caa96c2210e42bc914474c21c2bf9c319218f6d99f1005659e3544d563feaeddc895ddac79c34e9d7cc3"} 19:27:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:27:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:27:09 INFO - Contents: 19:27:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/4b4ed32fc7e08e172bcfca4599e1d805f2e31af9777c0c63bb017ff44e0cd77f1b6039c5e2de8d648b24f968123c5090851bc2b3d52b1ba828fcdedbe05f3a16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/40a3a43eb18953643c85d25499f27545f937666d0b54caa96c2210e42bc914474c21c2bf9c319218f6d99f1005659e3544d563feaeddc895ddac79c34e9d7cc3"} 19:27:09 INFO - Running post-run listener: copy_logs_to_upload_dir 19:27:09 INFO - Copying logs to upload dir... 19:27:09 INFO - mkdir: /builds/slave/test/build/upload/logs 19:27:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.104170 ========= master_lag: 4.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-02-29 19:27:14.356890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-29 19:27:14.360029) ========= 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.6TuFITZAb3/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.jXiyLfWIcn/Listeners TMPDIR=/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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/Date/sha512/4b4ed32fc7e08e172bcfca4599e1d805f2e31af9777c0c63bb017ff44e0cd77f1b6039c5e2de8d648b24f968123c5090851bc2b3d52b1ba828fcdedbe05f3a16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/40a3a43eb18953643c85d25499f27545f937666d0b54caa96c2210e42bc914474c21c2bf9c319218f6d99f1005659e3544d563feaeddc895ddac79c34e9d7cc3"} build_url:https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/LcfRVnP7RRGDu5l9yoar3g/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/4b4ed32fc7e08e172bcfca4599e1d805f2e31af9777c0c63bb017ff44e0cd77f1b6039c5e2de8d648b24f968123c5090851bc2b3d52b1ba828fcdedbe05f3a16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/40a3a43eb18953643c85d25499f27545f937666d0b54caa96c2210e42bc914474c21c2bf9c319218f6d99f1005659e3544d563feaeddc895ddac79c34e9d7cc3"}' ========= master_lag: 1.72 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-29 19:27:16.094312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 14 secs) (at 2016-02-29 19:27:16.094713) ========= 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.6TuFITZAb3/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.jXiyLfWIcn/Listeners TMPDIR=/var/folders/nm/237d458d70v0srksgx6f_qt800000w/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.005394 ========= master_lag: 14.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 14 secs) (at 2016-02-29 19:27:30.246701) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2016-02-29 19:27:30.247389) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2016-02-29 19:27:35.554201) ========= ========= Total master_lag: 20.46 =========