builder: release-comm-esr52-thunderbird_antivirus
slave: av-linux64-spot-004
starttime: 1507011372.74
results: failure (2)

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:12.736410) =========
master: http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:12.736834) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:12.737118) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:12.793718) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:12.794033) =========
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/tb-rel-c-esr52-av-000000000000/. (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:
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CCACHE_HASHDIR=
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=av-linux64-spot-004.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/tb-rel-c-esr52-av-000000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
--2017-10-02 23:16:13--  https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: ‘archiver_client.py’

     0K .......... .                                          100%  209M=0s

2017-10-02 23:16:13 (209 MB/s) - ‘archiver_client.py’ saved [12179/12179]

program finished with exit code 0
elapsedTime=0.916825
========= master_lag: 0.03 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:13.738693) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:13.739055) =========
rm -rf scripts properties
 in dir /builds/slave/tb-rel-c-esr52-av-000000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'scripts', 'properties']
 environment:
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CCACHE_HASHDIR=
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=av-linux64-spot-004.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/tb-rel-c-esr52-av-000000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
program finished with exit code 0
elapsedTime=0.002603
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:13.786526) =========

========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 23:16:13.786832) =========
bash -c 'python archiver_client.py mozharness --repo releases/mozilla-esr52 --tag THUNDERBIRD_52_4_0_RELEASE --destination scripts --debug'
 in dir /builds/slave/tb-rel-c-esr52-av-000000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-esr52 --tag THUNDERBIRD_52_4_0_RELEASE --destination scripts --debug']
 environment:
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CCACHE_HASHDIR=
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=av-linux64-spot-004.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/tb-rel-c-esr52-av-000000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
2017-10-02 23:16:13,827 Setting DEBUG logging.
2017-10-02 23:16:13,827 "THUNDERBIRD_52_4_0_RELEASE" was passed as the tag. Querying remote repository for corresponding rev hash.
warning: connecting to hg.mozilla.org using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info
2017-10-02 23:16:14,599 revision being used: 7245c4e7ec3e
2017-10-02 23:16:14,599 attempt 1/10
2017-10-02 23:16:14,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-esr52/7245c4e7ec3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-10-02 23:16:15,348 unpacking tar archive at: mozilla-esr52-7245c4e7ec3e/testing/mozharness/
program finished with exit code 0
elapsedTime=1.661349
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 23:16:15.455834) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:15.456171) =========
script_repo_revision: THUNDERBIRD_52_4_0_RELEASE
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:15.456588) =========

========= Started 'python2.7 scripts/scripts/release/antivirus.py ...' failed (results: 2, elapsed: 10 secs) (at 2017-10-02 23:16:15.456909) =========
python2.7 scripts/scripts/release/antivirus.py --product thunderbird --version 52.4.0 --build-number 1 --bucket-name net-mozaws-prod-delivery-archive --tools-revision THUNDERBIRD_52_4_0_RELEASE --tools-repo https://hg.mozilla.org/build/tools
 in dir /builds/slave/tb-rel-c-esr52-av-000000000000/. (timeout 10800 secs)
 watching logfiles {}
 argv: ['python2.7', 'scripts/scripts/release/antivirus.py', '--product', 'thunderbird', '--version', '52.4.0', '--build-number', '1', '--bucket-name', 'net-mozaws-prod-delivery-archive', '--tools-revision', 'THUNDERBIRD_52_4_0_RELEASE', '--tools-repo', 'https://hg.mozilla.org/build/tools']
 environment:
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CCACHE_HASHDIR=
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=av-linux64-spot-004.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PROPERTIES_FILE=/builds/slave/tb-rel-c-esr52-av-000000000000/buildprops.json
  PWD=/builds/slave/tb-rel-c-esr52-av-000000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
23:16:15     INFO - MultiFileLogger online at 20171002 23:16:15 in /builds/slave/tb-rel-c-esr52-av-000000000000
23:16:15     INFO - Run as scripts/scripts/release/antivirus.py --product thunderbird --version 52.4.0 --build-number 1 --bucket-name net-mozaws-prod-delivery-archive --tools-revision THUNDERBIRD_52_4_0_RELEASE --tools-repo https://hg.mozilla.org/build/tools
23:16:15     INFO - Dumping config to /builds/slave/tb-rel-c-esr52-av-000000000000/logs/localconfig.json.
23:16:15     INFO - {'append_to_log': False,
23:16:15     INFO -  'base_work_dir': '/builds/slave/tb-rel-c-esr52-av-000000000000',
23:16:15     INFO -  'bucket_name': 'net-mozaws-prod-delivery-archive',
23:16:15     INFO -  'build_number': '1',
23:16:15     INFO -  'download_parallelization': 6,
23:16:15     INFO -  'log_level': 'info',
23:16:15     INFO -  'log_to_console': True,
23:16:15     INFO -  'opt_config_files': (),
23:16:15     INFO -  'pip_index': True,
23:16:15     INFO -  'product': 'thunderbird',
23:16:15     INFO -  'scan_parallelization': 4,
23:16:15     INFO -  'tools_repo': 'https://hg.mozilla.org/build/tools',
23:16:15     INFO -  'tools_revision': 'THUNDERBIRD_52_4_0_RELEASE',
23:16:15     INFO -  'version': '52.4.0',
23:16:15     INFO -  'virtualenv_modules': ('boto', 'redo', 'mar'),
23:16:15     INFO -  'virtualenv_path': 'venv',
23:16:15     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
23:16:15     INFO -  'work_dir': 'build'}
23:16:15     INFO - [mozharness: 2017-10-03 06:16:15.583614Z] Running create-virtualenv step.
23:16:15     INFO - Running main action method: create_virtualenv
23:16:15     INFO - Creating virtualenv /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv
23:16:15     INFO - mkdir: /builds/slave/tb-rel-c-esr52-av-000000000000/build
23:16:15     INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/tb-rel-c-esr52-av-000000000000/build/venv'] in /builds/slave/tb-rel-c-esr52-av-000000000000/build
23:16:15     INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv
23:16:15     INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'}
23:16:15     INFO -  The --no-site-packages flag is deprecated; it is now the default behavior.
23:16:15     INFO -  New python executable in /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/python2.7
23:16:15     INFO -  Also creating executable in /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/python
23:16:17     INFO -  Installing distribute.............................................................................................................................................................................................done.
23:16:17     INFO -  Installing pip...............done.
23:16:17     INFO - Return code: 0
23:16:17     INFO - Getting output from command: ['/builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip', '--version']
23:16:17     INFO - Copy/paste: /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip --version
23:16:17     INFO - Reading from file tmpfile_stdout
23:16:17     INFO - Output received:
23:16:17     INFO -  pip 1.1 from /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7)
23:16:17     INFO - Installing boto into virtualenv /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv
23:16:17     INFO - retry: Calling run_command with args: [['/builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip', 'install', '--timeout', '120', 'boto']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c350>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cf045fea0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207dd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22825e0>, '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 0x22aa030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ce8a3be40>, 'level': 'critical'}], 'cwd': '/builds/slave/tb-rel-c-esr52-av-000000000000/build', 'env': {'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 'TMOUT': '86400', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 'HOME': '/home/cltbld', 'LANG': 'en_US.UTF-8', 'CCACHE_HASHDIR': '', 'TERM': 'linux', 'SHELL': '/bin/bash', 'SHLVL': '1', 'G_BROKEN_FILENAMES': '1', 'HISTSIZE': '1000', 'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr52-av-000000000000/buildprops.json', 'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', '_': '/tools/buildbot/bin/python', 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 'HOSTNAME': 'av-linux64-spot-004.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/tb-rel-c-esr52-av-000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1
23:16:17     INFO - Running command: ['/builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip', 'install', '--timeout', '120', 'boto'] in /builds/slave/tb-rel-c-esr52-av-000000000000/build
23:16:17     INFO - Copy/paste: /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip install --timeout 120 boto
23:16:17     INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom',
23:16:17     INFO -  'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs',
23:16:17     INFO -  'CCACHE_HASHDIR': '',
23:16:17     INFO -  'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber',
23:16:17     INFO -  'G_BROKEN_FILENAMES': '1',
23:16:17     INFO -  'HISTCONTROL': 'ignoredups',
23:16:17     INFO -  'HISTSIZE': '1000',
23:16:17     INFO -  'HOME': '/home/cltbld',
23:16:17     INFO -  'HOSTNAME': 'av-linux64-spot-004.build.releng.usw2.mozilla.com',
23:16:17     INFO -  'LANG': 'en_US.UTF-8',
23:16:17     INFO -  'LESSOPEN': '|/usr/bin/lesspipe.sh %s',
23:16:17     INFO -  'LOGNAME': 'cltbld',
23:16:17     INFO -  'MAIL': '/var/spool/mail/cltbld',
23:16:17     INFO -  'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin',
23:16:17     INFO -  'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr52-av-000000000000/buildprops.json',
23:16:17     INFO -  'PWD': '/builds/slave/tb-rel-c-esr52-av-000000000000',
23:16:17     INFO -  'SHELL': '/bin/bash',
23:16:17     INFO -  'SHLVL': '1',
23:16:17     INFO -  'TERM': 'linux',
23:16:17     INFO -  'TMOUT': '86400',
23:16:17     INFO -  'USER': 'cltbld',
23:16:17     INFO -  '_': '/tools/buildbot/bin/python'}
23:16:24     INFO -  Ignoring indexes: http://pypi.python.org/simple/
23:16:24     INFO -  Downloading/unpacking boto
23:16:24     INFO -    Running setup.py egg_info for package boto
23:16:24     INFO -  Downloading/unpacking botocore>=1.7.0,<1.8.0 (from boto)
23:16:24     INFO -    Running setup.py egg_info for package botocore
23:16:24     INFO -      no previously-included directories found matching 'docs/build'
23:16:24     INFO -  Downloading/unpacking jmespath>=0.7.1,<1.0.0 (from boto)
23:16:24     INFO -    Downloading jmespath-0.9.3.tar.gz
23:16:24     INFO -    Running setup.py egg_info for package jmespath
23:16:24     INFO -  Downloading/unpacking s3transfer>=0.1.10,<0.2.0 (from boto)
23:16:24     INFO -    Running setup.py egg_info for package s3transfer
23:16:24     INFO -  Downloading/unpacking python-dateutil>=2.1,<3.0.0 (from botocore>=1.7.0,<1.8.0->boto)
23:16:24     INFO -    Running setup.py egg_info for package python-dateutil
23:16:24     INFO -      warning: no previously-included files matching '__pycache__' found anywhere in distribution
23:16:24     INFO -      warning: no previously-included files matching '*.py[co]' found anywhere in distribution
23:16:24     INFO -  Downloading/unpacking docutils>=0.10 (from botocore>=1.7.0,<1.8.0->boto)
23:16:24     INFO -    Running setup.py egg_info for package docutils
23:16:24     INFO -      warning: no files found matching 'MANIFEST'
23:16:24     INFO -      warning: no previously-included files matching '*.pyc' found under directory '*'
23:16:24     INFO -      warning: no previously-included files matching '*~' found under directory '*'
23:16:24     INFO -      warning: no previously-included files matching '.DS_Store' found under directory '*'
23:16:24     INFO -  Downloading/unpacking futures>=2.2.0,<4.0.0 (from s3transfer>=0.1.10,<0.2.0->boto)
23:16:24     INFO -    Downloading futures-3.1.1.tar.gz
23:16:24     INFO -    Running setup.py egg_info for package futures
23:16:24     INFO -  Downloading/unpacking six>=1.5 (from python-dateutil>=2.1,<3.0.0->botocore>=1.7.0,<1.8.0->boto)
23:16:24     INFO -    Downloading six-1.10.0.tar.gz
23:16:24     INFO -    Running setup.py egg_info for package six
23:16:24     INFO -      no previously-included directories found matching 'documentation/_build'
23:16:24     INFO -  Installing collected packages: boto, botocore, jmespath, s3transfer, python-dateutil, docutils, futures, six
23:16:24     INFO -    Running setup.py install for boto
23:16:24     INFO -    Running setup.py install for botocore
23:16:24     INFO -      no previously-included directories found matching 'docs/build'
23:16:24     INFO -    Running setup.py install for jmespath
23:16:24     INFO -      changing mode of build/scripts-2.7/jp.py from 664 to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/jp.py to 775
23:16:24     INFO -    Running setup.py install for s3transfer
23:16:24     INFO -    Running setup.py install for python-dateutil
23:16:24     INFO -      warning: no previously-included files matching '__pycache__' found anywhere in distribution
23:16:24     INFO -      warning: no previously-included files matching '*.py[co]' found anywhere in distribution
23:16:24     INFO -    Running setup.py install for docutils
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2html.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2html4.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2html5.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2s5.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2latex.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2xetex.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2man.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2xml.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2pseudoxml.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rstpep2html.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2odt.py from 664 to 775
23:16:24     INFO -      changing mode of build/scripts-2.7/rst2odt_prepstyles.py from 664 to 775
23:16:24     INFO -      warning: no files found matching 'MANIFEST'
23:16:24     INFO -      warning: no previously-included files matching '*.pyc' found under directory '*'
23:16:24     INFO -      warning: no previously-included files matching '*~' found under directory '*'
23:16:24     INFO -      warning: no previously-included files matching '.DS_Store' found under directory '*'
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2odt.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2xetex.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2html4.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rstpep2html.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2pseudoxml.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2man.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2xml.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2latex.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2html5.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2s5.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2html.py to 775
23:16:24     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/rst2odt_prepstyles.py to 775
23:16:24     INFO -    Running setup.py install for futures
23:16:24     INFO -    Running setup.py install for six
23:16:24     INFO -      no previously-included directories found matching 'documentation/_build'
23:16:24     INFO -  Successfully installed boto botocore jmespath s3transfer python-dateutil docutils futures six
23:16:24     INFO -  Cleaning up...
23:16:24     INFO - Return code: 0
23:16:24     INFO - Installing redo into virtualenv /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv
23:16:24     INFO - retry: Calling run_command with args: [['/builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip', 'install', '--timeout', '120', 'redo']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c350>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cf045fea0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207dd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22825e0>, '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 0x22aa030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ce8a3be40>, 'level': 'critical'}], 'cwd': '/builds/slave/tb-rel-c-esr52-av-000000000000/build', 'env': {'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 'TMOUT': '86400', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 'HOME': '/home/cltbld', 'LANG': 'en_US.UTF-8', 'CCACHE_HASHDIR': '', 'TERM': 'linux', 'SHELL': '/bin/bash', 'SHLVL': '1', 'G_BROKEN_FILENAMES': '1', 'HISTSIZE': '1000', 'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr52-av-000000000000/buildprops.json', 'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', '_': '/tools/buildbot/bin/python', 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 'HOSTNAME': 'av-linux64-spot-004.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/tb-rel-c-esr52-av-000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1
23:16:24     INFO - Running command: ['/builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip', 'install', '--timeout', '120', 'redo'] in /builds/slave/tb-rel-c-esr52-av-000000000000/build
23:16:24     INFO - Copy/paste: /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip install --timeout 120 redo
23:16:24     INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom',
23:16:24     INFO -  'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs',
23:16:24     INFO -  'CCACHE_HASHDIR': '',
23:16:24     INFO -  'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber',
23:16:24     INFO -  'G_BROKEN_FILENAMES': '1',
23:16:24     INFO -  'HISTCONTROL': 'ignoredups',
23:16:24     INFO -  'HISTSIZE': '1000',
23:16:24     INFO -  'HOME': '/home/cltbld',
23:16:24     INFO -  'HOSTNAME': 'av-linux64-spot-004.build.releng.usw2.mozilla.com',
23:16:24     INFO -  'LANG': 'en_US.UTF-8',
23:16:24     INFO -  'LESSOPEN': '|/usr/bin/lesspipe.sh %s',
23:16:24     INFO -  'LOGNAME': 'cltbld',
23:16:24     INFO -  'MAIL': '/var/spool/mail/cltbld',
23:16:24     INFO -  'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin',
23:16:24     INFO -  'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr52-av-000000000000/buildprops.json',
23:16:24     INFO -  'PWD': '/builds/slave/tb-rel-c-esr52-av-000000000000',
23:16:24     INFO -  'SHELL': '/bin/bash',
23:16:24     INFO -  'SHLVL': '1',
23:16:24     INFO -  'TERM': 'linux',
23:16:24     INFO -  'TMOUT': '86400',
23:16:24     INFO -  'USER': 'cltbld',
23:16:24     INFO -  '_': '/tools/buildbot/bin/python'}
23:16:25     INFO -  Ignoring indexes: http://pypi.python.org/simple/
23:16:25     INFO -  Downloading/unpacking redo
23:16:25     INFO -    Downloading redo-1.5.tar.gz
23:16:25     INFO -    Running setup.py egg_info for package redo
23:16:25     INFO -  Installing collected packages: redo
23:16:25     INFO -    Running setup.py install for redo
23:16:25     INFO -      Installing retry script to /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin
23:16:25     INFO -  Successfully installed redo
23:16:25     INFO -  Cleaning up...
23:16:25     INFO - Return code: 0
23:16:25     INFO - Installing mar into virtualenv /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv
23:16:25     INFO - retry: Calling run_command with args: [['/builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip', 'install', '--timeout', '120', 'mar']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226c350>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cf045fea0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207dd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22825e0>, '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 0x22aa030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ce8a3be40>, 'level': 'critical'}], 'cwd': '/builds/slave/tb-rel-c-esr52-av-000000000000/build', 'env': {'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 'TMOUT': '86400', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 'HOME': '/home/cltbld', 'LANG': 'en_US.UTF-8', 'CCACHE_HASHDIR': '', 'TERM': 'linux', 'SHELL': '/bin/bash', 'SHLVL': '1', 'G_BROKEN_FILENAMES': '1', 'HISTSIZE': '1000', 'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr52-av-000000000000/buildprops.json', 'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', '_': '/tools/buildbot/bin/python', 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 'HOSTNAME': 'av-linux64-spot-004.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/tb-rel-c-esr52-av-000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1
23:16:25     INFO - Running command: ['/builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip', 'install', '--timeout', '120', 'mar'] in /builds/slave/tb-rel-c-esr52-av-000000000000/build
23:16:25     INFO - Copy/paste: /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip install --timeout 120 mar
23:16:25     INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom',
23:16:25     INFO -  'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs',
23:16:25     INFO -  'CCACHE_HASHDIR': '',
23:16:25     INFO -  'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber',
23:16:25     INFO -  'G_BROKEN_FILENAMES': '1',
23:16:25     INFO -  'HISTCONTROL': 'ignoredups',
23:16:25     INFO -  'HISTSIZE': '1000',
23:16:25     INFO -  'HOME': '/home/cltbld',
23:16:25     INFO -  'HOSTNAME': 'av-linux64-spot-004.build.releng.usw2.mozilla.com',
23:16:25     INFO -  'LANG': 'en_US.UTF-8',
23:16:25     INFO -  'LESSOPEN': '|/usr/bin/lesspipe.sh %s',
23:16:25     INFO -  'LOGNAME': 'cltbld',
23:16:25     INFO -  'MAIL': '/var/spool/mail/cltbld',
23:16:25     INFO -  'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin',
23:16:25     INFO -  'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr52-av-000000000000/buildprops.json',
23:16:25     INFO -  'PWD': '/builds/slave/tb-rel-c-esr52-av-000000000000',
23:16:25     INFO -  'SHELL': '/bin/bash',
23:16:25     INFO -  'SHLVL': '1',
23:16:25     INFO -  'TERM': 'linux',
23:16:25     INFO -  'TMOUT': '86400',
23:16:25     INFO -  'USER': 'cltbld',
23:16:25     INFO -  '_': '/tools/buildbot/bin/python'}
23:16:25     INFO -  Ignoring indexes: http://pypi.python.org/simple/
23:16:25     INFO -  Downloading/unpacking mar
23:16:25     INFO -    Downloading mar-1.2.tar.gz
23:16:25     INFO -    Running setup.py egg_info for package mar
23:16:25     INFO -      no previously-included directories found matching 'dist'
23:16:25     INFO -  Installing collected packages: mar
23:16:25     INFO -    Running setup.py install for mar
23:16:25     INFO -      changing mode of build/scripts-2.7/mar.py from 664 to 775
23:16:25     INFO -      no previously-included directories found matching 'dist'
23:16:25     INFO -      changing mode of /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/mar.py to 775
23:16:25     INFO -  Successfully installed mar
23:16:25     INFO -  Cleaning up...
23:16:25     INFO - Return code: 0
23:16:25     INFO - Done creating virtualenv /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv.
23:16:25     INFO - Getting output from command: ['/builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip', 'freeze']
23:16:25     INFO - Copy/paste: /builds/slave/tb-rel-c-esr52-av-000000000000/build/venv/bin/pip freeze
23:16:25     INFO - Reading from file tmpfile_stdout
23:16:25     INFO - Current package versions:
23:16:25     INFO -   boto3 == 1.4.7
23:16:25     INFO -   botocore == 1.7.7
23:16:25     INFO -   distribute == 0.6.24
23:16:25     INFO -   docutils == 0.14
23:16:25     INFO -   futures == 3.1.1
23:16:25     INFO -   jmespath == 0.9.3
23:16:25     INFO -   mar == 1.2
23:16:25     INFO -   python-dateutil == 2.6.0
23:16:25     INFO -   redo == 1.5
23:16:25     INFO -   s3transfer == 0.1.11
23:16:25     INFO -   six == 1.10.0
23:16:25     INFO -   wsgiref == 0.1.2
23:16:25     INFO - [mozharness: 2017-10-03 06:16:25.943766Z] Finished create-virtualenv step (success)
23:16:25     INFO - [mozharness: 2017-10-03 06:16:25.943943Z] Running activate-virtualenv step.
23:16:25     INFO - Running main action method: activate_virtualenv
23:16:25     INFO - [mozharness: 2017-10-03 06:16:25.945217Z] Finished activate-virtualenv step (success)
23:16:25     INFO - [mozharness: 2017-10-03 06:16:25.945402Z] Running get-extract-script step.
23:16:25     INFO - Running main action method: get_extract_script
23:16:25     INFO - Downloading https://hg.mozilla.org/build/tools/raw-file/THUNDERBIRD_52_4_0_RELEASE/stage/extract_and_run_command.py to extract_and_run_command.py
23:16:25     INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/build/tools/raw-file/THUNDERBIRD_52_4_0_RELEASE/stage/extract_and_run_command.py', 'file_name': 'extract_and_run_command.py'}, attempt #1
23:16:26     INFO - Downloaded 6430 bytes.
23:16:26     INFO - [mozharness: 2017-10-03 06:16:26.405442Z] Finished get-extract-script step (success)
23:16:26     INFO - [mozharness: 2017-10-03 06:16:26.405680Z] Running get-files step.
23:16:26     INFO - Running main action method: get_files
23:16:26     INFO - [mozharness: 2017-10-03 06:16:26.406274Z] Finished get-files step (failed)
23:16:26    FATAL - Uncaught exception: Traceback (most recent call last):
23:16:26    FATAL -   File "/builds/slave/tb-rel-c-esr52-av-000000000000/scripts/mozharness/base/script.py", line 2034, in run
23:16:26    FATAL -     self.run_action(action)
23:16:26    FATAL -   File "/builds/slave/tb-rel-c-esr52-av-000000000000/scripts/mozharness/base/script.py", line 1973, in run_action
23:16:26    FATAL -     self._possibly_run_method(method_name, error_if_missing=True)
23:16:26    FATAL -   File "/builds/slave/tb-rel-c-esr52-av-000000000000/scripts/mozharness/base/script.py", line 1913, in _possibly_run_method
23:16:26    FATAL -     return getattr(self, method_name)()
23:16:26    FATAL -   File "scripts/scripts/release/antivirus.py", line 131, in get_files
23:16:26    FATAL -     from boto.s3.connection import S3Connection
23:16:26    FATAL - ImportError: No module named boto.s3.connection
23:16:26    FATAL - Running post_fatal callback...
23:16:26    FATAL - Exiting -1
23:16:26     INFO - Running post-run listener: copy_logs_to_upload_dir
23:16:26     INFO - Copying logs to upload dir...
23:16:26     INFO - mkdir: /builds/slave/tb-rel-c-esr52-av-000000000000/build/upload/logs
program finished with exit code 255
elapsedTime=10.961318
========= master_lag: 0.01 =========
========= Finished 'python2.7 scripts/scripts/release/antivirus.py ...' failed (results: 2, elapsed: 10 secs) (at 2017-10-02 23:16:26.428726) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:26.430296) =========
bash -c 'for file in `ls -1`; do cat $file; done'
 in dir /builds/slave/tb-rel-c-esr52-av-000000000000/properties (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done']
 environment:
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CCACHE_HASHDIR=
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=av-linux64-spot-004.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/tb-rel-c-esr52-av-000000000000/properties
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
program finished with exit code 0
elapsedTime=0.004378

========= master_lag: 0.04 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2017-10-02 23:16:26.477995) =========

========= Total master_lag: 0.13 =========