builder: release-comm-esr38-thunderbird_checksums slave: bld-linux64-spot-348 starttime: 1448045253.5 results: success (0) ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.504371) ========= master: http://buildbot-master74.bb.releng.usw2.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.504906) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.505201) ========= bash -c pwd in dir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/. (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-348.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False /builds/slave/tb-rel-c-esr38-tb_sums-0000000 program finished with exit code 0 elapsedTime=0.004461 basedir: '/builds/slave/tb-rel-c-esr38-tb_sums-0000000' ========= master_lag: 0.26 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.768178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.768504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.782625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.782896) ========= rm -rf properties in dir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/. (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-348.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000 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.003572 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.831295) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.831598) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.831934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:33.832206) ========= 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-tb_sums-0000000/. (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-348.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False --2015-11-20 10:47:33-- 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% 89.8M=0s 2015-11-20 10:47:34 (89.8 MB/s) - ‘archiver_client.py’ saved [12141/12141] program finished with exit code 0 elapsedTime=0.309976 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:34.154884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:34.155202) ========= rm -rf scripts in dir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/. (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-348.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000 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.003631 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:34.204559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 10:47:34.204879) ========= 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-tb_sums-0000000/. (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=bld-linux64-spot-348.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2015-11-20 10:47:34,251 Setting DEBUG logging. 2015-11-20 10:47:34,251 "THUNDERBIRD_38_4_0_RELEASE" was passed as the tag. Querying remote repository for corresponding rev hash. 2015-11-20 10:47:34,979 revision being used: a05572d42980 2015-11-20 10:47:34,979 attempt 1/10 2015-11-20 10:47:34,980 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 10:47:35,357 unpacking tar archive at: mozilla-esr38-a05572d42980/testing/mozharness/ program finished with exit code 0 elapsedTime=1.259023 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 10:47:35.476666) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:35.476983) ========= 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 10:47:35.477350) ========= ========= Started remove old nonce (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:35.477648) ========= rm -f nonce in dir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/. (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-348.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000 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.003587 ========= master_lag: 0.04 ========= ========= Finished remove old nonce (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:35.526209) ========= ========= Started downloading to token (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:35.526515) ========= Slave: bld-linux64-spot-348 IP: 10.132.53.194 Duration: 25200 URI: https://signing6.srv.releng.scl3.mozilla.com:9120/token ========= Finished downloading to token (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:35.767928) ========= ========= Started set props: toolsdir (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:35.768374) ========= bash -c pwd in dir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/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-348.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000/scripts SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False /builds/slave/tb-rel-c-esr38-tb_sums-0000000/scripts program finished with exit code 0 elapsedTime=0.004316 toolsdir: '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/scripts' ========= master_lag: 0.05 ========= ========= Finished set props: toolsdir (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:35.818461) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:35.818781) ========= bash -c pwd in dir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/. (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-348.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False /builds/slave/tb-rel-c-esr38-tb_sums-0000000 program finished with exit code 0 elapsedTime=0.004243 basedir: '/builds/slave/tb-rel-c-esr38-tb_sums-0000000' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:35.868210) ========= ========= Started 'python2.7 scripts/scripts/release/generate-checksums.py ...' (results: 0, elapsed: 18 secs) (at 2015-11-20 10:47:35.868554) ========= python2.7 scripts/scripts/release/generate-checksums.py --stage-product thunderbird --version 38.4.0 --build-number 3 --bucket-name-prefix net-mozaws-prod-delivery --upload-host upload.tbirdbld.productdelivery.prod.mozaws.net --upload-user tbirdbld --upload-ssh-key '~/.ssh/tbirdbld_dsa' --gecko-repo https://hg.mozilla.org/releases/mozilla-esr38 --gecko-revision THUNDERBIRD_38_4_0_RELEASE --tools-repo /tools/checkouts/build-tools in dir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/. (timeout 1200 secs) watching logfiles {} argv: ['python2.7', 'scripts/scripts/release/generate-checksums.py', '--stage-product', 'thunderbird', '--version', '38.4.0', '--build-number', '3', '--bucket-name-prefix', 'net-mozaws-prod-delivery', '--upload-host', 'upload.tbirdbld.productdelivery.prod.mozaws.net', '--upload-user', 'tbirdbld', '--upload-ssh-key', '~/.ssh/tbirdbld_dsa', '--gecko-repo', 'https://hg.mozilla.org/releases/mozilla-esr38', '--gecko-revision', 'THUNDERBIRD_38_4_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-348.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/tb-rel-c-esr38-tb_sums-0000000/scripts/release/signing/signtool.py --cachedir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/signing_cache -t /builds/slave/tb-rel-c-esr38-tb_sums-0000000/token -n /builds/slave/tb-rel-c-esr38-tb_sums-0000000/nonce -c /builds/slave/tb-rel-c-esr38-tb_sums-0000000/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/tb-rel-c-esr38-tb_sums-0000000/buildprops.json PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 10:47:36 INFO - MultiFileLogger online at 20151120 10:47:36 in /builds/slave/tb-rel-c-esr38-tb_sums-0000000 10:47:36 INFO - Run as scripts/scripts/release/generate-checksums.py --stage-product thunderbird --version 38.4.0 --build-number 3 --bucket-name-prefix net-mozaws-prod-delivery --upload-host upload.tbirdbld.productdelivery.prod.mozaws.net --upload-user tbirdbld --upload-ssh-key ~/.ssh/tbirdbld_dsa --gecko-repo https://hg.mozilla.org/releases/mozilla-esr38 --gecko-revision THUNDERBIRD_38_4_0_RELEASE --tools-repo /tools/checkouts/build-tools 10:47:36 INFO - Dumping config to /builds/slave/tb-rel-c-esr38-tb_sums-0000000/logs/localconfig.json. 10:47:36 INFO - {'append_to_log': False, 10:47:36 INFO - 'base_work_dir': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000', 10:47:36 INFO - 'bucket_name_prefix': 'net-mozaws-prod-delivery', 10:47:36 INFO - 'build_number': '3', 10:47:36 INFO - 'formats': ('sha512',), 10:47:36 INFO - 'gecko_repo': 'https://hg.mozilla.org/releases/mozilla-esr38', 10:47:36 INFO - 'gecko_revision': 'THUNDERBIRD_38_4_0_RELEASE', 10:47:36 INFO - 'includes': ('^.*\\.tar\\.bz2$', 10:47:36 INFO - '^.*\\.dmg$', 10:47:36 INFO - '^.*\\.bundle$', 10:47:36 INFO - '^.*\\.mar$', 10:47:36 INFO - '^.*Setup.*\\.exe$', 10:47:36 INFO - '^.*\\.xpi$'), 10:47:36 INFO - 'log_level': 'info', 10:47:36 INFO - 'log_to_console': True, 10:47:36 INFO - 'opt_config_files': (), 10:47:36 INFO - 'parallelization': 20, 10:47:36 INFO - 'pip_index': True, 10:47:36 INFO - 'stage_product': 'thunderbird', 10:47:36 INFO - 'tools_repo': '/tools/checkouts/build-tools', 10:47:36 INFO - 'upload_host': 'upload.tbirdbld.productdelivery.prod.mozaws.net', 10:47:36 INFO - 'upload_ssh_key': '~/.ssh/tbirdbld_dsa', 10:47:36 INFO - 'upload_user': 'tbirdbld', 10:47:36 INFO - 'version': '38.4.0', 10:47:36 INFO - 'virtualenv_modules': ('boto', 'redo'), 10:47:36 INFO - 'virtualenv_path': 'venv', 10:47:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:47:36 INFO - 'work_dir': 'build'} 10:47:36 INFO - ##### 10:47:36 INFO - ##### Running create-virtualenv step. 10:47:36 INFO - ##### 10:47:36 INFO - Running main action method: create_virtualenv 10:47:36 INFO - Creating virtualenv /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv 10:47:36 INFO - mkdir: /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build 10:47:36 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv'] in /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build 10:47:36 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv 10:47:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:47:36 INFO - New python executable in /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/python2.7 10:47:36 INFO - Also creating executable in /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/python 10:47:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:47:37 INFO - Installing pip...............done. 10:47:37 INFO - Return code: 0 10:47:37 INFO - Installing boto into virtualenv /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv 10:47:37 INFO - retry: Calling run_command with args: [['/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/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 0x184b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983920>, '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 0x7f6af330b618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d3990>, 'level': 'critical'}], 'cwd': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/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/tb-rel-c-esr38-tb_sums-0000000/buildprops.json', 'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 'MOZ_SIGN_CMD': 'python /builds/slave/tb-rel-c-esr38-tb_sums-0000000/scripts/release/signing/signtool.py --cachedir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/signing_cache -t /builds/slave/tb-rel-c-esr38-tb_sums-0000000/token -n /builds/slave/tb-rel-c-esr38-tb_sums-0000000/nonce -c /builds/slave/tb-rel-c-esr38-tb_sums-0000000/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-348.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1 10:47:37 INFO - Running command: ['/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/cache', '--timeout', '120', 'boto'] in /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build 10:47:37 INFO - Copy/paste: /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/pip install --download-cache /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/cache --timeout 120 boto 10:47:37 INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 10:47:37 INFO - 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 10:47:37 INFO - 'CCACHE_HASHDIR': '', 10:47:37 INFO - 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 10:47:37 INFO - 'G_BROKEN_FILENAMES': '1', 10:47:37 INFO - 'HISTCONTROL': 'ignoredups', 10:47:37 INFO - 'HISTSIZE': '1000', 10:47:37 INFO - 'HOME': '/home/cltbld', 10:47:37 INFO - 'HOSTNAME': 'bld-linux64-spot-348.build.releng.usw2.mozilla.com', 10:47:37 INFO - 'LANG': 'en_US.UTF-8', 10:47:37 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 10:47:37 INFO - 'LOGNAME': 'cltbld', 10:47:37 INFO - 'MAIL': '/var/spool/mail/cltbld', 10:47:37 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', 10:47:37 INFO - 'MOZ_SIGN_CMD': 'python /builds/slave/tb-rel-c-esr38-tb_sums-0000000/scripts/release/signing/signtool.py --cachedir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/signing_cache -t /builds/slave/tb-rel-c-esr38-tb_sums-0000000/token -n /builds/slave/tb-rel-c-esr38-tb_sums-0000000/nonce -c /builds/slave/tb-rel-c-esr38-tb_sums-0000000/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', 10:47:37 INFO - 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 10:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/buildprops.json', 10:47:37 INFO - 'PWD': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000', 10:47:37 INFO - 'SHELL': '/bin/bash', 10:47:37 INFO - 'SHLVL': '1', 10:47:37 INFO - 'TERM': 'linux', 10:47:37 INFO - 'TMOUT': '86400', 10:47:37 INFO - 'USER': 'cltbld', 10:47:37 INFO - '_': '/tools/buildbot/bin/python'} 10:47:39 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:47:39 INFO - Downloading/unpacking boto 10:47:39 INFO - Creating supposed download cache at /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/cache 10:47:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fboto-2.38.0.tar.gz 10:47:39 INFO - Running setup.py egg_info for package boto 10:47:39 INFO - warning: no files found matching 'boto/mturk/test/*.doctest' 10:47:39 INFO - warning: no files found matching 'boto/mturk/test/.gitignore' 10:47:39 INFO - Installing collected packages: boto 10:47:39 INFO - Running setup.py install for boto 10:47:39 INFO - warning: no files found matching 'boto/mturk/test/*.doctest' 10:47:39 INFO - warning: no files found matching 'boto/mturk/test/.gitignore' 10:47:39 INFO - changing mode of build/scripts-2.7/sdbadmin from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/elbadmin from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/cfadmin from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/s3put from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/fetch_file from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/launch_instance from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/list_instances from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/taskadmin from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/kill_instance from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/bundle_image from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/pyami_sendmail from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/lss3 from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/cq from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/route53 from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/cwutil from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/instance_events from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/asadmin from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/glacier from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/mturk from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/dynamodb_dump from 664 to 775 10:47:39 INFO - changing mode of build/scripts-2.7/dynamodb_load from 664 to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/cfadmin to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/sdbadmin to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/launch_instance to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/route53 to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/list_instances to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/dynamodb_load to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/cq to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/cwutil to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/s3put to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/dynamodb_dump to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/kill_instance to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/bundle_image to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/fetch_file to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/mturk to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/asadmin to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/pyami_sendmail to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/lss3 to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/glacier to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/taskadmin to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/elbadmin to 775 10:47:39 INFO - changing mode of /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/instance_events to 775 10:47:39 INFO - Successfully installed boto 10:47:39 INFO - Cleaning up... 10:47:39 INFO - Return code: 0 10:47:39 INFO - Installing redo into virtualenv /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv 10:47:39 INFO - retry: Calling run_command with args: [['/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/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 0x184b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x170e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1983920>, '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 0x7f6af330b618>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d3990>, 'level': 'critical'}], 'cwd': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/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/tb-rel-c-esr38-tb_sums-0000000/buildprops.json', 'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 'MOZ_SIGN_CMD': 'python /builds/slave/tb-rel-c-esr38-tb_sums-0000000/scripts/release/signing/signtool.py --cachedir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/signing_cache -t /builds/slave/tb-rel-c-esr38-tb_sums-0000000/token -n /builds/slave/tb-rel-c-esr38-tb_sums-0000000/nonce -c /builds/slave/tb-rel-c-esr38-tb_sums-0000000/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-348.build.releng.usw2.mozilla.com', 'HISTCONTROL': 'ignoredups', 'PWD': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000', 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'MAIL': '/var/spool/mail/cltbld'}}, attempt #1 10:47:39 INFO - Running command: ['/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/cache', '--timeout', '120', 'redo'] in /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build 10:47:39 INFO - Copy/paste: /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/pip install --download-cache /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/cache --timeout 120 redo 10:47:39 INFO - Using env: {'BUILDBOTCUSTOM': 'https://hg.mozilla.org/build/buildbotcustom', 10:47:39 INFO - 'BUILDBOT_CONFIGS': 'https://hg.mozilla.org/build/buildbot-configs', 10:47:39 INFO - 'CCACHE_HASHDIR': '', 10:47:39 INFO - 'CLOBBERER_URL': 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 10:47:39 INFO - 'G_BROKEN_FILENAMES': '1', 10:47:39 INFO - 'HISTCONTROL': 'ignoredups', 10:47:39 INFO - 'HISTSIZE': '1000', 10:47:39 INFO - 'HOME': '/home/cltbld', 10:47:39 INFO - 'HOSTNAME': 'bld-linux64-spot-348.build.releng.usw2.mozilla.com', 10:47:39 INFO - 'LANG': 'en_US.UTF-8', 10:47:39 INFO - 'LESSOPEN': '|/usr/bin/lesspipe.sh %s', 10:47:39 INFO - 'LOGNAME': 'cltbld', 10:47:39 INFO - 'MAIL': '/var/spool/mail/cltbld', 10:47:39 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', 10:47:39 INFO - 'MOZ_SIGN_CMD': 'python /builds/slave/tb-rel-c-esr38-tb_sums-0000000/scripts/release/signing/signtool.py --cachedir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/signing_cache -t /builds/slave/tb-rel-c-esr38-tb_sums-0000000/token -n /builds/slave/tb-rel-c-esr38-tb_sums-0000000/nonce -c /builds/slave/tb-rel-c-esr38-tb_sums-0000000/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', 10:47:39 INFO - 'PATH': '/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin', 10:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/buildprops.json', 10:47:39 INFO - 'PWD': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000', 10:47:39 INFO - 'SHELL': '/bin/bash', 10:47:39 INFO - 'SHLVL': '1', 10:47:39 INFO - 'TERM': 'linux', 10:47:39 INFO - 'TMOUT': '86400', 10:47:39 INFO - 'USER': 'cltbld', 10:47:39 INFO - '_': '/tools/buildbot/bin/python'} 10:47:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:47:40 INFO - Downloading/unpacking redo 10:47:40 INFO - Downloading redo-1.4.tar.gz 10:47:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fredo-1.4.tar.gz 10:47:40 INFO - Running setup.py egg_info for package redo 10:47:40 INFO - Installing collected packages: redo 10:47:40 INFO - Running setup.py install for redo 10:47:40 INFO - Installing retry script to /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin 10:47:40 INFO - Successfully installed redo 10:47:40 INFO - Cleaning up... 10:47:40 INFO - Return code: 0 10:47:40 INFO - Done creating virtualenv /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv. 10:47:40 INFO - Getting output from command: ['/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/pip', 'freeze'] 10:47:40 INFO - Copy/paste: /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin/pip freeze 10:47:40 INFO - Reading from file tmpfile_stdout 10:47:40 INFO - Current package versions: 10:47:40 INFO - distribute == 0.6.24 10:47:40 INFO - redo == 1.4 10:47:40 INFO - wsgiref == 0.1.2 10:47:40 INFO - boto == 2.38.0 10:47:40 INFO - ##### 10:47:40 INFO - ##### Running activate-virtualenv step. 10:47:40 INFO - ##### 10:47:40 INFO - Running main action method: activate_virtualenv 10:47:40 INFO - ##### 10:47:40 INFO - ##### Running collect-individual-checksums step. 10:47:40 INFO - ##### 10:47:40 INFO - Running main action method: collect_individual_checksums 10:47:40 INFO - Bucket name is: net-mozaws-prod-delivery-archive 10:47:40 INFO - File prefix is: pub/thunderbird/candidates/38.4.0-candidates/build3 10:47:40 INFO - Connecting to S3 10:47:41 INFO - Getting key names from bucket 10:47:46 INFO - ##### 10:47:46 INFO - ##### Running create-big-checksums step. 10:47:46 INFO - ##### 10:47:46 INFO - Running main action method: create_big_checksums 10:47:46 INFO - Creating big checksums file: SHA512SUMS 10:47:46 INFO - ##### 10:47:46 INFO - ##### Running sign step. 10:47:46 INFO - ##### 10:47:46 INFO - Running main action method: sign 10:47:46 INFO - retry: Calling _get_revision with args: (, '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/tools'), kwargs: {}, attempt #1 10:47:46 INFO - Running command: ['hgtool.py', '/tools/checkouts/build-tools', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/tools'] 10:47:46 INFO - Copy/paste: hgtool.py /tools/checkouts/build-tools /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/tools 10:47:46 INFO - Using env: {'PATH': '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/venv/bin:/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin'} 10:47:46 INFO - Reporting hg version in use 10:47:46 INFO - command: START 10:47:46 INFO - command: hg -q version 10:47:46 INFO - command: cwd: . 10:47:46 INFO - command: output: 10:47:46 INFO - Mercurial Distributed SCM (version 3.2.1) 10:47:46 INFO - command: END (0.29s elapsed) 10:47:46 INFO - command: START 10:47:46 INFO - command: hg clone --traceback /tools/checkouts/build-tools /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/tools 10:47:46 INFO - command: cwd: /builds/slave/tb-rel-c-esr38-tb_sums-0000000 10:47:46 INFO - command: env: {'HGPLAIN': '1'} 10:47:47 INFO - command: END (1.00s elapsed) 10:47:47 INFO - command: output: 10:47:47 INFO - updating to branch default 10:47:47 INFO - 1125 files updated, 0 files merged, 0 files removed, 0 files unresolved 10:47:47 INFO - command: START 10:47:47 INFO - command: hg branch 10:47:47 INFO - command: cwd: /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/tools 10:47:47 INFO - command: env: {'HGPLAIN': '1'} 10:47:48 INFO - command: END (0.50s elapsed) 10:47:48 INFO - command: output: 10:47:48 INFO - default 10:47:48 INFO - command: START 10:47:48 INFO - command: hg update -C 10:47:48 INFO - command: cwd: /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/tools 10:47:48 INFO - command: output: 10:47:49 INFO - 0 files updated, 0 files merged, 0 files removed, 0 files unresolved 10:47:49 INFO - command: END (1.10s elapsed) 10:47:49 INFO - command: START 10:47:49 INFO - command: hg parent --template {node|short} 10:47:49 INFO - command: cwd: /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/tools 10:47:49 INFO - command: env: {'HGPLAIN': '1'} 10:47:49 INFO - command: END (0.50s elapsed) 10:47:49 INFO - command: output: 10:47:49 INFO - 014bc758e3bd 10:47:49 INFO - Got revision 014bc758e3bd 10:47:49 INFO - Return code: 0 10:47:49 INFO - Signing big checksums file: SHA512SUMS 10:47:49 INFO - Running command: ['python', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/tools/release/signing/signtool.py', '--cachedir', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/signing_cache', '-t', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/token', '-n', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/nonce', '-c', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/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'] 10:47:49 INFO - Copy/paste: python /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/tools/release/signing/signtool.py --cachedir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/signing_cache -t /builds/slave/tb-rel-c-esr38-tb_sums-0000000/token -n /builds/slave/tb-rel-c-esr38-tb_sums-0000000/nonce -c /builds/slave/tb-rel-c-esr38-tb_sums-0000000/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 10:47:50 INFO - 2015-11-20 10:47:50,042 - 0a4c76d6944c69b6731d05ea717b1a23eb80fc05: processing SHA512SUMS on https://signing6.srv.releng.scl3.mozilla.com:9120 10:47:50 INFO - 2015-11-20 10:47:50,175 - 0a4c76d6944c69b6731d05ea717b1a23eb80fc05: uploading for signing 10:47:51 INFO - 2015-11-20 10:47:51,486 - 0a4c76d6944c69b6731d05ea717b1a23eb80fc05: processing SHA512SUMS on https://signing6.srv.releng.scl3.mozilla.com:9120 10:47:51 INFO - 2015-11-20 10:47:51,619 - 0a4c76d6944c69b6731d05ea717b1a23eb80fc05: OK 10:47:51 INFO - 2015-11-20 10:47:51,619 - Copying SHA512SUMS.asc to cache /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/signing_cache/gpg/0a4c76d6944c69b6731d05ea717b1a23eb80fc05 10:47:51 INFO - Return code: 0 10:47:51 INFO - ##### 10:47:51 INFO - ##### Running get-upload-script step. 10:47:51 INFO - ##### 10:47:51 INFO - Running main action method: get_upload_script 10:47:51 INFO - Downloading https://hg.mozilla.org/releases/mozilla-esr38/raw-file/THUNDERBIRD_38_4_0_RELEASE/build/upload.py to upload.py 10:47:51 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-esr38/raw-file/THUNDERBIRD_38_4_0_RELEASE/build/upload.py', 'upload.py'), kwargs: {}, attempt #1 10:47:52 INFO - Downloaded 8941 bytes. 10:47:52 INFO - ##### 10:47:52 INFO - ##### Running upload step. 10:47:52 INFO - ##### 10:47:52 INFO - Running main action method: upload 10:47:52 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/tbirdbld_dsa', 'tbirdbld@upload.tbirdbld.productdelivery.prod.mozaws.net', 'mktemp -d'],), kwargs: {}, attempt #1 10:47:52 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/tbirdbld_dsa', 'tbirdbld@upload.tbirdbld.productdelivery.prod.mozaws.net', 'mkdir -p /tmp/tmp.ntM1V6xctx/'],), kwargs: {}, attempt #1 10:47:52 INFO - retry: Calling with args: (['scp', '-o', 'IdentityFile=~/.ssh/tbirdbld_dsa', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/SHA512SUMS', 'tbirdbld@upload.tbirdbld.productdelivery.prod.mozaws.net:/tmp/tmp.ntM1V6xctx/'],), kwargs: {}, attempt #1 10:47:53 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/tbirdbld_dsa', 'tbirdbld@upload.tbirdbld.productdelivery.prod.mozaws.net', 'mkdir -p /tmp/tmp.ntM1V6xctx/'],), kwargs: {}, attempt #1 10:47:53 INFO - retry: Calling with args: (['scp', '-o', 'IdentityFile=~/.ssh/tbirdbld_dsa', '/builds/slave/tb-rel-c-esr38-tb_sums-0000000/SHA512SUMS.asc', 'tbirdbld@upload.tbirdbld.productdelivery.prod.mozaws.net:/tmp/tmp.ntM1V6xctx/'],), kwargs: {}, attempt #1 10:47:53 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/tbirdbld_dsa', 'tbirdbld@upload.tbirdbld.productdelivery.prod.mozaws.net', 'post_upload.py -p thunderbird -n 3 -v 38.4.0 --release-to-candidates-dir --signed --bucket-prefix net-mozaws-prod-delivery "/tmp/tmp.ntM1V6xctx/" "/tmp/tmp.ntM1V6xctx//SHA512SUMS" "/tmp/tmp.ntM1V6xctx//SHA512SUMS.asc"'],), kwargs: {}, attempt #1 http://archive.mozilla.org/pub/thunderbird/candidates/38.4.0-candidates/build3/SHA512SUMS http://archive.mozilla.org/pub/thunderbird/candidates/38.4.0-candidates/build3/SHA512SUMS.asc 10:47:54 INFO - retry: Calling with args: (['ssh', '-o', 'IdentityFile=~/.ssh/tbirdbld_dsa', 'tbirdbld@upload.tbirdbld.productdelivery.prod.mozaws.net', 'rm -rf /tmp/tmp.ntM1V6xctx/'],), kwargs: {}, attempt #1 10:47:54 INFO - Copying logs to upload dir... 10:47:54 INFO - mkdir: /builds/slave/tb-rel-c-esr38-tb_sums-0000000/build/upload/logs program finished with exit code 0 elapsedTime=18.740082 ========= master_lag: 0.02 ========= ========= Finished 'python2.7 scripts/scripts/release/generate-checksums.py ...' (results: 0, elapsed: 18 secs) (at 2015-11-20 10:47:54.624120) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:54.625954) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/tb-rel-c-esr38-tb_sums-0000000/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-348.build.releng.usw2.mozilla.com LANG=en_US.UTF-8 LESSOPEN=|/usr/bin/lesspipe.sh %s LOGNAME=cltbld MAIL=/var/spool/mail/cltbld PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin PWD=/builds/slave/tb-rel-c-esr38-tb_sums-0000000/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.005217 ========= master_lag: 0.05 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2015-11-20 10:47:54.678920) ========= ========= Total master_lag: 0.57 =========