builder: release-comm-esr38-thunderbird_antivirus
slave: av-linux64-spot-002
starttime: 1448046381.3
results: failure (2)

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:21.297944) =========
master: http://buildbot-master71.bb.releng.use1.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:21.298368) =========

========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2015-11-20 11:06:21.298666) =========
bash -c pwd
 in dir /builds/slave/tb-rel-c-esr38-av-000000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'pwd']
 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-002.build.releng.use1.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-esr38-av-000000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
/builds/slave/tb-rel-c-esr38-av-000000000000
program finished with exit code 0
elapsedTime=0.004197
basedir: '/builds/slave/tb-rel-c-esr38-av-000000000000'
========= master_lag: 1.54 =========
========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2015-11-20 11:06:22.840095) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:22.840422) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:22.851953) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:22.852239) =========
rm -rf properties
 in dir /builds/slave/tb-rel-c-esr38-av-000000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', '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-002.build.releng.use1.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-esr38-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.002778
========= master_lag: 0.05 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:22.901348) =========

========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:22.901645) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:22.901992) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:22.903983) =========
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-esr38-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-002.build.releng.use1.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-esr38-av-000000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
--2015-11-20 11:06:23--  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%  190M=0s

2015-11-20 11:06:23 (190 MB/s) - ‘archiver_client.py’ saved [12141/12141]

program finished with exit code 0
elapsedTime=0.957486
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:23.878178) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:23.878509) =========
rm -rf scripts
 in dir /builds/slave/tb-rel-c-esr38-av-000000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'scripts']
 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-002.build.releng.use1.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-esr38-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.002677
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:23.926167) =========

========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-20 11:06:23.926453) =========
bash -c 'python archiver_client.py mozharness --repo releases/mozilla-esr38 --tag THUNDERBIRD_38_4_0_RELEASE --destination scripts --debug'
 in dir /builds/slave/tb-rel-c-esr38-av-000000000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-esr38 --tag THUNDERBIRD_38_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-002.build.releng.use1.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-esr38-av-000000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
2015-11-20 11:06:23,972 Setting DEBUG logging.
2015-11-20 11:06:23,972 "THUNDERBIRD_38_4_0_RELEASE" was passed as the tag. Querying remote repository for corresponding rev hash.
2015-11-20 11:06:25,134 revision being used: a05572d42980
2015-11-20 11:06:25,135 attempt 1/10
2015-11-20 11:06:25,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-esr38/a05572d42980?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-11-20 11:06:26,356 unpacking tar archive at: mozilla-esr38-a05572d42980/testing/mozharness/
program finished with exit code 0
elapsedTime=2.909348
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-20 11:06:26.844197) =========

========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:26.844519) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/THUNDERBIRD_38_4_0_RELEASE
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:26.844880) =========

========= Started 'python2.7 scripts/scripts/release/antivirus.py ...' failed (results: 2, elapsed: 11 secs) (at 2015-11-20 11:06:26.845188) =========
python2.7 scripts/scripts/release/antivirus.py --product thunderbird --version 38.4.0 --build-number 3 --bucket-name net-mozaws-prod-delivery-archive --tools-revision THUNDERBIRD_38_4_0_RELEASE --tools-repo https://hg.mozilla.org/build/tools
 in dir /builds/slave/tb-rel-c-esr38-av-000000000000/. (timeout 10800 secs)
 watching logfiles {}
 argv: ['python2.7', 'scripts/scripts/release/antivirus.py', '--product', 'thunderbird', '--version', '38.4.0', '--build-number', '3', '--bucket-name', 'net-mozaws-prod-delivery-archive', '--tools-revision', 'THUNDERBIRD_38_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-002.build.releng.use1.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-esr38-av-000000000000/buildprops.json
  PWD=/builds/slave/tb-rel-c-esr38-av-000000000000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
11:06:27     INFO - MultiFileLogger online at 20151120 11:06:27 in /builds/slave/tb-rel-c-esr38-av-000000000000
11:06:27     INFO - Run as scripts/scripts/release/antivirus.py --product thunderbird --version 38.4.0 --build-number 3 --bucket-name net-mozaws-prod-delivery-archive --tools-revision THUNDERBIRD_38_4_0_RELEASE --tools-repo https://hg.mozilla.org/build/tools
11:06:27     INFO - Dumping config to /builds/slave/tb-rel-c-esr38-av-000000000000/logs/localconfig.json.
11:06:27     INFO - {'append_to_log': False,
11:06:27     INFO -  'base_work_dir': '/builds/slave/tb-rel-c-esr38-av-000000000000',
11:06:27     INFO -  'bucket_name': 'net-mozaws-prod-delivery-archive',
11:06:27     INFO -  'build_number': '3',
11:06:27     INFO -  'download_parallelization': 6,
11:06:27     INFO -  'log_level': 'info',
11:06:27     INFO -  'log_to_console': True,
11:06:27     INFO -  'opt_config_files': (),
11:06:27     INFO -  'pip_index': True,
11:06:27     INFO -  'product': 'thunderbird',
11:06:27     INFO -  'scan_parallelization': 4,
11:06:27     INFO -  'tools_repo': 'https://hg.mozilla.org/build/tools',
11:06:27     INFO -  'tools_revision': 'THUNDERBIRD_38_4_0_RELEASE',
11:06:27     INFO -  'version': '38.4.0',
11:06:27     INFO -  'virtualenv_modules': ('boto', 'redo', 'mar'),
11:06:27     INFO -  'virtualenv_path': 'venv',
11:06:27     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
11:06:27     INFO -  'work_dir': 'build'}
11:06:27     INFO - #####
11:06:27     INFO - ##### Running create-virtualenv step.
11:06:27     INFO - #####
11:06:27     INFO - Running main action method: create_virtualenv
11:06:27     INFO - Creating virtualenv /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv
11:06:27     INFO - mkdir: /builds/slave/tb-rel-c-esr38-av-000000000000/build
11:06:27     INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv'] in /builds/slave/tb-rel-c-esr38-av-000000000000/build
11:06:27     INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv
11:06:27     INFO -  The --no-site-packages flag is deprecated; it is now the default behavior.
11:06:27     INFO -  New python executable in /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/python2.7
11:06:27     INFO -  Also creating executable in /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/python
11:06:29     INFO -  Installing distribute.............................................................................................................................................................................................done.
11:06:29     INFO -  Installing pip...............done.
11:06:29     INFO - Return code: 0
11:06:29     INFO - Installing boto into virtualenv /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv
11:06:29     INFO - retry: Calling run_command with args: [['/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache', '--timeout', '120', 'boto']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c216c0350>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c290338b8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18596d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c920>, '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 0x7f2c2906b618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6990>, 'level': 'critical'}], 'cwd': '/builds/slave/tb-rel-c-esr38-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-esr38-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-002.build.releng.use1.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/tb-rel-c-esr38-av-000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1
11:06:29     INFO - Running command: ['/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache', '--timeout', '120', 'boto'] in /builds/slave/tb-rel-c-esr38-av-000000000000/build
11:06:29     INFO - Copy/paste: /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip install --download-cache /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache --timeout 120 boto
11:06:29     INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom',
11:06:29     INFO -  'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs',
11:06:29     INFO -  'CCACHE_HASHDIR': '',
11:06:29     INFO -  'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber',
11:06:29     INFO -  'G_BROKEN_FILENAMES': '1',
11:06:29     INFO -  'HISTCONTROL': 'ignoredups',
11:06:29     INFO -  'HISTSIZE': '1000',
11:06:29     INFO -  'HOME': '/home/cltbld',
11:06:29     INFO -  'HOSTNAME': 'av-linux64-spot-002.build.releng.use1.mozilla.com',
11:06:29     INFO -  'LANG': 'en_US.UTF-8',
11:06:29     INFO -  'LESSOPEN': '|/usr/bin/lesspipe.sh %s',
11:06:29     INFO -  'LOGNAME': 'cltbld',
11:06:29     INFO -  'MAIL': '/var/spool/mail/cltbld',
11:06:29     INFO -  'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin',
11:06:29     INFO -  'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr38-av-000000000000/buildprops.json',
11:06:29     INFO -  'PWD': '/builds/slave/tb-rel-c-esr38-av-000000000000',
11:06:29     INFO -  'SHELL': '/bin/bash',
11:06:29     INFO -  'SHLVL': '1',
11:06:29     INFO -  'TERM': 'linux',
11:06:29     INFO -  'TMOUT': '86400',
11:06:29     INFO -  'USER': 'cltbld',
11:06:29     INFO -  '_': '/tools/buildbot/bin/python'}
11:06:33     INFO -  Ignoring indexes: http://pypi.python.org/simple/
11:06:33     INFO -  Downloading/unpacking boto
11:06:33     INFO -  Creating supposed download cache at /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache
11:06:33     INFO -    Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fboto-2.38.0.tar.gz
11:06:33     INFO -    Running setup.py egg_info for package boto
11:06:33     INFO -      warning: no files found matching 'boto/mturk/test/*.doctest'
11:06:33     INFO -      warning: no files found matching 'boto/mturk/test/.gitignore'
11:06:33     INFO -  Installing collected packages: boto
11:06:33     INFO -    Running setup.py install for boto
11:06:33     INFO -      warning: no files found matching 'boto/mturk/test/*.doctest'
11:06:33     INFO -      warning: no files found matching 'boto/mturk/test/.gitignore'
11:06:33     INFO -      changing mode of build/scripts-2.7/sdbadmin from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/elbadmin from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/cfadmin from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/s3put from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/fetch_file from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/launch_instance from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/list_instances from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/taskadmin from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/kill_instance from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/bundle_image from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/pyami_sendmail from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/lss3 from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/cq from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/route53 from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/cwutil from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/instance_events from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/asadmin from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/glacier from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/mturk from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/dynamodb_dump from 664 to 775
11:06:33     INFO -      changing mode of build/scripts-2.7/dynamodb_load from 664 to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/cfadmin to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/sdbadmin to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/launch_instance to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/route53 to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/list_instances to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/dynamodb_load to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/cq to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/cwutil to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/s3put to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/dynamodb_dump to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/kill_instance to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/bundle_image to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/fetch_file to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/mturk to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/asadmin to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pyami_sendmail to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/lss3 to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/glacier to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/taskadmin to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/elbadmin to 775
11:06:33     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/instance_events to 775
11:06:33     INFO -  Successfully installed boto
11:06:33     INFO -  Cleaning up...
11:06:33     INFO - Return code: 0
11:06:33     INFO - Installing redo into virtualenv /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv
11:06:33     INFO - retry: Calling run_command with args: [['/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache', '--timeout', '120', 'redo']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c216c0350>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c290338b8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18596d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c920>, '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 0x7f2c2906b618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6990>, 'level': 'critical'}], 'cwd': '/builds/slave/tb-rel-c-esr38-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-esr38-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-002.build.releng.use1.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/tb-rel-c-esr38-av-000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1
11:06:33     INFO - Running command: ['/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache', '--timeout', '120', 'redo'] in /builds/slave/tb-rel-c-esr38-av-000000000000/build
11:06:33     INFO - Copy/paste: /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip install --download-cache /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache --timeout 120 redo
11:06:33     INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom',
11:06:33     INFO -  'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs',
11:06:33     INFO -  'CCACHE_HASHDIR': '',
11:06:33     INFO -  'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber',
11:06:33     INFO -  'G_BROKEN_FILENAMES': '1',
11:06:33     INFO -  'HISTCONTROL': 'ignoredups',
11:06:33     INFO -  'HISTSIZE': '1000',
11:06:33     INFO -  'HOME': '/home/cltbld',
11:06:33     INFO -  'HOSTNAME': 'av-linux64-spot-002.build.releng.use1.mozilla.com',
11:06:33     INFO -  'LANG': 'en_US.UTF-8',
11:06:33     INFO -  'LESSOPEN': '|/usr/bin/lesspipe.sh %s',
11:06:33     INFO -  'LOGNAME': 'cltbld',
11:06:33     INFO -  'MAIL': '/var/spool/mail/cltbld',
11:06:33     INFO -  'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin',
11:06:33     INFO -  'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr38-av-000000000000/buildprops.json',
11:06:33     INFO -  'PWD': '/builds/slave/tb-rel-c-esr38-av-000000000000',
11:06:33     INFO -  'SHELL': '/bin/bash',
11:06:33     INFO -  'SHLVL': '1',
11:06:33     INFO -  'TERM': 'linux',
11:06:33     INFO -  'TMOUT': '86400',
11:06:33     INFO -  'USER': 'cltbld',
11:06:33     INFO -  '_': '/tools/buildbot/bin/python'}
11:06:34     INFO -  Ignoring indexes: http://pypi.python.org/simple/
11:06:34     INFO -  Downloading/unpacking redo
11:06:34     INFO -    Downloading redo-1.4.tar.gz
11:06:34     INFO -    Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fredo-1.4.tar.gz
11:06:34     INFO -    Running setup.py egg_info for package redo
11:06:34     INFO -  Installing collected packages: redo
11:06:34     INFO -    Running setup.py install for redo
11:06:34     INFO -      Installing retry script to /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin
11:06:34     INFO -  Successfully installed redo
11:06:34     INFO -  Cleaning up...
11:06:34     INFO - Return code: 0
11:06:34     INFO - Installing mar into virtualenv /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv
11:06:34     INFO - retry: Calling run_command with args: [['/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache', '--timeout', '120', 'mar']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c216c0350>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c290338b8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18596d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c920>, '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 0x7f2c2906b618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d6990>, 'level': 'critical'}], 'cwd': '/builds/slave/tb-rel-c-esr38-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-esr38-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-002.build.releng.use1.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/tb-rel-c-esr38-av-000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1
11:06:34     INFO - Running command: ['/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache', '--timeout', '120', 'mar'] in /builds/slave/tb-rel-c-esr38-av-000000000000/build
11:06:34     INFO - Copy/paste: /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip install --download-cache /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/cache --timeout 120 mar
11:06:34     INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom',
11:06:34     INFO -  'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs',
11:06:34     INFO -  'CCACHE_HASHDIR': '',
11:06:34     INFO -  'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber',
11:06:34     INFO -  'G_BROKEN_FILENAMES': '1',
11:06:34     INFO -  'HISTCONTROL': 'ignoredups',
11:06:34     INFO -  'HISTSIZE': '1000',
11:06:34     INFO -  'HOME': '/home/cltbld',
11:06:34     INFO -  'HOSTNAME': 'av-linux64-spot-002.build.releng.use1.mozilla.com',
11:06:34     INFO -  'LANG': 'en_US.UTF-8',
11:06:34     INFO -  'LESSOPEN': '|/usr/bin/lesspipe.sh %s',
11:06:34     INFO -  'LOGNAME': 'cltbld',
11:06:34     INFO -  'MAIL': '/var/spool/mail/cltbld',
11:06:34     INFO -  'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin',
11:06:34     INFO -  'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr38-av-000000000000/buildprops.json',
11:06:34     INFO -  'PWD': '/builds/slave/tb-rel-c-esr38-av-000000000000',
11:06:34     INFO -  'SHELL': '/bin/bash',
11:06:34     INFO -  'SHLVL': '1',
11:06:34     INFO -  'TERM': 'linux',
11:06:34     INFO -  'TMOUT': '86400',
11:06:34     INFO -  'USER': 'cltbld',
11:06:34     INFO -  '_': '/tools/buildbot/bin/python'}
11:06:36     INFO -  Ignoring indexes: http://pypi.python.org/simple/
11:06:36     INFO -  Downloading/unpacking mar
11:06:36     INFO -    Downloading mar-1.2.tar.gz
11:06:36     INFO -    Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmar-1.2.tar.gz
11:06:36     INFO -    Running setup.py egg_info for package mar
11:06:36     INFO -      no previously-included directories found matching 'dist'
11:06:36     INFO -  Installing collected packages: mar
11:06:36     INFO -    Running setup.py install for mar
11:06:36     INFO -      changing mode of build/scripts-2.7/mar.py from 664 to 775
11:06:36     INFO -      no previously-included directories found matching 'dist'
11:06:36     INFO -      changing mode of /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/mar.py to 775
11:06:36     INFO -  Successfully installed mar
11:06:36     INFO -  Cleaning up...
11:06:36     INFO - Return code: 0
11:06:36     INFO - Done creating virtualenv /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv.
11:06:36     INFO - Getting output from command: ['/builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip', 'freeze']
11:06:36     INFO - Copy/paste: /builds/slave/tb-rel-c-esr38-av-000000000000/build/venv/bin/pip freeze
11:06:36     INFO - Reading from file tmpfile_stdout
11:06:36     INFO - Current package versions:
11:06:36     INFO -   mar == 1.2
11:06:36     INFO -   distribute == 0.6.24
11:06:36     INFO -   redo == 1.4
11:06:36     INFO -   wsgiref == 0.1.2
11:06:36     INFO -   boto == 2.38.0
11:06:36     INFO - #####
11:06:36     INFO - ##### Running activate-virtualenv step.
11:06:36     INFO - #####
11:06:36     INFO - Running main action method: activate_virtualenv
11:06:36     INFO - #####
11:06:36     INFO - ##### Running get-extract-script step.
11:06:36     INFO - #####
11:06:36     INFO - Running main action method: get_extract_script
11:06:36     INFO - Downloading https://hg.mozilla.org/build/tools/raw-file/THUNDERBIRD_38_4_0_RELEASE/stage/extract_and_run_command.py to extract_and_run_command.py
11:06:36     INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/build/tools/raw-file/THUNDERBIRD_38_4_0_RELEASE/stage/extract_and_run_command.py', 'extract_and_run_command.py'), kwargs: {}, attempt #1
11:06:37     INFO - Downloaded 6429 bytes.
11:06:37     INFO - #####
11:06:37     INFO - ##### Running get-files step.
11:06:37     INFO - #####
11:06:37     INFO - Running main action method: get_files
11:06:37     INFO - Connecting to S3
11:06:37     INFO - Getting bucket net-mozaws-prod-delivery-archive
11:06:37     INFO - Getting key names from candidates
11:06:37    FATAL - Uncaught exception: Traceback (most recent call last):
11:06:37    FATAL -   File "/builds/slave/tb-rel-c-esr38-av-000000000000/scripts/mozharness/base/script.py", line 1693, in run
11:06:37    FATAL -     self.run_action(action)
11:06:37    FATAL -   File "/builds/slave/tb-rel-c-esr38-av-000000000000/scripts/mozharness/base/script.py", line 1635, in run_action
11:06:37    FATAL -     self._possibly_run_method(method_name, error_if_missing=True)
11:06:37    FATAL -   File "/builds/slave/tb-rel-c-esr38-av-000000000000/scripts/mozharness/base/script.py", line 1576, in _possibly_run_method
11:06:37    FATAL -     return getattr(self, method_name)()
11:06:37    FATAL -   File "scripts/scripts/release/antivirus.py", line 177, in get_files
11:06:37    FATAL -     pool.map(worker, find_release_files())
11:06:37    FATAL -   File "/tools/python27/lib/python2.7/multiprocessing/pool.py", line 227, in map
11:06:37    FATAL -     return self.map_async(func, iterable, chunksize).get()
11:06:37    FATAL -   File "/tools/python27/lib/python2.7/multiprocessing/pool.py", line 280, in map_async
11:06:37    FATAL -     iterable = list(iterable)
11:06:37    FATAL -   File "scripts/scripts/release/antivirus.py", line 173, in find_release_files
11:06:37    FATAL -     os.makedirs(dest_dir)
11:06:37    FATAL -   File "/tools/python27/lib/python2.7/os.py", line 157, in makedirs
11:06:37    FATAL -     mkdir(name, mode)
11:06:37    FATAL - OSError: [Errno 2] No such file or directory: ''
11:06:37    FATAL - Running post_fatal callback...
11:06:37    FATAL - Exiting -1
program finished with exit code 255
elapsedTime=10.992584
========= master_lag: 0.03 =========
========= Finished 'python2.7 scripts/scripts/release/antivirus.py ...' failed (results: 2, elapsed: 11 secs) (at 2015-11-20 11:06:37.864142) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:37.873996) =========
bash -c 'for file in `ls -1`; do cat $file; done'
 in dir /builds/slave/tb-rel-c-esr38-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-002.build.releng.use1.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-esr38-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.004669

========= master_lag: 0.05 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2015-11-20 11:06:37.923695) =========

========= Total master_lag: 1.73 =========