builder: release-mozilla-beta-firefox_bouncer_submitter
slave: bld-linux64-spot-414
starttime: 1456266378.04
results: success (0)
buildid: 20160223142613
builduid: 3584e8957789434bb674a141dee1d558
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.044037) =========
master: http://buildbot-master91.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.044480) =========
========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.044773) =========
bash -c pwd
in dir /builds/slave/rel-m-beta-bncr_sub-0000000000/. (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-414.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-m-beta-bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
/builds/slave/rel-m-beta-bncr_sub-0000000000
program finished with exit code 0
elapsedTime=0.004140
basedir: '/builds/slave/rel-m-beta-bncr_sub-0000000000'
========= master_lag: 0.03 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.081757) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.082074) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.140173) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.140545) =========
rm -rf properties
in dir /builds/slave/rel-m-beta-bncr_sub-0000000000/. (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-414.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-m-beta-bncr_sub-0000000000
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.002572
========= master_lag: 0.05 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.190803) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.191126) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.191474) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.191752) =========
bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'
in dir /builds/slave/rel-m-beta-bncr_sub-0000000000/. (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-414.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-m-beta-bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
--2016-02-23 14:26:18-- 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% 157M=0s
2016-02-23 14:26:18 (157 MB/s) - ‘archiver_client.py’ saved [12141/12141]
program finished with exit code 0
elapsedTime=0.291534
========= master_lag: 0.06 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.543946) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.544241) =========
rm -rf scripts
in dir /builds/slave/rel-m-beta-bncr_sub-0000000000/. (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-414.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-m-beta-bncr_sub-0000000000
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.002755
========= master_lag: 0.01 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 14:26:18.560280) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 mins, 29 secs) (at 2016-02-23 14:26:18.560581) =========
bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --tag FIREFOX_45_0b9_RELEASE --destination scripts --debug'
in dir /builds/slave/rel-m-beta-bncr_sub-0000000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --tag FIREFOX_45_0b9_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-414.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-m-beta-bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
2016-02-23 14:26:18,623 Setting DEBUG logging.
2016-02-23 14:26:18,623 "FIREFOX_45_0b9_RELEASE" was passed as the tag. Querying remote repository for corresponding rev hash.
2016-02-23 14:26:20,011 revision being used: ad87067f7429
2016-02-23 14:26:20,011 attempt 1/10
2016-02-23 14:26:20,012 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ad87067f7429?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-02-23 14:26:20,255 attempt 1/10
2016-02-23 14:26:20,637 current task status: no status available at this point. state: PENDING
2016-02-23 14:26:20,637 sleeping for 11.00s (attempt 1/10)
2016-02-23 14:26:31,648 attempt 2/10
2016-02-23 14:26:32,034 current task status: no status available at this point. state: PENDING
2016-02-23 14:26:32,034 sleeping for 16.50s (attempt 2/10)
2016-02-23 14:26:48,550 attempt 3/10
2016-02-23 14:26:48,927 current task status: no status available at this point. state: PENDING
2016-02-23 14:26:48,927 sleeping for 24.75s (attempt 3/10)
2016-02-23 14:27:13,702 attempt 4/10
2016-02-23 14:27:14,108 current task status: no status available at this point. state: PENDING
2016-02-23 14:27:14,108 sleeping for 37.12s (attempt 4/10)
2016-02-23 14:27:51,270 attempt 5/10
2016-02-23 14:27:51,624 current task status: no status available at this point. state: PENDING
2016-02-23 14:27:51,624 sleeping for 55.69s (attempt 5/10)
2016-02-23 14:28:47,367 attempt 6/10
2016-02-23 14:28:47,551 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS
2016-02-23 14:28:47,617 unpacking tar archive at: mozilla-beta-ad87067f7429/testing/mozharness/
program finished with exit code 0
elapsedTime=149.151187
========= master_lag: 0.03 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 mins, 29 secs) (at 2016-02-23 14:28:47.738079) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 14:28:47.738419) =========
echo FIREFOX_45_0b9_RELEASE
in dir /builds/slave/rel-m-beta-bncr_sub-0000000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['echo', 'FIREFOX_45_0b9_RELEASE']
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-414.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-m-beta-bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
FIREFOX_45_0b9_RELEASE
program finished with exit code 0
elapsedTime=0.004048
script_repo_revision: 'FIREFOX_45_0b9_RELEASE'
========= master_lag: 0.04 =========
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 14:28:47.786499) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 14:28:47.786805) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 14:28:47.796773) =========
========= Started 'scripts/scripts/bouncer_submitter.py -c ...' (results: 0, elapsed: 8 mins, 14 secs) (at 2016-02-23 14:28:47.797083) =========
scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_beta.py --revision FIREFOX_45_0b9_RELEASE --repo releases/mozilla-beta --version 45.0b9 --credentials-file oauth.txt --bouncer-api-prefix https://bounceradmin.mozilla.com/api --build-number 2 --previous-version 45.0b8build1 --previous-version 45.0b7build1 --previous-version 45.0b6build1
in dir /builds/slave/rel-m-beta-bncr_sub-0000000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['scripts/scripts/bouncer_submitter.py', '-c', 'releases/bouncer_firefox_beta.py', '--revision', 'FIREFOX_45_0b9_RELEASE', '--repo', 'releases/mozilla-beta', '--version', '45.0b9', '--credentials-file', 'oauth.txt', '--bouncer-api-prefix', 'https://bounceradmin.mozilla.com/api', '--build-number', '2', '--previous-version', '45.0b8build1', '--previous-version', '45.0b7build1', '--previous-version', '45.0b6build1']
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-414.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PROPERTIES_FILE=/builds/slave/rel-m-beta-bncr_sub-0000000000/buildprops.json
PWD=/builds/slave/rel-m-beta-bncr_sub-0000000000
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
_=/tools/buildbot/bin/python
using PTY: False
14:28:47 INFO - MultiFileLogger online at 20160223 14:28:47 in /builds/slave/rel-m-beta-bncr_sub-0000000000
14:28:47 INFO - Run as scripts/scripts/bouncer_submitter.py -c releases/bouncer_firefox_beta.py --revision FIREFOX_45_0b9_RELEASE --repo releases/mozilla-beta --version 45.0b9 --credentials-file oauth.txt --bouncer-api-prefix https://bounceradmin.mozilla.com/api --build-number 2 --previous-version 45.0b8build1 --previous-version 45.0b7build1 --previous-version 45.0b6build1
14:28:47 INFO - Dumping config to /builds/slave/rel-m-beta-bncr_sub-0000000000/logs/localconfig.json.
14:28:47 INFO - {'append_to_log': False,
14:28:47 INFO - 'base_work_dir': '/builds/slave/rel-m-beta-bncr_sub-0000000000',
14:28:47 INFO - 'bouncer-api-prefix': 'https://bounceradmin.mozilla.com/api',
14:28:47 INFO - 'build_number': '2',
14:28:47 INFO - 'config_files': ('releases/bouncer_firefox_beta.py',),
14:28:47 INFO - 'credentials_file': 'oauth.txt',
14:28:47 INFO - 'log_level': 'info',
14:28:47 INFO - 'log_to_console': True,
14:28:47 INFO - 'opt_config_files': (),
14:28:47 INFO - 'partials': {'releases-dir': {'add-locales': True,
14:28:47 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
14:28:47 INFO - 'linux64': {'bouncer-platform': 'linux64',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
14:28:47 INFO - 'macosx64': {'bouncer-platform': 'osx',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
14:28:47 INFO - 'win32': {'bouncer-platform': 'win',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'},
14:28:47 INFO - 'win64': {'bouncer-platform': 'win64',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(prev_version)s-%(version)s.partial.mar'}},
14:28:47 INFO - 'product-name': 'Firefox-%(version)s-Partial-%(prev_version)s',
14:28:47 INFO - 'ssl-only': False}},
14:28:47 INFO - 'prev_versions': ('45.0b8build1', '45.0b7build1', '45.0b6build1'),
14:28:47 INFO - 'products': {'complete-mar': {'add-locales': True,
14:28:47 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/linux-i686/:lang/firefox-%(version)s.complete.mar'},
14:28:47 INFO - 'linux64': {'bouncer-platform': 'linux64',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/linux-x86_64/:lang/firefox-%(version)s.complete.mar'},
14:28:47 INFO - 'macosx64': {'bouncer-platform': 'osx',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/mac/:lang/firefox-%(version)s.complete.mar'},
14:28:47 INFO - 'win32': {'bouncer-platform': 'win',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/win32/:lang/firefox-%(version)s.complete.mar'},
14:28:47 INFO - 'win64': {'bouncer-platform': 'win64',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/update/win64/:lang/firefox-%(version)s.complete.mar'}},
14:28:47 INFO - 'product-name': 'Firefox-%(version)s-Complete',
14:28:47 INFO - 'ssl-only': False},
14:28:47 INFO - 'installer': {'add-locales': True,
14:28:47 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
14:28:47 INFO - 'linux64': {'bouncer-platform': 'linux64',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
14:28:47 INFO - 'macosx64': {'bouncer-platform': 'osx',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
14:28:47 INFO - 'win32': {'bouncer-platform': 'win',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
14:28:47 INFO - 'win64': {'bouncer-platform': 'win64',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
14:28:47 INFO - 'product-name': 'Firefox-%(version)s',
14:28:47 INFO - 'ssl-only': False},
14:28:47 INFO - 'installer-ssl': {'add-locales': True,
14:28:47 INFO - 'paths': {'linux': {'bouncer-platform': 'linux',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/linux-i686/:lang/firefox-%(version)s.tar.bz2'},
14:28:47 INFO - 'linux64': {'bouncer-platform': 'linux64',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/linux-x86_64/:lang/firefox-%(version)s.tar.bz2'},
14:28:47 INFO - 'macosx64': {'bouncer-platform': 'osx',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/mac/:lang/Firefox%%20%(version)s.dmg'},
14:28:47 INFO - 'win32': {'bouncer-platform': 'win',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20%(version)s.exe'},
14:28:47 INFO - 'win64': {'bouncer-platform': 'win64',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20%(version)s.exe'}},
14:28:47 INFO - 'product-name': 'Firefox-%(version)s-SSL',
14:28:47 INFO - 'ssl-only': True},
14:28:47 INFO - 'stub-installer': {'add-locales': True,
14:28:47 INFO - 'paths': {'win32': {'bouncer-platform': 'win',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/win32/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'},
14:28:47 INFO - 'win64': {'bouncer-platform': 'win64',
14:28:47 INFO - 'path': '/firefox/releases/%(version)s/win64/:lang/Firefox%%20Setup%%20Stub%%20%(version)s.exe'}},
14:28:47 INFO - 'product-name': 'Firefox-%(version)s-stub',
14:28:47 INFO - 'ssl-only': True}},
14:28:47 INFO - 'repo': 'releases/mozilla-beta',
14:28:47 INFO - 'revision': 'FIREFOX_45_0b9_RELEASE',
14:28:47 INFO - 'shipped-locales-url': 'https://hg.mozilla.org/%(repo)s/raw-file/%(revision)s/browser/locales/shipped-locales',
14:28:47 INFO - 'version': '45.0b9',
14:28:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
14:28:47 INFO - 'work_dir': 'build'}
14:28:47 INFO - #####
14:28:47 INFO - ##### Running clobber step.
14:28:47 INFO - #####
14:28:47 INFO - Running main action method: clobber
14:28:47 INFO - rmtree: /builds/slave/rel-m-beta-bncr_sub-0000000000/build
14:28:47 INFO - #####
14:28:47 INFO - ##### Running download-shipped-locales step.
14:28:47 INFO - #####
14:28:47 INFO - Running main action method: download_shipped_locales
14:28:47 INFO - mkdir: /builds/slave/rel-m-beta-bncr_sub-0000000000/build
14:28:47 INFO - Downloading https://hg.mozilla.org/releases/mozilla-beta/raw-file/FIREFOX_45_0b9_RELEASE/browser/locales/shipped-locales to /builds/slave/rel-m-beta-bncr_sub-0000000000/build/shipped-locales
14:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-beta/raw-file/FIREFOX_45_0b9_RELEASE/browser/locales/shipped-locales', 'file_name': '/builds/slave/rel-m-beta-bncr_sub-0000000000/build/shipped-locales'}, attempt #1
14:28:48 INFO - Downloaded 369 bytes.
14:28:48 INFO - Reading from file /builds/slave/rel-m-beta-bncr_sub-0000000000/build/shipped-locales
14:28:48 INFO - Contents:
14:28:48 INFO - ach
14:28:48 INFO - af
14:28:48 INFO - an
14:28:48 INFO - ar
14:28:48 INFO - as
14:28:48 INFO - ast
14:28:48 INFO - az
14:28:48 INFO - be
14:28:48 INFO - bg
14:28:48 INFO - bn-BD
14:28:48 INFO - bn-IN
14:28:48 INFO - br
14:28:48 INFO - bs
14:28:48 INFO - ca
14:28:48 INFO - cs
14:28:48 INFO - cy
14:28:48 INFO - da
14:28:48 INFO - de
14:28:48 INFO - dsb
14:28:48 INFO - el
14:28:48 INFO - en-GB
14:28:48 INFO - en-US
14:28:48 INFO - en-ZA
14:28:48 INFO - eo
14:28:48 INFO - es-AR
14:28:48 INFO - es-CL
14:28:48 INFO - es-ES
14:28:48 INFO - es-MX
14:28:48 INFO - et
14:28:48 INFO - eu
14:28:48 INFO - fa
14:28:48 INFO - ff
14:28:48 INFO - fi
14:28:48 INFO - fr
14:28:48 INFO - fy-NL
14:28:48 INFO - ga-IE
14:28:48 INFO - gd
14:28:48 INFO - gl
14:28:48 INFO - gn
14:28:48 INFO - gu-IN
14:28:48 INFO - he
14:28:48 INFO - hi-IN
14:28:48 INFO - hr
14:28:48 INFO - hsb
14:28:48 INFO - hu
14:28:48 INFO - hy-AM
14:28:48 INFO - id
14:28:48 INFO - is
14:28:48 INFO - it
14:28:48 INFO - ja linux win32
14:28:48 INFO - ja-JP-mac osx
14:28:48 INFO - kk
14:28:48 INFO - km
14:28:48 INFO - kn
14:28:48 INFO - ko
14:28:48 INFO - lij
14:28:48 INFO - lt
14:28:48 INFO - lv
14:28:48 INFO - mai
14:28:48 INFO - mk
14:28:48 INFO - ml
14:28:48 INFO - mr
14:28:48 INFO - ms
14:28:48 INFO - nb-NO
14:28:48 INFO - nl
14:28:48 INFO - nn-NO
14:28:48 INFO - or
14:28:48 INFO - pa-IN
14:28:48 INFO - pl
14:28:48 INFO - pt-BR
14:28:48 INFO - pt-PT
14:28:48 INFO - rm
14:28:48 INFO - ro
14:28:48 INFO - ru
14:28:48 INFO - si
14:28:48 INFO - sk
14:28:48 INFO - sl
14:28:48 INFO - son
14:28:48 INFO - sq
14:28:48 INFO - sr
14:28:48 INFO - sv-SE
14:28:48 INFO - ta
14:28:48 INFO - te
14:28:48 INFO - th
14:28:48 INFO - tr
14:28:48 INFO - uk
14:28:48 INFO - uz
14:28:48 INFO - vi
14:28:48 INFO - xh
14:28:48 INFO - zh-CN
14:28:48 INFO - zh-TW
14:28:48 INFO - #####
14:28:48 INFO - ##### Running submit step.
14:28:48 INFO - #####
14:28:48 INFO - Running main action method: submit
14:28:48 INFO - Checking if Firefox-45.0b9-Complete already exists
14:28:48 INFO - retry: Calling _api_call with args: ('product_show?product=Firefox-45.0b9-Complete', None), kwargs: {}, attempt #1
14:28:48 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-45.0b9-Complete
14:28:49 INFO - Server response
14:28:49 INFO -
14:28:49 INFO - Products found: 1
14:28:49 WARNING - Product Firefox-45.0b9-Complete already exists. Skipping...
14:28:49 INFO - Checking if Firefox-45.0b9 already exists
14:28:49 INFO - retry: Calling _api_call with args: ('product_show?product=Firefox-45.0b9', None), kwargs: {}, attempt #1
14:28:49 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-45.0b9
14:28:49 INFO - Server response
14:28:49 INFO -
14:28:49 INFO - Products found: 1
14:28:49 WARNING - Product Firefox-45.0b9 already exists. Skipping...
14:28:49 INFO - Checking if Firefox-45.0b9-SSL already exists
14:28:49 INFO - retry: Calling _api_call with args: ('product_show?product=Firefox-45.0b9-SSL', None), kwargs: {}, attempt #1
14:28:49 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-45.0b9-SSL
14:28:49 INFO - Server response
14:28:49 INFO -
14:28:49 INFO - Products found: 1
14:28:49 WARNING - Product Firefox-45.0b9-SSL already exists. Skipping...
14:28:49 INFO - Checking if Firefox-45.0b9-stub already exists
14:28:49 INFO - retry: Calling _api_call with args: ('product_show?product=Firefox-45.0b9-stub', None), kwargs: {}, attempt #1
14:28:49 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-45.0b9-stub
14:28:50 INFO - Server response
14:28:50 INFO -
14:28:50 INFO - Products found: 1
14:28:50 WARNING - Product Firefox-45.0b9-stub already exists. Skipping...
14:28:50 INFO - Checking if Firefox-45.0b9-Partial-45.0b8 already exists
14:28:50 INFO - retry: Calling _api_call with args: ('product_show?product=Firefox-45.0b9-Partial-45.0b8', None), kwargs: {}, attempt #1
14:28:50 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-45.0b9-Partial-45.0b8
14:28:50 INFO - Server response
14:28:50 INFO -
14:28:50 INFO - Products found: 0
14:28:50 INFO - Adding partial updates for Firefox-45.0b9-Partial-45.0b8
14:28:50 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['ach', 'af', 'an', 'ar', 'as', 'ast', 'az', 'be', 'bg', 'bn-BD', 'bn-IN', 'br', 'bs', 'ca', 'cs', 'cy', 'da', 'de', 'dsb', 'el', 'en-GB', 'en-US', 'en-ZA', 'eo', 'es-AR', 'es-CL', 'es-ES', 'es-MX', 'et', 'eu', 'fa', 'ff', 'fi', 'fr', 'fy-NL', 'ga-IE', 'gd', 'gl', 'gn', 'gu-IN', 'he', 'hi-IN', 'hr', 'hsb', 'hu', 'hy-AM', 'id', 'is', 'it', 'ja', 'ja-JP-mac', 'kk', 'km', 'kn', 'ko', 'lij', 'lt', 'lv', 'mai', 'mk', 'ml', 'mr', 'ms', 'nb-NO', 'nl', 'nn-NO', 'or', 'pa-IN', 'pl', 'pt-BR', 'pt-PT', 'rm', 'ro', 'ru', 'si', 'sk', 'sl', 'son', 'sq', 'sr', 'sv-SE', 'ta', 'te', 'th', 'tr', 'uk', 'uz', 'vi', 'xh', 'zh-CN', 'zh-TW'], 'product': 'Firefox-45.0b9-Partial-45.0b8'}), kwargs: {}, attempt #1
14:28:50 INFO - POST data: languages=ach&languages=af&languages=an&languages=ar&languages=as&languages=ast&languages=az&languages=be&languages=bg&languages=bn-BD&languages=bn-IN&languages=br&languages=bs&languages=ca&languages=cs&languages=cy&languages=da&languages=de&languages=dsb&languages=el&languages=en-GB&languages=en-US&languages=en-ZA&languages=eo&languages=es-AR&languages=es-CL&languages=es-ES&languages=es-MX&languages=et&languages=eu&languages=fa&languages=ff&languages=fi&languages=fr&languages=fy-NL&languages=ga-IE&languages=gd&languages=gl&languages=gn&languages=gu-IN&languages=he&languages=hi-IN&languages=hr&languages=hsb&languages=hu&languages=hy-AM&languages=id&languages=is&languages=it&languages=ja&languages=ja-JP-mac&languages=kk&languages=km&languages=kn&languages=ko&languages=lij&languages=lt&languages=lv&languages=mai&languages=mk&languages=ml&languages=mr&languages=ms&languages=nb-NO&languages=nl&languages=nn-NO&languages=or&languages=pa-IN&languages=pl&languages=pt-BR&languages=pt-PT&languages=rm&languages=ro&languages=ru&languages=si&languages=sk&languages=sl&languages=son&languages=sq&languages=sr&languages=sv-SE&languages=ta&languages=te&languages=th&languages=tr&languages=uk&languages=uz&languages=vi&languages=xh&languages=zh-CN&languages=zh-TW&product=Firefox-45.0b9-Partial-45.0b8
14:28:50 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/
14:28:51 WARNING - Cannot access https://bounceradmin.mozilla.com/api/product_add/
14:28:51 WARNING - Returned page source:
14:28:51 WARNING - invalid language code(s)
14:28:51 INFO - retry: attempt #1 caught exception: HTTP Error 400: BAD REQUEST
14:28:51 INFO - retry: Failed, sleeping 60 seconds before retrying
14:29:51 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['ach', 'af', 'an', 'ar', 'as', 'ast', 'az', 'be', 'bg', 'bn-BD', 'bn-IN', 'br', 'bs', 'ca', 'cs', 'cy', 'da', 'de', 'dsb', 'el', 'en-GB', 'en-US', 'en-ZA', 'eo', 'es-AR', 'es-CL', 'es-ES', 'es-MX', 'et', 'eu', 'fa', 'ff', 'fi', 'fr', 'fy-NL', 'ga-IE', 'gd', 'gl', 'gn', 'gu-IN', 'he', 'hi-IN', 'hr', 'hsb', 'hu', 'hy-AM', 'id', 'is', 'it', 'ja', 'ja-JP-mac', 'kk', 'km', 'kn', 'ko', 'lij', 'lt', 'lv', 'mai', 'mk', 'ml', 'mr', 'ms', 'nb-NO', 'nl', 'nn-NO', 'or', 'pa-IN', 'pl', 'pt-BR', 'pt-PT', 'rm', 'ro', 'ru', 'si', 'sk', 'sl', 'son', 'sq', 'sr', 'sv-SE', 'ta', 'te', 'th', 'tr', 'uk', 'uz', 'vi', 'xh', 'zh-CN', 'zh-TW'], 'product': 'Firefox-45.0b9-Partial-45.0b8'}), kwargs: {}, attempt #2
14:29:51 INFO - POST data: languages=ach&languages=af&languages=an&languages=ar&languages=as&languages=ast&languages=az&languages=be&languages=bg&languages=bn-BD&languages=bn-IN&languages=br&languages=bs&languages=ca&languages=cs&languages=cy&languages=da&languages=de&languages=dsb&languages=el&languages=en-GB&languages=en-US&languages=en-ZA&languages=eo&languages=es-AR&languages=es-CL&languages=es-ES&languages=es-MX&languages=et&languages=eu&languages=fa&languages=ff&languages=fi&languages=fr&languages=fy-NL&languages=ga-IE&languages=gd&languages=gl&languages=gn&languages=gu-IN&languages=he&languages=hi-IN&languages=hr&languages=hsb&languages=hu&languages=hy-AM&languages=id&languages=is&languages=it&languages=ja&languages=ja-JP-mac&languages=kk&languages=km&languages=kn&languages=ko&languages=lij&languages=lt&languages=lv&languages=mai&languages=mk&languages=ml&languages=mr&languages=ms&languages=nb-NO&languages=nl&languages=nn-NO&languages=or&languages=pa-IN&languages=pl&languages=pt-BR&languages=pt-PT&languages=rm&languages=ro&languages=ru&languages=si&languages=sk&languages=sl&languages=son&languages=sq&languages=sr&languages=sv-SE&languages=ta&languages=te&languages=th&languages=tr&languages=uk&languages=uz&languages=vi&languages=xh&languages=zh-CN&languages=zh-TW&product=Firefox-45.0b9-Partial-45.0b8
14:29:51 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/
14:29:51 WARNING - Cannot access https://bounceradmin.mozilla.com/api/product_add/
14:29:51 WARNING - Returned page source:
14:29:51 WARNING - invalid language code(s)
14:29:51 INFO - retry: attempt #2 caught exception: HTTP Error 400: BAD REQUEST
14:29:51 INFO - retry: Failed, sleeping 120 seconds before retrying
14:31:51 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['ach', 'af', 'an', 'ar', 'as', 'ast', 'az', 'be', 'bg', 'bn-BD', 'bn-IN', 'br', 'bs', 'ca', 'cs', 'cy', 'da', 'de', 'dsb', 'el', 'en-GB', 'en-US', 'en-ZA', 'eo', 'es-AR', 'es-CL', 'es-ES', 'es-MX', 'et', 'eu', 'fa', 'ff', 'fi', 'fr', 'fy-NL', 'ga-IE', 'gd', 'gl', 'gn', 'gu-IN', 'he', 'hi-IN', 'hr', 'hsb', 'hu', 'hy-AM', 'id', 'is', 'it', 'ja', 'ja-JP-mac', 'kk', 'km', 'kn', 'ko', 'lij', 'lt', 'lv', 'mai', 'mk', 'ml', 'mr', 'ms', 'nb-NO', 'nl', 'nn-NO', 'or', 'pa-IN', 'pl', 'pt-BR', 'pt-PT', 'rm', 'ro', 'ru', 'si', 'sk', 'sl', 'son', 'sq', 'sr', 'sv-SE', 'ta', 'te', 'th', 'tr', 'uk', 'uz', 'vi', 'xh', 'zh-CN', 'zh-TW'], 'product': 'Firefox-45.0b9-Partial-45.0b8'}), kwargs: {}, attempt #3
14:31:51 INFO - POST data: languages=ach&languages=af&languages=an&languages=ar&languages=as&languages=ast&languages=az&languages=be&languages=bg&languages=bn-BD&languages=bn-IN&languages=br&languages=bs&languages=ca&languages=cs&languages=cy&languages=da&languages=de&languages=dsb&languages=el&languages=en-GB&languages=en-US&languages=en-ZA&languages=eo&languages=es-AR&languages=es-CL&languages=es-ES&languages=es-MX&languages=et&languages=eu&languages=fa&languages=ff&languages=fi&languages=fr&languages=fy-NL&languages=ga-IE&languages=gd&languages=gl&languages=gn&languages=gu-IN&languages=he&languages=hi-IN&languages=hr&languages=hsb&languages=hu&languages=hy-AM&languages=id&languages=is&languages=it&languages=ja&languages=ja-JP-mac&languages=kk&languages=km&languages=kn&languages=ko&languages=lij&languages=lt&languages=lv&languages=mai&languages=mk&languages=ml&languages=mr&languages=ms&languages=nb-NO&languages=nl&languages=nn-NO&languages=or&languages=pa-IN&languages=pl&languages=pt-BR&languages=pt-PT&languages=rm&languages=ro&languages=ru&languages=si&languages=sk&languages=sl&languages=son&languages=sq&languages=sr&languages=sv-SE&languages=ta&languages=te&languages=th&languages=tr&languages=uk&languages=uz&languages=vi&languages=xh&languages=zh-CN&languages=zh-TW&product=Firefox-45.0b9-Partial-45.0b8
14:31:51 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/
14:31:52 WARNING - Cannot access https://bounceradmin.mozilla.com/api/product_add/
14:31:52 WARNING - Returned page source:
14:31:52 WARNING - invalid language code(s)
14:31:52 INFO - retry: attempt #3 caught exception: HTTP Error 400: BAD REQUEST
14:31:52 INFO - retry: Failed, sleeping 240 seconds before retrying
14:35:52 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['ach', 'af', 'an', 'ar', 'as', 'ast', 'az', 'be', 'bg', 'bn-BD', 'bn-IN', 'br', 'bs', 'ca', 'cs', 'cy', 'da', 'de', 'dsb', 'el', 'en-GB', 'en-US', 'en-ZA', 'eo', 'es-AR', 'es-CL', 'es-ES', 'es-MX', 'et', 'eu', 'fa', 'ff', 'fi', 'fr', 'fy-NL', 'ga-IE', 'gd', 'gl', 'gn', 'gu-IN', 'he', 'hi-IN', 'hr', 'hsb', 'hu', 'hy-AM', 'id', 'is', 'it', 'ja', 'ja-JP-mac', 'kk', 'km', 'kn', 'ko', 'lij', 'lt', 'lv', 'mai', 'mk', 'ml', 'mr', 'ms', 'nb-NO', 'nl', 'nn-NO', 'or', 'pa-IN', 'pl', 'pt-BR', 'pt-PT', 'rm', 'ro', 'ru', 'si', 'sk', 'sl', 'son', 'sq', 'sr', 'sv-SE', 'ta', 'te', 'th', 'tr', 'uk', 'uz', 'vi', 'xh', 'zh-CN', 'zh-TW'], 'product': 'Firefox-45.0b9-Partial-45.0b8'}), kwargs: {}, attempt #4
14:35:52 INFO - POST data: languages=ach&languages=af&languages=an&languages=ar&languages=as&languages=ast&languages=az&languages=be&languages=bg&languages=bn-BD&languages=bn-IN&languages=br&languages=bs&languages=ca&languages=cs&languages=cy&languages=da&languages=de&languages=dsb&languages=el&languages=en-GB&languages=en-US&languages=en-ZA&languages=eo&languages=es-AR&languages=es-CL&languages=es-ES&languages=es-MX&languages=et&languages=eu&languages=fa&languages=ff&languages=fi&languages=fr&languages=fy-NL&languages=ga-IE&languages=gd&languages=gl&languages=gn&languages=gu-IN&languages=he&languages=hi-IN&languages=hr&languages=hsb&languages=hu&languages=hy-AM&languages=id&languages=is&languages=it&languages=ja&languages=ja-JP-mac&languages=kk&languages=km&languages=kn&languages=ko&languages=lij&languages=lt&languages=lv&languages=mai&languages=mk&languages=ml&languages=mr&languages=ms&languages=nb-NO&languages=nl&languages=nn-NO&languages=or&languages=pa-IN&languages=pl&languages=pt-BR&languages=pt-PT&languages=rm&languages=ro&languages=ru&languages=si&languages=sk&languages=sl&languages=son&languages=sq&languages=sr&languages=sv-SE&languages=ta&languages=te&languages=th&languages=tr&languages=uk&languages=uz&languages=vi&languages=xh&languages=zh-CN&languages=zh-TW&product=Firefox-45.0b9-Partial-45.0b8
14:35:52 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/
14:35:54 INFO - Server response
14:35:54 INFO -
14:35:54 INFO - linux (linux): /firefox/releases/45.0b9/update/linux-i686/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:54 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/linux-i686/:lang/firefox-45.0b8-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b8', 'os': 'linux'}), kwargs: {}, attempt #1
14:35:54 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0b8-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b8&os=linux
14:35:54 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:35:54 INFO - Server response
14:35:54 INFO - /firefox/releases/45.0b9/update/linux-i686/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:54 INFO - linux64 (linux64): /firefox/releases/45.0b9/update/linux-x86_64/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:54 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/linux-x86_64/:lang/firefox-45.0b8-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b8', 'os': 'linux64'}), kwargs: {}, attempt #1
14:35:54 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0b8-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b8&os=linux64
14:35:54 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:35:55 INFO - Server response
14:35:55 INFO - /firefox/releases/45.0b9/update/linux-x86_64/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:55 INFO - macosx64 (osx): /firefox/releases/45.0b9/update/mac/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:55 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/mac/:lang/firefox-45.0b8-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b8', 'os': 'osx'}), kwargs: {}, attempt #1
14:35:55 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0b8-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b8&os=osx
14:35:55 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:35:55 INFO - Server response
14:35:55 INFO - /firefox/releases/45.0b9/update/mac/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:55 INFO - win32 (win): /firefox/releases/45.0b9/update/win32/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:55 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/win32/:lang/firefox-45.0b8-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b8', 'os': 'win'}), kwargs: {}, attempt #1
14:35:55 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0b8-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b8&os=win
14:35:55 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:35:56 INFO - Server response
14:35:56 INFO - /firefox/releases/45.0b9/update/win32/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:56 INFO - win64 (win64): /firefox/releases/45.0b9/update/win64/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:56 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/win64/:lang/firefox-45.0b8-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b8', 'os': 'win64'}), kwargs: {}, attempt #1
14:35:56 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0b8-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b8&os=win64
14:35:56 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:35:56 INFO - Server response
14:35:56 INFO - /firefox/releases/45.0b9/update/win64/:lang/firefox-45.0b8-45.0b9.partial.mar
14:35:56 INFO - Checking if Firefox-45.0b9-Partial-45.0b7 already exists
14:35:56 INFO - retry: Calling _api_call with args: ('product_show?product=Firefox-45.0b9-Partial-45.0b7', None), kwargs: {}, attempt #1
14:35:56 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-45.0b9-Partial-45.0b7
14:35:57 INFO - Server response
14:35:57 INFO -
14:35:57 INFO - Products found: 0
14:35:57 INFO - Adding partial updates for Firefox-45.0b9-Partial-45.0b7
14:35:57 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['ach', 'af', 'an', 'ar', 'as', 'ast', 'az', 'be', 'bg', 'bn-BD', 'bn-IN', 'br', 'bs', 'ca', 'cs', 'cy', 'da', 'de', 'dsb', 'el', 'en-GB', 'en-US', 'en-ZA', 'eo', 'es-AR', 'es-CL', 'es-ES', 'es-MX', 'et', 'eu', 'fa', 'ff', 'fi', 'fr', 'fy-NL', 'ga-IE', 'gd', 'gl', 'gn', 'gu-IN', 'he', 'hi-IN', 'hr', 'hsb', 'hu', 'hy-AM', 'id', 'is', 'it', 'ja', 'ja-JP-mac', 'kk', 'km', 'kn', 'ko', 'lij', 'lt', 'lv', 'mai', 'mk', 'ml', 'mr', 'ms', 'nb-NO', 'nl', 'nn-NO', 'or', 'pa-IN', 'pl', 'pt-BR', 'pt-PT', 'rm', 'ro', 'ru', 'si', 'sk', 'sl', 'son', 'sq', 'sr', 'sv-SE', 'ta', 'te', 'th', 'tr', 'uk', 'uz', 'vi', 'xh', 'zh-CN', 'zh-TW'], 'product': 'Firefox-45.0b9-Partial-45.0b7'}), kwargs: {}, attempt #1
14:35:57 INFO - POST data: languages=ach&languages=af&languages=an&languages=ar&languages=as&languages=ast&languages=az&languages=be&languages=bg&languages=bn-BD&languages=bn-IN&languages=br&languages=bs&languages=ca&languages=cs&languages=cy&languages=da&languages=de&languages=dsb&languages=el&languages=en-GB&languages=en-US&languages=en-ZA&languages=eo&languages=es-AR&languages=es-CL&languages=es-ES&languages=es-MX&languages=et&languages=eu&languages=fa&languages=ff&languages=fi&languages=fr&languages=fy-NL&languages=ga-IE&languages=gd&languages=gl&languages=gn&languages=gu-IN&languages=he&languages=hi-IN&languages=hr&languages=hsb&languages=hu&languages=hy-AM&languages=id&languages=is&languages=it&languages=ja&languages=ja-JP-mac&languages=kk&languages=km&languages=kn&languages=ko&languages=lij&languages=lt&languages=lv&languages=mai&languages=mk&languages=ml&languages=mr&languages=ms&languages=nb-NO&languages=nl&languages=nn-NO&languages=or&languages=pa-IN&languages=pl&languages=pt-BR&languages=pt-PT&languages=rm&languages=ro&languages=ru&languages=si&languages=sk&languages=sl&languages=son&languages=sq&languages=sr&languages=sv-SE&languages=ta&languages=te&languages=th&languages=tr&languages=uk&languages=uz&languages=vi&languages=xh&languages=zh-CN&languages=zh-TW&product=Firefox-45.0b9-Partial-45.0b7
14:35:57 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/
14:35:57 WARNING - Cannot access https://bounceradmin.mozilla.com/api/product_add/
14:35:57 WARNING - Returned page source:
14:35:57 WARNING - invalid language code(s)
14:35:57 INFO - retry: attempt #1 caught exception: HTTP Error 400: BAD REQUEST
14:35:57 INFO - retry: Failed, sleeping 60 seconds before retrying
14:36:57 INFO - retry: Calling _api_call with args: ('product_add/', {'languages': ['ach', 'af', 'an', 'ar', 'as', 'ast', 'az', 'be', 'bg', 'bn-BD', 'bn-IN', 'br', 'bs', 'ca', 'cs', 'cy', 'da', 'de', 'dsb', 'el', 'en-GB', 'en-US', 'en-ZA', 'eo', 'es-AR', 'es-CL', 'es-ES', 'es-MX', 'et', 'eu', 'fa', 'ff', 'fi', 'fr', 'fy-NL', 'ga-IE', 'gd', 'gl', 'gn', 'gu-IN', 'he', 'hi-IN', 'hr', 'hsb', 'hu', 'hy-AM', 'id', 'is', 'it', 'ja', 'ja-JP-mac', 'kk', 'km', 'kn', 'ko', 'lij', 'lt', 'lv', 'mai', 'mk', 'ml', 'mr', 'ms', 'nb-NO', 'nl', 'nn-NO', 'or', 'pa-IN', 'pl', 'pt-BR', 'pt-PT', 'rm', 'ro', 'ru', 'si', 'sk', 'sl', 'son', 'sq', 'sr', 'sv-SE', 'ta', 'te', 'th', 'tr', 'uk', 'uz', 'vi', 'xh', 'zh-CN', 'zh-TW'], 'product': 'Firefox-45.0b9-Partial-45.0b7'}), kwargs: {}, attempt #2
14:36:57 INFO - POST data: languages=ach&languages=af&languages=an&languages=ar&languages=as&languages=ast&languages=az&languages=be&languages=bg&languages=bn-BD&languages=bn-IN&languages=br&languages=bs&languages=ca&languages=cs&languages=cy&languages=da&languages=de&languages=dsb&languages=el&languages=en-GB&languages=en-US&languages=en-ZA&languages=eo&languages=es-AR&languages=es-CL&languages=es-ES&languages=es-MX&languages=et&languages=eu&languages=fa&languages=ff&languages=fi&languages=fr&languages=fy-NL&languages=ga-IE&languages=gd&languages=gl&languages=gn&languages=gu-IN&languages=he&languages=hi-IN&languages=hr&languages=hsb&languages=hu&languages=hy-AM&languages=id&languages=is&languages=it&languages=ja&languages=ja-JP-mac&languages=kk&languages=km&languages=kn&languages=ko&languages=lij&languages=lt&languages=lv&languages=mai&languages=mk&languages=ml&languages=mr&languages=ms&languages=nb-NO&languages=nl&languages=nn-NO&languages=or&languages=pa-IN&languages=pl&languages=pt-BR&languages=pt-PT&languages=rm&languages=ro&languages=ru&languages=si&languages=sk&languages=sl&languages=son&languages=sq&languages=sr&languages=sv-SE&languages=ta&languages=te&languages=th&languages=tr&languages=uk&languages=uz&languages=vi&languages=xh&languages=zh-CN&languages=zh-TW&product=Firefox-45.0b9-Partial-45.0b7
14:36:57 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_add/
14:36:59 INFO - Server response
14:36:59 INFO -
14:36:59 INFO - linux (linux): /firefox/releases/45.0b9/update/linux-i686/:lang/firefox-45.0b7-45.0b9.partial.mar
14:36:59 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/linux-i686/:lang/firefox-45.0b7-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b7', 'os': 'linux'}), kwargs: {}, attempt #1
14:36:59 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Flinux-i686%2F%3Alang%2Ffirefox-45.0b7-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b7&os=linux
14:36:59 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:37:00 INFO - Server response
14:37:00 INFO - /firefox/releases/45.0b9/update/linux-i686/:lang/firefox-45.0b7-45.0b9.partial.mar
14:37:00 INFO - linux64 (linux64): /firefox/releases/45.0b9/update/linux-x86_64/:lang/firefox-45.0b7-45.0b9.partial.mar
14:37:00 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/linux-x86_64/:lang/firefox-45.0b7-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b7', 'os': 'linux64'}), kwargs: {}, attempt #1
14:37:00 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Flinux-x86_64%2F%3Alang%2Ffirefox-45.0b7-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b7&os=linux64
14:37:00 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:37:00 INFO - Server response
14:37:00 INFO - /firefox/releases/45.0b9/update/linux-x86_64/:lang/firefox-45.0b7-45.0b9.partial.mar
14:37:00 INFO - macosx64 (osx): /firefox/releases/45.0b9/update/mac/:lang/firefox-45.0b7-45.0b9.partial.mar
14:37:00 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/mac/:lang/firefox-45.0b7-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b7', 'os': 'osx'}), kwargs: {}, attempt #1
14:37:00 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Fmac%2F%3Alang%2Ffirefox-45.0b7-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b7&os=osx
14:37:00 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:37:01 INFO - Server response
14:37:01 INFO - /firefox/releases/45.0b9/update/mac/:lang/firefox-45.0b7-45.0b9.partial.mar
14:37:01 INFO - win32 (win): /firefox/releases/45.0b9/update/win32/:lang/firefox-45.0b7-45.0b9.partial.mar
14:37:01 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/win32/:lang/firefox-45.0b7-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b7', 'os': 'win'}), kwargs: {}, attempt #1
14:37:01 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Fwin32%2F%3Alang%2Ffirefox-45.0b7-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b7&os=win
14:37:01 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:37:01 INFO - Server response
14:37:01 INFO - /firefox/releases/45.0b9/update/win32/:lang/firefox-45.0b7-45.0b9.partial.mar
14:37:01 INFO - win64 (win64): /firefox/releases/45.0b9/update/win64/:lang/firefox-45.0b7-45.0b9.partial.mar
14:37:01 INFO - retry: Calling _api_call with args: ('location_add/', {'path': '/firefox/releases/45.0b9/update/win64/:lang/firefox-45.0b7-45.0b9.partial.mar', 'product': 'Firefox-45.0b9-Partial-45.0b7', 'os': 'win64'}), kwargs: {}, attempt #1
14:37:01 INFO - POST data: path=%2Ffirefox%2Freleases%2F45.0b9%2Fupdate%2Fwin64%2F%3Alang%2Ffirefox-45.0b7-45.0b9.partial.mar&product=Firefox-45.0b9-Partial-45.0b7&os=win64
14:37:01 INFO - Submitting to https://bounceradmin.mozilla.com/api/location_add/
14:37:02 INFO - Server response
14:37:02 INFO - /firefox/releases/45.0b9/update/win64/:lang/firefox-45.0b7-45.0b9.partial.mar
14:37:02 INFO - Checking if Firefox-45.0b9-Partial-45.0b6 already exists
14:37:02 INFO - retry: Calling _api_call with args: ('product_show?product=Firefox-45.0b9-Partial-45.0b6', None), kwargs: {}, attempt #1
14:37:02 INFO - Submitting to https://bounceradmin.mozilla.com/api/product_show?product=Firefox-45.0b9-Partial-45.0b6
14:37:02 INFO - Server response
14:37:02 INFO -
14:37:02 INFO - Products found: 1
14:37:02 WARNING - Product Firefox-45.0b9-Partial-45.0b6 already exists. Skipping...
14:37:02 INFO - Copying logs to upload dir...
14:37:02 INFO - mkdir: /builds/slave/rel-m-beta-bncr_sub-0000000000/build/upload/logs
Traceback (most recent call last):
File "/builds/slave/rel-m-beta-bncr_sub-0000000000/scripts/mozharness/mozilla/bouncer/submitter.py", line 57, in _api_call
res = urllib2.urlopen(request, timeout=60).read()
File "/usr/lib64/python2.6/urllib2.py", line 126, in urlopen
return _opener.open(url, data, timeout)
File "/usr/lib64/python2.6/urllib2.py", line 397, in open
response = meth(req, response)
File "/usr/lib64/python2.6/urllib2.py", line 510, in http_response
'http', request, response, code, msg, hdrs)
File "/usr/lib64/python2.6/urllib2.py", line 435, in error
return self._call_chain(*args)
File "/usr/lib64/python2.6/urllib2.py", line 369, in _call_chain
result = func(*args)
File "/usr/lib64/python2.6/urllib2.py", line 518, in http_error_default
raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
HTTPError: HTTP Error 400: BAD REQUEST
Traceback (most recent call last):
File "/builds/slave/rel-m-beta-bncr_sub-0000000000/scripts/mozharness/mozilla/bouncer/submitter.py", line 57, in _api_call
res = urllib2.urlopen(request, timeout=60).read()
File "/usr/lib64/python2.6/urllib2.py", line 126, in urlopen
return _opener.open(url, data, timeout)
File "/usr/lib64/python2.6/urllib2.py", line 397, in open
response = meth(req, response)
File "/usr/lib64/python2.6/urllib2.py", line 510, in http_response
'http', request, response, code, msg, hdrs)
File "/usr/lib64/python2.6/urllib2.py", line 435, in error
return self._call_chain(*args)
File "/usr/lib64/python2.6/urllib2.py", line 369, in _call_chain
result = func(*args)
File "/usr/lib64/python2.6/urllib2.py", line 518, in http_error_default
raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
HTTPError: HTTP Error 400: BAD REQUEST
Traceback (most recent call last):
File "/builds/slave/rel-m-beta-bncr_sub-0000000000/scripts/mozharness/mozilla/bouncer/submitter.py", line 57, in _api_call
res = urllib2.urlopen(request, timeout=60).read()
File "/usr/lib64/python2.6/urllib2.py", line 126, in urlopen
return _opener.open(url, data, timeout)
File "/usr/lib64/python2.6/urllib2.py", line 397, in open
response = meth(req, response)
File "/usr/lib64/python2.6/urllib2.py", line 510, in http_response
'http', request, response, code, msg, hdrs)
File "/usr/lib64/python2.6/urllib2.py", line 435, in error
return self._call_chain(*args)
File "/usr/lib64/python2.6/urllib2.py", line 369, in _call_chain
result = func(*args)
File "/usr/lib64/python2.6/urllib2.py", line 518, in http_error_default
raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
HTTPError: HTTP Error 400: BAD REQUEST
Traceback (most recent call last):
File "/builds/slave/rel-m-beta-bncr_sub-0000000000/scripts/mozharness/mozilla/bouncer/submitter.py", line 57, in _api_call
res = urllib2.urlopen(request, timeout=60).read()
File "/usr/lib64/python2.6/urllib2.py", line 126, in urlopen
return _opener.open(url, data, timeout)
File "/usr/lib64/python2.6/urllib2.py", line 397, in open
response = meth(req, response)
File "/usr/lib64/python2.6/urllib2.py", line 510, in http_response
'http', request, response, code, msg, hdrs)
File "/usr/lib64/python2.6/urllib2.py", line 435, in error
return self._call_chain(*args)
File "/usr/lib64/python2.6/urllib2.py", line 369, in _call_chain
result = func(*args)
File "/usr/lib64/python2.6/urllib2.py", line 518, in http_error_default
raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
HTTPError: HTTP Error 400: BAD REQUEST
program finished with exit code 0
elapsedTime=494.819072
========= master_lag: 0.02 =========
========= Finished 'scripts/scripts/bouncer_submitter.py -c ...' (results: 0, elapsed: 8 mins, 14 secs) (at 2016-02-23 14:37:02.632513) =========
========= Started no change (results: 0, elapsed: 0 secs) (at 2016-02-23 14:37:02.634636) =========
bash -c 'for file in `ls -1`; do cat $file; done'
in dir /builds/slave/rel-m-beta-bncr_sub-0000000000/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-414.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-m-beta-bncr_sub-0000000000/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.005196
========= master_lag: 0.05 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-02-23 14:37:02.688272) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 14:37:02.688593) =========
rm -f oauth.txt
in dir /builds/slave/rel-m-beta-bncr_sub-0000000000/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-f', 'oauth.txt']
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-414.build.releng.usw2.mozilla.com
LANG=en_US.UTF-8
LESSOPEN=|/usr/bin/lesspipe.sh %s
LOGNAME=cltbld
MAIL=/var/spool/mail/cltbld
PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
PWD=/builds/slave/rel-m-beta-bncr_sub-0000000000
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.003465
========= master_lag: 0.04 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 14:37:02.736779) =========
========= Total master_lag: 0.33 =========