builder: release-mozilla-release-firefox_checksums slave: bld-linux64-spot-301 starttime: 1445944182.44 results: success (0) ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.438226) ========= master: http://buildbot-master91.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.438671) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.438965) ========= bash -c pwd in dir /builds/slave/rel-m-rel-fx_sums-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=bld-linux64-spot-301.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-rel-fx_sums-000000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False /builds/slave/rel-m-rel-fx_sums-000000000000 program finished with exit code 0 elapsedTime=0.003754 basedir: '/builds/slave/rel-m-rel-fx_sums-000000000000' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.491906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.492209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.505843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.506150) ========= rm -rf properties in dir /builds/slave/rel-m-rel-fx_sums-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=bld-linux64-spot-301.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-rel-fx_sums-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.002808 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.554754) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.555056) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.555427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.555701) ========= 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-rel-fx_sums-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=bld-linux64-spot-301.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-rel-fx_sums-000000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False --2015-10-27 04:09:42-- 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% 107M=0s 2015-10-27 04:09:42 (107 MB/s) - ‘archiver_client.py’ saved [12141/12141] program finished with exit code 0 elapsedTime=0.369714 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.938005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.938325) ========= rm -rf scripts in dir /builds/slave/rel-m-rel-fx_sums-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=bld-linux64-spot-301.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-rel-fx_sums-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.002888 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:42.986758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-27 04:09:42.987070) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-release --tag FIREFOX_42_0_RELEASE --destination scripts --debug' in dir /builds/slave/rel-m-rel-fx_sums-000000000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-release --tag FIREFOX_42_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=bld-linux64-spot-301.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-rel-fx_sums-000000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2015-10-27 04:09:43,060 Setting DEBUG logging. 2015-10-27 04:09:43,060 "FIREFOX_42_0_RELEASE" was passed as the tag. Querying remote repository for corresponding rev hash. 2015-10-27 04:09:43,853 revision being used: b1a68883552e 2015-10-27 04:09:43,853 attempt 1/10 2015-10-27 04:09:43,853 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-release/b1a68883552e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-27 04:09:44,138 unpacking tar archive at: mozilla-release-b1a68883552e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.269514 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-27 04:09:44.270024) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.270363) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/FIREFOX_42_0_RELEASE ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.270737) ========= ========= Started remove old nonce (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.271014) ========= rm -f nonce in dir /builds/slave/rel-m-rel-fx_sums-000000000000/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'nonce'] 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=bld-linux64-spot-301.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-rel-fx_sums-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.002790 ========= Finished remove old nonce (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.319819) ========= ========= Started downloading to token (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.320126) ========= Slave: bld-linux64-spot-301 IP: 10.132.54.175 Duration: 25200 URI: https://mac-v2-signing7.srv.releng.scl3.mozilla.com:9120/token ========= Finished downloading to token (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.769042) ========= ========= Started set props: toolsdir (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.769480) ========= bash -c pwd in dir /builds/slave/rel-m-rel-fx_sums-000000000000/scripts (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=bld-linux64-spot-301.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-rel-fx_sums-000000000000/scripts SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False /builds/slave/rel-m-rel-fx_sums-000000000000/scripts program finished with exit code 0 elapsedTime=0.003626 toolsdir: '/builds/slave/rel-m-rel-fx_sums-000000000000/scripts' ========= Finished set props: toolsdir (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.818705) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.819026) ========= bash -c pwd in dir /builds/slave/rel-m-rel-fx_sums-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=bld-linux64-spot-301.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-rel-fx_sums-000000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False /builds/slave/rel-m-rel-fx_sums-000000000000 program finished with exit code 0 elapsedTime=0.003225 basedir: '/builds/slave/rel-m-rel-fx_sums-000000000000' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 04:09:44.868376) ========= ========= Started 'python2.7 scripts/scripts/release/generate-checksums.py ...' (results: 0, elapsed: 21 secs) (at 2015-10-27 04:09:44.868684) ========= python2.7 scripts/scripts/release/generate-checksums.py --stage-product firefox --version 42.0 --build-number 1 --bucket-name-prefix net-mozaws-prod-delivery --upload-host upload.ffxbld.productdelivery.prod.mozaws.net --upload-user ffxbld --upload-ssh-key '~/.ssh/ffxbld_rsa' --gecko-repo https://hg.mozilla.org/releases/mozilla-release --gecko-revision FIREFOX_42_0_RELEASE --tools-repo /tools/checkouts/build-tools in dir /builds/slave/rel-m-rel-fx_sums-000000000000/. (timeout 1200 secs) watching logfiles {} argv: ['python2.7', 'scripts/scripts/release/generate-checksums.py', '--stage-product', 'firefox', '--version', '42.0', '--build-number', '1', '--bucket-name-prefix', 'net-mozaws-prod-delivery', '--upload-host', 'upload.ffxbld.productdelivery.prod.mozaws.net', '--upload-user', 'ffxbld', '--upload-ssh-key', '~/.ssh/ffxbld_rsa', '--gecko-repo', 'https://hg.mozilla.org/releases/mozilla-release', '--gecko-revision', 'FIREFOX_42_0_RELEASE', '--tools-repo', '/tools/checkouts/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=bld-linux64-spot-301.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld MOZ_SIGNING_SERVERS=gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120 MOZ_SIGN_CMD=python /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/signtool.py --cachedir /builds/slave/rel-m-rel-fx_sums-000000000000/signing_cache -t /builds/slave/rel-m-rel-fx_sums-000000000000/token -n /builds/slave/rel-m-rel-fx_sums-000000000000/nonce -c /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120 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-rel-fx_sums-000000000000/buildprops.json PWD=/builds/slave/rel-m-rel-fx_sums-000000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 04:09:45 INFO - MultiFileLogger online at 20151027 04:09:45 in /builds/slave/rel-m-rel-fx_sums-000000000000 04:09:45 INFO - Run as scripts/scripts/release/generate-checksums.py --stage-product firefox --version 42.0 --build-number 1 --bucket-name-prefix net-mozaws-prod-delivery --upload-host upload.ffxbld.productdelivery.prod.mozaws.net --upload-user ffxbld --upload-ssh-key ~/.ssh/ffxbld_rsa --gecko-repo https://hg.mozilla.org/releases/mozilla-release --gecko-revision FIREFOX_42_0_RELEASE --tools-repo /tools/checkouts/build-tools 04:09:45 INFO - Dumping config to /builds/slave/rel-m-rel-fx_sums-000000000000/logs/localconfig.json. 04:09:45 INFO - {'append_to_log': False, 04:09:45 INFO - 'base_work_dir': '/builds/slave/rel-m-rel-fx_sums-000000000000', 04:09:45 INFO - 'bucket_name_prefix': 'net-mozaws-prod-delivery', 04:09:45 INFO - 'build_number': '1', 04:09:45 INFO - 'formats': ('sha512',), 04:09:45 INFO - 'gecko_repo': 'https://hg.mozilla.org/releases/mozilla-release', 04:09:45 INFO - 'gecko_revision': 'FIREFOX_42_0_RELEASE', 04:09:45 INFO - 'includes': ('^.*\\.tar\\.bz2$', 04:09:45 INFO - '^.*\\.dmg$', 04:09:45 INFO - '^.*\\.bundle$', 04:09:45 INFO - '^.*\\.mar$', 04:09:45 INFO - '^.*Setup.*\\.exe$', 04:09:45 INFO - '^.*\\.xpi$'), 04:09:45 INFO - 'log_level': 'info', 04:09:45 INFO - 'log_to_console': True, 04:09:45 INFO - 'opt_config_files': (), 04:09:45 INFO - 'parallelization': 20, 04:09:45 INFO - 'pip_index': True, 04:09:45 INFO - 'stage_product': 'firefox', 04:09:45 INFO - 'tools_repo': '/tools/checkouts/build-tools', 04:09:45 INFO - 'upload_host': 'upload.ffxbld.productdelivery.prod.mozaws.net', 04:09:45 INFO - 'upload_ssh_key': '~/.ssh/ffxbld_rsa', 04:09:45 INFO - 'upload_user': 'ffxbld', 04:09:45 INFO - 'version': '42.0', 04:09:45 INFO - 'virtualenv_modules': ('boto', 'redo'), 04:09:45 INFO - 'virtualenv_path': 'venv', 04:09:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:45 INFO - 'work_dir': 'build'} 04:09:45 INFO - ##### 04:09:45 INFO - ##### Running create-virtualenv step. 04:09:45 INFO - ##### 04:09:45 INFO - Running main action method: create_virtualenv 04:09:45 INFO - Creating virtualenv /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv 04:09:45 INFO - mkdir: /builds/slave/rel-m-rel-fx_sums-000000000000/build 04:09:45 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/rel-m-rel-fx_sums-000000000000/build/venv'] in /builds/slave/rel-m-rel-fx_sums-000000000000/build 04:09:45 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv 04:09:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:45 INFO - New python executable in /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/python2.7 04:09:45 INFO - Also creating executable in /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/python 04:09:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:46 INFO - Installing pip...............done. 04:09:46 INFO - Return code: 0 04:09:46 INFO - Installing boto into virtualenv /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv 04:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-rel-fx_sums-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 0x1c16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c63a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23920>, '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 0x7f4de1dad618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1971990>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-m-rel-fx_sums-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', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'SHLVL': '1', 'G_BROKEN_FILENAMES': '1', 'HISTSIZE': '1000', 'PROPERTIES_FILE': '/builds/slave/rel-m-rel-fx_sums-000000000000/buildprops.json', 'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 'MOZ_SIGN_CMD': 'python /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/signtool.py --cachedir /builds/slave/rel-m-rel-fx_sums-000000000000/signing_cache -t /builds/slave/rel-m-rel-fx_sums-000000000000/token -n /builds/slave/rel-m-rel-fx_sums-000000000000/nonce -c /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', '_': '/tools/buildbot/bin/python', 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 'HOSTNAME': 'bld-linux64-spot-301.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/rel-m-rel-fx_sums-000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1 04:09:46 INFO - Running command: ['/builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/cache', '--timeout', '120', 'boto'] in /builds/slave/rel-m-rel-fx_sums-000000000000/build 04:09:46 INFO - Copy/paste: /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/pip install --download-cache /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/cache --timeout 120 boto 04:09:46 INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 04:09:46 INFO - 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 04:09:46 INFO - 'CCACHE_HASHDIR': '', 04:09:46 INFO - 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 04:09:46 INFO - 'G_BROKEN_FILENAMES': '1', 04:09:46 INFO - 'HISTCONTROL': 'ignoredups', 04:09:46 INFO - 'HISTSIZE': '1000', 04:09:46 INFO - 'HOME': '/home/cltbld', 04:09:46 INFO - 'HOSTNAME': 'bld-linux64-spot-301.build.releng.usw2.mozilla.com', 04:09:46 INFO - 'LANG': 'en_US.UTF-8', 04:09:46 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 04:09:46 INFO - 'LOGNAME': 'cltbld', 04:09:46 INFO - 'MAIL': '/var/spool/mail/cltbld', 04:09:46 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:09:46 INFO - 'MOZ_SIGN_CMD': 'python /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/signtool.py --cachedir /builds/slave/rel-m-rel-fx_sums-000000000000/signing_cache -t /builds/slave/rel-m-rel-fx_sums-000000000000/token -n /builds/slave/rel-m-rel-fx_sums-000000000000/nonce -c /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:09:46 INFO - 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 04:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-m-rel-fx_sums-000000000000/buildprops.json', 04:09:46 INFO - 'PWD': '/builds/slave/rel-m-rel-fx_sums-000000000000', 04:09:46 INFO - 'SHELL': '/bin/bash', 04:09:46 INFO - 'SHLVL': '1', 04:09:46 INFO - 'TERM': 'linux', 04:09:46 INFO - 'TMOUT': '86400', 04:09:46 INFO - 'USER': 'cltbld', 04:09:46 INFO - '_': '/tools/buildbot/bin/python'} 04:09:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:09:48 INFO - Downloading/unpacking boto 04:09:48 INFO - Creating supposed download cache at /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/cache 04:09:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fboto-2.38.0.tar.gz 04:09:48 INFO - Running setup.py egg_info for package boto 04:09:48 INFO - warning: no files found matching 'boto/mturk/test/*.doctest' 04:09:48 INFO - warning: no files found matching 'boto/mturk/test/.gitignore' 04:09:48 INFO - Installing collected packages: boto 04:09:48 INFO - Running setup.py install for boto 04:09:48 INFO - warning: no files found matching 'boto/mturk/test/*.doctest' 04:09:48 INFO - warning: no files found matching 'boto/mturk/test/.gitignore' 04:09:48 INFO - changing mode of build/scripts-2.7/sdbadmin from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/elbadmin from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/cfadmin from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/s3put from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/fetch_file from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/launch_instance from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/list_instances from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/taskadmin from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/kill_instance from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/bundle_image from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/pyami_sendmail from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/lss3 from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/cq from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/route53 from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/cwutil from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/instance_events from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/asadmin from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/glacier from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/mturk from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/dynamodb_dump from 664 to 775 04:09:48 INFO - changing mode of build/scripts-2.7/dynamodb_load from 664 to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/cfadmin to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/sdbadmin to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/launch_instance to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/route53 to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/list_instances to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/dynamodb_load to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/cq to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/cwutil to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/s3put to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/dynamodb_dump to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/kill_instance to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/bundle_image to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/fetch_file to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/mturk to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/asadmin to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/pyami_sendmail to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/lss3 to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/glacier to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/taskadmin to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/elbadmin to 775 04:09:48 INFO - changing mode of /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/instance_events to 775 04:09:48 INFO - Successfully installed boto 04:09:48 INFO - Cleaning up... 04:09:48 INFO - Return code: 0 04:09:48 INFO - Installing redo into virtualenv /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv 04:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-rel-fx_sums-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 0x1c16490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c63a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c23920>, '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 0x7f4de1dad618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1971990>, 'level': 'critical'}], 'cwd': '/builds/slave/rel-m-rel-fx_sums-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', 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'SHLVL': '1', 'G_BROKEN_FILENAMES': '1', 'HISTSIZE': '1000', 'PROPERTIES_FILE': '/builds/slave/rel-m-rel-fx_sums-000000000000/buildprops.json', 'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 'MOZ_SIGN_CMD': 'python /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/signtool.py --cachedir /builds/slave/rel-m-rel-fx_sums-000000000000/signing_cache -t /builds/slave/rel-m-rel-fx_sums-000000000000/token -n /builds/slave/rel-m-rel-fx_sums-000000000000/nonce -c /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', '_': '/tools/buildbot/bin/python', 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 'HOSTNAME': 'bld-linux64-spot-301.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/rel-m-rel-fx_sums-000000000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1 04:09:48 INFO - Running command: ['/builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/cache', '--timeout', '120', 'redo'] in /builds/slave/rel-m-rel-fx_sums-000000000000/build 04:09:48 INFO - Copy/paste: /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/pip install --download-cache /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/cache --timeout 120 redo 04:09:48 INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 04:09:48 INFO - 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 04:09:48 INFO - 'CCACHE_HASHDIR': '', 04:09:48 INFO - 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 04:09:48 INFO - 'G_BROKEN_FILENAMES': '1', 04:09:48 INFO - 'HISTCONTROL': 'ignoredups', 04:09:48 INFO - 'HISTSIZE': '1000', 04:09:48 INFO - 'HOME': '/home/cltbld', 04:09:48 INFO - 'HOSTNAME': 'bld-linux64-spot-301.build.releng.usw2.mozilla.com', 04:09:48 INFO - 'LANG': 'en_US.UTF-8', 04:09:48 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 04:09:48 INFO - 'LOGNAME': 'cltbld', 04:09:48 INFO - 'MAIL': '/var/spool/mail/cltbld', 04:09:48 INFO - 'MOZ_SIGNING_SERVERS': 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120,gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120,dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:09:48 INFO - 'MOZ_SIGN_CMD': 'python /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/signtool.py --cachedir /builds/slave/rel-m-rel-fx_sums-000000000000/signing_cache -t /builds/slave/rel-m-rel-fx_sums-000000000000/token -n /builds/slave/rel-m-rel-fx_sums-000000000000/nonce -c /builds/slave/rel-m-rel-fx_sums-000000000000/scripts/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 04:09:48 INFO - 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 04:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/rel-m-rel-fx_sums-000000000000/buildprops.json', 04:09:48 INFO - 'PWD': '/builds/slave/rel-m-rel-fx_sums-000000000000', 04:09:48 INFO - 'SHELL': '/bin/bash', 04:09:48 INFO - 'SHLVL': '1', 04:09:48 INFO - 'TERM': 'linux', 04:09:48 INFO - 'TMOUT': '86400', 04:09:48 INFO - 'USER': 'cltbld', 04:09:48 INFO - '_': '/tools/buildbot/bin/python'} 04:09:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:09:49 INFO - Downloading/unpacking redo 04:09:49 INFO - Downloading redo-1.4.tar.gz 04:09:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fredo-1.4.tar.gz 04:09:49 INFO - Running setup.py egg_info for package redo 04:09:49 INFO - Installing collected packages: redo 04:09:49 INFO - Running setup.py install for redo 04:09:49 INFO - Installing retry script to /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin 04:09:49 INFO - Successfully installed redo 04:09:49 INFO - Cleaning up... 04:09:49 INFO - Return code: 0 04:09:49 INFO - Done creating virtualenv /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv. 04:09:49 INFO - Getting output from command: ['/builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/pip', 'freeze'] 04:09:49 INFO - Copy/paste: /builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin/pip freeze 04:09:49 INFO - Reading from file tmpfile_stdout 04:09:49 INFO - Current package versions: 04:09:49 INFO - distribute == 0.6.24 04:09:49 INFO - redo == 1.4 04:09:49 INFO - wsgiref == 0.1.2 04:09:49 INFO - boto == 2.38.0 04:09:49 INFO - ##### 04:09:49 INFO - ##### Running activate-virtualenv step. 04:09:49 INFO - ##### 04:09:49 INFO - Running main action method: activate_virtualenv 04:09:49 INFO - ##### 04:09:49 INFO - ##### Running collect-individual-checksums step. 04:09:49 INFO - ##### 04:09:49 INFO - Running main action method: collect_individual_checksums 04:09:49 INFO - Bucket name is: net-mozaws-prod-delivery-firefox 04:09:49 INFO - File prefix is: pub/firefox/candidates/42.0-candidates/build1 04:09:49 INFO - Connecting to S3 04:09:49 INFO - Getting key names from bucket 04:09:58 INFO - ##### 04:09:58 INFO - ##### Running create-big-checksums step. 04:09:58 INFO - ##### 04:09:58 INFO - Running main action method: create_big_checksums 04:09:58 INFO - Creating big checksums file: SHA512SUMS 04:09:58 INFO - ##### 04:09:58 INFO - ##### Running sign step. 04:09:58 INFO - ##### 04:09:58 INFO - Running main action method: sign 04:09:58 INFO - retry: Calling _get_revision with args: (, '/builds/slave/rel-m-rel-fx_sums-000000000000/build/tools'), kwargs: {}, attempt #1 04:09:58 INFO - Running command: ['hgtool.py', '/tools/checkouts/build-tools', '/builds/slave/rel-m-rel-fx_sums-000000000000/build/tools'] 04:09:58 INFO - Copy/paste: hgtool.py /tools/checkouts/build-tools /builds/slave/rel-m-rel-fx_sums-000000000000/build/tools 04:09:58 INFO - Using env: {'PATH': '/builds/slave/rel-m-rel-fx_sums-000000000000/build/venv/bin:/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin'} 04:09:58 INFO - Reporting hg version in use 04:09:58 INFO - command: START 04:09:58 INFO - command: hg -q version 04:09:58 INFO - command: cwd: . 04:09:58 INFO - command: output: 04:09:58 INFO - Mercurial Distributed SCM (version 3.2.1) 04:09:58 INFO - command: END (0.29s elapsed) 04:09:58 INFO - command: START 04:09:58 INFO - command: hg clone --traceback /tools/checkouts/build-tools /builds/slave/rel-m-rel-fx_sums-000000000000/build/tools 04:09:58 INFO - command: cwd: /builds/slave/rel-m-rel-fx_sums-000000000000 04:09:58 INFO - command: env: {'HGPLAIN': '1'} 04:10:00 INFO - command: END (1.50s elapsed) 04:10:00 INFO - command: output: 04:10:00 INFO - updating to branch default 04:10:00 INFO - 1125 files updated, 0 files merged, 0 files removed, 0 files unresolved 04:10:00 INFO - command: START 04:10:00 INFO - command: hg branch 04:10:00 INFO - command: cwd: /builds/slave/rel-m-rel-fx_sums-000000000000/build/tools 04:10:00 INFO - command: env: {'HGPLAIN': '1'} 04:10:00 INFO - command: END (0.50s elapsed) 04:10:00 INFO - command: output: 04:10:00 INFO - default 04:10:00 INFO - command: START 04:10:00 INFO - command: hg update -C 04:10:00 INFO - command: cwd: /builds/slave/rel-m-rel-fx_sums-000000000000/build/tools 04:10:00 INFO - command: output: 04:10:01 INFO - 0 files updated, 0 files merged, 0 files removed, 0 files unresolved 04:10:01 INFO - command: END (1.09s elapsed) 04:10:01 INFO - command: START 04:10:01 INFO - command: hg parent --template {node|short} 04:10:01 INFO - command: cwd: /builds/slave/rel-m-rel-fx_sums-000000000000/build/tools 04:10:01 INFO - command: env: {'HGPLAIN': '1'} 04:10:02 INFO - command: END (0.50s elapsed) 04:10:02 INFO - command: output: 04:10:02 INFO - 4cd39eec6f0e 04:10:02 INFO - Got revision 4cd39eec6f0e 04:10:02 INFO - Return code: 0 04:10:02 INFO - Signing big checksums file: SHA512SUMS 04:10:02 INFO - Running command: ['python', '/builds/slave/rel-m-rel-fx_sums-000000000000/build/tools/release/signing/signtool.py', '--cachedir', '/builds/slave/rel-m-rel-fx_sums-000000000000/build/signing_cache', '-t', '/builds/slave/rel-m-rel-fx_sums-000000000000/token', '-n', '/builds/slave/rel-m-rel-fx_sums-000000000000/nonce', '-c', '/builds/slave/rel-m-rel-fx_sums-000000000000/build/tools/release/signing/host.cert', '-f', 'gpg', '-H', 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120', '-H', 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120', '-H', 'gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120', '-H', 'dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120', '-H', 'dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120', '-H', 'dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120', '-H', 'dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120', '-H', 'dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120', '-H', 'dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120', 'SHA512SUMS'] 04:10:02 INFO - Copy/paste: python /builds/slave/rel-m-rel-fx_sums-000000000000/build/tools/release/signing/signtool.py --cachedir /builds/slave/rel-m-rel-fx_sums-000000000000/build/signing_cache -t /builds/slave/rel-m-rel-fx_sums-000000000000/token -n /builds/slave/rel-m-rel-fx_sums-000000000000/nonce -c /builds/slave/rel-m-rel-fx_sums-000000000000/build/tools/release/signing/host.cert -f gpg -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:b2gmar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120 SHA512SUMS 04:10:02 INFO - 2015-10-27 04:10:02,300 - 725783e2d5142d57418e958d62c5ab114562328b: processing SHA512SUMS on https://signing5.srv.releng.scl3.mozilla.com:9120 04:10:02 INFO - 2015-10-27 04:10:02,458 - 725783e2d5142d57418e958d62c5ab114562328b: uploading for signing 04:10:03 INFO - 2015-10-27 04:10:03,829 - 725783e2d5142d57418e958d62c5ab114562328b: processing SHA512SUMS on https://signing5.srv.releng.scl3.mozilla.com:9120 04:10:03 INFO - 2015-10-27 04:10:03,952 - 725783e2d5142d57418e958d62c5ab114562328b: OK 04:10:03 INFO - 2015-10-27 04:10:03,952 - Copying SHA512SUMS.asc to cache /builds/slave/rel-m-rel-fx_sums-000000000000/build/signing_cache/gpg/725783e2d5142d57418e958d62c5ab114562328b 04:10:03 INFO - Return code: 0 04:10:03 INFO - ##### 04:10:03 INFO - ##### Running get-upload-script step. 04:10:03 INFO - ##### 04:10:03 INFO - Running main action method: get_upload_script 04:10:03 INFO - Downloading https://hg.mozilla.org/releases/mozilla-release/raw-file/FIREFOX_42_0_RELEASE/build/upload.py to upload.py 04:10:03 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-release/raw-file/FIREFOX_42_0_RELEASE/build/upload.py', 'upload.py'), kwargs: {}, attempt #1 04:10:04 INFO - Downloaded 8941 bytes. 04:10:04 INFO - ##### 04:10:04 INFO - ##### Running upload step. 04:10:04 INFO - ##### 04:10:04 INFO - Running main action method: upload 04:10:04 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/ffxbld_rsa', 'ffxbld@upload.ffxbld.productdelivery.prod.mozaws.net', 'mktemp -d'],), kwargs: {}, attempt #1 04:10:04 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/ffxbld_rsa', 'ffxbld@upload.ffxbld.productdelivery.prod.mozaws.net', 'mkdir -p /media/ephemeral0/tmp/tmp.2qHMZ6UIpq/'],), kwargs: {}, attempt #1 04:10:04 INFO - retry: Calling with args: (['scp', '-o', 'IdentityFile=~/.ssh/ffxbld_rsa', '/builds/slave/rel-m-rel-fx_sums-000000000000/SHA512SUMS', 'ffxbld@upload.ffxbld.productdelivery.prod.mozaws.net:/media/ephemeral0/tmp/tmp.2qHMZ6UIpq/'],), kwargs: {}, attempt #1 04:10:04 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/ffxbld_rsa', 'ffxbld@upload.ffxbld.productdelivery.prod.mozaws.net', 'mkdir -p /media/ephemeral0/tmp/tmp.2qHMZ6UIpq/'],), kwargs: {}, attempt #1 04:10:04 INFO - retry: Calling with args: (['scp', '-o', 'IdentityFile=~/.ssh/ffxbld_rsa', '/builds/slave/rel-m-rel-fx_sums-000000000000/SHA512SUMS.asc', 'ffxbld@upload.ffxbld.productdelivery.prod.mozaws.net:/media/ephemeral0/tmp/tmp.2qHMZ6UIpq/'],), kwargs: {}, attempt #1 04:10:04 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/ffxbld_rsa', 'ffxbld@upload.ffxbld.productdelivery.prod.mozaws.net', 'post_upload.py -p firefox -n 1 -v 42.0 --release-to-candidates-dir --signed --bucket-prefix net-mozaws-prod-delivery "/media/ephemeral0/tmp/tmp.2qHMZ6UIpq/" "/media/ephemeral0/tmp/tmp.2qHMZ6UIpq//SHA512SUMS" "/media/ephemeral0/tmp/tmp.2qHMZ6UIpq//SHA512SUMS.asc"'],), kwargs: {}, attempt #1 http://archive.mozilla.org/pub/firefox/candidates/42.0-candidates/build1/SHA512SUMS http://archive.mozilla.org/pub/firefox/candidates/42.0-candidates/build1/SHA512SUMS.asc 04:10:06 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/ffxbld_rsa', 'ffxbld@upload.ffxbld.productdelivery.prod.mozaws.net', 'rm -rf /media/ephemeral0/tmp/tmp.2qHMZ6UIpq/'],), kwargs: {}, attempt #1 04:10:06 INFO - Copying logs to upload dir... 04:10:06 INFO - mkdir: /builds/slave/rel-m-rel-fx_sums-000000000000/build/upload/logs program finished with exit code 0 elapsedTime=21.614350 ========= Finished 'python2.7 scripts/scripts/release/generate-checksums.py ...' (results: 0, elapsed: 21 secs) (at 2015-10-27 04:10:06.498863) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2015-10-27 04:10:06.500735) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/rel-m-rel-fx_sums-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=bld-linux64-spot-301.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-rel-fx_sums-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.004752 ========= Finished no change (results: 0, elapsed: 0 secs) (at 2015-10-27 04:10:06.554374) =========