builder: release-mozilla-beta-firefox_antivirus slave: av-linux64-spot-004 starttime: 1447135542.56 results: failure (2) ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.561311) ========= master: http://buildbot-master72.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.561731) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.562043) ========= bash -c pwd in dir /builds/slave/rel-m-beta-av-0000000000000000/. (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-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/rel-m-beta-av-0000000000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False /builds/slave/rel-m-beta-av-0000000000000000 program finished with exit code 0 elapsedTime=0.003697 basedir: '/builds/slave/rel-m-beta-av-0000000000000000' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.614604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.614919) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.626216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.626481) ========= rm -rf properties in dir /builds/slave/rel-m-beta-av-0000000000000000/. (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-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/rel-m-beta-av-0000000000000000 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.002223 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.674121) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.674402) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.674731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:42.675030) ========= 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/rel-m-beta-av-0000000000000000/. (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/rel-m-beta-av-0000000000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False --2015-11-09 22:05:42-- 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: 12141 (12K) [text/x-python] Saving to: ‘archiver_client.py’ 0K .......... . 100% 7.84M=0.001s 2015-11-09 22:05:43 (7.84 MB/s) - ‘archiver_client.py’ saved [12141/12141] program finished with exit code 0 elapsedTime=0.333031 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:43.016242) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:43.016570) ========= rm -rf scripts in dir /builds/slave/rel-m-beta-av-0000000000000000/. (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-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/rel-m-beta-av-0000000000000000 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.002219 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:43.065080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-09 22:05:43.065357) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --tag FIREFOX_43_0b2_RELEASE --destination scripts --debug' in dir /builds/slave/rel-m-beta-av-0000000000000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --tag FIREFOX_43_0b2_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/rel-m-beta-av-0000000000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2015-11-09 22:05:43,114 Setting DEBUG logging. 2015-11-09 22:05:43,114 "FIREFOX_43_0b2_RELEASE" was passed as the tag. Querying remote repository for corresponding rev hash. 2015-11-09 22:05:43,725 revision being used: 6735ab09c616 2015-11-09 22:05:43,725 attempt 1/10 2015-11-09 22:05:43,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6735ab09c616?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-09 22:05:44,500 unpacking tar archive at: mozilla-beta-6735ab09c616/testing/mozharness/ program finished with exit code 0 elapsedTime=1.524597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-09 22:05:44.598628) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:44.598967) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/FIREFOX_43_0b2_RELEASE ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:44.599332) ========= ========= Started 'python2.7 scripts/scripts/release/antivirus.py ...' failed (results: 2, elapsed: 7 secs) (at 2015-11-09 22:05:44.599616) ========= python2.7 scripts/scripts/release/antivirus.py --product firefox --version 43.0b2 --build-number 1 --bucket-name net-mozaws-prod-delivery-firefox --tools-revision FIREFOX_43_0b2_RELEASE --tools-repo https://hg.mozilla.org/build/tools in dir /builds/slave/rel-m-beta-av-0000000000000000/. (timeout 10800 secs) watching logfiles {} argv: ['python2.7', 'scripts/scripts/release/antivirus.py', '--product', 'firefox', '--version', '43.0b2', '--build-number', '1', '--bucket-name', 'net-mozaws-prod-delivery-firefox', '--tools-revision', 'FIREFOX_43_0b2_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/rel-m-beta-av-0000000000000000/buildprops.json PWD=/builds/slave/rel-m-beta-av-0000000000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 22:05:44 INFO - MultiFileLogger online at 20151109 22:05:44 in /builds/slave/rel-m-beta-av-0000000000000000 22:05:44 INFO - Run as scripts/scripts/release/antivirus.py --product firefox --version 43.0b2 --build-number 1 --bucket-name net-mozaws-prod-delivery-firefox --tools-revision FIREFOX_43_0b2_RELEASE --tools-repo https://hg.mozilla.org/build/tools 22:05:44 INFO - Dumping config to /builds/slave/rel-m-beta-av-0000000000000000/logs/localconfig.json. 22:05:44 INFO - {'append_to_log': False, 22:05:44 INFO - 'base_work_dir': '/builds/slave/rel-m-beta-av-0000000000000000', 22:05:44 INFO - 'bucket_name': 'net-mozaws-prod-delivery-firefox', 22:05:44 INFO - 'build_number': '1', 22:05:44 INFO - 'download_parallelization': 6, 22:05:44 INFO - 'log_level': 'info', 22:05:44 INFO - 'log_to_console': True, 22:05:44 INFO - 'opt_config_files': (), 22:05:44 INFO - 'pip_index': True, 22:05:44 INFO - 'product': 'firefox', 22:05:44 INFO - 'scan_parallelization': 4, 22:05:44 INFO - 'tools_repo': 'https://hg.mozilla.org/build/tools', 22:05:44 INFO - 'tools_revision': 'FIREFOX_43_0b2_RELEASE', 22:05:44 INFO - 'version': '43.0b2', 22:05:44 INFO - 'virtualenv_modules': ('boto', 'redo', 'mar'), 22:05:44 INFO - 'virtualenv_path': 'venv', 22:05:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:05:44 INFO - 'work_dir': 'build'} 22:05:44 INFO - ##### 22:05:44 INFO - ##### Running create-virtualenv step. 22:05:44 INFO - ##### 22:05:44 INFO - Running main action method: create_virtualenv 22:05:44 INFO - Creating virtualenv /builds/slave/rel-m-beta-av-0000000000000000/build/venv 22:05:44 INFO - mkdir: /builds/slave/rel-m-beta-av-0000000000000000/build 22:05:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/rel-m-beta-av-0000000000000000/build/venv'] in /builds/slave/rel-m-beta-av-0000000000000000/build 22:05:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/rel-m-beta-av-0000000000000000/build/venv 22:05:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:05:45 INFO - New python executable in /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/python2.7 22:05:45 INFO - Also creating executable in /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/python 22:05:46 INFO - Installing distribute.............................................................................................................................................................................................done. 22:05:46 INFO - Installing pip...............done. 22:05:46 INFO - Return code: 0 22:05:46 INFO - Installing boto into virtualenv /builds/slave/rel-m-beta-av-0000000000000000/build/venv 22:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-beta-av-0000000000000000/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 0x7f1f319af2b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f39322960>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4920>, '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 0x7f1f3935a618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f3190d990>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-m-beta-av-0000000000000000/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/rel-m-beta-av-0000000000000000/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/rel-m-beta-av-0000000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1 22:05:46 INFO - Running command: ['/builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-beta-av-0000000000000000/build/venv/cache', '--timeout', '120', 'boto'] in /builds/slave/rel-m-beta-av-0000000000000000/build 22:05:46 INFO - Copy/paste: /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip install --download-cache /builds/slave/rel-m-beta-av-0000000000000000/build/venv/cache --timeout 120 boto 22:05:46 INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 22:05:46 INFO - 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 22:05:46 INFO - 'CCACHE_HASHDIR': '', 22:05:46 INFO - 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 22:05:46 INFO - 'G_BROKEN_FILENAMES': '1', 22:05:46 INFO - 'HISTCONTROL': 'ignoredups', 22:05:46 INFO - 'HISTSIZE': '1000', 22:05:46 INFO - 'HOME': '/home/cltbld', 22:05:46 INFO - 'HOSTNAME': 'av-linux64-spot-004.build.releng.usw2.mozilla.com', 22:05:46 INFO - 'LANG': 'en_US.UTF-8', 22:05:46 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 22:05:46 INFO - 'LOGNAME': 'cltbld', 22:05:46 INFO - 'MAIL': '/var/spool/mail/cltbld', 22:05:46 INFO - 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 22:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-m-beta-av-0000000000000000/buildprops.json', 22:05:46 INFO - 'PWD': '/builds/slave/rel-m-beta-av-0000000000000000', 22:05:46 INFO - 'SHELL': '/bin/bash', 22:05:46 INFO - 'SHLVL': '1', 22:05:46 INFO - 'TERM': 'linux', 22:05:46 INFO - 'TMOUT': '86400', 22:05:46 INFO - 'USER': 'cltbld', 22:05:46 INFO - '_': '/tools/buildbot/bin/python'} 22:05:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 22:05:48 INFO - Downloading/unpacking boto 22:05:48 INFO - Creating supposed download cache at /builds/slave/rel-m-beta-av-0000000000000000/build/venv/cache 22:05:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fboto-2.38.0.tar.gz 22:05:48 INFO - Running setup.py egg_info for package boto 22:05:48 INFO - warning: no files found matching 'boto/mturk/test/*.doctest' 22:05:48 INFO - warning: no files found matching 'boto/mturk/test/.gitignore' 22:05:48 INFO - Installing collected packages: boto 22:05:48 INFO - Running setup.py install for boto 22:05:48 INFO - warning: no files found matching 'boto/mturk/test/*.doctest' 22:05:48 INFO - warning: no files found matching 'boto/mturk/test/.gitignore' 22:05:48 INFO - changing mode of build/scripts-2.7/sdbadmin from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/elbadmin from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/cfadmin from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/s3put from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/fetch_file from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/launch_instance from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/list_instances from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/taskadmin from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/kill_instance from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/bundle_image from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/pyami_sendmail from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/lss3 from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/cq from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/route53 from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/cwutil from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/instance_events from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/asadmin from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/glacier from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/mturk from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/dynamodb_dump from 664 to 775 22:05:48 INFO - changing mode of build/scripts-2.7/dynamodb_load from 664 to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/cfadmin to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/sdbadmin to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/launch_instance to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/route53 to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/list_instances to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/dynamodb_load to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/cq to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/cwutil to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/s3put to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/dynamodb_dump to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/kill_instance to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/bundle_image to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/fetch_file to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/mturk to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/asadmin to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pyami_sendmail to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/lss3 to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/glacier to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/taskadmin to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/elbadmin to 775 22:05:48 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/instance_events to 775 22:05:48 INFO - Successfully installed boto 22:05:48 INFO - Cleaning up... 22:05:48 INFO - Return code: 0 22:05:48 INFO - Installing redo into virtualenv /builds/slave/rel-m-beta-av-0000000000000000/build/venv 22:05:48 INFO - retry: Calling run_command with args: [['/builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-beta-av-0000000000000000/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 0x7f1f319af2b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f39322960>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4920>, '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 0x7f1f3935a618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f3190d990>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-m-beta-av-0000000000000000/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/rel-m-beta-av-0000000000000000/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/rel-m-beta-av-0000000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1 22:05:48 INFO - Running command: ['/builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-beta-av-0000000000000000/build/venv/cache', '--timeout', '120', 'redo'] in /builds/slave/rel-m-beta-av-0000000000000000/build 22:05:48 INFO - Copy/paste: /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip install --download-cache /builds/slave/rel-m-beta-av-0000000000000000/build/venv/cache --timeout 120 redo 22:05:48 INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 22:05:48 INFO - 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 22:05:48 INFO - 'CCACHE_HASHDIR': '', 22:05:48 INFO - 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 22:05:48 INFO - 'G_BROKEN_FILENAMES': '1', 22:05:48 INFO - 'HISTCONTROL': 'ignoredups', 22:05:48 INFO - 'HISTSIZE': '1000', 22:05:48 INFO - 'HOME': '/home/cltbld', 22:05:48 INFO - 'HOSTNAME': 'av-linux64-spot-004.build.releng.usw2.mozilla.com', 22:05:48 INFO - 'LANG': 'en_US.UTF-8', 22:05:48 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 22:05:48 INFO - 'LOGNAME': 'cltbld', 22:05:48 INFO - 'MAIL': '/var/spool/mail/cltbld', 22:05:48 INFO - 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 22:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-m-beta-av-0000000000000000/buildprops.json', 22:05:48 INFO - 'PWD': '/builds/slave/rel-m-beta-av-0000000000000000', 22:05:48 INFO - 'SHELL': '/bin/bash', 22:05:48 INFO - 'SHLVL': '1', 22:05:48 INFO - 'TERM': 'linux', 22:05:48 INFO - 'TMOUT': '86400', 22:05:48 INFO - 'USER': 'cltbld', 22:05:48 INFO - '_': '/tools/buildbot/bin/python'} 22:05:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 22:05:49 INFO - Downloading/unpacking redo 22:05:49 INFO - Downloading redo-1.4.tar.gz 22:05:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fredo-1.4.tar.gz 22:05:49 INFO - Running setup.py egg_info for package redo 22:05:49 INFO - Installing collected packages: redo 22:05:49 INFO - Running setup.py install for redo 22:05:49 INFO - Installing retry script to /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin 22:05:49 INFO - Successfully installed redo 22:05:49 INFO - Cleaning up... 22:05:49 INFO - Return code: 0 22:05:49 INFO - Installing mar into virtualenv /builds/slave/rel-m-beta-av-0000000000000000/build/venv 22:05:49 INFO - retry: Calling run_command with args: [['/builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-beta-av-0000000000000000/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 0x7f1f319af2b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f39322960>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f4920>, '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 0x7f1f3935a618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f3190d990>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-m-beta-av-0000000000000000/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/rel-m-beta-av-0000000000000000/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/rel-m-beta-av-0000000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1 22:05:49 INFO - Running command: ['/builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-beta-av-0000000000000000/build/venv/cache', '--timeout', '120', 'mar'] in /builds/slave/rel-m-beta-av-0000000000000000/build 22:05:49 INFO - Copy/paste: /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip install --download-cache /builds/slave/rel-m-beta-av-0000000000000000/build/venv/cache --timeout 120 mar 22:05:49 INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 22:05:49 INFO - 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 22:05:49 INFO - 'CCACHE_HASHDIR': '', 22:05:49 INFO - 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 22:05:49 INFO - 'G_BROKEN_FILENAMES': '1', 22:05:49 INFO - 'HISTCONTROL': 'ignoredups', 22:05:49 INFO - 'HISTSIZE': '1000', 22:05:49 INFO - 'HOME': '/home/cltbld', 22:05:49 INFO - 'HOSTNAME': 'av-linux64-spot-004.build.releng.usw2.mozilla.com', 22:05:49 INFO - 'LANG': 'en_US.UTF-8', 22:05:49 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 22:05:49 INFO - 'LOGNAME': 'cltbld', 22:05:49 INFO - 'MAIL': '/var/spool/mail/cltbld', 22:05:49 INFO - 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 22:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-m-beta-av-0000000000000000/buildprops.json', 22:05:49 INFO - 'PWD': '/builds/slave/rel-m-beta-av-0000000000000000', 22:05:49 INFO - 'SHELL': '/bin/bash', 22:05:49 INFO - 'SHLVL': '1', 22:05:49 INFO - 'TERM': 'linux', 22:05:49 INFO - 'TMOUT': '86400', 22:05:49 INFO - 'USER': 'cltbld', 22:05:49 INFO - '_': '/tools/buildbot/bin/python'} 22:05:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 22:05:50 INFO - Downloading/unpacking mar 22:05:50 INFO - Downloading mar-1.2.tar.gz 22:05:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmar-1.2.tar.gz 22:05:50 INFO - Running setup.py egg_info for package mar 22:05:50 INFO - no previously-included directories found matching 'dist' 22:05:50 INFO - Installing collected packages: mar 22:05:50 INFO - Running setup.py install for mar 22:05:50 INFO - changing mode of build/scripts-2.7/mar.py from 664 to 775 22:05:50 INFO - no previously-included directories found matching 'dist' 22:05:50 INFO - changing mode of /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/mar.py to 775 22:05:50 INFO - Successfully installed mar 22:05:50 INFO - Cleaning up... 22:05:50 INFO - Return code: 0 22:05:50 INFO - Done creating virtualenv /builds/slave/rel-m-beta-av-0000000000000000/build/venv. 22:05:50 INFO - Getting output from command: ['/builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip', 'freeze'] 22:05:50 INFO - Copy/paste: /builds/slave/rel-m-beta-av-0000000000000000/build/venv/bin/pip freeze 22:05:50 INFO - Reading from file tmpfile_stdout 22:05:50 INFO - Current package versions: 22:05:50 INFO - boto == 2.38.0 22:05:50 INFO - distribute == 0.6.24 22:05:50 INFO - mar == 1.2 22:05:50 INFO - redo == 1.4 22:05:50 INFO - wsgiref == 0.1.2 22:05:50 INFO - ##### 22:05:50 INFO - ##### Running activate-virtualenv step. 22:05:50 INFO - ##### 22:05:50 INFO - Running main action method: activate_virtualenv 22:05:50 INFO - ##### 22:05:50 INFO - ##### Running get-extract-script step. 22:05:50 INFO - ##### 22:05:50 INFO - Running main action method: get_extract_script 22:05:50 INFO - Downloading https://hg.mozilla.org/build/tools/raw-file/FIREFOX_43_0b2_RELEASE/stage/extract_and_run_command.py to extract_and_run_command.py 22:05:50 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/build/tools/raw-file/FIREFOX_43_0b2_RELEASE/stage/extract_and_run_command.py', 'extract_and_run_command.py'), kwargs: {}, attempt #1 22:05:50 INFO - Downloaded 6429 bytes. 22:05:50 INFO - ##### 22:05:50 INFO - ##### Running get-files step. 22:05:50 INFO - ##### 22:05:50 INFO - Running main action method: get_files 22:05:50 INFO - Connecting to S3 22:05:50 INFO - Getting bucket net-mozaws-prod-delivery-firefox 22:05:51 INFO - Getting key names from candidates 22:05:52 FATAL - Uncaught exception: Traceback (most recent call last): 22:05:52 FATAL - File "/builds/slave/rel-m-beta-av-0000000000000000/scripts/mozharness/base/script.py", line 1698, in run 22:05:52 FATAL - self.run_action(action) 22:05:52 FATAL - File "/builds/slave/rel-m-beta-av-0000000000000000/scripts/mozharness/base/script.py", line 1640, in run_action 22:05:52 FATAL - self._possibly_run_method(method_name, error_if_missing=True) 22:05:52 FATAL - File "/builds/slave/rel-m-beta-av-0000000000000000/scripts/mozharness/base/script.py", line 1581, in _possibly_run_method 22:05:52 FATAL - return getattr(self, method_name)() 22:05:52 FATAL - File "scripts/scripts/release/antivirus.py", line 177, in get_files 22:05:52 FATAL - pool.map(worker, find_release_files()) 22:05:52 FATAL - File "/tools/python27/lib/python2.7/multiprocessing/pool.py", line 227, in map 22:05:52 FATAL - return self.map_async(func, iterable, chunksize).get() 22:05:52 FATAL - File "/tools/python27/lib/python2.7/multiprocessing/pool.py", line 280, in map_async 22:05:52 FATAL - iterable = list(iterable) 22:05:52 FATAL - File "scripts/scripts/release/antivirus.py", line 173, in find_release_files 22:05:52 FATAL - os.makedirs(dest_dir) 22:05:52 FATAL - File "/tools/python27/lib/python2.7/os.py", line 157, in makedirs 22:05:52 FATAL - mkdir(name, mode) 22:05:52 FATAL - OSError: [Errno 2] No such file or directory: '' 22:05:52 FATAL - Running post_fatal callback... 22:05:52 FATAL - Exiting -1 program finished with exit code 255 elapsedTime=7.619135 ========= master_lag: 0.01 ========= ========= Finished 'python2.7 scripts/scripts/release/antivirus.py ...' failed (results: 2, elapsed: 7 secs) (at 2015-11-09 22:05:52.228816) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:52.230417) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-m-beta-av-0000000000000000/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/rel-m-beta-av-0000000000000000/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.004469 ========= master_lag: 0.04 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2015-11-09 22:05:52.279396) ========= ========= Total master_lag: 0.21 =========