builder: release-jamun_firefox_bncr_sub
slave: bld-linux64-spot-1056
starttime: 1460402254.81
results: success (0)
revision: 2caa65c52ebe4480f54e030149983141b4fc81e1
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:34.805474) =========
master: http://buildbot-master91.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:34.805907) =========
========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:34.806206) =========
bash -c pwd
in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'pwd']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-1056.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-jamun_fx_bncr_sub-00000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
/builds/slave/rel-jamun_fx_bncr_sub-00000000
program finished with exit code 0
elapsedTime=0.004097
basedir: '/builds/slave/rel-jamun_fx_bncr_sub-00000000'
========= master_lag: 0.34 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.149466) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.149774) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.167448) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.167753) =========
rm -rf properties
in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'properties']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-1056.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-jamun_fx_bncr_sub-00000000
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.003317
========= master_lag: 0.05 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.218297) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.218597) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.218969) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.219248) =========
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-jamun_fx_bncr_sub-00000000/. (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:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-1056.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-jamun_fx_bncr_sub-00000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
--2016-04-11 12:17:35-- 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% 517K=0.02s
2016-04-11 12:17:35 (517 KB/s) - ‘archiver_client.py’ saved [12141/12141]
program finished with exit code 0
elapsedTime=0.241953
========= master_lag: 0.04 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.503772) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.504188) =========
rm -rf scripts
in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-1056.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-jamun_fx_bncr_sub-00000000
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.003324
========= master_lag: 0.05 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.554469) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:35.554819) =========
bash -c 'python archiver_client.py mozharness --repo projects/jamun --rev 2caa65c52ebe4480f54e030149983141b4fc81e1 --destination scripts --debug'
in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/jamun --rev 2caa65c52ebe4480f54e030149983141b4fc81e1 --destination scripts --debug']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-1056.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-jamun_fx_bncr_sub-00000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
2016-04-11 12:17:35,610 truncating revision to first 12 chars
2016-04-11 12:17:35,610 Setting DEBUG logging.
2016-04-11 12:17:35,610 attempt 1/10
2016-04-11 12:17:35,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/jamun/2caa65c52ebe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-04-11 12:17:35,955 unpacking tar archive at: jamun-2caa65c52ebe/testing/mozharness/
program finished with exit code 0
elapsedTime=0.505128
========= master_lag: 0.04 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:36.099694) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:36.100113) =========
echo 2caa65c52ebe4480f54e030149983141b4fc81e1
in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['echo', '2caa65c52ebe4480f54e030149983141b4fc81e1']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-1056.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-jamun_fx_bncr_sub-00000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
2caa65c52ebe4480f54e030149983141b4fc81e1
program finished with exit code 0
elapsedTime=0.004961
script_repo_revision: '2caa65c52ebe4480f54e030149983141b4fc81e1'
========= master_lag: 0.05 =========
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:36.159582) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:36.159930) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 12:17:36.176242) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 25 secs) (at 2016-04-11 12:17:36.176605) =========
/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_release.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer.stage.mozaws.net/api --repo projects/jamun
in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 3600 secs) (maxTime 14400 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/bouncer_submitter.py', '-c', 'releases/bouncer_firefox_release.py', '--credentials-file', 'oauth.txt', '--bouncer-api-prefix', 'https://admin-bouncer.stage.mozaws.net/api', '--repo', 'projects/jamun']
environment:
CCACHE_COMPRESS=1
CCACHE_DIR=/builds/ccache
CCACHE_HASHDIR=
CCACHE_UMASK=002
DISPLAY=:2
G_BROKEN_FILENAMES=1
HG_SHARE_BASE_DIR=/builds/hg-shared
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-1056.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LC_ALL=C
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
MOZ_AUTOMATION=1
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_OBJDIR=obj-firefox
PATH=/tools/buildbot/bin:/usr/local/bin:/usr/lib64/ccache:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/tools/git/bin:/tools/python27/bin:/tools/python27-mercurial/bin:/home/cltbld/bin
PROPERTIES_FILE=/builds/slave/rel-jamun_fx_bncr_sub-00000000/buildprops.json
PWD=/builds/slave/rel-jamun_fx_bncr_sub-00000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TINDERBOX_OUTPUT=1
TMOUT=86400
TOOLTOOL_CACHE=/builds/tooltool_cache
TOOLTOOL_HOME=/builds
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
12:17:36 INFO - MultiFileLogger online at 20160411 12:17:36 in /builds/slave/rel-jamun_fx_bncr_sub-00000000
12:17:36 INFO - Using buildbot properties:
12:17:36 INFO - {
12:17:36 INFO - "project": "",
12:17:36 INFO - "product": "firefox",
12:17:36 INFO - "build_number": 8,
12:17:36 INFO - "taskId": "1uP6ejcUQ8e4rDfJ8ZidxA",
12:17:36 INFO - "repository": "",
12:17:36 INFO - "buildername": "release-jamun_firefox_bncr_sub",
12:17:36 INFO - "basedir": "/builds/slave/rel-jamun_fx_bncr_sub-00000000",
12:17:36 INFO - "buildnumber": 0,
12:17:36 INFO - "slavename": "bld-linux64-spot-1056",
12:17:36 INFO - "version": "46.0",
12:17:36 INFO - "release_promotion": true,
12:17:36 INFO - "platform": null,
12:17:36 INFO - "branch": "jamun",
12:17:36 INFO - "script_repo_revision": "2caa65c52ebe4480f54e030149983141b4fc81e1",
12:17:36 INFO - "master": "http://buildbot-master91.bb.releng.usw2.mozilla.com:8001/",
12:17:36 INFO - "revision": "2caa65c52ebe4480f54e030149983141b4fc81e1",
12:17:36 INFO - "partial_versions": "44.0build3, 45.0build2, 46.0b9build1",
12:17:36 INFO - "repo_path": "projects/jamun"
12:17:36 INFO - }
12:17:36 INFO - Overriding product with firefox
12:17:36 INFO - Overriding version with 46.0
12:17:36 INFO - Overriding build_number with 8
12:17:36 INFO - Overriding revision with 2caa65c52ebe4480f54e030149983141b4fc81e1
12:17:36 INFO - Run as scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_release.py --credentials-file oauth.txt --bouncer-api-prefix https://admin-bouncer.stage.mozaws.net/api --repo projects/jamun
12:17:36 INFO - Dumping config to /builds/slave/rel-jamun_fx_bncr_sub-00000000/logs/localconfig.json.
12:17:36 INFO - {'append_to_log': False,
12:17:36 INFO - 'base_work_dir': '/builds/slave/rel-jamun_fx_bncr_sub-00000000',
12:17:36 INFO - 'bouncer-api-prefix': 'https://admin-bouncer.stage.mozaws.net/api',
12:17:36 INFO - 'build_number': 8,
12:17:36 INFO - 'buildbot_json_path': 'buildprops.json',
12:17:36 INFO - 'config_files': ('releases/bouncer_firefox_release.py',),
12:17:36 INFO - 'credentials_file': 'oauth.txt',
12:17:36 INFO - 'log_level': 'info',
12:17:36 INFO - 'log_to_console': True,
12:17:36 INFO - 'opt_config_files': (),
12:17:36 INFO - 'partials': {'candidates-dir': {'add-locales': False,
12:17:36 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:17:36 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:17:36 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:17:36 INFO - 'win32': {'bouncer-platform': 'win',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:17:36 INFO - 'win64': {'bouncer-platform': 'win64',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
12:17:36 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Partial-%(prev_version)sbuild%(prev_build_number)s',
12:17:36 INFO - 'ssl-only': False},
12:17:36 INFO - 'releases-dir': {'add-locales': False,
12:17:36 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:17:36 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:17:36 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:17:36 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.opensolaris-i386.partial.mar'},
12:17:36 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.opensolaris-sparc.partial.mar'},
12:17:36 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.solaris-i386.partial.mar'},
12:17:36 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(prev_version)s-%(version)s.en-US.solaris-sparc.partial.mar'},
12:17:36 INFO - 'win32': {'bouncer-platform': 'win',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
12:17:36 INFO - 'win64': {'bouncer-platform': 'win64',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
12:17:36 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s',
12:17:36 INFO - 'ssl-only': False}},
12:17:36 INFO - 'prev_versions': (u'44.0build3', u'45.0build2', u'46.0b9build1'),
12:17:36 INFO - 'product': u'firefox',
12:17:36 INFO - 'products': {'complete-mar': {'add-locales': False,
12:17:36 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
12:17:36 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
12:17:36 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
12:17:36 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.complete.mar'},
12:17:36 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.complete.mar'},
12:17:36 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.complete.mar'},
12:17:36 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.complete.mar'},
12:17:36 INFO - 'win32': {'bouncer-platform': 'win',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
12:17:36 INFO - 'win64': {'bouncer-platform': 'win64',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
12:17:36 INFO - 'product-name': 'Firefox-%(version)s-Complete',
12:17:36 INFO - 'ssl-only': False},
12:17:36 INFO - 'complete-mar-candidates': {'add-locales': False,
12:17:36 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
12:17:36 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
12:17:36 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
12:17:36 INFO - 'win32': {'bouncer-platform': 'win',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
12:17:36 INFO - 'win64': {'bouncer-platform': 'win64',
12:17:36 INFO - 'path': '/firefox/candidates/%(version)s-candidates/build%(build_number)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
12:17:36 INFO - 'product-name': 'Firefox-%(version)sbuild%(build_number)s-Complete',
12:17:36 INFO - 'ssl-only': False},
12:17:36 INFO - 'installer': {'add-locales': False,
12:17:36 INFO - 'alias': 'firefox-latest',
12:17:36 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
12:17:36 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
12:17:36 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
12:17:36 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.tar.bz2'},
12:17:36 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.tar.bz2'},
12:17:36 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.tar.bz2'},
12:17:36 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.tar.bz2'},
12:17:36 INFO - 'win32': {'bouncer-platform': 'win',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
12:17:36 INFO - 'win64': {'bouncer-platform': 'win64',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
12:17:36 INFO - 'product-name': 'Firefox-%(version)s',
12:17:36 INFO - 'ssl-only': False},
12:17:36 INFO - 'installer-ssl': {'add-locales': False,
12:17:36 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
12:17:36 INFO - 'linux64': {'bouncer-platform': 'linux64',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
12:17:36 INFO - 'macosx64': {'bouncer-platform': 'osx',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
12:17:36 INFO - 'opensolaris-i386': {'bouncer-platform': 'opensolaris-i386',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-i386.tar.bz2'},
12:17:36 INFO - 'opensolaris-sparc': {'bouncer-platform': 'opensolaris-sparc',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.opensolaris-sparc.tar.bz2'},
12:17:36 INFO - 'solaris-i386': {'bouncer-platform': 'solaris-i386',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-i386.tar.bz2'},
12:17:36 INFO - 'solaris-sparc': {'bouncer-platform': 'solaris-sparc',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/contrib/solaris_tarball/firefox-%(version)s.en-US.solaris-sparc.tar.bz2'},
12:17:36 INFO - 'win32': {'bouncer-platform': 'win',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
12:17:36 INFO - 'win64': {'bouncer-platform': 'win64',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
12:17:36 INFO - 'product-name': 'Firefox-%(version)s-SSL',
12:17:36 INFO - 'ssl-only': True},
12:17:36 INFO - 'stub-installer': {'add-locales': False,
12:17:36 INFO - 'alias': 'firefox-stub',
12:17:36 INFO - 'paths': {'win32': {'bouncer-platform': 'win',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'},
12:17:36 INFO - 'win64': {'bouncer-platform': 'win64',
12:17:36 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}},
12:17:36 INFO - 'product-name': 'Firefox-%(version)s-stub',
12:17:36 INFO - 'ssl-only': True}},
12:17:36 INFO - 'repo': 'projects/jamun',
12:17:36 INFO - 'revision': u'2caa65c52ebe4480f54e030149983141b4fc81e1',
12:17:36 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales',
12:17:36 INFO - 'version': u'46.0',
12:17:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
12:17:36 INFO - 'work_dir': 'build'}
12:17:36 INFO - #####
12:17:36 INFO - ##### Running clobber step.
12:17:36 INFO - #####
12:17:36 INFO - Running main action method: clobber
12:17:36 INFO - rmtree: /builds/slave/rel-jamun_fx_bncr_sub-00000000/build
12:17:36 INFO - #####
12:17:36 INFO - ##### Running download-shipped-locales step.
12:17:36 INFO - #####
12:17:36 INFO - Running main action method: download_shipped_locales
12:17:36 INFO - No need to download shipped-locales
12:17:36 INFO - #####
12:17:36 INFO - ##### Running submit step.
12:17:36 INFO - #####
12:17:36 INFO - Running main action method: submit
12:17:36 INFO - Checking if Firefox-46.0-Complete already exists
12:17:36 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Complete', None), kwargs: {}, attempt #1
12:17:36 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Complete
12:17:37 INFO - Server response
12:17:37 INFO -
12:17:37 INFO - Products found: 1
12:17:37 WARNING - Product Firefox-46.0-Complete already exists. Skipping...
12:17:37 INFO - Checking if Firefox-46.0build8-Complete already exists
12:17:37 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build8-Complete', None), kwargs: {}, attempt #1
12:17:37 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build8-Complete
12:17:37 INFO - Server response
12:17:37 INFO -
12:17:37 INFO - Products found: 0
12:17:37 INFO - Adding complete-mar-candidates...
12:17:37 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build8-Complete'}), kwargs: {}, attempt #1
12:17:37 INFO - POST data: product=Firefox-46.0build8-Complete
12:17:37 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
12:17:38 INFO - Server response
12:17:38 INFO -
12:17:38 INFO - Adding paths...
12:17:38 INFO - linux (linux): /firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-46.0.complete.mar
12:17:38 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build8-Complete', 'os': 'linux'}), kwargs: {}, attempt #1
12:17:38 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build8-Complete&os=linux
12:17:38 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:39 INFO - Server response
12:17:39 INFO - /firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-46.0.complete.mar
12:17:39 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-46.0.complete.mar
12:17:39 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build8-Complete', 'os': 'linux64'}), kwargs: {}, attempt #1
12:17:39 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build8-Complete&os=linux64
12:17:39 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:39 INFO - Server response
12:17:39 INFO - /firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-46.0.complete.mar
12:17:39 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-46.0.complete.mar
12:17:39 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build8-Complete', 'os': 'osx'}), kwargs: {}, attempt #1
12:17:39 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build8-Complete&os=osx
12:17:39 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:40 INFO - Server response
12:17:40 INFO - /firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-46.0.complete.mar
12:17:40 INFO - win32 (win): /firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-46.0.complete.mar
12:17:40 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build8-Complete', 'os': 'win'}), kwargs: {}, attempt #1
12:17:40 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build8-Complete&os=win
12:17:40 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:41 INFO - Server response
12:17:41 INFO - /firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-46.0.complete.mar
12:17:41 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-46.0.complete.mar
12:17:41 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-46.0.complete.mar', 'product': u'Firefox-46.0build8-Complete', 'os': 'win64'}), kwargs: {}, attempt #1
12:17:41 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-46.0.complete.mar&product=Firefox-46.0build8-Complete&os=win64
12:17:41 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:42 INFO - Server response
12:17:42 INFO - /firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-46.0.complete.mar
12:17:42 INFO - Checking if Firefox-46.0 already exists
12:17:42 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0', None), kwargs: {}, attempt #1
12:17:42 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0
12:17:42 INFO - Server response
12:17:42 INFO -
12:17:42 INFO - Products found: 1
12:17:42 WARNING - Product Firefox-46.0 already exists. Skipping...
12:17:42 INFO - Checking if Firefox-46.0-SSL already exists
12:17:42 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-SSL', None), kwargs: {}, attempt #1
12:17:42 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-SSL
12:17:43 INFO - Server response
12:17:43 INFO -
12:17:43 INFO - Products found: 1
12:17:43 WARNING - Product Firefox-46.0-SSL already exists. Skipping...
12:17:43 INFO - Checking if Firefox-46.0-stub already exists
12:17:43 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-stub', None), kwargs: {}, attempt #1
12:17:43 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-stub
12:17:43 INFO - Server response
12:17:43 INFO -
12:17:43 INFO - Products found: 1
12:17:43 WARNING - Product Firefox-46.0-stub already exists. Skipping...
12:17:43 INFO - Checking if Firefox-46.0build8-Partial-44.0build3 already exists
12:17:43 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build8-Partial-44.0build3', None), kwargs: {}, attempt #1
12:17:43 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build8-Partial-44.0build3
12:17:45 INFO - Server response
12:17:45 INFO -
12:17:45 INFO - Products found: 0
12:17:45 INFO - Adding partial updates for Firefox-46.0build8-Partial-44.0build3
12:17:45 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build8-Partial-44.0build3'}), kwargs: {}, attempt #1
12:17:45 INFO - POST data: product=Firefox-46.0build8-Partial-44.0build3
12:17:45 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
12:17:46 INFO - Server response
12:17:46 INFO -
12:17:46 INFO - linux (linux): /firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-44.0-46.0.partial.mar
12:17:46 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-44.0build3', 'os': 'linux'}), kwargs: {}, attempt #1
12:17:46 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-44.0build3&os=linux
12:17:46 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:46 INFO - Server response
12:17:46 INFO - /firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-44.0-46.0.partial.mar
12:17:46 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-44.0-46.0.partial.mar
12:17:46 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-44.0build3', 'os': 'linux64'}), kwargs: {}, attempt #1
12:17:46 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-44.0build3&os=linux64
12:17:46 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:47 INFO - Server response
12:17:47 INFO - /firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-44.0-46.0.partial.mar
12:17:47 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-44.0-46.0.partial.mar
12:17:47 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-44.0build3', 'os': 'osx'}), kwargs: {}, attempt #1
12:17:47 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-44.0build3&os=osx
12:17:47 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:48 INFO - Server response
12:17:48 INFO - /firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-44.0-46.0.partial.mar
12:17:48 INFO - win32 (win): /firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-44.0-46.0.partial.mar
12:17:48 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-44.0build3', 'os': 'win'}), kwargs: {}, attempt #1
12:17:48 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-44.0build3&os=win
12:17:48 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:48 INFO - Server response
12:17:48 INFO - /firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-44.0-46.0.partial.mar
12:17:48 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-44.0-46.0.partial.mar
12:17:48 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-44.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-44.0build3', 'os': 'win64'}), kwargs: {}, attempt #1
12:17:48 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-44.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-44.0build3&os=win64
12:17:48 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:49 INFO - Server response
12:17:49 INFO - /firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-44.0-46.0.partial.mar
12:17:49 INFO - Checking if Firefox-46.0build8-Partial-45.0build2 already exists
12:17:49 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build8-Partial-45.0build2', None), kwargs: {}, attempt #1
12:17:49 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build8-Partial-45.0build2
12:17:50 INFO - Server response
12:17:50 INFO -
12:17:50 INFO - Products found: 0
12:17:50 INFO - Adding partial updates for Firefox-46.0build8-Partial-45.0build2
12:17:50 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build8-Partial-45.0build2'}), kwargs: {}, attempt #1
12:17:50 INFO - POST data: product=Firefox-46.0build8-Partial-45.0build2
12:17:50 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
12:17:50 INFO - Server response
12:17:50 INFO -
12:17:50 INFO - linux (linux): /firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-45.0-46.0.partial.mar
12:17:50 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-45.0build2', 'os': 'linux'}), kwargs: {}, attempt #1
12:17:50 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-45.0build2&os=linux
12:17:50 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:51 INFO - Server response
12:17:51 INFO - /firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-45.0-46.0.partial.mar
12:17:51 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-45.0-46.0.partial.mar
12:17:51 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-45.0build2', 'os': 'linux64'}), kwargs: {}, attempt #1
12:17:51 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-45.0build2&os=linux64
12:17:51 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:52 INFO - Server response
12:17:52 INFO - /firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-45.0-46.0.partial.mar
12:17:52 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-45.0-46.0.partial.mar
12:17:52 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-45.0build2', 'os': 'osx'}), kwargs: {}, attempt #1
12:17:52 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-45.0build2&os=osx
12:17:52 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:52 INFO - Server response
12:17:52 INFO - /firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-45.0-46.0.partial.mar
12:17:52 INFO - win32 (win): /firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-45.0-46.0.partial.mar
12:17:52 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-45.0build2', 'os': 'win'}), kwargs: {}, attempt #1
12:17:52 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-45.0build2&os=win
12:17:52 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:53 INFO - Server response
12:17:53 INFO - /firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-45.0-46.0.partial.mar
12:17:53 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-45.0-46.0.partial.mar
12:17:53 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-45.0-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-45.0build2', 'os': 'win64'}), kwargs: {}, attempt #1
12:17:53 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0-46.0.partial.mar&product=Firefox-46.0build8-Partial-45.0build2&os=win64
12:17:53 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:54 INFO - Server response
12:17:54 INFO - /firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-45.0-46.0.partial.mar
12:17:54 INFO - Checking if Firefox-46.0build8-Partial-46.0b9build1 already exists
12:17:54 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0build8-Partial-46.0b9build1', None), kwargs: {}, attempt #1
12:17:54 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0build8-Partial-46.0b9build1
12:17:54 INFO - Server response
12:17:54 INFO -
12:17:54 INFO - Products found: 0
12:17:54 INFO - Adding partial updates for Firefox-46.0build8-Partial-46.0b9build1
12:17:54 INFO - retry: Calling _api_call with args: ('product_add/', {'product': u'Firefox-46.0build8-Partial-46.0b9build1'}), kwargs: {}, attempt #1
12:17:54 INFO - POST data: product=Firefox-46.0build8-Partial-46.0b9build1
12:17:54 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_add/
12:17:55 INFO - Server response
12:17:55 INFO -
12:17:55 INFO - linux (linux): /firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-46.0b9-46.0.partial.mar
12:17:55 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-46.0b9-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-46.0b9build1', 'os': 'linux'}), kwargs: {}, attempt #1
12:17:55 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-46.0b9-46.0.partial.mar&product=Firefox-46.0build8-Partial-46.0b9build1&os=linux
12:17:55 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:56 INFO - Server response
12:17:56 INFO - /firefox/candidates/46.0-candidates/build8/update/linux-i686/:lang/firefox-46.0b9-46.0.partial.mar
12:17:56 INFO - linux64 (linux64): /firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-46.0b9-46.0.partial.mar
12:17:56 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-46.0b9-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-46.0b9build1', 'os': 'linux64'}), kwargs: {}, attempt #1
12:17:56 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-46.0b9-46.0.partial.mar&product=Firefox-46.0build8-Partial-46.0b9build1&os=linux64
12:17:56 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:56 INFO - Server response
12:17:56 INFO - /firefox/candidates/46.0-candidates/build8/update/linux-x86_64/:lang/firefox-46.0b9-46.0.partial.mar
12:17:56 INFO - macosx64 (osx): /firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-46.0b9-46.0.partial.mar
12:17:56 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-46.0b9-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-46.0b9build1', 'os': 'osx'}), kwargs: {}, attempt #1
12:17:56 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-46.0b9-46.0.partial.mar&product=Firefox-46.0build8-Partial-46.0b9build1&os=osx
12:17:56 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:57 INFO - Server response
12:17:57 INFO - /firefox/candidates/46.0-candidates/build8/update/mac/:lang/firefox-46.0b9-46.0.partial.mar
12:17:57 INFO - win32 (win): /firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-46.0b9-46.0.partial.mar
12:17:57 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-46.0b9-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-46.0b9build1', 'os': 'win'}), kwargs: {}, attempt #1
12:17:57 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-46.0b9-46.0.partial.mar&product=Firefox-46.0build8-Partial-46.0b9build1&os=win
12:17:57 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:58 INFO - Server response
12:17:58 INFO - /firefox/candidates/46.0-candidates/build8/update/win32/:lang/firefox-46.0b9-46.0.partial.mar
12:17:58 INFO - win64 (win64): /firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-46.0b9-46.0.partial.mar
12:17:58 INFO - retry: Calling _api_call with args: ('location_add/', {'path': u'/firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-46.0b9-46.0.partial.mar', 'product': u'Firefox-46.0build8-Partial-46.0b9build1', 'os': 'win64'}), kwargs: {}, attempt #1
12:17:58 INFO - POST data: path=%2Ffirefox%2Fcandidates%2F46.0-candidates%2Fbuild8%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-46.0b9-46.0.partial.mar&product=Firefox-46.0build8-Partial-46.0b9build1&os=win64
12:17:58 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/location_add/
12:17:58 INFO - Server response
12:17:58 INFO - /firefox/candidates/46.0-candidates/build8/update/win64/:lang/firefox-46.0b9-46.0.partial.mar
12:17:58 INFO - Checking if Firefox-46.0-Partial-44.0 already exists
12:17:58 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-44.0', None), kwargs: {}, attempt #1
12:17:58 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Partial-44.0
12:17:59 INFO - Server response
12:17:59 INFO -
12:17:59 INFO - Products found: 1
12:17:59 WARNING - Product Firefox-46.0-Partial-44.0 already exists. Skipping...
12:17:59 INFO - Checking if Firefox-46.0-Partial-45.0 already exists
12:17:59 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-45.0', None), kwargs: {}, attempt #1
12:17:59 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Partial-45.0
12:18:00 INFO - Server response
12:18:00 INFO -
12:18:00 INFO - Products found: 1
12:18:00 WARNING - Product Firefox-46.0-Partial-45.0 already exists. Skipping...
12:18:00 INFO - Checking if Firefox-46.0-Partial-46.0b9 already exists
12:18:00 INFO - retry: Calling _api_call with args: (u'product_show?product=Firefox-46.0-Partial-46.0b9', None), kwargs: {}, attempt #1
12:18:00 INFO - Submitting to https://admin-bouncer.stage.mozaws.net/api/product_show?product=Firefox-46.0-Partial-46.0b9
12:18:01 INFO - Server response
12:18:01 INFO -
12:18:01 INFO - Products found: 1
12:18:01 WARNING - Product Firefox-46.0-Partial-46.0b9 already exists. Skipping...
12:18:01 INFO - Running post-run listener: copy_logs_to_upload_dir
12:18:01 INFO - Copying logs to upload dir...
12:18:01 INFO - mkdir: /builds/slave/rel-jamun_fx_bncr_sub-00000000/build/upload/logs
12:18:01 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=25.083528
========= master_lag: 0.05 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/bouncer_submitter.py ...' (results: 0, elapsed: 25 secs) (at 2016-04-11 12:18:01.313763) =========
========= Started no change (results: 0, elapsed: 0 secs) (at 2016-04-11 12:18:01.316872) =========
bash -c 'for file in `ls -1`; do cat $file; done'
in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/properties (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-1056.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-jamun_fx_bncr_sub-00000000/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.005076
========= master_lag: 0.01 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-04-11 12:18:01.336165) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:18:01.336461) =========
rm -f oauth.txt
in dir /builds/slave/rel-jamun_fx_bncr_sub-00000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-f', 'oauth.txt']
environment:
CCACHE_HASHDIR=
G_BROKEN_FILENAMES=1
HISTCONTROL=ignoredups
HISTSIZE=1000
HOME=/home/cltbld
HOSTNAME=bld-linux64-spot-1056.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-jamun_fx_bncr_sub-00000000
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.003260
========= master_lag: 0.07 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:18:01.408761) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 12:18:01.409092) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 12:18:01.409413) =========
========= Total master_lag: 0.71 =========